builder: mozilla-inbound_yosemite_test-dromaeojs-e10s slave: t-yosemite-r5-0052 starttime: 1447138105.92 results: success (0) buildid: 20151109213837 builduid: 803c8211727a456b9c73ba57fb878c3a revision: 3b84d7638278ac102cb20514fe926a3a66a6c6f7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-09 22:48:25.923756) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-09 22:48:25.927272) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-09 22:48:25.927601) ========= 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.iwFIwsLjrd/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.GCPsDKhCxl/Listeners TMPDIR=/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/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.006015 basedir: '/builds/slave/test' ========= master_lag: 0.24 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-09 22:48:26.171040) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-09 22:48:26.171447) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-09 22:48:26.434875) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 22:48:26.435172) ========= 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.iwFIwsLjrd/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.GCPsDKhCxl/Listeners TMPDIR=/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/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.005358 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 22:48:26.477851) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-09 22:48:26.478252) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-09 22:48:26.478680) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 22:48:26.478991) ========= 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.iwFIwsLjrd/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.GCPsDKhCxl/Listeners TMPDIR=/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/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-09 22:48:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.102, 63.245.215.25, ... Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 13.6M=0.001s 2015-11-09 22:48:26 (13.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.284724 ========= master_lag: 0.68 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 22:48:27.442564) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 22:48:27.442897) ========= 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.iwFIwsLjrd/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.GCPsDKhCxl/Listeners TMPDIR=/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/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.019907 ========= master_lag: 0.10 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 22:48:27.563683) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 22:48:27.564077) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 3b84d7638278ac102cb20514fe926a3a66a6c6f7 --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 3b84d7638278ac102cb20514fe926a3a66a6c6f7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.iwFIwsLjrd/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.GCPsDKhCxl/Listeners TMPDIR=/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/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-09 22:48:27,652 truncating revision to first 12 chars 2015-11-09 22:48:27,652 Setting DEBUG logging. 2015-11-09 22:48:27,652 attempt 1/10 2015-11-09 22:48:27,652 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/3b84d7638278?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-09 22:48:27,907 unpacking tar archive at: mozilla-inbound-3b84d7638278/testing/mozharness/ program finished with exit code 0 elapsedTime=0.502870 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 22:48:28.095297) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-09 22:48:28.095645) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-09 22:48:28.123541) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-09 22:48:28.123926) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-09 22:48:28.124454) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 5 secs) (at 2015-11-09 22:48:28.124790) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.iwFIwsLjrd/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.GCPsDKhCxl/Listeners TMPDIR=/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/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 22:48:28 INFO - MultiFileLogger online at 20151109 22:48:28 in /builds/slave/test 22:48:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 22:48:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:48:28 INFO - {'append_to_log': False, 22:48:28 INFO - 'base_work_dir': '/builds/slave/test', 22:48:28 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 22:48:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:48:28 INFO - 'branch': 'Mozilla-Inbound', 22:48:28 INFO - 'buildbot_json_path': 'buildprops.json', 22:48:28 INFO - 'config_files': ('talos/mac_config.py',), 22:48:28 INFO - 'default_actions': ('clobber', 22:48:28 INFO - 'read-buildbot-config', 22:48:28 INFO - 'download-and-extract', 22:48:28 INFO - 'populate-webroot', 22:48:28 INFO - 'create-virtualenv', 22:48:28 INFO - 'install', 22:48:28 INFO - 'run-tests'), 22:48:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:48:28 INFO - 'download_minidump_stackwalk': True, 22:48:28 INFO - 'download_symbols': 'ondemand', 22:48:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:48:28 INFO - 'tooltool.py': '/tools/tooltool.py', 22:48:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:48:28 INFO - '/tools/misc-python/virtualenv.py')}, 22:48:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:48:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:48:28 INFO - 'installer_path': 'installer.exe', 22:48:28 INFO - 'log_level': 'info', 22:48:28 INFO - 'log_name': 'talos', 22:48:28 INFO - 'log_to_console': True, 22:48:28 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 22:48:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 22:48:28 INFO - 'opt_config_files': (), 22:48:28 INFO - 'pip_index': False, 22:48:28 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:48:28 INFO - 'cmd': ('bash', 22:48:28 INFO - '-c', 22:48:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:48:28 INFO - 'enabled': True, 22:48:28 INFO - 'halt_on_failure': False, 22:48:28 INFO - 'name': 'check_screen_resolution'},), 22:48:28 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:48:28 INFO - 'cmd': ('bash', 22:48:28 INFO - '-c', 22:48:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:48:28 INFO - 'enabled': True, 22:48:28 INFO - 'halt_on_failure': False, 22:48:28 INFO - 'name': 'check_screen_resolution'},), 22:48:28 INFO - 'run_cmd_checks_enabled': True, 22:48:28 INFO - 'sps_profile': False, 22:48:28 INFO - 'sps_profile_interval': 0, 22:48:28 INFO - 'suite': 'dromaeojs-e10s', 22:48:28 INFO - 'system_bits': '64', 22:48:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:48:28 INFO - 'title': 't-yosemite-r5-0052', 22:48:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:48:28 INFO - 'use_talos_json': True, 22:48:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:48:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:48:28 INFO - 'work_dir': 'build'} 22:48:28 INFO - ##### 22:48:28 INFO - ##### Running clobber step. 22:48:28 INFO - ##### 22:48:28 INFO - Running pre-action listener: _resource_record_pre_action 22:48:28 INFO - Running main action method: clobber 22:48:28 INFO - rmtree: /builds/slave/test/build 22:48:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:48:29 INFO - Running post-action listener: _resource_record_post_action 22:48:29 INFO - ##### 22:48:29 INFO - ##### Running read-buildbot-config step. 22:48:29 INFO - ##### 22:48:29 INFO - Running pre-action listener: _resource_record_pre_action 22:48:29 INFO - Running main action method: read_buildbot_config 22:48:29 INFO - Using buildbot properties: 22:48:29 INFO - { 22:48:29 INFO - "properties": { 22:48:29 INFO - "buildnumber": 36, 22:48:29 INFO - "product": "firefox", 22:48:29 INFO - "script_repo_revision": "production", 22:48:29 INFO - "builddir": "mozilla-inbound_yosemite_test-dromaeojs-e10s", 22:48:29 INFO - "repository": "", 22:48:29 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-inbound talos dromaeojs-e10s", 22:48:29 INFO - "buildid": "20151109213837", 22:48:29 INFO - "slavename": "t-yosemite-r5-0052", 22:48:29 INFO - "pgo_build": "False", 22:48:29 INFO - "basedir": "/builds/slave/test", 22:48:29 INFO - "project": "", 22:48:29 INFO - "platform": "yosemite", 22:48:29 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 22:48:29 INFO - "slavebuilddir": "test", 22:48:29 INFO - "scheduler": "tests-mozilla-inbound-macosx64-talos", 22:48:29 INFO - "branch": "mozilla-inbound", 22:48:29 INFO - "repo_path": "integration/mozilla-inbound", 22:48:29 INFO - "stage_platform": "macosx64", 22:48:29 INFO - "builduid": "803c8211727a456b9c73ba57fb878c3a", 22:48:29 INFO - "revision": "3b84d7638278ac102cb20514fe926a3a66a6c6f7" 22:48:29 INFO - }, 22:48:29 INFO - "sourcestamp": { 22:48:29 INFO - "repository": "", 22:48:29 INFO - "hasPatch": false, 22:48:29 INFO - "project": "", 22:48:29 INFO - "branch": "mozilla-inbound-macosx64-talos", 22:48:29 INFO - "changes": [ 22:48:29 INFO - { 22:48:29 INFO - "category": null, 22:48:29 INFO - "files": [ 22:48:29 INFO - { 22:48:29 INFO - "url": null, 22:48:29 INFO - "name": "https://queue.taskcluster.net/v1/task/-yQa9VkZTsmsaD1ZXQPBrw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 22:48:29 INFO - } 22:48:29 INFO - ], 22:48:29 INFO - "repository": "", 22:48:29 INFO - "rev": "3b84d7638278ac102cb20514fe926a3a66a6c6f7", 22:48:29 INFO - "who": "nnethercote@mozilla.com", 22:48:29 INFO - "when": 1447138062, 22:48:29 INFO - "number": 6641239, 22:48:29 INFO - "comments": "Bug 1038663 (part 7, attempt 3) - Add test for percentage values for 'word-spacing'. r=heycam.", 22:48:29 INFO - "project": "", 22:48:29 INFO - "at": "Mon 09 Nov 2015 22:47:42", 22:48:29 INFO - "branch": "mozilla-inbound-macosx64-talos", 22:48:29 INFO - "revlink": "", 22:48:29 INFO - "properties": [ 22:48:29 INFO - [ 22:48:29 INFO - "buildid", 22:48:29 INFO - "20151109213837", 22:48:29 INFO - "Change" 22:48:29 INFO - ], 22:48:29 INFO - [ 22:48:29 INFO - "builduid", 22:48:29 INFO - "803c8211727a456b9c73ba57fb878c3a", 22:48:29 INFO - "Change" 22:48:29 INFO - ], 22:48:29 INFO - [ 22:48:29 INFO - "pgo_build", 22:48:29 INFO - "False", 22:48:29 INFO - "Change" 22:48:29 INFO - ] 22:48:29 INFO - ], 22:48:29 INFO - "revision": "3b84d7638278ac102cb20514fe926a3a66a6c6f7" 22:48:29 INFO - } 22:48:29 INFO - ], 22:48:29 INFO - "revision": "3b84d7638278ac102cb20514fe926a3a66a6c6f7" 22:48:29 INFO - } 22:48:29 INFO - } 22:48:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/-yQa9VkZTsmsaD1ZXQPBrw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 22:48:29 INFO - Running post-action listener: _resource_record_post_action 22:48:29 INFO - ##### 22:48:29 INFO - ##### Running download-and-extract step. 22:48:29 INFO - ##### 22:48:29 INFO - Running pre-action listener: _resource_record_pre_action 22:48:29 INFO - Running main action method: download_and_extract 22:48:29 INFO - mkdir: /builds/slave/test/build/tests 22:48:29 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')]} 22:48:29 INFO - https://queue.taskcluster.net/v1/task/-yQa9VkZTsmsaD1ZXQPBrw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:48:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-yQa9VkZTsmsaD1ZXQPBrw/artifacts/public/build/test_packages.json 22:48:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-yQa9VkZTsmsaD1ZXQPBrw/artifacts/public/build/test_packages.json 22:48:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-yQa9VkZTsmsaD1ZXQPBrw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 22:48:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-yQa9VkZTsmsaD1ZXQPBrw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 22:48:42 INFO - Downloaded 1149 bytes. 22:48:42 INFO - Reading from file /builds/slave/test/build/test_packages.json 22:48:42 INFO - Using the following test package requirements: 22:48:42 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 22:48:42 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 22:48:42 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 22:48:42 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 22:48:42 INFO - u'jsshell-mac.zip'], 22:48:42 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 22:48:42 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 22:48:42 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 22:48:42 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 22:48:42 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 22:48:42 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 22:48:42 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 22:48:42 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 22:48:42 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 22:48:42 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 22:48:42 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 22:48:42 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 22:48:42 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 22:48:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:48:42 INFO - https://queue.taskcluster.net/v1/task/-yQa9VkZTsmsaD1ZXQPBrw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 22:48:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-yQa9VkZTsmsaD1ZXQPBrw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 22:48:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-yQa9VkZTsmsaD1ZXQPBrw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 22:48:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-yQa9VkZTsmsaD1ZXQPBrw/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 22:48:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-yQa9VkZTsmsaD1ZXQPBrw/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 22:48:44 INFO - Downloaded 17436516 bytes. 22:48:44 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 22:48:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 22:48:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 22:48:50 INFO - Return code: 0 22:48:50 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 22:48:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:48:50 INFO - https://queue.taskcluster.net/v1/task/-yQa9VkZTsmsaD1ZXQPBrw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 22:48:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-yQa9VkZTsmsaD1ZXQPBrw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 22:48:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-yQa9VkZTsmsaD1ZXQPBrw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 22:48:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-yQa9VkZTsmsaD1ZXQPBrw/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 22:48:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-yQa9VkZTsmsaD1ZXQPBrw/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 22:48:55 INFO - Downloaded 17436516 bytes. 22:48:55 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 22:48:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 22:48:55 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 22:49:00 INFO - Return code: 0 22:49:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:49:00 INFO - https://queue.taskcluster.net/v1/task/-yQa9VkZTsmsaD1ZXQPBrw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 22:49:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-yQa9VkZTsmsaD1ZXQPBrw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 22:49:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-yQa9VkZTsmsaD1ZXQPBrw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 22:49:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-yQa9VkZTsmsaD1ZXQPBrw/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 22:49:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-yQa9VkZTsmsaD1ZXQPBrw/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 22:49:01 INFO - Downloaded 11131618 bytes. 22:49:01 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 22:49:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 22:49:01 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 22:49:02 INFO - Return code: 0 22:49: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')]} 22:49:02 INFO - https://queue.taskcluster.net/v1/task/-yQa9VkZTsmsaD1ZXQPBrw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 22:49:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-yQa9VkZTsmsaD1ZXQPBrw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 22:49:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-yQa9VkZTsmsaD1ZXQPBrw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 22:49:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-yQa9VkZTsmsaD1ZXQPBrw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 22:49:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-yQa9VkZTsmsaD1ZXQPBrw/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 22:49:05 INFO - Downloaded 108640432 bytes. 22:49:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/-yQa9VkZTsmsaD1ZXQPBrw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 22:49:05 INFO - mkdir: /builds/slave/test/properties 22:49:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:49:05 INFO - Writing to file /builds/slave/test/properties/build_url 22:49:05 INFO - Contents: 22:49:05 INFO - build_url:https://queue.taskcluster.net/v1/task/-yQa9VkZTsmsaD1ZXQPBrw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 22:49:05 INFO - Running post-action listener: _resource_record_post_action 22:49:05 INFO - Running post-action listener: set_extra_try_arguments 22:49:05 INFO - ##### 22:49:05 INFO - ##### Running populate-webroot step. 22:49:05 INFO - ##### 22:49:05 INFO - Running pre-action listener: _resource_record_pre_action 22:49:05 INFO - Running main action method: populate_webroot 22:49:05 INFO - Guessing talos json url... 22:49:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:49:05 INFO - https://queue.taskcluster.net/v1/task/-yQa9VkZTsmsaD1ZXQPBrw/artifacts/public/build/firefox-45.0a1.en-US.mac.txt matches https://queue.taskcluster.net 22:49:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-yQa9VkZTsmsaD1ZXQPBrw/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 22:49:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-yQa9VkZTsmsaD1ZXQPBrw/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 22:49:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-yQa9VkZTsmsaD1ZXQPBrw/artifacts/public/build/firefox-45.0a1.en-US.mac.txt to /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 22:49:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-yQa9VkZTsmsaD1ZXQPBrw/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 22:49:07 INFO - Downloaded 111 bytes. 22:49:07 INFO - Reading from file /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 22:49:07 INFO - Contents: 22:49:07 INFO - 20151109213837 22:49:07 INFO - https://hg.mozilla.org/integration/mozilla-inbound/rev/3b84d7638278ac102cb20514fe926a3a66a6c6f7 22:49: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')]} 22:49:07 INFO - trying https://hg.mozilla.org/integration/mozilla-inbound/raw-file/3b84d76382/testing/talos/talos.json 22:49:07 INFO - Downloading https://hg.mozilla.org/integration/mozilla-inbound/raw-file/3b84d76382/testing/talos/talos.json to /builds/slave/test/build/talos.json 22:49:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/integration/mozilla-inbound/raw-file/3b84d76382/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 22:49:07 INFO - Downloaded 4206 bytes. 22:49:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:49:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:49:07 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 22:49:07 INFO - '../fennec_ids.txt'], 22:49:07 INFO - 'tests': ['tcheck2']}, 22:49:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:49:07 INFO - '--tppagecycles', 22:49:07 INFO - '7'], 22:49:07 INFO - 'tests': ['tsvgm']}}, 22:49:07 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:49:07 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:49:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:49:07 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:49:07 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:49:07 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:49:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:49:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:49:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:49:07 INFO - 'talos_options': ['--e10s'], 22:49:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:49:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:49:07 INFO - 'tests': ['damp', 'tps']}, 22:49:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:49:07 INFO - 'talos_options': ['--e10s'], 22:49:07 INFO - 'tests': ['damp', 'tps']}, 22:49:07 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:49:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:49:07 INFO - 'other': {'tests': ['a11yr', 22:49:07 INFO - 'ts_paint', 22:49:07 INFO - 'tpaint', 22:49:07 INFO - 'sessionrestore', 22:49:07 INFO - 'sessionrestore_no_auto_restore']}, 22:49:07 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:49:07 INFO - 'tests': ['a11yr', 22:49:07 INFO - 'ts_paint', 22:49:07 INFO - 'tpaint', 22:49:07 INFO - 'sessionrestore', 22:49:07 INFO - 'sessionrestore_no_auto_restore']}, 22:49:07 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:49:07 INFO - 'tests': ['a11yr', 22:49:07 INFO - 'ts_paint', 22:49:07 INFO - 'tpaint', 22:49:07 INFO - 'sessionrestore', 22:49:07 INFO - 'sessionrestore_no_auto_restore']}, 22:49:07 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:49:07 INFO - 'tests': ['a11yr', 22:49:07 INFO - 'ts_paint', 22:49:07 INFO - 'tpaint', 22:49:07 INFO - 'sessionrestore', 22:49:07 INFO - 'sessionrestore_no_auto_restore']}, 22:49:07 INFO - 'other_l64': {'tests': ['a11yr', 22:49:07 INFO - 'ts_paint', 22:49:07 INFO - 'tpaint', 22:49:07 INFO - 'sessionrestore', 22:49:07 INFO - 'sessionrestore_no_auto_restore']}, 22:49:07 INFO - 'other_nol64': {'tests': ['a11yr', 22:49:07 INFO - 'ts_paint', 22:49:07 INFO - 'tpaint', 22:49:07 INFO - 'sessionrestore', 22:49:07 INFO - 'sessionrestore_no_auto_restore']}, 22:49:07 INFO - 'svgr': {'tests': ['tsvgx', 22:49:07 INFO - 'tsvgr_opacity', 22:49:07 INFO - 'tart', 22:49:07 INFO - 'tscrollx', 22:49:07 INFO - 'cart']}, 22:49:07 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:49:07 INFO - 'tests': ['tsvgx', 22:49:07 INFO - 'tsvgr_opacity', 22:49:07 INFO - 'tart', 22:49:07 INFO - 'tscrollx', 22:49:07 INFO - 'cart']}, 22:49:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:49:07 INFO - 'tests': ['tp5o']}, 22:49:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:49:07 INFO - 'talos_options': ['--e10s'], 22:49:07 INFO - 'tests': ['tp5o']}, 22:49:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:49:07 INFO - 'talos_options': ['--xperf_path', 22:49:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:49:07 INFO - 'tests': ['tp5n']}, 22:49:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:49:07 INFO - 'talos_options': ['--e10s', 22:49:07 INFO - '--xperf_path', 22:49:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:49:07 INFO - 'tests': ['tp5n']}}, 22:49:07 INFO - 'talos.zip': {'path': '', 22:49:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:49:07 INFO - Running post-action listener: _resource_record_post_action 22:49:07 INFO - ##### 22:49:07 INFO - ##### Running create-virtualenv step. 22:49:07 INFO - ##### 22:49:07 INFO - Running pre-action listener: _resource_record_pre_action 22:49:07 INFO - Running main action method: create_virtualenv 22:49:07 INFO - Creating virtualenv /builds/slave/test/build/venv 22:49:07 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 22:49:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:49:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:49:07 INFO - Using real prefix '/tools/python27' 22:49:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:49:08 INFO - Installing distribute.............................................................................................................................................................................................done. 22:49:11 INFO - Installing pip.................done. 22:49:11 INFO - Return code: 0 22:49:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:49:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:49:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:49:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:49:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:49:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:49:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:49:11 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 0x105924a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105991228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3b9caa4e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058d99f0>, '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 0x105638cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1058a3990>, '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.iwFIwsLjrd/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.GCPsDKhCxl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/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 22:49:11 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 22:49:11 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 22:49:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iwFIwsLjrd/Render', 22:49:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:49:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:49:11 INFO - 'HOME': '/Users/cltbld', 22:49:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:49:11 INFO - 'LOGNAME': 'cltbld', 22:49:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:49:11 INFO - 'MOZ_NO_REMOTE': '1', 22:49:11 INFO - 'NO_EM_RESTART': '1', 22:49:11 INFO - 'PAGER': '/bin/cat', 22:49:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:49:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:49:11 INFO - 'PWD': '/builds/slave/test', 22:49:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:49:11 INFO - 'SHELL': '/bin/bash', 22:49:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GCPsDKhCxl/Listeners', 22:49:11 INFO - 'TMPDIR': '/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/', 22:49:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:49:11 INFO - 'USER': 'cltbld', 22:49:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:49:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:49:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:49:11 INFO - 'XPC_FLAGS': '0x0', 22:49:11 INFO - 'XPC_SERVICE_NAME': '0', 22:49:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:49:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:49:12 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 22:49:12 INFO - Cleaning up... 22:49:12 INFO - Return code: 0 22:49:12 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:49:12 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')]} 22:49:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:49:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:49:12 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')]} 22:49:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:49:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:49:12 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 0x105924a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105991228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3b9caa4e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058d99f0>, '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 0x105638cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1058a3990>, '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.iwFIwsLjrd/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.GCPsDKhCxl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/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 22:49:12 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 22:49:12 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 22:49:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iwFIwsLjrd/Render', 22:49:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:49:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:49:12 INFO - 'HOME': '/Users/cltbld', 22:49:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:49:12 INFO - 'LOGNAME': 'cltbld', 22:49:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:49:12 INFO - 'MOZ_NO_REMOTE': '1', 22:49:12 INFO - 'NO_EM_RESTART': '1', 22:49:12 INFO - 'PAGER': '/bin/cat', 22:49:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:49:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:49:12 INFO - 'PWD': '/builds/slave/test', 22:49:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:49:12 INFO - 'SHELL': '/bin/bash', 22:49:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GCPsDKhCxl/Listeners', 22:49:12 INFO - 'TMPDIR': '/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/', 22:49:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:49:12 INFO - 'USER': 'cltbld', 22:49:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:49:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:49:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:49:12 INFO - 'XPC_FLAGS': '0x0', 22:49:12 INFO - 'XPC_SERVICE_NAME': '0', 22:49:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:49:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:49:12 INFO - Downloading/unpacking psutil>=0.7.1 22:49:12 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 22:49:12 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 22:49:12 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 22:49:12 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 22:49:12 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 22:49:12 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 22:49:15 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 22:49:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 22:49:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:49:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:49:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:49:15 INFO - Installing collected packages: psutil 22:49:15 INFO - Running setup.py install for psutil 22:49:15 INFO - building 'psutil._psutil_osx' extension 22:49:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 22:49:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 22:49:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 22:49:15 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 22:49:15 INFO - building 'psutil._psutil_posix' extension 22:49:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 22:49:16 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 22:49:16 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 22:49:16 INFO - ^ 22:49:16 INFO - 1 warning generated. 22:49:16 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 22:49:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:49:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:49:16 INFO - Successfully installed psutil 22:49:16 INFO - Cleaning up... 22:49:16 INFO - Return code: 0 22:49:16 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:49:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:49:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:49:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:49:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:49:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:49:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:49:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105924a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105991228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3b9caa4e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058d99f0>, '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 0x105638cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1058a3990>, '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.iwFIwsLjrd/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.GCPsDKhCxl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/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 22:49:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 22:49:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 22:49:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iwFIwsLjrd/Render', 22:49:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:49:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:49:16 INFO - 'HOME': '/Users/cltbld', 22:49:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:49:16 INFO - 'LOGNAME': 'cltbld', 22:49:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:49:16 INFO - 'MOZ_NO_REMOTE': '1', 22:49:16 INFO - 'NO_EM_RESTART': '1', 22:49:16 INFO - 'PAGER': '/bin/cat', 22:49:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:49:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:49:16 INFO - 'PWD': '/builds/slave/test', 22:49:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:49:16 INFO - 'SHELL': '/bin/bash', 22:49:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GCPsDKhCxl/Listeners', 22:49:16 INFO - 'TMPDIR': '/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/', 22:49:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:49:16 INFO - 'USER': 'cltbld', 22:49:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:49:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:49:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:49:16 INFO - 'XPC_FLAGS': '0x0', 22:49:16 INFO - 'XPC_SERVICE_NAME': '0', 22:49:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:49:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:49:16 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:49:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:49:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:49:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:49:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:49:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:49:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:49:19 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:49:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:49:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:49:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:49:19 INFO - Installing collected packages: mozsystemmonitor 22:49:19 INFO - Running setup.py install for mozsystemmonitor 22:49:19 INFO - Successfully installed mozsystemmonitor 22:49:19 INFO - Cleaning up... 22:49:19 INFO - Return code: 0 22:49:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:49:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:49:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:49:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:49:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:49:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:49:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:49:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105924a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105991228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3b9caa4e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058d99f0>, '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 0x105638cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1058a3990>, '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.iwFIwsLjrd/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.GCPsDKhCxl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/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 22:49:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:49:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:49:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iwFIwsLjrd/Render', 22:49:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:49:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:49:19 INFO - 'HOME': '/Users/cltbld', 22:49:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:49:19 INFO - 'LOGNAME': 'cltbld', 22:49:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:49:19 INFO - 'MOZ_NO_REMOTE': '1', 22:49:19 INFO - 'NO_EM_RESTART': '1', 22:49:19 INFO - 'PAGER': '/bin/cat', 22:49:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:49:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:49:19 INFO - 'PWD': '/builds/slave/test', 22:49:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:49:19 INFO - 'SHELL': '/bin/bash', 22:49:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GCPsDKhCxl/Listeners', 22:49:19 INFO - 'TMPDIR': '/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/', 22:49:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:49:19 INFO - 'USER': 'cltbld', 22:49:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:49:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:49:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:49:19 INFO - 'XPC_FLAGS': '0x0', 22:49:19 INFO - 'XPC_SERVICE_NAME': '0', 22:49:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:49:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:49:19 INFO - Downloading/unpacking blobuploader==1.2.4 22:49:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:49:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:49:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:49:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:49:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:49:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:49:22 INFO - Downloading blobuploader-1.2.4.tar.gz 22:49:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 22:49:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:49:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:49: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 22:49: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 22:49: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 22:49: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 22:49: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 22:49: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 22:49:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:49:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:49:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:49:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:49:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:49:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:49:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:49:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:49:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:49:23 INFO - Downloading docopt-0.6.1.tar.gz 22:49:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:49:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:49:23 INFO - Installing collected packages: blobuploader, requests, docopt 22:49:23 INFO - Running setup.py install for blobuploader 22:49:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:49:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:49:23 INFO - Running setup.py install for requests 22:49:24 INFO - Running setup.py install for docopt 22:49:24 INFO - Successfully installed blobuploader requests docopt 22:49:24 INFO - Cleaning up... 22:49:24 INFO - Return code: 0 22:49:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:49:24 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')]} 22:49:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:49:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:49:24 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')]} 22:49:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:49:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:49:24 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 0x105924a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105991228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3b9caa4e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058d99f0>, '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 0x105638cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1058a3990>, '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.iwFIwsLjrd/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.GCPsDKhCxl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/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 22:49:24 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 22:49:24 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 22:49:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iwFIwsLjrd/Render', 22:49:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:49:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:49:24 INFO - 'HOME': '/Users/cltbld', 22:49:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:49:24 INFO - 'LOGNAME': 'cltbld', 22:49:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:49:24 INFO - 'MOZ_NO_REMOTE': '1', 22:49:24 INFO - 'NO_EM_RESTART': '1', 22:49:24 INFO - 'PAGER': '/bin/cat', 22:49:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:49:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:49:24 INFO - 'PWD': '/builds/slave/test', 22:49:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:49:24 INFO - 'SHELL': '/bin/bash', 22:49:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GCPsDKhCxl/Listeners', 22:49:24 INFO - 'TMPDIR': '/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/', 22:49:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:49:24 INFO - 'USER': 'cltbld', 22:49:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:49:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:49:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:49:24 INFO - 'XPC_FLAGS': '0x0', 22:49:24 INFO - 'XPC_SERVICE_NAME': '0', 22:49:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:49:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:49:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:49:24 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-TjjToA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:49:25 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-plrVAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:49:25 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-bMRGWy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:49:25 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-NtepfR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:49:25 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-ig_dZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:49:25 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-faPzI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:49:25 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-sLluBk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:49:25 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-Jc8D8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:49:25 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-BVBiLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:49:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:49:26 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-y71lWO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:49:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:49:26 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-xDQ2E7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:49:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:49:26 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-VKMXmD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:49:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:49:26 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-Lvhc6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:49:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:49:26 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-nGToAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:49:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:49:26 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-P3Mj09-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:49:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:49:26 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-RVAn0s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:49:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:49:26 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-IdRmAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:49:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:49:27 INFO - Running setup.py install for manifestparser 22:49:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:49:27 INFO - Running setup.py install for mozcrash 22:49:27 INFO - Running setup.py install for mozdebug 22:49:27 INFO - Running setup.py install for mozdevice 22:49:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:49:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:49:27 INFO - Running setup.py install for mozfile 22:49:27 INFO - Running setup.py install for mozhttpd 22:49:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:49:28 INFO - Running setup.py install for mozinfo 22:49:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:49:28 INFO - Running setup.py install for mozInstall 22:49:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:49:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:49:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:49:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:49:28 INFO - Running setup.py install for mozleak 22:49:28 INFO - Running setup.py install for mozlog 22:49:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:49:29 INFO - Running setup.py install for moznetwork 22:49:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:49:29 INFO - Running setup.py install for mozprocess 22:49:29 INFO - Running setup.py install for mozprofile 22:49:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:49:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:49:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:49:29 INFO - Running setup.py install for mozrunner 22:49:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:49:29 INFO - Running setup.py install for mozscreenshot 22:49:29 INFO - Running setup.py install for moztest 22:49:30 INFO - Running setup.py install for mozversion 22:49:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:49:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:49:30 INFO - Cleaning up... 22:49:30 INFO - Return code: 0 22:49:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:49:30 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')]} 22:49:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:49:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:49:30 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')]} 22:49:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:49:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:49:30 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 0x105924a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105991228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3b9caa4e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058d99f0>, '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 0x105638cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1058a3990>, '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.iwFIwsLjrd/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.GCPsDKhCxl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/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 22:49:30 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 22:49:30 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 22:49:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iwFIwsLjrd/Render', 22:49:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:49:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:49:30 INFO - 'HOME': '/Users/cltbld', 22:49:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:49:30 INFO - 'LOGNAME': 'cltbld', 22:49:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:49:30 INFO - 'MOZ_NO_REMOTE': '1', 22:49:30 INFO - 'NO_EM_RESTART': '1', 22:49:30 INFO - 'PAGER': '/bin/cat', 22:49:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:49:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:49:30 INFO - 'PWD': '/builds/slave/test', 22:49:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:49:30 INFO - 'SHELL': '/bin/bash', 22:49:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GCPsDKhCxl/Listeners', 22:49:30 INFO - 'TMPDIR': '/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/', 22:49:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:49:30 INFO - 'USER': 'cltbld', 22:49:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:49:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:49:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:49:30 INFO - 'XPC_FLAGS': '0x0', 22:49:30 INFO - 'XPC_SERVICE_NAME': '0', 22:49:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:49:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:49:30 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-pK99_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:49:30 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)) 22:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:49:30 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-PkgZWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:49:30 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)) 22:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:49:30 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-mlwLHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:49:31 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)) 22:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:49:31 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-SHmZ6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:49:31 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)) 22:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:49:31 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-tfp77r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:49:31 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)) 22:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:49:31 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-Q3S1t8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:49:31 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)) 22:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:49:31 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-Elh8TG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:49:31 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)) 22:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:49:31 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-Bo3dae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:49:31 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)) 22:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:49:31 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-dVDOSS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:49:31 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)) 22:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:49:31 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-cRVw7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:49:31 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)) 22:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:49:31 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-u3AO1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:49:32 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)) 22:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:49:32 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-V5gQ_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:49:32 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)) 22:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:49:32 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-9m9Luv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:49:32 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)) 22:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:49:32 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-vPNnr9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:49:32 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)) 22:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:49:32 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-la9WVY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:49:32 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)) 22:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:49:32 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-9kJeWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:49:32 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)) 22:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:49:32 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-IEteRH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:49:32 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)) 22:49:32 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)) 22:49:32 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)) 22:49:32 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)) 22:49:32 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)) 22:49:32 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)) 22:49:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:49:32 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 22:49:32 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 22:49:32 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 22:49:32 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 22:49:32 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 22:49:32 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 22:49:35 INFO - Downloading blessings-1.5.1.tar.gz 22:49:35 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 22:49:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:49:35 INFO - Installing collected packages: blessings 22:49:35 INFO - Running setup.py install for blessings 22:49:35 INFO - Successfully installed blessings 22:49:35 INFO - Cleaning up... 22:49:35 INFO - Return code: 0 22:49:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:49:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:49:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:49:36 INFO - Reading from file tmpfile_stdout 22:49:36 INFO - Current package versions: 22:49:36 INFO - blessings == 1.5.1 22:49:36 INFO - blobuploader == 1.2.4 22:49:36 INFO - docopt == 0.6.1 22:49:36 INFO - manifestparser == 1.1 22:49:36 INFO - mozInstall == 1.12 22:49:36 INFO - mozcrash == 0.16 22:49:36 INFO - mozdebug == 0.1 22:49:36 INFO - mozdevice == 0.47 22:49:36 INFO - mozfile == 1.2 22:49:36 INFO - mozhttpd == 0.7 22:49:36 INFO - mozinfo == 0.9 22:49:36 INFO - mozleak == 0.1 22:49:36 INFO - mozlog == 3.0 22:49:36 INFO - moznetwork == 0.27 22:49:36 INFO - mozprocess == 0.22 22:49:36 INFO - mozprofile == 0.27 22:49:36 INFO - mozrunner == 6.11 22:49:36 INFO - mozscreenshot == 0.1 22:49:36 INFO - mozsystemmonitor == 0.0 22:49:36 INFO - moztest == 0.7 22:49:36 INFO - mozversion == 1.4 22:49:36 INFO - psutil == 3.1.1 22:49:36 INFO - requests == 1.2.3 22:49:36 INFO - wsgiref == 0.1.2 22:49:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:49:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:49:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:49:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:49:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:49:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:49:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:49:36 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 0x105924a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105991228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3b9caa4e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058d99f0>, '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 0x105638cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1058a3990>, '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.iwFIwsLjrd/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.GCPsDKhCxl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/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 22:49:36 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 22:49:36 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 22:49:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iwFIwsLjrd/Render', 22:49:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:49:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:49:36 INFO - 'HOME': '/Users/cltbld', 22:49:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:49:36 INFO - 'LOGNAME': 'cltbld', 22:49:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:49:36 INFO - 'MOZ_NO_REMOTE': '1', 22:49:36 INFO - 'NO_EM_RESTART': '1', 22:49:36 INFO - 'PAGER': '/bin/cat', 22:49:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:49:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:49:36 INFO - 'PWD': '/builds/slave/test', 22:49:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:49:36 INFO - 'SHELL': '/bin/bash', 22:49:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GCPsDKhCxl/Listeners', 22:49:36 INFO - 'TMPDIR': '/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/', 22:49:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:49:36 INFO - 'USER': 'cltbld', 22:49:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:49:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:49:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:49:36 INFO - 'XPC_FLAGS': '0x0', 22:49:36 INFO - 'XPC_SERVICE_NAME': '0', 22:49:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:49:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:49:36 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)) 22:49:36 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)) 22:49:36 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)) 22:49:36 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)) 22:49:36 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)) 22:49:36 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)) 22:49:36 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)) 22:49:36 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)) 22:49: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.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:49:36 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)) 22:49:36 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)) 22:49:36 INFO - Cleaning up... 22:49:36 INFO - Return code: 0 22:49:36 INFO - Running post-action listener: _resource_record_post_action 22:49:36 INFO - Running post-action listener: _start_resource_monitoring 22:49:36 INFO - Starting resource monitoring. 22:49:36 INFO - ##### 22:49:36 INFO - ##### Running install step. 22:49:36 INFO - ##### 22:49:36 INFO - Running pre-action listener: _resource_record_pre_action 22:49:36 INFO - Running main action method: install 22:49:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:49:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:49:36 INFO - Reading from file tmpfile_stdout 22:49:36 INFO - Detecting whether we're running mozinstall >=1.0... 22:49:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:49:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:49:36 INFO - Reading from file tmpfile_stdout 22:49:36 INFO - Output received: 22:49:36 INFO - Usage: mozinstall [options] installer 22:49:36 INFO - Options: 22:49:36 INFO - -h, --help show this help message and exit 22:49:36 INFO - -d DEST, --destination=DEST 22:49:36 INFO - Directory to install application into. [default: 22:49:36 INFO - "/builds/slave/test"] 22:49:36 INFO - --app=APP Application being installed. [default: firefox] 22:49:36 INFO - mkdir: /builds/slave/test/build/application 22:49:36 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'] 22:49:36 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 22:50:17 INFO - Reading from file tmpfile_stdout 22:50:17 INFO - Output received: 22:50:17 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 22:50:17 INFO - Running post-action listener: _resource_record_post_action 22:50:17 INFO - ##### 22:50:17 INFO - ##### Running run-tests step. 22:50:17 INFO - ##### 22:50:17 INFO - Running pre-action listener: _resource_record_pre_action 22:50:17 INFO - Running main action method: run_tests 22:50:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:50:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:50:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:50:17 INFO - 2015-11-09 22:50:17.045 screenresolution[1921:11408] starting screenresolution argv=screenresolution get 22:50:17 INFO - 2015-11-09 22:50:17.049 screenresolution[1921:11408] Display 0: 1600x1200x32@60 22:50:17 INFO - 2015-11-09 22:50:17.056 screenresolution[1922:11410] starting screenresolution argv=screenresolution list 22:50:17 INFO - Available Modes on Display 0 22:50:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:50:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:50:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:50:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:50:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:50:17 INFO - Intel HD Graphics 3000: 22:50:17 INFO - Chipset Model: Intel HD Graphics 3000 22:50:17 INFO - Type: GPU 22:50:17 INFO - Bus: Built-In 22:50:17 INFO - VRAM (Total): 512 MB 22:50:17 INFO - VRAM (Dynamic, Max): 10 22:50:17 INFO - Vendor: Intel (0x8086) 22:50:17 INFO - Device ID: 0x0116 22:50:17 INFO - Revision ID: 0x0009 22:50:17 INFO - Displays: 22:50:17 INFO - Display: 22:50:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:50:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:50:17 INFO - Display Serial Number: 1600x1200 60 22:50:17 INFO - Main Display: Yes 22:50:17 INFO - Mirror: Off 22:50:17 INFO - Online: Yes 22:50:17 INFO - Rotation: Supported 22:50:17 INFO - Return code: 0 22:50:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:50:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:50:17 INFO - Python 2.7.3 22:50:17 INFO - Return code: 0 22:50:17 INFO - grabbing minidump binary from tooltool 22:50:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:50:17 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 0x1058d99f0>, '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 0x105638cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1058a3990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:50:17 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 22:50:17 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 22:50:17 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:50:17 INFO - Return code: 0 22:50:17 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 22:50:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:50:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:50:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 22:50:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:50:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/-yQa9VkZTsmsaD1ZXQPBrw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0052', '--webServer', 'localhost'] in /builds/slave/test/build 22:50:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/-yQa9VkZTsmsaD1ZXQPBrw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0052 --webServer localhost 22:50:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iwFIwsLjrd/Render', 22:50:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:50:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:50:17 INFO - 'HOME': '/Users/cltbld', 22:50:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:50:17 INFO - 'LOGNAME': 'cltbld', 22:50:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:50:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 22:50:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:50:17 INFO - 'MOZ_NO_REMOTE': '1', 22:50:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:50:17 INFO - 'NO_EM_RESTART': '1', 22:50:17 INFO - 'PAGER': '/bin/cat', 22:50:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:50:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:50:17 INFO - 'PWD': '/builds/slave/test', 22:50:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:50:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:50:17 INFO - 'SHELL': '/bin/bash', 22:50:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GCPsDKhCxl/Listeners', 22:50:17 INFO - 'TMPDIR': '/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/', 22:50:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:50:17 INFO - 'USER': 'cltbld', 22:50:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:50:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:50:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:50:17 INFO - 'XPC_FLAGS': '0x0', 22:50:17 INFO - 'XPC_SERVICE_NAME': '0', 22:50:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:50:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/-yQa9VkZTsmsaD1ZXQPBrw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0052', '--webServer', 'localhost'] with output_timeout 3600 22:50:17 INFO - mozversion INFO | application_buildid: 20151109213837 22:50:17 INFO - mozversion INFO | application_changeset: 3b84d7638278ac102cb20514fe926a3a66a6c6f7 22:50:17 INFO - mozversion INFO | application_display_name: Nightly 22:50:17 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:50:17 INFO - mozversion INFO | application_name: Firefox 22:50:17 INFO - mozversion INFO | application_remotingname: firefox 22:50:17 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:50:17 INFO - mozversion INFO | application_vendor: Mozilla 22:50:17 INFO - mozversion INFO | application_version: 45.0a1 22:50:17 INFO - mozversion INFO | platform_buildid: 20151109213837 22:50:17 INFO - mozversion INFO | platform_changeset: 3b84d7638278ac102cb20514fe926a3a66a6c6f7 22:50:17 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:50:17 INFO - mozversion INFO | platform_version: 45.0a1 22:50:17 INFO - 2015-11-09 22:50:17,724 DEBUG : using testdate: 1447138217 22:50:17 INFO - 2015-11-09 22:50:17,724 DEBUG : actual date: 1447138217 22:50:17 INFO - 2015-11-09 22:50:17,740 INFO : starting webserver on 'localhost:49656' 22:50:17 INFO - 2015-11-09 22:50:17,741 INFO : Starting test suite t-yosemite-r5-0052.e 22:50:17 INFO - 2015-11-09 22:50:17,741 INFO : Starting test dromaeo_css 22:50:17 INFO - 2015-11-09 22:50:17,741 DEBUG : operating with platform_type : mac_ 22:50:17 INFO - 2015-11-09 22:50:17,742 INFO : Initialising browser for dromaeo_css test... 22:50:17 INFO - 2015-11-09 22:50:17,757 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/tmprOgQGh/profile http://localhost:49656/getInfo.html 22:50:21 INFO - 2015-11-09 22:50:21,265 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:50:21 INFO - 2015-11-09 22:50:21,265 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:50:21 INFO - 2015-11-09 22:50:21,266 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 22:50:21 INFO - 2015-11-09 22:50:21,266 DEBUG : BROWSER_OUTPUT: __metrics 22:50:21 INFO - 2015-11-09 22:50:21,993 INFO : Browser initialized. 22:50:21 INFO - 2015-11-09 22:50:21,994 INFO : Running cycle 1/1 for dromaeo_css test... 22:50:21 INFO - 2015-11-09 22:50:21,994 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/tmprOgQGh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:50:34 INFO - 2015-11-09 22:50:34,310 DEBUG : BROWSER_OUTPUT: RSS: Main: 241008640 22:50:34 INFO - 2015-11-09 22:50:34,310 DEBUG : BROWSER_OUTPUT: 22:51:24 INFO - 2015-11-09 22:51:24,047 DEBUG : BROWSER_OUTPUT: 1447138284040 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] 22:53:33 INFO - 2015-11-09 22:53:33,567 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49656/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49656/tests/dromaeo/cssquery-ext.html) 22:53:34 INFO - 2015-11-09 22:53:34,687 DEBUG : BROWSER_OUTPUT: RSS: Main: 268161024 22:53:34 INFO - 2015-11-09 22:53:34,687 DEBUG : BROWSER_OUTPUT: 22:56:36 INFO - 2015-11-09 22:56:36,788 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49656/tests/dromaeo/cssquery-ext.html (next: http://localhost:49656/tests/dromaeo/cssquery-jquery.html) 22:56:37 INFO - 2015-11-09 22:56:37,374 DEBUG : BROWSER_OUTPUT: RSS: Main: 273948672 22:56:37 INFO - 2015-11-09 22:56:37,374 DEBUG : BROWSER_OUTPUT: 22:59:39 INFO - 2015-11-09 22:59:39,285 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49656/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49656/tests/dromaeo/cssquery-mootools.html) 22:59:39 INFO - 2015-11-09 22:59:39,876 DEBUG : BROWSER_OUTPUT: RSS: Main: 276365312 22:59:39 INFO - 2015-11-09 22:59:39,876 DEBUG : BROWSER_OUTPUT: 23:02:41 INFO - 2015-11-09 23:02:41,632 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49656/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49656/tests/dromaeo/cssquery-prototype.html) 23:02:42 INFO - 2015-11-09 23:02:42,207 DEBUG : BROWSER_OUTPUT: RSS: Main: 281600000 23:02:42 INFO - 2015-11-09 23:02:42,207 DEBUG : BROWSER_OUTPUT: 23:05:44 INFO - 2015-11-09 23:05:44,892 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49656/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49656/tests/dromaeo/cssquery-yui.html) 23:05:45 INFO - 2015-11-09 23:05:45,502 DEBUG : BROWSER_OUTPUT: RSS: Main: 287907840 23:05:45 INFO - 2015-11-09 23:05:45,502 DEBUG : BROWSER_OUTPUT: 23:08:47 INFO - 2015-11-09 23:08:47,940 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49656/tests/dromaeo/cssquery-yui.html (next: http://localhost:49656/tests/dromaeo/cssquery-dojo.html) 23:08:48 INFO - 2015-11-09 23:08:48,199 DEBUG : BROWSER_OUTPUT: RSS: Main: 291897344 23:08:48 INFO - 2015-11-09 23:08:48,199 DEBUG : BROWSER_OUTPUT: 23:08:48 INFO - 2015-11-09 23:08:48,199 DEBUG : BROWSER_OUTPUT: __start_tp_report 23:08:48 INFO - 2015-11-09 23:08:48,199 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 23:08:48 INFO - 2015-11-09 23:08:48,199 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 23:08:48 INFO - 2015-11-09 23:08:48,200 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 23:08:48 INFO - 2015-11-09 23:08:48,200 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2690.6098615700726;2773.639426874506;2795.6784969728487;2812.1985234208255;2834.0647586296536;4665.066986602685;4724.3622111015;4776.641751868607;4808.855734327967;4887.41351037875;4541.841035563756;4650.511696271894;4675.953240467595;4678.345031695565;4760.976195119019;4422.181896349178;4454.443194600675;4473.932891006638;4494.617957473619;4537.0925814837;94.18355396136641;4523.163214805255;4548.454185497745;4679.298105284201;4691.671582989192;4520.886977825548;4561.7262964222255;4567.36056952027;4590.104929538741;4598.333241679954;4536.115457485792;4556.111558246143;4562.680612357136;4565.429321334833;4587.816487340502;4367.388565600819;4421.6904816662845;4507.594316511497;4541.318802179667;4614.007988282502;4571.748553829538;4689.976550117228;4712.717236965793;4730.290456431529;4763.166445871959;5093.312402825608;5106.183010718267;5145.716985565792;5191.325127733408;5196.818111366084;4972.602191824645;5104.591632669415;5113.7443127843835;5206.76569554371;5233.4243233244315;4770.379850619397;4777.8088876445245;4787.234042553175;4789.114013907403;4915.066137433876;4967.528084831935;5179.870503237374;5230;5235.188545775411;5240.68555886648;4830.66185367028;4932.309476673268;4939.703617782944;4945.678530895552;4999.950000500021;5147.897042059138;5150.150225212873;5154.226865970059;5180.792768289301;5181.663191892515;4959.2065269557415;5038.420581633086;5048.1418158913075;5057.949420505822;5067.163917953497;4926.75366231687;4965.404151501771;4979.029089327546;4980.12847751642;4995.725235112031;4015.19696060789;4015.7992100394863;4019.0957034666967;4021.2158629067053;4074;3477.1654802847133;3494.965050349515;3602.9099272517874;3623.148560088377;3669.8532058717888;4786.928196077061;4808.230683090689;4819.3012013257885;4824;4849.781759820817;5135.537801597874;5139.12634852076;5148.253503242084;5170.741462926839;5173.611979101583;4659.487456379796;4780.043991201704;4791.161546729309;4861.9027619447415;4879.707217566957;4510.255807791743;4512.571305725951;4566.20091483989;4586.082783443325;4610.4467463903875;5315.3090098286975;5318.042752304622;5321.122014867504;5363.088274993261;5371.973140134274;5033.295338652665;5051.570616497639;5110.335656364798;5128.7179205144075;5177.378714554277;5262.763175657181;5326;5352.0366334060245;5363.19552067193;5428.37573679032;4914.385701787277;5074.5686616637995;5109.79560817578;5141.28022076917;5163.483651634957;5025.623078269217;5084.5932325414615;5097.796088156432;5113.335266415343;5161;4974.353334066548;5030.220315851049;5061;5093.108705976365;5095.796168153232;4764.237721964469;4927.482614325444;5012.624053195952;5044.646874718735;5065.265536497113;4746.620270378292;4790.664653474223;4797.328374027708;4804.615630749601;4850.417949846041;4888.315635810918;5039.924401134059;5042.949570504248;5071.112555302881;5096.43939166684;4717.363155974037;4806.831760888352;4812.807487700453;4906.95093049065;4984.7258400788305 23:08:48 INFO - 2015-11-09 23:08:48,200 DEBUG : BROWSER_OUTPUT: |1;ext.html;476.60203729885563;489.9289603007564;492.96477397465327;505.53238254614485;526.7339993303381;33362.16594585134;35235.82382088086;35386.46920296195;35470.64529354709;35514.2897142057;36682.449763253506;37294.25411491768;37535.62464375355;37591.624083759154;37624;7845.529268243909;8001.199880011981;8039.397045221603;8068.314193293577;8072.55600941948;7805.4536182467255;7921.207879212062;7952.403569732264;7985.081715602722;8026.678932842679;7894.763157105296;8004;8018.077921039067;8027.197280271956;8031.799205019863;7996.600169991477;8051.0741264754715;8077.394195435366;8091.069527004411;8092.635831387602;7922.524648521049;7932.365410767183;7933;7952.125266220711;7963.562004089773;34320;34727.6527234727;34819.30361392758;34843.82578087093;34887;2247.3033359658393;2357.1988892578534;2412.2401443545227;2620.7641312281985;2702.2298644886114;25141.37146571332;25392.873035634704;25794.871025644752;26038.73961260401;26701;2135.903884325209;2139.8074173324476;2153;2153.547754971458;2179.204590324536;232005;234543.8272808642;236375;237637;238935;52966;53313.2003019955;53347.466525335025;53741.1938820918;53793.1931021035;52345.429637110945;53373.46626533763;57060.42939570551;58217;58296.417035829945;11484.310941343547;11506.942465287788;11510.597129100608;11514;11677.357745324089;9292.488913109844;9392.765180870396;9406.764830879283;9409.858852117224;9412.764680883032;17335.82664173342;17474.291484819874;17775.55561110957;17925.820741792675;18001.54996125081;7663.693452261959;7950.284474397332;7953.801154971056;7959.243871832166;7976.401769867283;833.954132522705;837.6356285015916;861.3410740783306;863.9870401943975;873.1966590736538;24353.512929741308;24480.755192448203;24529.38676533065;24736.876315618665;24760.13339533108;925.6852670092201;940.1209868772719;964.6671898195111;1012.0436187802603;1025.707673313102;12631.305278209604;12828.871711282954;12889.806652900214;12891.613251602466;12898.935505322414;271559;274704;275252;276175;277480;46463;46598;46639.76680116646;46704;47359.5264047362;1072.2762135558623;1220.7680540697238;1225.957091501811;1226.4603574427224;1228.588422878328;23732.406689832893;23847.403814904766;24077.638835417834;25719.614205787304;27646.170614881587;44942.10115797731;45168.09663806771;45198.93209611019;45232.77383613061;45241.54758452505;237451;238283;240388;241008;241772;36413.63586364102;37866.40269174424;39427.80286098551;39495.605043950345;39670.40494392644;36963.07592310214;37323.81338093292;37334.25331493409;37348.62651373452;37351.626483735905;30651.54022689617;31958.84020579882;31991.840040800576;32052.19869503281;32075.518867216542;30520.084397468112;30739.385212295183;30979.907510763365;31135.37729245357;31358.216044599067;31381;31573;32106.35787284288;32121.678783212803;32159.196020099684;25862.482750345265;26035;27341.726582733918;27401.51969606047;27512.862435688494;21145.25991590287;21191.152353905672;21382.679259811426;21528.138874444845;21680.457988550414 23:08:48 INFO - 2015-11-09 23:08:48,204 DEBUG : BROWSER_OUTPUT: |2;jquery.html;292.55239483590117;296.3923955890424;297.1560767420525;298.19784778944637;303.9452898478273;12614.180078294905;13067.73864522709;14779.704405911876;14877.553673389802;15508.53474395767;15335.079895206296;15498.225088745574;16196.109213993226;16205.918970405131;16456.588585285375;4614.4462664480225;4754.690945088575;4776.567029891036;4787.8324258650955;4803.687760295587;3940.074082590603;4103.281925662997;4109.116539943911;4151.398047283142;4744.857654270378;4020.457238272825;4022.2558826617023;4039.9798001009954;4068.572799856017;4070.206309769596;4165.27107756143;4226.873193804176;4228.873133805975;4257.19113368459;4274.957250427487;3538.5222994895616;3556.5732112146707;3564.091156755037;3568.9293212036287;3578.6779189873037;11070.28043177191;11200.439978001068;11336.886631133748;11338.659840204724;11475.081993440504;1606.598350412397;1655.081429806457;1681.495551334607;1743.7733094697735;1771.3888708395582;8177.877331840027;8360.58197090143;8360.58197090143;8366.24703776663;8381.832363352698;1332.6734949937327;1342.3757952552012;1350.0617071135466;1355.335885416139;1448.66680663448;48462;50324.74837625825;50441.495585044046;50745;51125.23312150358;5562.249096372019;5563.638363506359;5588.636738611977;5627.662340259598;5634.098544232903;6402.967985160044;6407.519436042222;6408.1669382980845;6414.743410263631;6472.967635161888;4558.088382323548;4603.677742558056;4605.125026245069;4616.3537104805355;4623.976880115578;4795.376601041912;4807.519248075235;4808.447028591687;4824.276358546246;4825.1555977703765;2521.6343630173524;2549.247971848309;2559.590465525507;2568.345072006664;2580.909668161605;904.5296445848122;907.981840363189;916.3722849847876;923.2106548900593;942.5617088054088;354.1588726773912;383.46123696206877;390.0424457955712;393.15079428434444;409.0203961512162;9449.196818270386;9835.016498350107;9842.704718858302;9875.753106172404;9925.255605829592;384.2085304273206;386.6809881847487;389.4080996884776;398.9002749312672;400.4453831443472;5450.91823622646;5516.062269414209;5521.475459831309;5533.667979921218;5535.778568857281;460148;462112;479940;512148;513222;55621.72189139028;57627.13559296614;57703;58665;58895.70552147298;416.79993603070693;439.28615999001624;439.7735166389312;439.9164158809816;441.73937376947754;9319.16127548524;9415.293852960918;9515.238780897373;9546.379485333431;9614.278929080487;29018.7098129016;29109.41781164407;29214.70785292205;29460.852695736383;29479;38663.806680966416;39190.608093918694;39302.6069739299;39360.80319598383;42660;5176.948230517647;5420.566354691537;5428.050091233939;5446.564274857923;5454.372747134131;8462.449940753831;9216.815663686823;10023.498825058863;10314.535845886803;10335.793284134426;8535.701250456204;8705.608247628745;8718.738437846874;8800.91199088001;8886.73339799807;8283.502989820388;8369.832603347777;8373.74878753614;8426.4944103354;8658;7785.961070194613;8741.519216443157;9108.180263776292;9204.539773011189;9258.166764991183;5324.36107667067;5432.2123292123215;5443.401225865073;5466.098093814635;5494.752736126804;8830.896137982752;8899.065598112105;8928.642854285756;8948.955255223942;9061.320400969822 23:08:48 INFO - 2015-11-09 23:08:48,205 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1457.6793105516797;1507.9547613571592;1567.4278888205802;1574.7244232259352;1584.4058478070726;6467.417932386084;6518.967405162967;6769.627670478122;7188.928110718898;7293.562386256822;6719.899201511981;6723.260441351447;6878.484113691468;6911.516193866431;6921;1885.1422602715732;1891.9905400473012;1897.0704354866086;1924.0764433072134;1930.5945751392223;1949.0839305526451;1963.9312624058161;1968.5177131602777;2020.171729590868;2030.2893987104544;1944.9902750486228;1949.541857663448;1954.8338391236762;1974.6149500847341;1975.0914579293542;1874.184729642603;1913.3590247267252;1915.817997290255;1916.3771774173379;1926.5087402712359;1941.175000624729;1966.7738210105879;1981.1184023109722;1982.6926826341796;1995.6906679464705;6979.860402791966;7070.186928503236;7075.787726368218;7078.681459334342;7105.964470177668;4207.978960105211;4276.102018576103;4288.24955632763;4299.946513104278;4316.0504688968695;2275.9544809103727;2359.1978727232654;2427.781499665021;2503.5368456835545;2515.559777039011;816.7141500474846;837.3259526081501;838.0237023867248;842.9968337678143;858.5664239558982;8881.866771998426;8908.420952638122;8943.284537237005;8948.686795962176;9078.77303067422;3803.7717736935874;3870.4774855394726;3945.684345252373;3946.131850992777;3995.260876737813;8164.918350816534;8187.5087494750505;8191.918080819235;8200.179982001871;8219.794505137419;4346.847860324937;4360.236958532244;4360.345948107809;4369.563043695605;4375.409319741794;3922.6077392260545;3958.9010274742786;3965.6629186518894;3975.0857302820514;3975.7018223633345;3218.275887925245;3315.5192497087787;3330.916727081794;3332.5501057356946;3341.348437054751;1077.4074259157433;1090.841827934945;1095.6329629574182;1098.8626421697288;1116.2242241641982;893.5666201892077;914.6752902719438;917.0783362720423;946.6970569417721;1184.419634379148;6653.1018312527185;6655.23464801554;6681.599104053772;6702.296258892844;6752.561083529555;409.0754893939658;409.5065446137397;412.4411422522499;424.1114864359163;424.99276714187573;5164.302819119446;5235.73821308933;5240.266362709223;5242.18746094356;5275.182346736262;7267.854642907112;8237.217464340878;8351.8329633407;8365.8326833463;8383.916160838435;8269.09040005599;8322;8338.499690018618;8351.707690230813;8392.622331995075;6526.314736952647;6593.351662084478;6662.900056499157;6663.600183988976;6688;6401.743930242738;6403.135576697086;6404.551681382259;6416.294207637063;6432.614043157426;7306.123265208209;7389.704411823682;7571.242875712384;7581.3176814087;7611.695532178873;7571.091469023752;7723.459357845121;7760.107587627495;7767.4562780607075;7804.375649947877;6067.787627433018;6179.969100154471;6183.196184495987;6187.257529096537;6223.719932602953;6608.339166083546;6746.966265168643;6768.56004359715;6780.288069752605;6784.59292442455;6282.528810339151;6331.841703957438;6339.270983836917;6415.582987105823;6454.386833250834;6169.876602468015;6228.22147231596;6288.779892703734;6307.810765677037;6335.176427064452;5843.678597676999;6072.1498990140535;6074.757009719562;6074.878502429839;6127.754889804358;5675.829725108253;5707.058335374617;5728.083506638918;5733.483986441241;5747.224124743107;5720.313562372542;5753.1945527627;5767.913481297868;5768.573508943135;5840.1531777892815 23:08:48 INFO - 2015-11-09 23:08:48,209 DEBUG : BROWSER_OUTPUT: |4;prototype.html;271.1431875274134;275.7518233589769;276.21279353841567;278.2223684800981;280.53431304035297;5126.487351264872;5430.212619170218;5543.861403464915;5552.472515111058;5602.579806514513;5232;5371.086915224411;5374.274472946151;5388;5394.946050539494;4127.215828992496;4190.245755763961;4192.454980852485;4209.9789501052455;4220.219259436999;4173.290540608089;4189.7695626740515;4193.056562273479;4193.538710741831;4203.726757760735;4048.858289959852;4130.97934510327;4141.047559061418;4147.626713595776;4264.445622069142;4199.0342221289275;4218.367244913272;4224.640905523003;4226.239276930151;4234.047339348653;3614.4759009943673;3623.3115708015393;3623.9275214495824;3626.673599376069;3629.963700362989;5316.494932981399;5325.094733895247;5340.092184328673;5340.866478338034;5347.278117454132;4453.487848897385;4637.747808091796;4690.7654617269345;4694.600958918496;4695.60087392572;5355.491228333302;5559.610827242094;5568.136938774496;5569.359523654791;5699.914501282484;3816.8091595420397;3817.8281977310808;3822.827972741233;3824.8852534424013;3842.731008829383;5887.8233652990475;5890.558208134407;5921.230240068807;5924.407559244084;5940.584159108864;3809.9047523811573;3896.376579747227;3924.941125883114;3928.5874983126932;3950.288947989332;4015.5382131054716;4023.4166045923175;4040.959590404117;4046.0289530512464;4054.8580799671868;4643.094596553708;4655.185342565105;4677.181493238738;4691.812327506861;4711.976440117846;5715.799947001835;5716.657000579979;5725.398833122462;5761.049426844524;5772.595918285764;1356.0778670503955;1434.6628542292553;1460.2041887171517;1460.9415623374946;1464.2312785787547;879.1252703559999;882.7528292078229;898.5462341517492;901.8827552418144;903.0382642485863;5429.941161473554;5433.782648694008;5439.864003399946;5443.074677304868;5469.480399362054;5861.9413805861395;5868.23712917318;5892.705364731746;5897.734601942923;5914.970425147847;5380.381256155514;5410.648307859977;5416.647917885325;5423.566114710814;5524.558035357162;3208.2139875730595;3274.0668909361193;3277.6722327767034;3287.7534184936226;3299.785513941586;6039.54703397247;6053.303870054912;6077.36187700294;6083.6045657032155;6090.208272924491;5996.190514280604;6011.128386384037;6017.518598512109;6048.999999999912;6053.4551890330085;5848.444397782204;6041.063635136561;6085.939140608626;6131.6321020738005;6156.753729850935;5896.469317761422;5984.8803023940145;5996.130561068708;6020.157177995172;6022.48808851235;5833.095870140135;5842.591018628826;5849.795257166149;5857.443542863592;5902.055671092605;5949.6430214187285;6073.939260607337;6180.381961803783;6186.659733714689;6189.690515474298;3795.2409518095938;3840.9615903840604;3857.247836671822;3879.8060096994473;3890.3775395936514;5865.648061116347;5897.705114744332;5904.439078287556;5907.793227237026;5919.852003699942;5741.3971532988435;5750.539956803529;5760.366359700346;5798.797042103506;5807.535397168301;5637.351704554028;5834.562407819346;5851.1223316502865;5858.7070646468355;5891.05743081105;5696.829095127153;5701.800436984686;5721.256236689203;5724.914126288026;5807.506361959281;5601.523870470893;5664.85837854057;5717.113847353667;5747.770089196552;5856.970715146567;5604.383517812956;5631.943680563306;5669.34802497718;5671.858203544944;5690.174924635988 23:08:48 INFO - 2015-11-09 23:08:48,209 DEBUG : BROWSER_OUTPUT: |5;yui.html;566.9036263835147;583.6527266276564;602.9638221706696;670.4870773857999;681.7273090763695;11928.463219155137;12246.877531224685;12291.754164916707;12316.261024338535;12494.250344979308;11001.339919604829;11026.503807328669;11044.3373397596;11089.390083545422;12342.444589993449;766.4175226827596;769.4383100336757;780.683823051665;781.7928249014016;787.0673252196137;758.2455456820471;768.174212721324;771.8919351290824;772.0735117858565;772.3087836386459;811.8457493076326;812.8943237379133;816.3142959913671;818.9754307370788;820.6963423533301;793.2464159048898;807.2411932783224;807.9272865442139;811.5090370325956;815.1888870573757;595.8272101090679;604.939506049396;605.975900727773;606.8331208917539;607.8146165419545;10980.066694330992;11006.614768483065;11015.83476247857;11016.394098324588;11037.779244415147;9469.66856160038;9774.56014479343;9850.90149098507;10105.595776169019;10231.59073637061;7789.649465774054;7843.294103530709;7957.442978991473;7990.683866195522;8029.558374289411;2875.1949454152873;2875.52553828618;2898.9275268118254;2902.6226590543306;2946.9263268418244;36667.26665466676;38504.422433663516;40044.19911601781;42523.57476425258;42531.7873410631;7423.44324175689;7450.701971921171;7459.925400746031;7507.924920750723;7621.894825250308;16335.509934701979;16346.427875024317;16397.42609008679;16431.096289703943;16590.336386544644;5793.420657934173;5824.796132135355;5861.150133230658;6040.124181993674;6090.908636370458;3086.3518661081425;3135.4179643702505;3141.701538353853;3194.425003499346;3247.7401807855313;2518.1690042286;2554.5657238269537;2558.7952963762855;2561.6285638582303;2562.7437256274598;382.277495533442;387.42660861923946;393.5238361582517;396.3638360431466;398.87236084453275;359.0485214182385;450.54720006393364;499.35084390292474;510.8978204359143;526.147640821871;6254.562180647311;6475.222973243147;6497.772577959749;6703.564268322543;7272;440.76859648684695;461.8337398536524;466.622036150719;502.813958835226;525.2961032216848;3019.5017822059112;3057.8929737459525;3091.474449343617;3116.2988327626103;3442.5008373785663;45791;46558.76720616375;46758.5324146761;46777.532224678;47610.76194619074;42097.579024209976;42571;42819;42823.143537129086;42824.78587607042;35984.820075899974;37389.25221495555;38948.80525597354;39312.6068739309;40625;6517;6529.7388104475285;6828.453723702191;6909.585424874524;7002.404795592432;29758.55362169526;29999.05224144925;30416.543751844183;30479.238019049702;30567.388652226386;35641.64358356383;35747.46378804372;35778;39429.2114157721;39438.408423874236;5899.616524925866;6124.755009799558;6133.355997620186;6258.9359808833515;6423.197100362455;9327.113924177193;9370.578323975302;9458.243340532603;9509.286803489627;10139.138173255356;8444.915550844413;8707.738767836974;8801.779955501164;8812.691555795516;8846.778830529289;8698.782530436789;8842.292616590528;8866.64533418656;9021.864672030057;9029;8604.397692161489;8680.956595217236;8713.172248636369;8744.69393571222;9158.221551168226;7451.180370159386;7601.3918886487845;7667.578283194255;7697.422693297913;7797.298243158143;7149.857002860018;7255.274472552703;7278.308560686726;7397.667104980396;7514.624268786648 23:08:48 INFO - 2015-11-09 23:08:48,209 DEBUG : BROWSER_OUTPUT: __end_tp_report 23:08:48 INFO - 2015-11-09 23:08:48,209 DEBUG : BROWSER_OUTPUT: __start_cc_report 23:08:48 INFO - 2015-11-09 23:08:48,210 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,291 23:08:48 INFO - 2015-11-09 23:08:48,210 DEBUG : BROWSER_OUTPUT: __end_cc_report 23:08:48 INFO - 2015-11-09 23:08:48,210 DEBUG : BROWSER_OUTPUT: __startTimestamp1447139328195__endTimestamp 23:08:48 INFO - 2015-11-09 23:08:48,210 DEBUG : BROWSER_OUTPUT: 23:08:48 INFO - 2015-11-09 23:08:48,212 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 23:08:48 INFO - 2015-11-09 23:08:48,212 DEBUG : BROWSER_OUTPUT: Number of tests: 6 23:08:48 INFO - 2015-11-09 23:08:48,212 DEBUG : BROWSER_OUTPUT: 23:08:48 INFO - 2015-11-09 23:08:48,212 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4746.43 Median:4887.41 stddev:623.93 (12.8%) stddev-sans-first:604.64 23:08:48 INFO - 2015-11-09 23:08:48,212 DEBUG : BROWSER_OUTPUT: Values: 2690.6 2773.6 2795.7 2812.2 2834.1 4665.1 4724.4 4776.6 4808.9 4887.4 4541.8 4650.5 4676.0 4678.3 4761.0 4422.2 4454.4 4473.9 4494.6 4537.1 94.2 4523.2 4548.5 4679.3 4691.7 4520.9 4561.7 4567.4 4590.1 4598.3 4536.1 4556.1 4562.7 4565.4 4587.8 4367.4 4421.7 4507.6 4541.3 4614.0 4571.7 4690.0 4712.7 4730.3 4763.2 5093.3 5106.2 5145.7 5191.3 5196.8 4972.6 5104.6 5113.7 5206.8 5233.4 4770.4 4777.8 4787.2 4789.1 4915.1 4967.5 5179.9 5230.0 5235.2 5240.7 4830.7 4932.3 4939.7 4945.7 5000.0 5147.9 5150.2 5154.2 5180.8 5181.7 4959.2 5038.4 5048.1 5057.9 5067.2 4926.8 4965.4 4979.0 4980.1 4995.7 4015.2 4015.8 4019.1 4021.2 4074.0 3477.2 3495.0 3602.9 3623.1 3669.9 4786.9 4808.2 4819.3 4824.0 4849.8 5135.5 5139.1 5148.3 5170.7 5173.6 4659.5 4780.0 4791.2 4861.9 4879.7 4510.3 4512.6 4566.2 4586.1 4610.4 5315.3 5318.0 5321.1 5363.1 5372.0 5033.3 5051.6 5110.3 5128.7 5177.4 5262.8 5326.0 5352.0 5363.2 5428.4 4914.4 5074.6 5109.8 5141.3 5163.5 5025.6 5084.6 5097.8 5113.3 5161.0 4974.4 5030.2 5061.0 5093.1 5095.8 4764.2 4927.5 5012.6 5044.6 5065.3 4746.6 4790.7 4797.3 4804.6 4850.4 4888.3 5039.9 5042.9 5071.1 5096.4 4717.4 4806.8 4812.8 4907.0 4984.7 23:08:48 INFO - 2015-11-09 23:08:48,212 DEBUG : BROWSER_OUTPUT: 23:08:48 INFO - 2015-11-09 23:08:48,213 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40567.08 Median:34831.56 stddev:65505.57 (188.1%) stddev-sans-first:65620.17 23:08:48 INFO - 2015-11-09 23:08:48,214 DEBUG : BROWSER_OUTPUT: Values: 476.6 489.9 493.0 505.5 526.7 33362.2 35235.8 35386.5 35470.6 35514.3 36682.4 37294.3 37535.6 37591.6 37624.0 7845.5 8001.2 8039.4 8068.3 8072.6 7805.5 7921.2 7952.4 7985.1 8026.7 7894.8 8004.0 8018.1 8027.2 8031.8 7996.6 8051.1 8077.4 8091.1 8092.6 7922.5 7932.4 7933.0 7952.1 7963.6 34320.0 34727.7 34819.3 34843.8 34887.0 2247.3 2357.2 2412.2 2620.8 2702.2 25141.4 25392.9 25794.9 26038.7 26701.0 2135.9 2139.8 2153.0 2153.5 2179.2 232005.0 234543.8 236375.0 237637.0 238935.0 52966.0 53313.2 53347.5 53741.2 53793.2 52345.4 53373.5 57060.4 58217.0 58296.4 11484.3 11506.9 11510.6 11514.0 11677.4 9292.5 9392.8 9406.8 9409.9 9412.8 17335.8 17474.3 17775.6 17925.8 18001.5 7663.7 7950.3 7953.8 7959.2 7976.4 834.0 837.6 861.3 864.0 873.2 24353.5 24480.8 24529.4 24736.9 24760.1 925.7 940.1 964.7 1012.0 1025.7 12631.3 12828.9 12889.8 12891.6 12898.9 271559.0 274704.0 275252.0 276175.0 277480.0 46463.0 46598.0 46639.8 46704.0 47359.5 1072.3 1220.8 1226.0 1226.5 1228.6 23732.4 23847.4 24077.6 25719.6 27646.2 44942.1 45168.1 45198.9 45232.8 45241.5 237451.0 238283.0 240388.0 241008.0 241772.0 36413.6 37866.4 39427.8 39495.6 39670.4 36963.1 37323.8 37334.3 37348.6 37351.6 30651.5 31958.8 31991.8 32052.2 32075.5 30520.1 30739.4 30979.9 31135.4 31358.2 31381.0 31573.0 32106.4 32121.7 32159.2 25862.5 26035.0 27341.7 27401.5 27512.9 21145.3 21191.2 21382.7 21528.1 21680.5 23:08:48 INFO - 2015-11-09 23:08:48,214 DEBUG : BROWSER_OUTPUT: 23:08:48 INFO - 2015-11-09 23:08:48,214 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:23408.04 Median:4749.77 stddev:79520.25 (1674.2%) stddev-sans-first:79724.38 23:08:48 INFO - 2015-11-09 23:08:48,215 DEBUG : BROWSER_OUTPUT: Values: 292.6 296.4 297.2 298.2 303.9 12614.2 13067.7 14779.7 14877.6 15508.5 15335.1 15498.2 16196.1 16205.9 16456.6 4614.4 4754.7 4776.6 4787.8 4803.7 3940.1 4103.3 4109.1 4151.4 4744.9 4020.5 4022.3 4040.0 4068.6 4070.2 4165.3 4226.9 4228.9 4257.2 4275.0 3538.5 3556.6 3564.1 3568.9 3578.7 11070.3 11200.4 11336.9 11338.7 11475.1 1606.6 1655.1 1681.5 1743.8 1771.4 8177.9 8360.6 8360.6 8366.2 8381.8 1332.7 1342.4 1350.1 1355.3 1448.7 48462.0 50324.7 50441.5 50745.0 51125.2 5562.2 5563.6 5588.6 5627.7 5634.1 6403.0 6407.5 6408.2 6414.7 6473.0 4558.1 4603.7 4605.1 4616.4 4624.0 4795.4 4807.5 4808.4 4824.3 4825.2 2521.6 2549.2 2559.6 2568.3 2580.9 904.5 908.0 916.4 923.2 942.6 354.2 383.5 390.0 393.2 409.0 9449.2 9835.0 9842.7 9875.8 9925.3 384.2 386.7 389.4 398.9 400.4 5450.9 5516.1 5521.5 5533.7 5535.8 460148.0 462112.0 479940.0 512148.0 513222.0 55621.7 57627.1 57703.0 58665.0 58895.7 416.8 439.3 439.8 439.9 441.7 9319.2 9415.3 9515.2 9546.4 9614.3 29018.7 29109.4 29214.7 29460.9 29479.0 38663.8 39190.6 39302.6 39360.8 42660.0 5176.9 5420.6 5428.1 5446.6 5454.4 8462.4 9216.8 10023.5 10314.5 10335.8 8535.7 8705.6 8718.7 8800.9 8886.7 8283.5 8369.8 8373.7 8426.5 8658.0 7786.0 8741.5 9108.2 9204.5 9258.2 5324.4 5432.2 5443.4 5466.1 5494.8 8830.9 8899.1 8928.6 8949.0 9061.3 23:08:48 INFO - 2015-11-09 23:08:48,216 DEBUG : BROWSER_OUTPUT: 23:08:48 INFO - 2015-11-09 23:08:48,216 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4844.81 Median:6101.32 stddev:2532.37 (41.5%) stddev-sans-first:2526.68 23:08:48 INFO - 2015-11-09 23:08:48,217 DEBUG : BROWSER_OUTPUT: Values: 1457.7 1508.0 1567.4 1574.7 1584.4 6467.4 6519.0 6769.6 7188.9 7293.6 6719.9 6723.3 6878.5 6911.5 6921.0 1885.1 1892.0 1897.1 1924.1 1930.6 1949.1 1963.9 1968.5 2020.2 2030.3 1945.0 1949.5 1954.8 1974.6 1975.1 1874.2 1913.4 1915.8 1916.4 1926.5 1941.2 1966.8 1981.1 1982.7 1995.7 6979.9 7070.2 7075.8 7078.7 7106.0 4208.0 4276.1 4288.2 4299.9 4316.1 2276.0 2359.2 2427.8 2503.5 2515.6 816.7 837.3 838.0 843.0 858.6 8881.9 8908.4 8943.3 8948.7 9078.8 3803.8 3870.5 3945.7 3946.1 3995.3 8164.9 8187.5 8191.9 8200.2 8219.8 4346.8 4360.2 4360.3 4369.6 4375.4 3922.6 3958.9 3965.7 3975.1 3975.7 3218.3 3315.5 3330.9 3332.6 3341.3 1077.4 1090.8 1095.6 1098.9 1116.2 893.6 914.7 917.1 946.7 1184.4 6653.1 6655.2 6681.6 6702.3 6752.6 409.1 409.5 412.4 424.1 425.0 5164.3 5235.7 5240.3 5242.2 5275.2 7267.9 8237.2 8351.8 8365.8 8383.9 8269.1 8322.0 8338.5 8351.7 8392.6 6526.3 6593.4 6662.9 6663.6 6688.0 6401.7 6403.1 6404.6 6416.3 6432.6 7306.1 7389.7 7571.2 7581.3 7611.7 7571.1 7723.5 7760.1 7767.5 7804.4 6067.8 6180.0 6183.2 6187.3 6223.7 6608.3 6747.0 6768.6 6780.3 6784.6 6282.5 6331.8 6339.3 6415.6 6454.4 6169.9 6228.2 6288.8 6307.8 6335.2 5843.7 6072.1 6074.8 6074.9 6127.8 5675.8 5707.1 5728.1 5733.5 5747.2 5720.3 5753.2 5767.9 5768.6 5840.2 23:08:48 INFO - 2015-11-09 23:08:48,217 DEBUG : BROWSER_OUTPUT: 23:08:48 INFO - 2015-11-09 23:08:48,217 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4776.70 Median:5456.28 stddev:1456.06 (26.7%) stddev-sans-first:1420.33 23:08:48 INFO - 2015-11-09 23:08:48,219 DEBUG : BROWSER_OUTPUT: Values: 271.1 275.8 276.2 278.2 280.5 5126.5 5430.2 5543.9 5552.5 5602.6 5232.0 5371.1 5374.3 5388.0 5394.9 4127.2 4190.2 4192.5 4210.0 4220.2 4173.3 4189.8 4193.1 4193.5 4203.7 4048.9 4131.0 4141.0 4147.6 4264.4 4199.0 4218.4 4224.6 4226.2 4234.0 3614.5 3623.3 3623.9 3626.7 3630.0 5316.5 5325.1 5340.1 5340.9 5347.3 4453.5 4637.7 4690.8 4694.6 4695.6 5355.5 5559.6 5568.1 5569.4 5699.9 3816.8 3817.8 3822.8 3824.9 3842.7 5887.8 5890.6 5921.2 5924.4 5940.6 3809.9 3896.4 3924.9 3928.6 3950.3 4015.5 4023.4 4041.0 4046.0 4054.9 4643.1 4655.2 4677.2 4691.8 4712.0 5715.8 5716.7 5725.4 5761.0 5772.6 1356.1 1434.7 1460.2 1460.9 1464.2 879.1 882.8 898.5 901.9 903.0 5429.9 5433.8 5439.9 5443.1 5469.5 5861.9 5868.2 5892.7 5897.7 5915.0 5380.4 5410.6 5416.6 5423.6 5524.6 3208.2 3274.1 3277.7 3287.8 3299.8 6039.5 6053.3 6077.4 6083.6 6090.2 5996.2 6011.1 6017.5 6049.0 6053.5 5848.4 6041.1 6085.9 6131.6 6156.8 5896.5 5984.9 5996.1 6020.2 6022.5 5833.1 5842.6 5849.8 5857.4 5902.1 5949.6 6073.9 6180.4 6186.7 6189.7 3795.2 3841.0 3857.2 3879.8 3890.4 5865.6 5897.7 5904.4 5907.8 5919.9 5741.4 5750.5 5760.4 5798.8 5807.5 5637.4 5834.6 5851.1 5858.7 5891.1 5696.8 5701.8 5721.3 5724.9 5807.5 5601.5 5664.9 5717.1 5747.8 5857.0 5604.4 5631.9 5669.3 5671.9 5690.2 23:08:48 INFO - 2015-11-09 23:08:48,219 DEBUG : BROWSER_OUTPUT: 23:08:48 INFO - 2015-11-09 23:08:48,219 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11263.09 Median:3204.22 stddev:13316.17 (415.6%) stddev-sans-first:13329.30 23:08:48 INFO - 2015-11-09 23:08:48,220 DEBUG : BROWSER_OUTPUT: Values: 566.9 583.7 603.0 670.5 681.7 11928.5 12246.9 12291.8 12316.3 12494.3 11001.3 11026.5 11044.3 11089.4 12342.4 766.4 769.4 780.7 781.8 787.1 758.2 768.2 771.9 772.1 772.3 811.8 812.9 816.3 819.0 820.7 793.2 807.2 807.9 811.5 815.2 595.8 604.9 606.0 606.8 607.8 10980.1 11006.6 11015.8 11016.4 11037.8 9469.7 9774.6 9850.9 10105.6 10231.6 7789.6 7843.3 7957.4 7990.7 8029.6 2875.2 2875.5 2898.9 2902.6 2946.9 36667.3 38504.4 40044.2 42523.6 42531.8 7423.4 7450.7 7459.9 7507.9 7621.9 16335.5 16346.4 16397.4 16431.1 16590.3 5793.4 5824.8 5861.2 6040.1 6090.9 3086.4 3135.4 3141.7 3194.4 3247.7 2518.2 2554.6 2558.8 2561.6 2562.7 382.3 387.4 393.5 396.4 398.9 359.0 450.5 499.4 510.9 526.1 6254.6 6475.2 6497.8 6703.6 7272.0 440.8 461.8 466.6 502.8 525.3 3019.5 3057.9 3091.5 3116.3 3442.5 45791.0 46558.8 46758.5 46777.5 47610.8 42097.6 42571.0 42819.0 42823.1 42824.8 35984.8 37389.3 38948.8 39312.6 40625.0 6517.0 6529.7 6828.5 6909.6 7002.4 29758.6 29999.1 30416.5 30479.2 30567.4 35641.6 35747.5 35778.0 39429.2 39438.4 5899.6 6124.8 6133.4 6258.9 6423.2 9327.1 9370.6 9458.2 9509.3 10139.1 8444.9 8707.7 8801.8 8812.7 8846.8 8698.8 8842.3 8866.6 9021.9 9029.0 8604.4 8681.0 8713.2 8744.7 9158.2 7451.2 7601.4 7667.6 7697.4 7797.3 7149.9 7255.3 7278.3 7397.7 7514.6 23:08:48 INFO - 2015-11-09 23:08:48,220 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 23:08:48 INFO - 2015-11-09 23:08:48,221 DEBUG : BROWSER_OUTPUT: 23:08:48 INFO - 2015-11-09 23:08:48,848 INFO : Browser exited with error code: 0 23:08:48 INFO - 2015-11-09 23:08:48,880 INFO : Completed test dromaeo_css (00:18:31) 23:08:48 INFO - 2015-11-09 23:08:48,880 INFO : Starting test kraken 23:08:48 INFO - 2015-11-09 23:08:48,880 DEBUG : operating with platform_type : mac_ 23:08:48 INFO - 2015-11-09 23:08:48,880 INFO : Initialising browser for kraken test... 23:08:48 INFO - 2015-11-09 23:08:48,894 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/tmprIpiRE/profile http://localhost:49656/getInfo.html 23:08:52 INFO - 2015-11-09 23:08:52,212 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 23:08:52 INFO - 2015-11-09 23:08:52,212 DEBUG : BROWSER_OUTPUT: colorDepth:24 23:08:52 INFO - 2015-11-09 23:08:52,214 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 23:08:52 INFO - 2015-11-09 23:08:52,214 DEBUG : BROWSER_OUTPUT: __metrics 23:08:52 INFO - 2015-11-09 23:08:52,906 INFO : Browser initialized. 23:08:52 INFO - 2015-11-09 23:08:52,906 INFO : Running cycle 1/1 for kraken test... 23:08:52 INFO - 2015-11-09 23:08:52,906 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/tmprIpiRE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 23:09:05 INFO - 2015-11-09 23:09:05,216 DEBUG : BROWSER_OUTPUT: RSS: Main: 241201152 23:09:05 INFO - 2015-11-09 23:09:05,216 DEBUG : BROWSER_OUTPUT: 23:09:07 INFO - 2015-11-09 23:09:07,992 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49656/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49656/tests/kraken/driver.html?testName=audio-beat-detection) 23:09:08 INFO - 2015-11-09 23:09:08,590 DEBUG : BROWSER_OUTPUT: RSS: Main: 259829760 23:09:08 INFO - 2015-11-09 23:09:08,590 DEBUG : BROWSER_OUTPUT: 23:09:11 INFO - 2015-11-09 23:09:11,561 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49656/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49656/tests/kraken/driver.html?testName=audio-dft) 23:09:12 INFO - 2015-11-09 23:09:12,163 DEBUG : BROWSER_OUTPUT: RSS: Main: 267186176 23:09:12 INFO - 2015-11-09 23:09:12,163 DEBUG : BROWSER_OUTPUT: 23:09:15 INFO - 2015-11-09 23:09:15,370 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49656/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49656/tests/kraken/driver.html?testName=audio-fft) 23:09:15 INFO - 2015-11-09 23:09:15,950 DEBUG : BROWSER_OUTPUT: RSS: Main: 267042816 23:09:15 INFO - 2015-11-09 23:09:15,950 DEBUG : BROWSER_OUTPUT: 23:09:18 INFO - 2015-11-09 23:09:18,101 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49656/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49656/tests/kraken/driver.html?testName=audio-oscillator) 23:09:18 INFO - 2015-11-09 23:09:18,691 DEBUG : BROWSER_OUTPUT: RSS: Main: 267407360 23:09:18 INFO - 2015-11-09 23:09:18,691 DEBUG : BROWSER_OUTPUT: 23:09:21 INFO - 2015-11-09 23:09:21,037 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49656/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49656/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:09:21 INFO - 2015-11-09 23:09:21,622 DEBUG : BROWSER_OUTPUT: RSS: Main: 267898880 23:09:21 INFO - 2015-11-09 23:09:21,622 DEBUG : BROWSER_OUTPUT: 23:09:25 INFO - 2015-11-09 23:09:25,016 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49656/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49656/tests/kraken/driver.html?testName=imaging-darkroom) 23:09:25 INFO - 2015-11-09 23:09:25,604 DEBUG : BROWSER_OUTPUT: RSS: Main: 266543104 23:09:25 INFO - 2015-11-09 23:09:25,604 DEBUG : BROWSER_OUTPUT: 23:09:29 INFO - 2015-11-09 23:09:29,122 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49656/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49656/tests/kraken/driver.html?testName=imaging-desaturate) 23:09:29 INFO - 2015-11-09 23:09:29,710 DEBUG : BROWSER_OUTPUT: RSS: Main: 266493952 23:09:29 INFO - 2015-11-09 23:09:29,710 DEBUG : BROWSER_OUTPUT: 23:09:32 INFO - 2015-11-09 23:09:32,938 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49656/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49656/tests/kraken/driver.html?testName=json-parse-financial) 23:09:33 INFO - 2015-11-09 23:09:33,530 DEBUG : BROWSER_OUTPUT: RSS: Main: 266039296 23:09:33 INFO - 2015-11-09 23:09:33,530 DEBUG : BROWSER_OUTPUT: 23:09:35 INFO - 2015-11-09 23:09:35,212 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49656/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49656/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:09:35 INFO - 2015-11-09 23:09:35,797 DEBUG : BROWSER_OUTPUT: RSS: Main: 267517952 23:09:35 INFO - 2015-11-09 23:09:35,798 DEBUG : BROWSER_OUTPUT: 23:09:37 INFO - 2015-11-09 23:09:37,762 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49656/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49656/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:09:38 INFO - 2015-11-09 23:09:38,389 DEBUG : BROWSER_OUTPUT: RSS: Main: 268386304 23:09:38 INFO - 2015-11-09 23:09:38,390 DEBUG : BROWSER_OUTPUT: 23:09:40 INFO - 2015-11-09 23:09:40,754 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49656/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49656/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:09:41 INFO - 2015-11-09 23:09:41,339 DEBUG : BROWSER_OUTPUT: RSS: Main: 268541952 23:09:41 INFO - 2015-11-09 23:09:41,339 DEBUG : BROWSER_OUTPUT: 23:09:44 INFO - 2015-11-09 23:09:44,217 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49656/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49656/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:09:44 INFO - 2015-11-09 23:09:44,812 DEBUG : BROWSER_OUTPUT: RSS: Main: 268611584 23:09:44 INFO - 2015-11-09 23:09:44,812 DEBUG : BROWSER_OUTPUT: 23:09:47 INFO - 2015-11-09 23:09:47,773 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49656/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49656/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:09:48 INFO - 2015-11-09 23:09:48,355 DEBUG : BROWSER_OUTPUT: RSS: Main: 267702272 23:09:48 INFO - 2015-11-09 23:09:48,355 DEBUG : BROWSER_OUTPUT: 23:09:50 INFO - 2015-11-09 23:09:50,244 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49656/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49656/tests/kraken/driver.html?testName=ai-astar) 23:09:50 INFO - 2015-11-09 23:09:50,506 DEBUG : BROWSER_OUTPUT: RSS: Main: 268894208 23:09:50 INFO - 2015-11-09 23:09:50,506 DEBUG : BROWSER_OUTPUT: 23:09:50 INFO - 2015-11-09 23:09:50,506 DEBUG : BROWSER_OUTPUT: __start_tp_report 23:09:50 INFO - 2015-11-09 23:09:50,506 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 23:09:50 INFO - 2015-11-09 23:09:50,506 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 23:09:50 INFO - 2015-11-09 23:09:50,506 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 23:09:50 INFO - 2015-11-09 23:09:50,506 DEBUG : BROWSER_OUTPUT: |0;ai-astar;125;117;128;129;136;145;129;128;130;130 23:09:50 INFO - 2015-11-09 23:09:50,506 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;176;154;183;198;156;173;174;158;198;152 23:09:50 INFO - 2015-11-09 23:09:50,507 DEBUG : BROWSER_OUTPUT: |2;audio-dft;187;193;210;202;193;195;191;187;198;195 23:09:50 INFO - 2015-11-09 23:09:50,507 DEBUG : BROWSER_OUTPUT: |3;audio-fft;78;86;91;133;82;80;84;85;133;77 23:09:50 INFO - 2015-11-09 23:09:50,507 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;99;152;107;108;107;147;104;105;149 23:09:50 INFO - 2015-11-09 23:09:50,507 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;143;136;143;143;141;137;143;144;137;143 23:09:50 INFO - 2015-11-09 23:09:50,507 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;150;149;156;152;149;150;149;149;157;152 23:09:50 INFO - 2015-11-09 23:09:50,507 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;122;130;127;129;121;121;125;125;128;122 23:09:50 INFO - 2015-11-09 23:09:50,507 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;66;68;71;73;72;72;73;72;72;73 23:09:50 INFO - 2015-11-09 23:09:50,507 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;72;75;79;80;79;80;83;83;82;79 23:09:50 INFO - 2015-11-09 23:09:50,507 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;98;102;107;106;108;105;103;102;113;108 23:09:50 INFO - 2015-11-09 23:09:50,507 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;148;153;154;153;155;163;156;149;157;153 23:09:50 INFO - 2015-11-09 23:09:50,507 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;185;187;187;187;187;177;194;192;186;172 23:09:50 INFO - 2015-11-09 23:09:50,508 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;79;86;87;89;85;88;90;91;92;88 23:09:50 INFO - 2015-11-09 23:09:50,508 DEBUG : BROWSER_OUTPUT: __end_tp_report 23:09:50 INFO - 2015-11-09 23:09:50,508 DEBUG : BROWSER_OUTPUT: __start_cc_report 23:09:50 INFO - 2015-11-09 23:09:50,508 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,734 23:09:50 INFO - 2015-11-09 23:09:50,508 DEBUG : BROWSER_OUTPUT: __end_cc_report 23:09:50 INFO - 2015-11-09 23:09:50,508 DEBUG : BROWSER_OUTPUT: __startTimestamp1447139390503__endTimestamp 23:09:50 INFO - 2015-11-09 23:09:50,508 DEBUG : BROWSER_OUTPUT: 23:09:50 INFO - 2015-11-09 23:09:50,510 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 23:09:50 INFO - 2015-11-09 23:09:50,510 DEBUG : BROWSER_OUTPUT: Number of tests: 14 23:09:50 INFO - 2015-11-09 23:09:50,510 DEBUG : BROWSER_OUTPUT: 23:09:50 INFO - 2015-11-09 23:09:50,510 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:129.70 Median:129.50 stddev:7.18 (5.5%) stddev-sans-first:7.41 23:09:50 INFO - 2015-11-09 23:09:50,510 DEBUG : BROWSER_OUTPUT: Values: 125.0 117.0 128.0 129.0 136.0 145.0 129.0 128.0 130.0 130.0 23:09:50 INFO - 2015-11-09 23:09:50,511 DEBUG : BROWSER_OUTPUT: 23:09:50 INFO - 2015-11-09 23:09:50,511 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:172.20 Median:175.00 stddev:17.22 (9.8%) stddev-sans-first:18.21 23:09:50 INFO - 2015-11-09 23:09:50,511 DEBUG : BROWSER_OUTPUT: Values: 176.0 154.0 183.0 198.0 156.0 173.0 174.0 158.0 198.0 152.0 23:09:50 INFO - 2015-11-09 23:09:50,511 DEBUG : BROWSER_OUTPUT: 23:09:50 INFO - 2015-11-09 23:09:50,511 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:195.10 Median:195.00 stddev:6.95 (3.6%) stddev-sans-first:6.73 23:09:50 INFO - 2015-11-09 23:09:50,511 DEBUG : BROWSER_OUTPUT: Values: 187.0 193.0 210.0 202.0 193.0 195.0 191.0 187.0 198.0 195.0 23:09:50 INFO - 2015-11-09 23:09:50,511 DEBUG : BROWSER_OUTPUT: 23:09:50 INFO - 2015-11-09 23:09:50,512 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:92.90 Median:83.00 stddev:21.52 (25.9%) stddev-sans-first:22.14 23:09:50 INFO - 2015-11-09 23:09:50,512 DEBUG : BROWSER_OUTPUT: Values: 78.0 86.0 91.0 133.0 82.0 80.0 84.0 85.0 133.0 77.0 23:09:50 INFO - 2015-11-09 23:09:50,512 DEBUG : BROWSER_OUTPUT: 23:09:50 INFO - 2015-11-09 23:09:50,512 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:117.20 Median:148.00 stddev:22.60 (15.3%) stddev-sans-first:22.35 23:09:50 INFO - 2015-11-09 23:09:50,512 DEBUG : BROWSER_OUTPUT: Values: 94.0 99.0 152.0 107.0 108.0 107.0 147.0 104.0 105.0 149.0 23:09:50 INFO - 2015-11-09 23:09:50,512 DEBUG : BROWSER_OUTPUT: 23:09:50 INFO - 2015-11-09 23:09:50,512 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:141.00 Median:143.00 stddev:3.09 (2.2%) stddev-sans-first:3.19 23:09:50 INFO - 2015-11-09 23:09:50,513 DEBUG : BROWSER_OUTPUT: Values: 143.0 136.0 143.0 143.0 141.0 137.0 143.0 144.0 137.0 143.0 23:09:50 INFO - 2015-11-09 23:09:50,513 DEBUG : BROWSER_OUTPUT: 23:09:50 INFO - 2015-11-09 23:09:50,513 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:151.30 Median:151.00 stddev:2.98 (2.0%) stddev-sans-first:3.13 23:09:50 INFO - 2015-11-09 23:09:50,513 DEBUG : BROWSER_OUTPUT: Values: 150.0 149.0 156.0 152.0 149.0 150.0 149.0 149.0 157.0 152.0 23:09:50 INFO - 2015-11-09 23:09:50,513 DEBUG : BROWSER_OUTPUT: 23:09:50 INFO - 2015-11-09 23:09:50,515 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:125.00 Median:126.00 stddev:3.40 (2.7%) stddev-sans-first:3.43 23:09:50 INFO - 2015-11-09 23:09:50,515 DEBUG : BROWSER_OUTPUT: Values: 122.0 130.0 127.0 129.0 121.0 121.0 125.0 125.0 128.0 122.0 23:09:50 INFO - 2015-11-09 23:09:50,515 DEBUG : BROWSER_OUTPUT: 23:09:50 INFO - 2015-11-09 23:09:50,515 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.20 Median:72.00 stddev:2.35 (3.3%) stddev-sans-first:1.56 23:09:50 INFO - 2015-11-09 23:09:50,515 DEBUG : BROWSER_OUTPUT: Values: 66.0 68.0 71.0 73.0 72.0 72.0 73.0 72.0 72.0 73.0 23:09:50 INFO - 2015-11-09 23:09:50,515 DEBUG : BROWSER_OUTPUT: 23:09:50 INFO - 2015-11-09 23:09:50,515 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:79.20 Median:80.00 stddev:3.46 (4.3%) stddev-sans-first:2.50 23:09:50 INFO - 2015-11-09 23:09:50,516 DEBUG : BROWSER_OUTPUT: Values: 72.0 75.0 79.0 80.0 79.0 80.0 83.0 83.0 82.0 79.0 23:09:50 INFO - 2015-11-09 23:09:50,516 DEBUG : BROWSER_OUTPUT: 23:09:50 INFO - 2015-11-09 23:09:50,516 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:105.20 Median:107.50 stddev:4.18 (3.9%) stddev-sans-first:3.54 23:09:50 INFO - 2015-11-09 23:09:50,516 DEBUG : BROWSER_OUTPUT: Values: 98.0 102.0 107.0 106.0 108.0 105.0 103.0 102.0 113.0 108.0 23:09:50 INFO - 2015-11-09 23:09:50,516 DEBUG : BROWSER_OUTPUT: 23:09:50 INFO - 2015-11-09 23:09:50,516 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:154.10 Median:154.50 stddev:4.20 (2.7%) stddev-sans-first:3.83 23:09:50 INFO - 2015-11-09 23:09:50,516 DEBUG : BROWSER_OUTPUT: Values: 148.0 153.0 154.0 153.0 155.0 163.0 156.0 149.0 157.0 153.0 23:09:50 INFO - 2015-11-09 23:09:50,517 DEBUG : BROWSER_OUTPUT: 23:09:50 INFO - 2015-11-09 23:09:50,517 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.40 Median:187.00 stddev:6.48 (3.5%) stddev-sans-first:6.88 23:09:50 INFO - 2015-11-09 23:09:50,517 DEBUG : BROWSER_OUTPUT: Values: 185.0 187.0 187.0 187.0 187.0 177.0 194.0 192.0 186.0 172.0 23:09:50 INFO - 2015-11-09 23:09:50,517 DEBUG : BROWSER_OUTPUT: 23:09:50 INFO - 2015-11-09 23:09:50,517 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:87.50 Median:88.50 stddev:3.69 (4.2%) stddev-sans-first:2.30 23:09:50 INFO - 2015-11-09 23:09:50,517 DEBUG : BROWSER_OUTPUT: Values: 79.0 86.0 87.0 89.0 85.0 88.0 90.0 91.0 92.0 88.0 23:09:50 INFO - 2015-11-09 23:09:50,517 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 23:09:50 INFO - 2015-11-09 23:09:50,517 DEBUG : BROWSER_OUTPUT: 23:09:51 INFO - 2015-11-09 23:09:51,228 INFO : Browser exited with error code: 0 23:09:51 INFO - 2015-11-09 23:09:51,282 INFO : Completed test kraken (00:01:02) 23:09:51 INFO - 2015-11-09 23:09:51,282 INFO : Starting test v8_7 23:09:51 INFO - 2015-11-09 23:09:51,282 DEBUG : operating with platform_type : mac_ 23:09:51 INFO - 2015-11-09 23:09:51,282 INFO : Initialising browser for v8_7 test... 23:09:51 INFO - 2015-11-09 23:09:51,296 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/tmpJ6vNJ8/profile http://localhost:49656/getInfo.html 23:09:54 INFO - 2015-11-09 23:09:54,568 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 23:09:54 INFO - 2015-11-09 23:09:54,568 DEBUG : BROWSER_OUTPUT: colorDepth:24 23:09:54 INFO - 2015-11-09 23:09:54,568 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 23:09:54 INFO - 2015-11-09 23:09:54,569 DEBUG : BROWSER_OUTPUT: __metrics 23:09:55 INFO - 2015-11-09 23:09:55,211 INFO : Browser initialized. 23:09:55 INFO - 2015-11-09 23:09:55,211 INFO : Running cycle 1/1 for v8_7 test... 23:09:55 INFO - 2015-11-09 23:09:55,211 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/tmpJ6vNJ8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 23:10:07 INFO - 2015-11-09 23:10:07,490 DEBUG : BROWSER_OUTPUT: RSS: Main: 240873472 23:10:07 INFO - 2015-11-09 23:10:07,490 DEBUG : BROWSER_OUTPUT: 23:10:30 INFO - 2015-11-09 23:10:30,064 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49656/tests/v8_7/run.html (next: http://localhost:49656/tests/v8_7/run.html) 23:10:30 INFO - 2015-11-09 23:10:30,323 DEBUG : BROWSER_OUTPUT: RSS: Main: 261201920 23:10:30 INFO - 2015-11-09 23:10:30,323 DEBUG : BROWSER_OUTPUT: 23:10:30 INFO - 2015-11-09 23:10:30,323 DEBUG : BROWSER_OUTPUT: __start_tp_report 23:10:30 INFO - 2015-11-09 23:10:30,323 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 23:10:30 INFO - 2015-11-09 23:10:30,324 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 23:10:30 INFO - 2015-11-09 23:10:30,324 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 23:10:30 INFO - 2015-11-09 23:10:30,324 DEBUG : BROWSER_OUTPUT: |0;Richards;189.32222642938282 23:10:30 INFO - 2015-11-09 23:10:30,324 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;226.75736961451247 23:10:30 INFO - 2015-11-09 23:10:30,324 DEBUG : BROWSER_OUTPUT: |2;Encrypt;365.36353671903544 23:10:30 INFO - 2015-11-09 23:10:30,324 DEBUG : BROWSER_OUTPUT: |3;Decrypt;7548.872180451128 23:10:30 INFO - 2015-11-09 23:10:30,324 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1284.9807445442875 23:10:30 INFO - 2015-11-09 23:10:30,324 DEBUG : BROWSER_OUTPUT: |5;Earley;888.0994671403197 23:10:30 INFO - 2015-11-09 23:10:30,324 DEBUG : BROWSER_OUTPUT: |6;Boyer;15149.253731343284 23:10:30 INFO - 2015-11-09 23:10:30,325 DEBUG : BROWSER_OUTPUT: |7;RegExp;33262.29508196721 23:10:30 INFO - 2015-11-09 23:10:30,325 DEBUG : BROWSER_OUTPUT: |8;Splay;881.8342151675485 23:10:30 INFO - 2015-11-09 23:10:30,325 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6585.526315789473 23:10:30 INFO - 2015-11-09 23:10:30,325 DEBUG : BROWSER_OUTPUT: __end_tp_report 23:10:30 INFO - 2015-11-09 23:10:30,325 DEBUG : BROWSER_OUTPUT: __startTimestamp1447139430318__endTimestamp 23:10:30 INFO - 2015-11-09 23:10:30,325 DEBUG : BROWSER_OUTPUT: 23:10:30 INFO - 2015-11-09 23:10:30,325 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 23:10:30 INFO - 2015-11-09 23:10:30,325 DEBUG : BROWSER_OUTPUT: Number of tests: 10 23:10:30 INFO - 2015-11-09 23:10:30,326 DEBUG : BROWSER_OUTPUT: 23:10:30 INFO - 2015-11-09 23:10:30,326 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:189.32 Median:189.32 stddev:0.00 (0.0%) 23:10:30 INFO - 2015-11-09 23:10:30,326 DEBUG : BROWSER_OUTPUT: Values: 189.3 23:10:30 INFO - 2015-11-09 23:10:30,326 DEBUG : BROWSER_OUTPUT: 23:10:30 INFO - 2015-11-09 23:10:30,326 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:226.76 Median:226.76 stddev:0.00 (0.0%) 23:10:30 INFO - 2015-11-09 23:10:30,326 DEBUG : BROWSER_OUTPUT: Values: 226.8 23:10:30 INFO - 2015-11-09 23:10:30,326 DEBUG : BROWSER_OUTPUT: 23:10:30 INFO - 2015-11-09 23:10:30,326 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:365.36 Median:365.36 stddev:0.00 (0.0%) 23:10:30 INFO - 2015-11-09 23:10:30,326 DEBUG : BROWSER_OUTPUT: Values: 365.4 23:10:30 INFO - 2015-11-09 23:10:30,327 DEBUG : BROWSER_OUTPUT: 23:10:30 INFO - 2015-11-09 23:10:30,327 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:7548.87 Median:7548.87 stddev:0.00 (0.0%) 23:10:30 INFO - 2015-11-09 23:10:30,327 DEBUG : BROWSER_OUTPUT: Values: 7548.9 23:10:30 INFO - 2015-11-09 23:10:30,327 DEBUG : BROWSER_OUTPUT: 23:10:30 INFO - 2015-11-09 23:10:30,327 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1284.98 Median:1284.98 stddev:0.00 (0.0%) 23:10:30 INFO - 2015-11-09 23:10:30,327 DEBUG : BROWSER_OUTPUT: Values: 1285.0 23:10:30 INFO - 2015-11-09 23:10:30,327 DEBUG : BROWSER_OUTPUT: 23:10:30 INFO - 2015-11-09 23:10:30,327 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:888.10 Median:888.10 stddev:0.00 (0.0%) 23:10:30 INFO - 2015-11-09 23:10:30,327 DEBUG : BROWSER_OUTPUT: Values: 888.1 23:10:30 INFO - 2015-11-09 23:10:30,328 DEBUG : BROWSER_OUTPUT: 23:10:30 INFO - 2015-11-09 23:10:30,328 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:15149.25 Median:15149.25 stddev:0.00 (0.0%) 23:10:30 INFO - 2015-11-09 23:10:30,328 DEBUG : BROWSER_OUTPUT: Values: 15149.3 23:10:30 INFO - 2015-11-09 23:10:30,328 DEBUG : BROWSER_OUTPUT: 23:10:30 INFO - 2015-11-09 23:10:30,328 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:33262.30 Median:33262.30 stddev:0.00 (0.0%) 23:10:30 INFO - 2015-11-09 23:10:30,328 DEBUG : BROWSER_OUTPUT: Values: 33262.3 23:10:30 INFO - 2015-11-09 23:10:30,328 DEBUG : BROWSER_OUTPUT: 23:10:30 INFO - 2015-11-09 23:10:30,329 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:881.83 Median:881.83 stddev:0.00 (0.0%) 23:10:30 INFO - 2015-11-09 23:10:30,329 DEBUG : BROWSER_OUTPUT: Values: 881.8 23:10:30 INFO - 2015-11-09 23:10:30,329 DEBUG : BROWSER_OUTPUT: 23:10:30 INFO - 2015-11-09 23:10:30,329 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6585.53 Median:6585.53 stddev:0.00 (0.0%) 23:10:30 INFO - 2015-11-09 23:10:30,329 DEBUG : BROWSER_OUTPUT: Values: 6585.5 23:10:30 INFO - 2015-11-09 23:10:30,329 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 23:10:30 INFO - 2015-11-09 23:10:30,329 DEBUG : BROWSER_OUTPUT: 23:10:31 INFO - 2015-11-09 23:10:31,011 INFO : Browser exited with error code: 0 23:10:31 INFO - 2015-11-09 23:10:31,034 INFO : Completed test v8_7 (00:00:39) 23:10:31 INFO - 2015-11-09 23:10:31,277 INFO : Completed test suite (00:20:13) 23:10:31 INFO - 2015-11-09 23:10:31,277 DEBUG : Working with test: dromaeo_css 23:10:31 INFO - 2015-11-09 23:10:31,277 DEBUG : Generating results file: dromaeo_css 23:10:31 INFO - 2015-11-09 23:10:31,278 DEBUG : Working with test: kraken 23:10:31 INFO - 2015-11-09 23:10:31,278 DEBUG : Generating results file: kraken 23:10:31 INFO - 2015-11-09 23:10:31,278 INFO : javascript benchmark 23:10:31 INFO - 2015-11-09 23:10:31,278 DEBUG : Working with test: v8_7 23:10:31 INFO - 2015-11-09 23:10:31,279 DEBUG : Generating results file: v8_7 23:10:31 INFO - 2015-11-09 23:10:31,279 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:10:31 INFO - 2015-11-09 23:10:31,411 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,57]] 23:10:31 INFO - 2015-11-09 23:10:31,411 DEBUG : process_Request line: dromaeo_css 5785.37 graph.html#tests=[[72,63,57]] 23:10:31 INFO - 2015-11-09 23:10:31,411 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:10:31 INFO - 2015-11-09 23:10:31,513 DEBUG : process_Request line: kraken 1807.00 graph.html#tests=[[232,63,57]] 23:10:31 INFO - 2015-11-09 23:10:31,513 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:10:31 INFO - 2015-11-09 23:10:31,636 DEBUG : process_Request line: v8_7 16611.18 graph.html#tests=[[230,63,57]] 23:10:31 INFO - 2015-11-09 23:10:31,637 INFO : javascript benchmark 23:10:31 INFO - 2015-11-09 23:10:31,639 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [292.55239483590117, 296.3923955890424, 297.1560767420525, 298.19784778944637, 303.9452898478273, 12614.180078294905, 13067.73864522709, 14779.704405911876, 14877.553673389802, 15508.53474395767, 15335.079895206296, 15498.225088745574, 16196.109213993226, 16205.918970405131, 16456.588585285375, 4614.4462664480225, 4754.690945088575, 4776.567029891036, 4787.8324258650955, 4803.687760295587, 3940.074082590603, 4103.281925662997, 4109.116539943911, 4151.398047283142, 4744.857654270378, 4020.457238272825, 4022.2558826617023, 4039.9798001009954, 4068.572799856017, 4070.206309769596, 4165.27107756143, 4226.873193804176, 4228.873133805975, 4257.19113368459, 4274.957250427487, 3538.5222994895616, 3556.5732112146707, 3564.091156755037, 3568.9293212036287, 3578.6779189873037, 11070.28043177191, 11200.439978001068, 11336.886631133748, 11338.659840204724, 11475.081993440504, 1606.598350412397, 1655.081429806457, 1681.495551334607, 1743.7733094697735, 1771.3888708395582, 8177.877331840027, 8360.58197090143, 8360.58197090143, 8366.24703776663, 8381.832363352698, 1332.6734949937327, 1342.3757952552012, 1350.0617071135466, 1355.335885416139, 1448.66680663448, 48462.0, 50324.74837625825, 50441.495585044046, 50745.0, 51125.23312150358, 5562.249096372019, 5563.638363506359, 5588.636738611977, 5627.662340259598, 5634.098544232903, 6402.967985160044, 6407.519436042222, 6408.1669382980845, 6414.743410263631, 6472.967635161888, 4558.088382323548, 4603.677742558056, 4605.125026245069, 4616.3537104805355, 4623.976880115578, 4795.376601041912, 4807.519248075235, 4808.447028591687, 4824.276358546246, 4825.1555977703765, 2521.6343630173524, 2549.247971848309, 2559.590465525507, 2568.345072006664, 2580.909668161605, 904.5296445848122, 907.981840363189, 916.3722849847876, 923.2106548900593, 942.5617088054088, 354.1588726773912, 383.46123696206877, 390.0424457955712, 393.15079428434444, 409.0203961512162, 9449.196818270386, 9835.016498350107, 9842.704718858302, 9875.753106172404, 9925.255605829592, 384.2085304273206, 386.6809881847487, 389.4080996884776, 398.9002749312672, 400.4453831443472, 5450.91823622646, 5516.062269414209, 5521.475459831309, 5533.667979921218, 5535.778568857281, 460148.0, 462112.0, 479940.0, 512148.0, 513222.0, 55621.72189139028, 57627.13559296614, 57703.0, 58665.0, 58895.70552147298, 416.79993603070693, 439.28615999001624, 439.7735166389312, 439.9164158809816, 441.73937376947754, 9319.16127548524, 9415.293852960918, 9515.238780897373, 9546.379485333431, 9614.278929080487, 29018.7098129016, 29109.41781164407, 29214.70785292205, 29460.852695736383, 29479.0, 38663.806680966416, 39190.608093918694, 39302.6069739299, 39360.80319598383, 42660.0, 5176.948230517647, 5420.566354691537, 5428.050091233939, 5446.564274857923, 5454.372747134131, 8462.449940753831, 9216.815663686823, 10023.498825058863, 10314.535845886803, 10335.793284134426, 8535.701250456204, 8705.608247628745, 8718.738437846874, 8800.91199088001, 8886.73339799807, 8283.502989820388, 8369.832603347777, 8373.74878753614, 8426.4944103354, 8658.0, 7785.961070194613, 8741.519216443157, 9108.180263776292, 9204.539773011189, 9258.166764991183, 5324.36107667067, 5432.2123292123215, 5443.401225865073, 5466.098093814635, 5494.752736126804, 8830.896137982752, 8899.065598112105, 8928.642854285756, 8948.955255223942, 9061.320400969822], "dojo.html": [2690.6098615700726, 2773.639426874506, 2795.6784969728487, 2812.1985234208255, 2834.0647586296536, 4665.066986602685, 4724.3622111015, 4776.641751868607, 4808.855734327967, 4887.41351037875, 4541.841035563756, 4650.511696271894, 4675.953240467595, 4678.345031695565, 4760.976195119019, 4422.181896349178, 4454.443194600675, 4473.932891006638, 4494.617957473619, 4537.0925814837, 94.18355396136641, 4523.163214805255, 4548.454185497745, 4679.298105284201, 4691.671582989192, 4520.886977825548, 4561.7262964222255, 4567.36056952027, 4590.104929538741, 4598.333241679954, 4536.115457485792, 4556.111558246143, 4562.680612357136, 4565.429321334833, 4587.816487340502, 4367.388565600819, 4421.6904816662845, 4507.594316511497, 4541.318802179667, 4614.007988282502, 4571.748553829538, 4689.976550117228, 4712.717236965793, 4730.290456431529, 4763.166445871959, 5093.312402825608, 5106.183010718267, 5145.716985565792, 5191.325127733408, 5196.818111366084, 4972.602191824645, 5104.591632669415, 5113.7443127843835, 5206.76569554371, 5233.4243233244315, 4770.379850619397, 4777.8088876445245, 4787.234042553175, 4789.114013907403, 4915.066137433876, 4967.528084831935, 5179.870503237374, 5230.0, 5235.188545775411, 5240.68555886648, 4830.66185367028, 4932.309476673268, 4939.703617782944, 4945.678530895552, 4999.950000500021, 5147.897042059138, 5150.150225212873, 5154.226865970059, 5180.792768289301, 5181.663191892515, 4959.2065269557415, 5038.420581633086, 5048.1418158913075, 5057.949420505822, 5067.163917953497, 4926.75366231687, 4965.404151501771, 4979.029089327546, 4980.12847751642, 4995.725235112031, 4015.19696060789, 4015.7992100394863, 4019.0957034666967, 4021.2158629067053, 4074.0, 3477.1654802847133, 3494.965050349515, 3602.9099272517874, 3623.148560088377, 3669.8532058717888, 4786.928196077061, 4808.230683090689, 4819.3012013257885, 4824.0, 4849.781759820817, 5135.537801597874, 5139.12634852076, 5148.253503242084, 5170.741462926839, 5173.611979101583, 4659.487456379796, 4780.043991201704, 4791.161546729309, 4861.9027619447415, 4879.707217566957, 4510.255807791743, 4512.571305725951, 4566.20091483989, 4586.082783443325, 4610.4467463903875, 5315.3090098286975, 5318.042752304622, 5321.122014867504, 5363.088274993261, 5371.973140134274, 5033.295338652665, 5051.570616497639, 5110.335656364798, 5128.7179205144075, 5177.378714554277, 5262.763175657181, 5326.0, 5352.0366334060245, 5363.19552067193, 5428.37573679032, 4914.385701787277, 5074.5686616637995, 5109.79560817578, 5141.28022076917, 5163.483651634957, 5025.623078269217, 5084.5932325414615, 5097.796088156432, 5113.335266415343, 5161.0, 4974.353334066548, 5030.220315851049, 5061.0, 5093.108705976365, 5095.796168153232, 4764.237721964469, 4927.482614325444, 5012.624053195952, 5044.646874718735, 5065.265536497113, 4746.620270378292, 4790.664653474223, 4797.328374027708, 4804.615630749601, 4850.417949846041, 4888.315635810918, 5039.924401134059, 5042.949570504248, 5071.112555302881, 5096.43939166684, 4717.363155974037, 4806.831760888352, 4812.807487700453, 4906.95093049065, 4984.7258400788305], "mootools.html": [1457.6793105516797, 1507.9547613571592, 1567.4278888205802, 1574.7244232259352, 1584.4058478070726, 6467.417932386084, 6518.967405162967, 6769.627670478122, 7188.928110718898, 7293.562386256822, 6719.899201511981, 6723.260441351447, 6878.484113691468, 6911.516193866431, 6921.0, 1885.1422602715732, 1891.9905400473012, 1897.0704354866086, 1924.0764433072134, 1930.5945751392223, 1949.0839305526451, 1963.9312624058161, 1968.5177131602777, 2020.171729590868, 2030.2893987104544, 1944.9902750486228, 1949.541857663448, 1954.8338391236762, 1974.6149500847341, 1975.0914579293542, 1874.184729642603, 1913.3590247267252, 1915.817997290255, 1916.3771774173379, 1926.5087402712359, 1941.175000624729, 1966.7738210105879, 1981.1184023109722, 1982.6926826341796, 1995.6906679464705, 6979.860402791966, 7070.186928503236, 7075.787726368218, 7078.681459334342, 7105.964470177668, 4207.978960105211, 4276.102018576103, 4288.24955632763, 4299.946513104278, 4316.0504688968695, 2275.9544809103727, 2359.1978727232654, 2427.781499665021, 2503.5368456835545, 2515.559777039011, 816.7141500474846, 837.3259526081501, 838.0237023867248, 842.9968337678143, 858.5664239558982, 8881.866771998426, 8908.420952638122, 8943.284537237005, 8948.686795962176, 9078.77303067422, 3803.7717736935874, 3870.4774855394726, 3945.684345252373, 3946.131850992777, 3995.260876737813, 8164.918350816534, 8187.5087494750505, 8191.918080819235, 8200.179982001871, 8219.794505137419, 4346.847860324937, 4360.236958532244, 4360.345948107809, 4369.563043695605, 4375.409319741794, 3922.6077392260545, 3958.9010274742786, 3965.6629186518894, 3975.0857302820514, 3975.7018223633345, 3218.275887925245, 3315.5192497087787, 3330.916727081794, 3332.5501057356946, 3341.348437054751, 1077.4074259157433, 1090.841827934945, 1095.6329629574182, 1098.8626421697288, 1116.2242241641982, 893.5666201892077, 914.6752902719438, 917.0783362720423, 946.6970569417721, 1184.419634379148, 6653.1018312527185, 6655.23464801554, 6681.599104053772, 6702.296258892844, 6752.561083529555, 409.0754893939658, 409.5065446137397, 412.4411422522499, 424.1114864359163, 424.99276714187573, 5164.302819119446, 5235.73821308933, 5240.266362709223, 5242.18746094356, 5275.182346736262, 7267.854642907112, 8237.217464340878, 8351.8329633407, 8365.8326833463, 8383.916160838435, 8269.09040005599, 8322.0, 8338.499690018618, 8351.707690230813, 8392.622331995075, 6526.314736952647, 6593.351662084478, 6662.900056499157, 6663.600183988976, 6688.0, 6401.743930242738, 6403.135576697086, 6404.551681382259, 6416.294207637063, 6432.614043157426, 7306.123265208209, 7389.704411823682, 7571.242875712384, 7581.3176814087, 7611.695532178873, 7571.091469023752, 7723.459357845121, 7760.107587627495, 7767.4562780607075, 7804.375649947877, 6067.787627433018, 6179.969100154471, 6183.196184495987, 6187.257529096537, 6223.719932602953, 6608.339166083546, 6746.966265168643, 6768.56004359715, 6780.288069752605, 6784.59292442455, 6282.528810339151, 6331.841703957438, 6339.270983836917, 6415.582987105823, 6454.386833250834, 6169.876602468015, 6228.22147231596, 6288.779892703734, 6307.810765677037, 6335.176427064452, 5843.678597676999, 6072.1498990140535, 6074.757009719562, 6074.878502429839, 6127.754889804358, 5675.829725108253, 5707.058335374617, 5728.083506638918, 5733.483986441241, 5747.224124743107, 5720.313562372542, 5753.1945527627, 5767.913481297868, 5768.573508943135, 5840.1531777892815], "ext.html": [476.60203729885563, 489.9289603007564, 492.96477397465327, 505.53238254614485, 526.7339993303381, 33362.16594585134, 35235.82382088086, 35386.46920296195, 35470.64529354709, 35514.2897142057, 36682.449763253506, 37294.25411491768, 37535.62464375355, 37591.624083759154, 37624.0, 7845.529268243909, 8001.199880011981, 8039.397045221603, 8068.314193293577, 8072.55600941948, 7805.4536182467255, 7921.207879212062, 7952.403569732264, 7985.081715602722, 8026.678932842679, 7894.763157105296, 8004.0, 8018.077921039067, 8027.197280271956, 8031.799205019863, 7996.600169991477, 8051.0741264754715, 8077.394195435366, 8091.069527004411, 8092.635831387602, 7922.524648521049, 7932.365410767183, 7933.0, 7952.125266220711, 7963.562004089773, 34320.0, 34727.6527234727, 34819.30361392758, 34843.82578087093, 34887.0, 2247.3033359658393, 2357.1988892578534, 2412.2401443545227, 2620.7641312281985, 2702.2298644886114, 25141.37146571332, 25392.873035634704, 25794.871025644752, 26038.73961260401, 26701.0, 2135.903884325209, 2139.8074173324476, 2153.0, 2153.547754971458, 2179.204590324536, 232005.0, 234543.8272808642, 236375.0, 237637.0, 238935.0, 52966.0, 53313.2003019955, 53347.466525335025, 53741.1938820918, 53793.1931021035, 52345.429637110945, 53373.46626533763, 57060.42939570551, 58217.0, 58296.417035829945, 11484.310941343547, 11506.942465287788, 11510.597129100608, 11514.0, 11677.357745324089, 9292.488913109844, 9392.765180870396, 9406.764830879283, 9409.858852117224, 9412.764680883032, 17335.82664173342, 17474.291484819874, 17775.55561110957, 17925.820741792675, 18001.54996125081, 7663.693452261959, 7950.284474397332, 7953.801154971056, 7959.243871832166, 7976.401769867283, 833.954132522705, 837.6356285015916, 861.3410740783306, 863.9870401943975, 873.1966590736538, 24353.512929741308, 24480.755192448203, 24529.38676533065, 24736.876315618665, 24760.13339533108, 925.6852670092201, 940.1209868772719, 964.6671898195111, 1012.0436187802603, 1025.707673313102, 12631.305278209604, 12828.871711282954, 12889.806652900214, 12891.613251602466, 12898.935505322414, 271559.0, 274704.0, 275252.0, 276175.0, 277480.0, 46463.0, 46598.0, 46639.76680116646, 46704.0, 47359.5264047362, 1072.2762135558623, 1220.7680540697238, 1225.957091501811, 1226.4603574427224, 1228.588422878328, 23732.406689832893, 23847.403814904766, 24077.638835417834, 25719.614205787304, 27646.170614881587, 44942.10115797731, 45168.09663806771, 45198.93209611019, 45232.77383613061, 45241.54758452505, 237451.0, 238283.0, 240388.0, 241008.0, 241772.0, 36413.63586364102, 37866.40269174424, 39427.80286098551, 39495.605043950345, 39670.40494392644, 36963.07592310214, 37323.81338093292, 37334.25331493409, 37348.62651373452, 37351.626483735905, 30651.54022689617, 31958.84020579882, 31991.840040800576, 32052.19869503281, 32075.518867216542, 30520.084397468112, 30739.385212295183, 30979.907510763365, 31135.37729245357, 31358.216044599067, 31381.0, 31573.0, 32106.35787284288, 32121.678783212803, 32159.196020099684, 25862.482750345265, 26035.0, 27341.726582733918, 27401.51969606047, 27512.862435688494, 21145.25991590287, 21191.152353905672, 21382.679259811426, 21528.138874444845, 21680.457988550414], "prototype.html": [271.1431875274134, 275.7518233589769, 276.21279353841567, 278.2223684800981, 280.53431304035297, 5126.487351264872, 5430.212619170218, 5543.861403464915, 5552.472515111058, 5602.579806514513, 5232.0, 5371.086915224411, 5374.274472946151, 5388.0, 5394.946050539494, 4127.215828992496, 4190.245755763961, 4192.454980852485, 4209.9789501052455, 4220.219259436999, 4173.290540608089, 4189.7695626740515, 4193.056562273479, 4193.538710741831, 4203.726757760735, 4048.858289959852, 4130.97934510327, 4141.047559061418, 4147.626713595776, 4264.445622069142, 4199.0342221289275, 4218.367244913272, 4224.640905523003, 4226.239276930151, 4234.047339348653, 3614.4759009943673, 3623.3115708015393, 3623.9275214495824, 3626.673599376069, 3629.963700362989, 5316.494932981399, 5325.094733895247, 5340.092184328673, 5340.866478338034, 5347.278117454132, 4453.487848897385, 4637.747808091796, 4690.7654617269345, 4694.600958918496, 4695.60087392572, 5355.491228333302, 5559.610827242094, 5568.136938774496, 5569.359523654791, 5699.914501282484, 3816.8091595420397, 3817.8281977310808, 3822.827972741233, 3824.8852534424013, 3842.731008829383, 5887.8233652990475, 5890.558208134407, 5921.230240068807, 5924.407559244084, 5940.584159108864, 3809.9047523811573, 3896.376579747227, 3924.941125883114, 3928.5874983126932, 3950.288947989332, 4015.5382131054716, 4023.4166045923175, 4040.959590404117, 4046.0289530512464, 4054.8580799671868, 4643.094596553708, 4655.185342565105, 4677.181493238738, 4691.812327506861, 4711.976440117846, 5715.799947001835, 5716.657000579979, 5725.398833122462, 5761.049426844524, 5772.595918285764, 1356.0778670503955, 1434.6628542292553, 1460.2041887171517, 1460.9415623374946, 1464.2312785787547, 879.1252703559999, 882.7528292078229, 898.5462341517492, 901.8827552418144, 903.0382642485863, 5429.941161473554, 5433.782648694008, 5439.864003399946, 5443.074677304868, 5469.480399362054, 5861.9413805861395, 5868.23712917318, 5892.705364731746, 5897.734601942923, 5914.970425147847, 5380.381256155514, 5410.648307859977, 5416.647917885325, 5423.566114710814, 5524.558035357162, 3208.2139875730595, 3274.0668909361193, 3277.6722327767034, 3287.7534184936226, 3299.785513941586, 6039.54703397247, 6053.303870054912, 6077.36187700294, 6083.6045657032155, 6090.208272924491, 5996.190514280604, 6011.128386384037, 6017.518598512109, 6048.999999999912, 6053.4551890330085, 5848.444397782204, 6041.063635136561, 6085.939140608626, 6131.6321020738005, 6156.753729850935, 5896.469317761422, 5984.8803023940145, 5996.130561068708, 6020.157177995172, 6022.48808851235, 5833.095870140135, 5842.591018628826, 5849.795257166149, 5857.443542863592, 5902.055671092605, 5949.6430214187285, 6073.939260607337, 6180.381961803783, 6186.659733714689, 6189.690515474298, 3795.2409518095938, 3840.9615903840604, 3857.247836671822, 3879.8060096994473, 3890.3775395936514, 5865.648061116347, 5897.705114744332, 5904.439078287556, 5907.793227237026, 5919.852003699942, 5741.3971532988435, 5750.539956803529, 5760.366359700346, 5798.797042103506, 5807.535397168301, 5637.351704554028, 5834.562407819346, 5851.1223316502865, 5858.7070646468355, 5891.05743081105, 5696.829095127153, 5701.800436984686, 5721.256236689203, 5724.914126288026, 5807.506361959281, 5601.523870470893, 5664.85837854057, 5717.113847353667, 5747.770089196552, 5856.970715146567, 5604.383517812956, 5631.943680563306, 5669.34802497718, 5671.858203544944, 5690.174924635988], "yui.html": [566.9036263835147, 583.6527266276564, 602.9638221706696, 670.4870773857999, 681.7273090763695, 11928.463219155137, 12246.877531224685, 12291.754164916707, 12316.261024338535, 12494.250344979308, 11001.339919604829, 11026.503807328669, 11044.3373397596, 11089.390083545422, 12342.444589993449, 766.4175226827596, 769.4383100336757, 780.683823051665, 781.7928249014016, 787.0673252196137, 758.2455456820471, 768.174212721324, 771.8919351290824, 772.0735117858565, 772.3087836386459, 811.8457493076326, 812.8943237379133, 816.3142959913671, 818.9754307370788, 820.6963423533301, 793.2464159048898, 807.2411932783224, 807.9272865442139, 811.5090370325956, 815.1888870573757, 595.8272101090679, 604.939506049396, 605.975900727773, 606.8331208917539, 607.8146165419545, 10980.066694330992, 11006.614768483065, 11015.83476247857, 11016.394098324588, 11037.779244415147, 9469.66856160038, 9774.56014479343, 9850.90149098507, 10105.595776169019, 10231.59073637061, 7789.649465774054, 7843.294103530709, 7957.442978991473, 7990.683866195522, 8029.558374289411, 2875.1949454152873, 2875.52553828618, 2898.9275268118254, 2902.6226590543306, 2946.9263268418244, 36667.26665466676, 38504.422433663516, 40044.19911601781, 42523.57476425258, 42531.7873410631, 7423.44324175689, 7450.701971921171, 7459.925400746031, 7507.924920750723, 7621.894825250308, 16335.509934701979, 16346.427875024317, 16397.42609008679, 16431.096289703943, 16590.336386544644, 5793.420657934173, 5824.796132135355, 5861.150133230658, 6040.124181993674, 6090.908636370458, 3086.3518661081425, 3135.4179643702505, 3141.701538353853, 3194.425003499346, 3247.7401807855313, 2518.1690042286, 2554.5657238269537, 2558.7952963762855, 2561.6285638582303, 2562.7437256274598, 382.277495533442, 387.42660861923946, 393.5238361582517, 396.3638360431466, 398.87236084453275, 359.0485214182385, 450.54720006393364, 499.35084390292474, 510.8978204359143, 526.147640821871, 6254.562180647311, 6475.222973243147, 6497.772577959749, 6703.564268322543, 7272.0, 440.76859648684695, 461.8337398536524, 466.622036150719, 502.813958835226, 525.2961032216848, 3019.5017822059112, 3057.8929737459525, 3091.474449343617, 3116.2988327626103, 3442.5008373785663, 45791.0, 46558.76720616375, 46758.5324146761, 46777.532224678, 47610.76194619074, 42097.579024209976, 42571.0, 42819.0, 42823.143537129086, 42824.78587607042, 35984.820075899974, 37389.25221495555, 38948.80525597354, 39312.6068739309, 40625.0, 6517.0, 6529.7388104475285, 6828.453723702191, 6909.585424874524, 7002.404795592432, 29758.55362169526, 29999.05224144925, 30416.543751844183, 30479.238019049702, 30567.388652226386, 35641.64358356383, 35747.46378804372, 35778.0, 39429.2114157721, 39438.408423874236, 5899.616524925866, 6124.755009799558, 6133.355997620186, 6258.9359808833515, 6423.197100362455, 9327.113924177193, 9370.578323975302, 9458.243340532603, 9509.286803489627, 10139.138173255356, 8444.915550844413, 8707.738767836974, 8801.779955501164, 8812.691555795516, 8846.778830529289, 8698.782530436789, 8842.292616590528, 8866.64533418656, 9021.864672030057, 9029.0, 8604.397692161489, 8680.956595217236, 8713.172248636369, 8744.69393571222, 9158.221551168226, 7451.180370159386, 7601.3918886487845, 7667.578283194255, 7697.422693297913, 7797.298243158143, 7149.857002860018, 7255.274472552703, 7278.308560686726, 7397.667104980396, 7514.624268786648]}, "summary": {"lowerIsBetter": false, "suite": 5785.368507413425, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 5799.864805234864, "unit": "ms", "value": 5799.864805234864}, "dojo.html": {"lowerIsBetter": false, "filtered": 4710.33218845587, "unit": "ms", "value": 4710.33218845587}, "mootools.html": {"lowerIsBetter": false, "filtered": 3889.7860485665688, "unit": "ms", "value": 3889.7860485665688}, "ext.html": {"lowerIsBetter": false, "filtered": 16138.727243926862, "unit": "ms", "value": 16138.727243926862}, "prototype.html": {"lowerIsBetter": false, "filtered": 4288.101016793475, "unit": "ms", "value": 4288.101016793475}, "yui.html": {"lowerIsBetter": false, "filtered": 5098.178841925773, "unit": "ms", "value": 5098.178841925773}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0052.e"}, "testrun": {"date": 1447138217, "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": "20151109213837", "branch": "Mozilla-Inbound", "revision": "3b84d7638278ac102cb20514fe926a3a66a6c6f7"}}, {"talos_counters": {}, "results": {"audio-dft": [187.0, 193.0, 210.0, 202.0, 193.0, 195.0, 191.0, 187.0, 198.0, 195.0], "ai-astar": [125.0, 117.0, 128.0, 129.0, 136.0, 145.0, 129.0, 128.0, 130.0, 130.0], "imaging-gaussian-blur": [143.0, 136.0, 143.0, 143.0, 141.0, 137.0, 143.0, 144.0, 137.0, 143.0], "audio-beat-detection": [176.0, 154.0, 183.0, 198.0, 156.0, 173.0, 174.0, 158.0, 198.0, 152.0], "json-stringify-tinderbox": [72.0, 75.0, 79.0, 80.0, 79.0, 80.0, 83.0, 83.0, 82.0, 79.0], "stanford-crypto-pbkdf2": [185.0, 187.0, 187.0, 187.0, 187.0, 177.0, 194.0, 192.0, 186.0, 172.0], "json-parse-financial": [66.0, 68.0, 71.0, 73.0, 72.0, 72.0, 73.0, 72.0, 72.0, 73.0], "stanford-crypto-sha256-iterative": [79.0, 86.0, 87.0, 89.0, 85.0, 88.0, 90.0, 91.0, 92.0, 88.0], "audio-fft": [78.0, 86.0, 91.0, 133.0, 82.0, 80.0, 84.0, 85.0, 133.0, 77.0], "imaging-darkroom": [150.0, 149.0, 156.0, 152.0, 149.0, 150.0, 149.0, 149.0, 157.0, 152.0], "stanford-crypto-ccm": [148.0, 153.0, 154.0, 153.0, 155.0, 163.0, 156.0, 149.0, 157.0, 153.0], "audio-oscillator": [94.0, 99.0, 152.0, 107.0, 108.0, 107.0, 147.0, 104.0, 105.0, 149.0], "stanford-crypto-aes": [98.0, 102.0, 107.0, 106.0, 108.0, 105.0, 103.0, 102.0, 113.0, 108.0], "imaging-desaturate": [122.0, 130.0, 127.0, 129.0, 121.0, 121.0, 125.0, 125.0, 128.0, 122.0]}, "summary": {"lowerIsBetter": true, "suite": 1807.0000000000002, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 92.9, "unit": "ms", "value": 92.9}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 185.4, "unit": "ms", "value": 185.4}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 172.2, "unit": "ms", "value": 172.2}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 154.1, "unit": "ms", "value": 154.1}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 151.3, "unit": "ms", "value": 151.3}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 71.2, "unit": "ms", "value": 71.2}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 117.2, "unit": "ms", "value": 117.2}, "ai-astar": {"lowerIsBetter": true, "filtered": 129.7, "unit": "ms", "value": 129.7}, "audio-dft": {"lowerIsBetter": true, "filtered": 195.1, "unit": "ms", "value": 195.1}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 87.5, "unit": "ms", "value": 87.5}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 79.2, "unit": "ms", "value": 79.2}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 141.0, "unit": "ms", "value": 141.0}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 105.2, "unit": "ms", "value": 105.2}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 125.0, "unit": "ms", "value": 125.0}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0052.e"}, "testrun": {"date": 1447138217, "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": "20151109213837", "branch": "Mozilla-Inbound", "revision": "3b84d7638278ac102cb20514fe926a3a66a6c6f7"}}, {"talos_counters": {}, "results": {"DeltaBlue": [226.75736961451247], "Encrypt": [365.36353671903544], "NavierStokes": [6585.526315789473], "Decrypt": [7548.872180451128], "Splay": [881.8342151675485], "Richards": [189.32222642938282], "RegExp": [33262.29508196721], "Earley": [888.0994671403197], "Boyer": [15149.253731343284], "RayTrace": [1284.9807445442875]}, "summary": {"lowerIsBetter": false, "suite": 16611.18136660406, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 291.5803799999999, "unit": "score", "value": 291.5803799999999}, "Encrypt": {"lowerIsBetter": false, "filtered": 728.5373970000002, "unit": "score", "value": 728.5373970000002}, "NavierStokes": {"lowerIsBetter": false, "filtered": 225.34265734265745, "unit": "score", "value": 225.34265734265745}, "Decrypt": {"lowerIsBetter": false, "filtered": 35.26102888446218, "unit": "score", "value": 35.26102888446218}, "Splay": {"lowerIsBetter": false, "filtered": 92.41079399999997, "unit": "score", "value": 92.41079399999997}, "RegExp": {"lowerIsBetter": false, "filtered": 27.387917693445036, "unit": "score", "value": 27.387917693445036}, "Richards": {"lowerIsBetter": false, "filtered": 186.46516400000002, "unit": "score", "value": 186.46516400000002}, "Earley": {"lowerIsBetter": false, "filtered": 750.4373380000002, "unit": "score", "value": 750.4373380000002}, "Boyer": {"lowerIsBetter": false, "filtered": 43.99312413793104, "unit": "score", "value": 43.99312413793104}, "RayTrace": {"lowerIsBetter": false, "filtered": 575.8755554445554, "unit": "score", "value": 575.8755554445554}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0052.e"}, "testrun": {"date": 1447138217, "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": "20151109213837", "branch": "Mozilla-Inbound", "revision": "3b84d7638278ac102cb20514fe926a3a66a6c6f7"}}] 23:10:31 INFO - RETURN: dromaeo_css: 5785.37 23:10:31 INFO - RETURN: kraken: 1807.00 23:10:31 INFO - RETURN: v8_7: 16611.18 23:10:31 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,57]]", "result": "16611.18"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,57]]", "result": "1807.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,57]]", "result": "5785.37"}}} 23:10:31 INFO - Return code: 0 23:10:31 INFO - # TBPL SUCCESS # 23:10:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:10:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:10:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:10:31 INFO - 2015-11-09 23:10:31.746 screenresolution[1952:14264] starting screenresolution argv=screenresolution get 23:10:31 INFO - 2015-11-09 23:10:31.749 screenresolution[1952:14264] Display 0: 1600x1200x32@60 23:10:31 INFO - 2015-11-09 23:10:31.755 screenresolution[1953:14267] starting screenresolution argv=screenresolution list 23:10:31 INFO - Available Modes on Display 0 23:10:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:10:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:10:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:10:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:10:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:10:32 INFO - Intel HD Graphics 3000: 23:10:32 INFO - Chipset Model: Intel HD Graphics 3000 23:10:32 INFO - Type: GPU 23:10:32 INFO - Bus: Built-In 23:10:32 INFO - VRAM (Total): 512 MB 23:10:32 INFO - VRAM (Dynamic, Max): 10 23:10:32 INFO - Vendor: Intel (0x8086) 23:10:32 INFO - Device ID: 0x0116 23:10:32 INFO - Revision ID: 0x0009 23:10:32 INFO - Displays: 23:10:32 INFO - Display: 23:10:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:10:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:10:32 INFO - Display Serial Number: 1600x1200 60 23:10:32 INFO - Main Display: Yes 23:10:32 INFO - Mirror: Off 23:10:32 INFO - Online: Yes 23:10:32 INFO - Rotation: Supported 23:10:32 INFO - Return code: 0 23:10:32 INFO - Running post-action listener: _resource_record_post_action 23:10:32 INFO - Running post-run listener: _resource_record_post_run 23:10:33 INFO - Total resource usage - Wall time: 1255s; CPU: 30.0%; Read bytes: 24576; Write bytes: 688230400; Read time: 56; Write time: 64798 23:10:33 INFO - install - Wall time: 40s; CPU: 30.0%; Read bytes: 338463232; Write bytes: 334505984; Read time: 35240; Write time: 6482 23:10:33 INFO - run-tests - Wall time: 1215s; CPU: 30.0%; Read bytes: 24576; Write bytes: 342521856; Read time: 56; Write time: 57600 23:10:33 INFO - Running post-run listener: _upload_blobber_files 23:10:33 INFO - Blob upload gear active. 23:10:33 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 23:10:33 INFO - Copying logs to upload dir... 23:10:33 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1325.008697 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 5 secs) (at 2015-11-09 23:10:33.170730) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-09 23:10:33.174717) ========= 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.iwFIwsLjrd/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.GCPsDKhCxl/Listeners TMPDIR=/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/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/-yQa9VkZTsmsaD1ZXQPBrw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010114 build_url: 'https://queue.taskcluster.net/v1/task/-yQa9VkZTsmsaD1ZXQPBrw/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-09 23:10:33.201189) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 23:10:33.201580) ========= 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.iwFIwsLjrd/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.GCPsDKhCxl/Listeners TMPDIR=/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/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.005646 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 23:10:33.251653) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-09 23:10:33.252011) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-09 23:10:33.252522) ========= ========= Total master_lag: 1.18 =========