builder: mozilla-inbound_yosemite_test-dromaeojs slave: t-yosemite-r5-0032 starttime: 1447782212.73 results: success (0) buildid: 20151117080511 builduid: ff2c6c76a1514bc9afcb0d9106c5e9c0 revision: fe34d01fb2ecb2dd4cda82e788cf7b541d5cbdb4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 09:43:32.727780) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 09:43:32.728332) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 09:43:32.728694) ========= 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.wevk1CWRcm/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.02OtNTM0UO/Listeners TMPDIR=/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/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.006199 basedir: '/builds/slave/test' ========= master_lag: 0.31 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 09:43:33.041071) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 09:43:33.041465) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 09:43:33.063013) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 09:43:33.063582) ========= 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.wevk1CWRcm/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.02OtNTM0UO/Listeners TMPDIR=/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/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.017270 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 09:43:33.114512) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 09:43:33.114920) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 09:43:33.115347) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 09:43:33.115694) ========= 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.wevk1CWRcm/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.02OtNTM0UO/Listeners TMPDIR=/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/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-17 09:43:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.25, 63.245.215.102, ... Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.41G=0s 2015-11-17 09:43:33 (1.41 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.242206 ========= master_lag: 0.34 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 09:43:33.693079) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 09:43:33.693460) ========= 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.wevk1CWRcm/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.02OtNTM0UO/Listeners TMPDIR=/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/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.124387 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 09:43:33.837954) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 09:43:33.838836) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev fe34d01fb2ecb2dd4cda82e788cf7b541d5cbdb4 --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 fe34d01fb2ecb2dd4cda82e788cf7b541d5cbdb4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wevk1CWRcm/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.02OtNTM0UO/Listeners TMPDIR=/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/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-17 09:43:33,921 truncating revision to first 12 chars 2015-11-17 09:43:33,921 Setting DEBUG logging. 2015-11-17 09:43:33,921 attempt 1/10 2015-11-17 09:43:33,921 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/fe34d01fb2ec?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-17 09:43:34,162 unpacking tar archive at: mozilla-inbound-fe34d01fb2ec/testing/mozharness/ program finished with exit code 0 elapsedTime=0.501312 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 09:43:34.359096) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 09:43:34.359687) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 09:43:34.374349) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 09:43:34.374796) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 09:43:34.375408) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 5 secs) (at 2015-11-17 09:43:34.375894) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wevk1CWRcm/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.02OtNTM0UO/Listeners TMPDIR=/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/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 09:43:34 INFO - MultiFileLogger online at 20151117 09:43:34 in /builds/slave/test 09:43:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 09:43:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:43:34 INFO - {'append_to_log': False, 09:43:34 INFO - 'base_work_dir': '/builds/slave/test', 09:43:34 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 09:43:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:43:34 INFO - 'branch': 'Mozilla-Inbound', 09:43:34 INFO - 'buildbot_json_path': 'buildprops.json', 09:43:34 INFO - 'config_files': ('talos/mac_config.py',), 09:43:34 INFO - 'default_actions': ('clobber', 09:43:34 INFO - 'read-buildbot-config', 09:43:34 INFO - 'download-and-extract', 09:43:34 INFO - 'populate-webroot', 09:43:34 INFO - 'create-virtualenv', 09:43:34 INFO - 'install', 09:43:34 INFO - 'run-tests'), 09:43:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:43:34 INFO - 'download_minidump_stackwalk': True, 09:43:34 INFO - 'download_symbols': 'ondemand', 09:43:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:43:34 INFO - 'tooltool.py': '/tools/tooltool.py', 09:43:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:43:34 INFO - '/tools/misc-python/virtualenv.py')}, 09:43:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:43:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:43:34 INFO - 'installer_path': 'installer.exe', 09:43:34 INFO - 'log_level': 'info', 09:43:34 INFO - 'log_name': 'talos', 09:43:34 INFO - 'log_to_console': True, 09:43:34 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:43:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:43:34 INFO - 'opt_config_files': (), 09:43:34 INFO - 'pip_index': False, 09:43:34 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:43:34 INFO - 'cmd': ('bash', 09:43:34 INFO - '-c', 09:43:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:43:34 INFO - 'enabled': True, 09:43:34 INFO - 'halt_on_failure': False, 09:43:34 INFO - 'name': 'check_screen_resolution'},), 09:43:34 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:43:34 INFO - 'cmd': ('bash', 09:43:34 INFO - '-c', 09:43:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:43:34 INFO - 'enabled': True, 09:43:34 INFO - 'halt_on_failure': False, 09:43:34 INFO - 'name': 'check_screen_resolution'},), 09:43:34 INFO - 'run_cmd_checks_enabled': True, 09:43:34 INFO - 'sps_profile': False, 09:43:34 INFO - 'sps_profile_interval': 0, 09:43:34 INFO - 'suite': 'dromaeojs', 09:43:34 INFO - 'system_bits': '64', 09:43:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:43:34 INFO - 'title': 't-yosemite-r5-0032', 09:43:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:43:34 INFO - 'use_talos_json': True, 09:43:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:43:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:43:34 INFO - 'work_dir': 'build'} 09:43:34 INFO - ##### 09:43:34 INFO - ##### Running clobber step. 09:43:34 INFO - ##### 09:43:34 INFO - Running pre-action listener: _resource_record_pre_action 09:43:34 INFO - Running main action method: clobber 09:43:34 INFO - rmtree: /builds/slave/test/build 09:43:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:43:38 INFO - Running post-action listener: _resource_record_post_action 09:43:38 INFO - ##### 09:43:38 INFO - ##### Running read-buildbot-config step. 09:43:38 INFO - ##### 09:43:38 INFO - Running pre-action listener: _resource_record_pre_action 09:43:38 INFO - Running main action method: read_buildbot_config 09:43:38 INFO - Using buildbot properties: 09:43:38 INFO - { 09:43:38 INFO - "properties": { 09:43:38 INFO - "buildnumber": 3338, 09:43:38 INFO - "product": "firefox", 09:43:38 INFO - "script_repo_revision": "production", 09:43:38 INFO - "builddir": "mozilla-inbound_yosemite_test-dromaeojs", 09:43:38 INFO - "repository": "", 09:43:38 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-inbound talos dromaeojs", 09:43:38 INFO - "buildid": "20151117080511", 09:43:38 INFO - "slavename": "t-yosemite-r5-0032", 09:43:38 INFO - "pgo_build": "False", 09:43:38 INFO - "basedir": "/builds/slave/test", 09:43:38 INFO - "project": "", 09:43:38 INFO - "platform": "yosemite", 09:43:38 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 09:43:38 INFO - "slavebuilddir": "test", 09:43:38 INFO - "scheduler": "tests-mozilla-inbound-macosx64-talos", 09:43:38 INFO - "branch": "mozilla-inbound", 09:43:38 INFO - "repo_path": "integration/mozilla-inbound", 09:43:38 INFO - "stage_platform": "macosx64", 09:43:38 INFO - "builduid": "ff2c6c76a1514bc9afcb0d9106c5e9c0", 09:43:38 INFO - "revision": "fe34d01fb2ecb2dd4cda82e788cf7b541d5cbdb4" 09:43:38 INFO - }, 09:43:38 INFO - "sourcestamp": { 09:43:38 INFO - "repository": "", 09:43:38 INFO - "hasPatch": false, 09:43:38 INFO - "project": "", 09:43:38 INFO - "branch": "mozilla-inbound-macosx64-talos", 09:43:38 INFO - "changes": [ 09:43:38 INFO - { 09:43:38 INFO - "category": null, 09:43:38 INFO - "files": [ 09:43:38 INFO - { 09:43:38 INFO - "url": null, 09:43:38 INFO - "name": "https://queue.taskcluster.net/v1/task/pbFhpK7IQh2Jwco9oVW47g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 09:43:38 INFO - } 09:43:38 INFO - ], 09:43:38 INFO - "repository": "", 09:43:38 INFO - "rev": "fe34d01fb2ecb2dd4cda82e788cf7b541d5cbdb4", 09:43:38 INFO - "who": "j.parkouss@gmail.com", 09:43:38 INFO - "when": 1447782173, 09:43:38 INFO - "number": 6672798, 09:43:38 INFO - "comments": "Bug 1222588 - talos should output PERFHERDER_DATA instead of TALOS_DATA. r=jmaher", 09:43:38 INFO - "project": "", 09:43:38 INFO - "at": "Tue 17 Nov 2015 09:42:53", 09:43:38 INFO - "branch": "mozilla-inbound-macosx64-talos", 09:43:38 INFO - "revlink": "", 09:43:38 INFO - "properties": [ 09:43:38 INFO - [ 09:43:38 INFO - "buildid", 09:43:38 INFO - "20151117080511", 09:43:38 INFO - "Change" 09:43:38 INFO - ], 09:43:38 INFO - [ 09:43:38 INFO - "builduid", 09:43:38 INFO - "ff2c6c76a1514bc9afcb0d9106c5e9c0", 09:43:38 INFO - "Change" 09:43:38 INFO - ], 09:43:38 INFO - [ 09:43:38 INFO - "pgo_build", 09:43:38 INFO - "False", 09:43:38 INFO - "Change" 09:43:38 INFO - ] 09:43:38 INFO - ], 09:43:38 INFO - "revision": "fe34d01fb2ecb2dd4cda82e788cf7b541d5cbdb4" 09:43:38 INFO - } 09:43:38 INFO - ], 09:43:38 INFO - "revision": "fe34d01fb2ecb2dd4cda82e788cf7b541d5cbdb4" 09:43:38 INFO - } 09:43:38 INFO - } 09:43:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/pbFhpK7IQh2Jwco9oVW47g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 09:43:38 INFO - Running post-action listener: _resource_record_post_action 09:43:38 INFO - ##### 09:43:38 INFO - ##### Running download-and-extract step. 09:43:38 INFO - ##### 09:43:38 INFO - Running pre-action listener: _resource_record_pre_action 09:43:38 INFO - Running main action method: download_and_extract 09:43:38 INFO - mkdir: /builds/slave/test/build/tests 09:43:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:38 INFO - https://queue.taskcluster.net/v1/task/pbFhpK7IQh2Jwco9oVW47g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:43:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pbFhpK7IQh2Jwco9oVW47g/artifacts/public/build/test_packages.json 09:43:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pbFhpK7IQh2Jwco9oVW47g/artifacts/public/build/test_packages.json 09:43:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pbFhpK7IQh2Jwco9oVW47g/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 09:43:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pbFhpK7IQh2Jwco9oVW47g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 09:43:40 INFO - Downloaded 1149 bytes. 09:43:40 INFO - Reading from file /builds/slave/test/build/test_packages.json 09:43:40 INFO - Using the following test package requirements: 09:43:40 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 09:43:40 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 09:43:40 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 09:43:40 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 09:43:40 INFO - u'jsshell-mac.zip'], 09:43:40 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 09:43:40 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 09:43:40 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 09:43:40 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 09:43:40 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 09:43:40 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 09:43:40 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 09:43:40 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 09:43:40 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 09:43:40 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 09:43:40 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 09:43:40 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 09:43:40 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:43:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:40 INFO - https://queue.taskcluster.net/v1/task/pbFhpK7IQh2Jwco9oVW47g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:43:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pbFhpK7IQh2Jwco9oVW47g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 09:43:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pbFhpK7IQh2Jwco9oVW47g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 09:43:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pbFhpK7IQh2Jwco9oVW47g/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 09:43:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pbFhpK7IQh2Jwco9oVW47g/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 09:43:42 INFO - Downloaded 17463447 bytes. 09:43:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 09:43:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 09:43:42 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 09:43:47 INFO - Return code: 0 09:43:47 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip', u'firefox-45.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 09:43:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:47 INFO - https://queue.taskcluster.net/v1/task/pbFhpK7IQh2Jwco9oVW47g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:43:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pbFhpK7IQh2Jwco9oVW47g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 09:43:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pbFhpK7IQh2Jwco9oVW47g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 09:43:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pbFhpK7IQh2Jwco9oVW47g/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 09:43:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pbFhpK7IQh2Jwco9oVW47g/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 09:43:55 INFO - Downloaded 17463447 bytes. 09:43: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 09:43:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 09:43:55 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 09:44:00 INFO - Return code: 0 09:44:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:00 INFO - https://queue.taskcluster.net/v1/task/pbFhpK7IQh2Jwco9oVW47g/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:44:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pbFhpK7IQh2Jwco9oVW47g/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 09:44:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pbFhpK7IQh2Jwco9oVW47g/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 09:44:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pbFhpK7IQh2Jwco9oVW47g/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 09:44:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pbFhpK7IQh2Jwco9oVW47g/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 09:44:02 INFO - Downloaded 11131004 bytes. 09:44:02 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 09:44:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 09:44:02 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 09:44:02 INFO - Return code: 0 09:44: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')]} 09:44:02 INFO - https://queue.taskcluster.net/v1/task/pbFhpK7IQh2Jwco9oVW47g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 09:44:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pbFhpK7IQh2Jwco9oVW47g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 09:44:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pbFhpK7IQh2Jwco9oVW47g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 09:44:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pbFhpK7IQh2Jwco9oVW47g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 09:44:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pbFhpK7IQh2Jwco9oVW47g/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 09:44:06 INFO - Downloaded 108841285 bytes. 09:44:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/pbFhpK7IQh2Jwco9oVW47g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 09:44:06 INFO - mkdir: /builds/slave/test/properties 09:44:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:44:06 INFO - Writing to file /builds/slave/test/properties/build_url 09:44:06 INFO - Contents: 09:44:06 INFO - build_url:https://queue.taskcluster.net/v1/task/pbFhpK7IQh2Jwco9oVW47g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 09:44:06 INFO - Running post-action listener: _resource_record_post_action 09:44:06 INFO - Running post-action listener: set_extra_try_arguments 09:44:06 INFO - ##### 09:44:06 INFO - ##### Running populate-webroot step. 09:44:06 INFO - ##### 09:44:06 INFO - Running pre-action listener: _resource_record_pre_action 09:44:06 INFO - Running main action method: populate_webroot 09:44:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:44:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:44:06 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 09:44:06 INFO - '../fennec_ids.txt'], 09:44:06 INFO - 'tests': ['tcheck2']}, 09:44:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:44:06 INFO - '--tppagecycles', 09:44:06 INFO - '7'], 09:44:06 INFO - 'tests': ['tsvgm']}}, 09:44:06 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:44:06 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:44:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:44:06 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:44:06 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:44:06 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:44:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:44:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:44:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:44:06 INFO - 'talos_options': ['--e10s'], 09:44:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:44:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:44:06 INFO - 'tests': ['damp', 'tps']}, 09:44:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:44:06 INFO - 'talos_options': ['--e10s'], 09:44:06 INFO - 'tests': ['damp', 'tps']}, 09:44:06 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:44:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:44:06 INFO - 'other': {'tests': ['a11yr', 09:44:06 INFO - 'ts_paint', 09:44:06 INFO - 'tpaint', 09:44:06 INFO - 'sessionrestore', 09:44:06 INFO - 'sessionrestore_no_auto_restore']}, 09:44:06 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:44:06 INFO - 'tests': ['a11yr', 09:44:06 INFO - 'ts_paint', 09:44:06 INFO - 'tpaint', 09:44:06 INFO - 'sessionrestore', 09:44:06 INFO - 'sessionrestore_no_auto_restore']}, 09:44:06 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:44:06 INFO - 'tests': ['a11yr', 09:44:06 INFO - 'ts_paint', 09:44:06 INFO - 'tpaint', 09:44:06 INFO - 'sessionrestore', 09:44:06 INFO - 'sessionrestore_no_auto_restore']}, 09:44:06 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:44:06 INFO - 'tests': ['a11yr', 09:44:06 INFO - 'ts_paint', 09:44:06 INFO - 'tpaint', 09:44:06 INFO - 'sessionrestore', 09:44:06 INFO - 'sessionrestore_no_auto_restore']}, 09:44:06 INFO - 'other_l64': {'tests': ['a11yr', 09:44:06 INFO - 'ts_paint', 09:44:06 INFO - 'tpaint', 09:44:06 INFO - 'sessionrestore', 09:44:06 INFO - 'sessionrestore_no_auto_restore']}, 09:44:06 INFO - 'other_nol64': {'tests': ['a11yr', 09:44:06 INFO - 'ts_paint', 09:44:06 INFO - 'tpaint', 09:44:06 INFO - 'sessionrestore', 09:44:06 INFO - 'sessionrestore_no_auto_restore']}, 09:44:06 INFO - 'svgr': {'tests': ['tsvgx', 09:44:06 INFO - 'tsvgr_opacity', 09:44:06 INFO - 'tart', 09:44:06 INFO - 'tscrollx', 09:44:06 INFO - 'cart']}, 09:44:06 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:44:06 INFO - 'tests': ['tsvgx', 09:44:06 INFO - 'tsvgr_opacity', 09:44:06 INFO - 'tart', 09:44:06 INFO - 'tscrollx', 09:44:06 INFO - 'cart']}, 09:44:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:44:06 INFO - 'tests': ['tp5o']}, 09:44:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:44:06 INFO - 'talos_options': ['--e10s'], 09:44:06 INFO - 'tests': ['tp5o']}, 09:44:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:44:06 INFO - 'talos_options': ['--xperf_path', 09:44:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:44:06 INFO - 'tests': ['tp5n']}, 09:44:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:44:06 INFO - 'talos_options': ['--e10s', 09:44:06 INFO - '--xperf_path', 09:44:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:44:06 INFO - 'tests': ['tp5n']}}, 09:44:06 INFO - 'talos.zip': {'path': '', 09:44:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:44:06 INFO - Running post-action listener: _resource_record_post_action 09:44:06 INFO - ##### 09:44:06 INFO - ##### Running create-virtualenv step. 09:44:06 INFO - ##### 09:44:06 INFO - Running pre-action listener: _resource_record_pre_action 09:44:06 INFO - Running main action method: create_virtualenv 09:44:06 INFO - Creating virtualenv /builds/slave/test/build/venv 09:44:06 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 09:44:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:44:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:44:06 INFO - Using real prefix '/tools/python27' 09:44:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:44:08 INFO - Installing distribute.............................................................................................................................................................................................done. 09:44:12 INFO - Installing pip.................done. 09:44:12 INFO - Return code: 0 09:44:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:44: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')]} 09:44:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:44:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44: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')]} 09:44:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:44:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100d8f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d6c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa041e128b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cb39f0>, '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 0x100a12db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ca68c8>, '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.wevk1CWRcm/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.02OtNTM0UO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/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 09:44: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', 'pip>=1.5'] in /builds/slave/test/build 09:44: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 pip>=1.5 09:44:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wevk1CWRcm/Render', 09:44:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:44:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:44:12 INFO - 'HOME': '/Users/cltbld', 09:44:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:44:12 INFO - 'LOGNAME': 'cltbld', 09:44:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:12 INFO - 'MOZ_NO_REMOTE': '1', 09:44:12 INFO - 'NO_EM_RESTART': '1', 09:44:12 INFO - 'PAGER': '/bin/cat', 09:44:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:44:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:12 INFO - 'PWD': '/builds/slave/test', 09:44:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:44:12 INFO - 'SHELL': '/bin/bash', 09:44:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.02OtNTM0UO/Listeners', 09:44:12 INFO - 'TMPDIR': '/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/', 09:44:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:44:12 INFO - 'USER': 'cltbld', 09:44:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:44:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:44:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:12 INFO - 'XPC_FLAGS': '0x0', 09:44:12 INFO - 'XPC_SERVICE_NAME': '0', 09:44:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:44:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:44: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 09:44:12 INFO - Cleaning up... 09:44:12 INFO - Return code: 0 09:44:12 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:44: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')]} 09:44:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:44:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44: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')]} 09:44:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:44:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44: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 0x100d8f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d6c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa041e128b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cb39f0>, '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 0x100a12db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ca68c8>, '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.wevk1CWRcm/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.02OtNTM0UO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/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 09:44: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 09:44: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 09:44:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wevk1CWRcm/Render', 09:44:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:44:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:44:12 INFO - 'HOME': '/Users/cltbld', 09:44:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:44:12 INFO - 'LOGNAME': 'cltbld', 09:44:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:12 INFO - 'MOZ_NO_REMOTE': '1', 09:44:12 INFO - 'NO_EM_RESTART': '1', 09:44:12 INFO - 'PAGER': '/bin/cat', 09:44:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:44:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:12 INFO - 'PWD': '/builds/slave/test', 09:44:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:44:12 INFO - 'SHELL': '/bin/bash', 09:44:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.02OtNTM0UO/Listeners', 09:44:12 INFO - 'TMPDIR': '/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/', 09:44:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:44:12 INFO - 'USER': 'cltbld', 09:44:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:44:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:44:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:12 INFO - 'XPC_FLAGS': '0x0', 09:44:12 INFO - 'XPC_SERVICE_NAME': '0', 09:44:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:44:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:44:13 INFO - Downloading/unpacking psutil>=0.7.1 09:44:13 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 09:44:13 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 09:44:13 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 09:44:13 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 09:44:13 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 09:44:13 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 09:44:15 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 09:44:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:44:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:44:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:44:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:44:15 INFO - Installing collected packages: psutil 09:44:15 INFO - Running setup.py install for psutil 09:44:16 INFO - building 'psutil._psutil_osx' extension 09:44:16 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 09:44:17 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 09:44:17 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 09:44:17 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 09:44:18 INFO - building 'psutil._psutil_posix' extension 09:44:18 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 09:44:18 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:44:18 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:44:18 INFO - ^ 09:44:18 INFO - 1 warning generated. 09:44:18 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 09:44:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:44:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:44:18 INFO - Successfully installed psutil 09:44:18 INFO - Cleaning up... 09:44:18 INFO - Return code: 0 09:44:18 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:44:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:44:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:44:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100d8f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d6c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa041e128b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cb39f0>, '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 0x100a12db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ca68c8>, '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.wevk1CWRcm/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.02OtNTM0UO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/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 09:44:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:44:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:44:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wevk1CWRcm/Render', 09:44:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:44:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:44:18 INFO - 'HOME': '/Users/cltbld', 09:44:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:44:18 INFO - 'LOGNAME': 'cltbld', 09:44:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:18 INFO - 'MOZ_NO_REMOTE': '1', 09:44:18 INFO - 'NO_EM_RESTART': '1', 09:44:18 INFO - 'PAGER': '/bin/cat', 09:44:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:44:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:18 INFO - 'PWD': '/builds/slave/test', 09:44:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:44:18 INFO - 'SHELL': '/bin/bash', 09:44:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.02OtNTM0UO/Listeners', 09:44:18 INFO - 'TMPDIR': '/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/', 09:44:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:44:18 INFO - 'USER': 'cltbld', 09:44:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:44:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:44:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:18 INFO - 'XPC_FLAGS': '0x0', 09:44:18 INFO - 'XPC_SERVICE_NAME': '0', 09:44:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:44:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:44:18 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:44:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:44:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:44:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:44:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:44:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:44:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:44:21 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:44:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:44:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:44:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:44:21 INFO - Installing collected packages: mozsystemmonitor 09:44:21 INFO - Running setup.py install for mozsystemmonitor 09:44:21 INFO - Successfully installed mozsystemmonitor 09:44:21 INFO - Cleaning up... 09:44:21 INFO - Return code: 0 09:44:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:44:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:44:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:44:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100d8f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d6c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa041e128b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cb39f0>, '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 0x100a12db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ca68c8>, '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.wevk1CWRcm/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.02OtNTM0UO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/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 09:44:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:44:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:44:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wevk1CWRcm/Render', 09:44:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:44:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:44:21 INFO - 'HOME': '/Users/cltbld', 09:44:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:44:21 INFO - 'LOGNAME': 'cltbld', 09:44:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:21 INFO - 'MOZ_NO_REMOTE': '1', 09:44:21 INFO - 'NO_EM_RESTART': '1', 09:44:21 INFO - 'PAGER': '/bin/cat', 09:44:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:44:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:21 INFO - 'PWD': '/builds/slave/test', 09:44:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:44:21 INFO - 'SHELL': '/bin/bash', 09:44:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.02OtNTM0UO/Listeners', 09:44:21 INFO - 'TMPDIR': '/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/', 09:44:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:44:21 INFO - 'USER': 'cltbld', 09:44:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:44:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:44:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:21 INFO - 'XPC_FLAGS': '0x0', 09:44:21 INFO - 'XPC_SERVICE_NAME': '0', 09:44:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:44:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:44:22 INFO - Downloading/unpacking blobuploader==1.2.4 09:44: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 09:44: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 09:44: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 09:44: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 09:44: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 09:44: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 09:44:24 INFO - Downloading blobuploader-1.2.4.tar.gz 09:44:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:44:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:44:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:44:24 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 09:44:24 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 09:44:24 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 09:44:24 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 09:44:24 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 09:44:24 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 09:44:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:44:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:44:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:44:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:44:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:44:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:44:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:44:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:44:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:44:26 INFO - Downloading docopt-0.6.1.tar.gz 09:44:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:44:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:44:26 INFO - Installing collected packages: blobuploader, requests, docopt 09:44:26 INFO - Running setup.py install for blobuploader 09:44:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:44:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:44:26 INFO - Running setup.py install for requests 09:44:26 INFO - Running setup.py install for docopt 09:44:27 INFO - Successfully installed blobuploader requests docopt 09:44:27 INFO - Cleaning up... 09:44:27 INFO - Return code: 0 09:44:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:44:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:44:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:44:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100d8f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d6c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa041e128b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cb39f0>, '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 0x100a12db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ca68c8>, '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.wevk1CWRcm/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.02OtNTM0UO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/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 09:44:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:44:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:44:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wevk1CWRcm/Render', 09:44:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:44:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:44:27 INFO - 'HOME': '/Users/cltbld', 09:44:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:44:27 INFO - 'LOGNAME': 'cltbld', 09:44:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:27 INFO - 'MOZ_NO_REMOTE': '1', 09:44:27 INFO - 'NO_EM_RESTART': '1', 09:44:27 INFO - 'PAGER': '/bin/cat', 09:44:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:44:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:27 INFO - 'PWD': '/builds/slave/test', 09:44:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:44:27 INFO - 'SHELL': '/bin/bash', 09:44:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.02OtNTM0UO/Listeners', 09:44:27 INFO - 'TMPDIR': '/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/', 09:44:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:44:27 INFO - 'USER': 'cltbld', 09:44:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:44:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:44:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:27 INFO - 'XPC_FLAGS': '0x0', 09:44:27 INFO - 'XPC_SERVICE_NAME': '0', 09:44:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:44:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:44:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:44:27 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-0alE7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:44:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:44:27 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-krux71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:44:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:44:27 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-aIdxLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:44:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:44:27 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-_uxhnn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:44:28 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-SBh_nJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:44:28 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-AMfvIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:44:28 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-p0sPie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:44:28 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-6PzDgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:44:28 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-pA6a0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:44:28 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-_nVg62-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:44:28 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-ZelgcI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:44:28 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-Rjq5z7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:44:29 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-pOXMby-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:44:29 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-ZV1rUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:44:29 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-rRlPyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:44:29 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-KOakdm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:44:29 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-EKZmNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:44:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:44:29 INFO - Running setup.py install for manifestparser 09:44:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:44:29 INFO - Running setup.py install for mozcrash 09:44:30 INFO - Running setup.py install for mozdebug 09:44:30 INFO - Running setup.py install for mozdevice 09:44:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:44:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:44:30 INFO - Running setup.py install for mozfile 09:44:30 INFO - Running setup.py install for mozhttpd 09:44:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:44:30 INFO - Running setup.py install for mozinfo 09:44:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:44:30 INFO - Running setup.py install for mozInstall 09:44:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:44:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:44:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:44:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:44:31 INFO - Running setup.py install for mozleak 09:44:31 INFO - Running setup.py install for mozlog 09:44:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:44:31 INFO - Running setup.py install for moznetwork 09:44:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:44:31 INFO - Running setup.py install for mozprocess 09:44:31 INFO - Running setup.py install for mozprofile 09:44:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:44:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:44:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:44:32 INFO - Running setup.py install for mozrunner 09:44:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:44:32 INFO - Running setup.py install for mozscreenshot 09:44:32 INFO - Running setup.py install for moztest 09:44:32 INFO - Running setup.py install for mozversion 09:44:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:44:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:44:32 INFO - Cleaning up... 09:44:32 INFO - Return code: 0 09:44:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:44:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:44:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:44:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:32 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 0x100d8f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d6c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa041e128b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cb39f0>, '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 0x100a12db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ca68c8>, '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.wevk1CWRcm/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.02OtNTM0UO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/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 09:44:32 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 09:44:32 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 09:44:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wevk1CWRcm/Render', 09:44:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:44:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:44:32 INFO - 'HOME': '/Users/cltbld', 09:44:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:44:32 INFO - 'LOGNAME': 'cltbld', 09:44:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:32 INFO - 'MOZ_NO_REMOTE': '1', 09:44:32 INFO - 'NO_EM_RESTART': '1', 09:44:32 INFO - 'PAGER': '/bin/cat', 09:44:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:44:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:32 INFO - 'PWD': '/builds/slave/test', 09:44:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:44:32 INFO - 'SHELL': '/bin/bash', 09:44:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.02OtNTM0UO/Listeners', 09:44:32 INFO - 'TMPDIR': '/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/', 09:44:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:44:32 INFO - 'USER': 'cltbld', 09:44:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:44:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:44:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:32 INFO - 'XPC_FLAGS': '0x0', 09:44:32 INFO - 'XPC_SERVICE_NAME': '0', 09:44:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:44:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:44:33 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-bG2pYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:44:33 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)) 09:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:44:33 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-YmQ77H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:44:33 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)) 09:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:44:33 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-Au7zHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:44:33 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)) 09:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:44:33 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-Ldfy4Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:44:33 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)) 09:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:44:33 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-L6nDnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:44:33 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)) 09:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:44:33 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-uEotPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:44:34 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)) 09:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:44:34 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-YuCRAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:44:34 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)) 09:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:44:34 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-KU47yJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:44:34 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)) 09:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:44:34 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-75Q4T6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:44:34 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)) 09:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:44:34 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-5ULXC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:44:34 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)) 09:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:44:34 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-fJXRJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:44:34 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)) 09:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:44:34 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-hNjcw0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:44:34 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)) 09:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:44:34 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-hjqmlk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:44:34 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)) 09:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:44:34 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-rOntRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:44:35 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)) 09:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:44:35 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-9KpuXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:44:35 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)) 09:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:44:35 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-0zT7_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:44:35 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)) 09:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:44:35 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-AjcSNc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:44:35 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)) 09:44:35 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)) 09:44:35 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)) 09:44:35 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)) 09:44:35 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)) 09:44:35 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)) 09:44:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:44:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:44:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:44:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:44:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:44:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:44:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:44:38 INFO - Downloading blessings-1.5.1.tar.gz 09:44:38 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 09:44:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:44:38 INFO - Installing collected packages: blessings 09:44:38 INFO - Running setup.py install for blessings 09:44:38 INFO - Successfully installed blessings 09:44:38 INFO - Cleaning up... 09:44:38 INFO - Return code: 0 09:44:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:44:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:44:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:44:38 INFO - Reading from file tmpfile_stdout 09:44:38 INFO - Current package versions: 09:44:38 INFO - blessings == 1.5.1 09:44:38 INFO - blobuploader == 1.2.4 09:44:38 INFO - docopt == 0.6.1 09:44:38 INFO - manifestparser == 1.1 09:44:38 INFO - mozInstall == 1.12 09:44:38 INFO - mozcrash == 0.16 09:44:38 INFO - mozdebug == 0.1 09:44:38 INFO - mozdevice == 0.47 09:44:38 INFO - mozfile == 1.2 09:44:38 INFO - mozhttpd == 0.7 09:44:38 INFO - mozinfo == 0.9 09:44:38 INFO - mozleak == 0.1 09:44:38 INFO - mozlog == 3.0 09:44:38 INFO - moznetwork == 0.27 09:44:38 INFO - mozprocess == 0.22 09:44:38 INFO - mozprofile == 0.27 09:44:38 INFO - mozrunner == 6.11 09:44:38 INFO - mozscreenshot == 0.1 09:44:38 INFO - mozsystemmonitor == 0.0 09:44:38 INFO - moztest == 0.7 09:44:38 INFO - mozversion == 1.4 09:44:38 INFO - psutil == 3.1.1 09:44:38 INFO - requests == 1.2.3 09:44:38 INFO - wsgiref == 0.1.2 09:44:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:44:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:44:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:44:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x100d8f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d6c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa041e128b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cb39f0>, '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 0x100a12db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ca68c8>, '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.wevk1CWRcm/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.02OtNTM0UO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/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 09:44:38 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 09:44:38 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 09:44:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wevk1CWRcm/Render', 09:44:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:44:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:44:38 INFO - 'HOME': '/Users/cltbld', 09:44:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:44:38 INFO - 'LOGNAME': 'cltbld', 09:44:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:38 INFO - 'MOZ_NO_REMOTE': '1', 09:44:38 INFO - 'NO_EM_RESTART': '1', 09:44:38 INFO - 'PAGER': '/bin/cat', 09:44:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:44:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:38 INFO - 'PWD': '/builds/slave/test', 09:44:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:44:38 INFO - 'SHELL': '/bin/bash', 09:44:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.02OtNTM0UO/Listeners', 09:44:38 INFO - 'TMPDIR': '/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/', 09:44:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:44:38 INFO - 'USER': 'cltbld', 09:44:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:44:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:44:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:38 INFO - 'XPC_FLAGS': '0x0', 09:44:38 INFO - 'XPC_SERVICE_NAME': '0', 09:44:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:44:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:44:39 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)) 09:44:39 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)) 09:44:39 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)) 09:44:39 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)) 09:44:39 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)) 09:44:39 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)) 09:44:39 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)) 09:44:39 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)) 09:44:39 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)) 09:44:39 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)) 09:44:39 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)) 09:44:39 INFO - Cleaning up... 09:44:39 INFO - Return code: 0 09:44:39 INFO - Running post-action listener: _resource_record_post_action 09:44:39 INFO - Running post-action listener: _start_resource_monitoring 09:44:39 INFO - Starting resource monitoring. 09:44:39 INFO - ##### 09:44:39 INFO - ##### Running install step. 09:44:39 INFO - ##### 09:44:39 INFO - Running pre-action listener: _resource_record_pre_action 09:44:39 INFO - Running main action method: install 09:44:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:44:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:44:39 INFO - Reading from file tmpfile_stdout 09:44:39 INFO - Detecting whether we're running mozinstall >=1.0... 09:44:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:44:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:44:39 INFO - Reading from file tmpfile_stdout 09:44:39 INFO - Output received: 09:44:39 INFO - Usage: mozinstall [options] installer 09:44:39 INFO - Options: 09:44:39 INFO - -h, --help show this help message and exit 09:44:39 INFO - -d DEST, --destination=DEST 09:44:39 INFO - Directory to install application into. [default: 09:44:39 INFO - "/builds/slave/test"] 09:44:39 INFO - --app=APP Application being installed. [default: firefox] 09:44:39 INFO - mkdir: /builds/slave/test/build/application 09:44:39 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'] 09:44:39 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 09:45:19 INFO - Reading from file tmpfile_stdout 09:45:19 INFO - Output received: 09:45:19 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:45:19 INFO - Running post-action listener: _resource_record_post_action 09:45:19 INFO - ##### 09:45:19 INFO - ##### Running run-tests step. 09:45:19 INFO - ##### 09:45:19 INFO - Running pre-action listener: _resource_record_pre_action 09:45:19 INFO - Running main action method: run_tests 09:45:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:45:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:45:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:45:19 INFO - 2015-11-17 09:45:19.630 screenresolution[1631:8665] starting screenresolution argv=screenresolution get 09:45:19 INFO - 2015-11-17 09:45:19.633 screenresolution[1631:8665] Display 0: 1600x1200x32@60 09:45:19 INFO - 2015-11-17 09:45:19.640 screenresolution[1632:8667] starting screenresolution argv=screenresolution list 09:45:19 INFO - Available Modes on Display 0 09:45:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:45:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:45:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:45:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:45:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:45:19 INFO - Intel HD Graphics 3000: 09:45:19 INFO - Chipset Model: Intel HD Graphics 3000 09:45:19 INFO - Type: GPU 09:45:19 INFO - Bus: Built-In 09:45:19 INFO - VRAM (Total): 512 MB 09:45:19 INFO - VRAM (Dynamic, Max): 10 09:45:19 INFO - Vendor: Intel (0x8086) 09:45:19 INFO - Device ID: 0x0116 09:45:19 INFO - Revision ID: 0x0009 09:45:19 INFO - Displays: 09:45:19 INFO - Display: 09:45:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:45:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:45:19 INFO - Display Serial Number: 1600x1200 60 09:45:19 INFO - Main Display: Yes 09:45:19 INFO - Mirror: Off 09:45:19 INFO - Online: Yes 09:45:19 INFO - Rotation: Supported 09:45:19 INFO - Return code: 0 09:45:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:45:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:45:19 INFO - Python 2.7.3 09:45:19 INFO - Return code: 0 09:45:19 INFO - grabbing minidump binary from tooltool 09:45: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')]} 09:45:19 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 0x100cb39f0>, '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 0x100a12db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ca68c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:45:19 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 09:45:19 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 09:45:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:45:20 INFO - Return code: 0 09:45:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:45:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:45:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:45:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:45:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:45:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/pbFhpK7IQh2Jwco9oVW47g/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0032', '--webServer', 'localhost'] in /builds/slave/test/build 09:45:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/pbFhpK7IQh2Jwco9oVW47g/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0032 --webServer localhost 09:45:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wevk1CWRcm/Render', 09:45:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:20 INFO - 'HOME': '/Users/cltbld', 09:45:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:20 INFO - 'LOGNAME': 'cltbld', 09:45:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:45:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:45:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:20 INFO - 'MOZ_NO_REMOTE': '1', 09:45:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:45:20 INFO - 'NO_EM_RESTART': '1', 09:45:20 INFO - 'PAGER': '/bin/cat', 09:45:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:20 INFO - 'PWD': '/builds/slave/test', 09:45:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:45:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:20 INFO - 'SHELL': '/bin/bash', 09:45:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.02OtNTM0UO/Listeners', 09:45:20 INFO - 'TMPDIR': '/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/', 09:45:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:20 INFO - 'USER': 'cltbld', 09:45:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:20 INFO - 'XPC_FLAGS': '0x0', 09:45:20 INFO - 'XPC_SERVICE_NAME': '0', 09:45:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:45:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/pbFhpK7IQh2Jwco9oVW47g/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0032', '--webServer', 'localhost'] with output_timeout 3600 09:45:20 INFO - mozversion INFO | application_buildid: 20151117080511 09:45:20 INFO - mozversion INFO | application_changeset: fe34d01fb2ecb2dd4cda82e788cf7b541d5cbdb4 09:45:20 INFO - mozversion INFO | application_display_name: Nightly 09:45:20 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:45:20 INFO - mozversion INFO | application_name: Firefox 09:45:20 INFO - mozversion INFO | application_remotingname: firefox 09:45:20 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:45:20 INFO - mozversion INFO | application_vendor: Mozilla 09:45:20 INFO - mozversion INFO | application_version: 45.0a1 09:45:20 INFO - mozversion INFO | platform_buildid: 20151117080511 09:45:20 INFO - mozversion INFO | platform_changeset: fe34d01fb2ecb2dd4cda82e788cf7b541d5cbdb4 09:45:20 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:45:20 INFO - mozversion INFO | platform_version: 45.0a1 09:45:20 INFO - 2015-11-17 09:45:20,375 DEBUG : using testdate: 1447782320 09:45:20 INFO - 2015-11-17 09:45:20,375 DEBUG : actual date: 1447782320 09:45:20 INFO - 2015-11-17 09:45:20,386 INFO : starting webserver on 'localhost:49267' 09:45:20 INFO - 2015-11-17 09:45:20,387 INFO : Starting test suite t-yosemite-r5-0032 09:45:20 INFO - 2015-11-17 09:45:20,387 INFO : Starting test dromaeo_css 09:45:20 INFO - 2015-11-17 09:45:20,387 DEBUG : operating with platform_type : mac_ 09:45:20 INFO - 2015-11-17 09:45:20,388 INFO : Initialising browser for dromaeo_css test... 09:45:20 INFO - 2015-11-17 09:45:20,423 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/tmpQPYg1G/profile http://localhost:49267/getInfo.html 09:45:23 INFO - 2015-11-17 09:45:23,688 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:45:23 INFO - 2015-11-17 09:45:23,688 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:45:23 INFO - 2015-11-17 09:45:23,688 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 09:45:23 INFO - 2015-11-17 09:45:23,689 DEBUG : BROWSER_OUTPUT: __metrics 09:45:23 INFO - 2015-11-17 09:45:23,707 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:45:24 INFO - 2015-11-17 09:45:24,436 INFO : Browser initialized. 09:45:24 INFO - 2015-11-17 09:45:24,437 INFO : Running cycle 1/1 for dromaeo_css test... 09:45:24 INFO - 2015-11-17 09:45:24,437 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/tmpQPYg1G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:45:36 INFO - 2015-11-17 09:45:36,537 DEBUG : BROWSER_OUTPUT: RSS: Main: 228728832 09:45:36 INFO - 2015-11-17 09:45:36,537 DEBUG : BROWSER_OUTPUT: 09:46:28 INFO - 2015-11-17 09:46:28,356 DEBUG : BROWSER_OUTPUT: 1447782388354 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] 09:48:38 INFO - 2015-11-17 09:48:38,602 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 09:48:39 INFO - 2015-11-17 09:48:39,766 DEBUG : BROWSER_OUTPUT: RSS: Main: 335917056 09:48:39 INFO - 2015-11-17 09:48:39,766 DEBUG : BROWSER_OUTPUT: 09:51:42 INFO - 2015-11-17 09:51:42,513 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 09:51:43 INFO - 2015-11-17 09:51:43,098 DEBUG : BROWSER_OUTPUT: RSS: Main: 375222272 09:51:43 INFO - 2015-11-17 09:51:43,098 DEBUG : BROWSER_OUTPUT: 09:54:45 INFO - 2015-11-17 09:54:45,611 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 09:54:46 INFO - 2015-11-17 09:54:46,195 DEBUG : BROWSER_OUTPUT: RSS: Main: 340619264 09:54:46 INFO - 2015-11-17 09:54:46,195 DEBUG : BROWSER_OUTPUT: 09:57:48 INFO - 2015-11-17 09:57:48,331 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 09:57:48 INFO - 2015-11-17 09:57:48,924 DEBUG : BROWSER_OUTPUT: RSS: Main: 328519680 09:57:48 INFO - 2015-11-17 09:57:48,924 DEBUG : BROWSER_OUTPUT: 10:00:52 INFO - 2015-11-17 10:00:52,150 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 10:00:52 INFO - 2015-11-17 10:00:52,763 DEBUG : BROWSER_OUTPUT: RSS: Main: 328491008 10:00:52 INFO - 2015-11-17 10:00:52,763 DEBUG : BROWSER_OUTPUT: 10:03:55 INFO - 2015-11-17 10:03:55,673 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 10:03:55 INFO - 2015-11-17 10:03:55,935 DEBUG : BROWSER_OUTPUT: RSS: Main: 373596160 10:03:55 INFO - 2015-11-17 10:03:55,936 DEBUG : BROWSER_OUTPUT: 10:03:55 INFO - 2015-11-17 10:03:55,936 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:03:55 INFO - 2015-11-17 10:03:55,936 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:03:55 INFO - 2015-11-17 10:03:55,936 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:03:55 INFO - 2015-11-17 10:03:55,936 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:03:55 INFO - 2015-11-17 10:03:55,938 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2794.9099851058086;2830.235836324191;2859.656841179059;2872.037867314451;2875.1087162979484;4637.7217366958;4688.367070445489;4746.121967436026;4817.132916075109;4837.467878533363;4686.156491831469;4802.639802014845;4806.9038619227595;4917.114919314522;4979.10376132296;4350.73895566267;4446.0441005183875;4456.732596044248;4471.128130014648;4534.433195850519;4497.527759585246;4555.840545580905;4557.134144512532;4617.769111544426;4620.815167393317;4233.301505251629;4339.457567804025;4369.584889435499;4497.437820272466;4534.183846907556;4307;4370.978145109254;4400.097979914142;4436.9556304436865;4462.754548499831;4434.733915965053;4441.71128876622;4472.731636101845;4503.549645035503;4508.864734057984;4576.496585375606;4806.807727690888;4837.782299796518;4855.951440485585;4876.68301560401;4927.334809800667;4996.950030499721;5091.643584949055;5096.643234973553;5106.412762532282;5186.273921650972;5232.843014709527;5241.161414173752;5293.3647962244395;5296.25852380667;4667.346571479996;4853;4898.519989844522;4915.680480768739;4918.286848407032;5093.516115968977;5173.948260517422;5229.607779416483;5336.733163341817;5366.356037275474;5041.9411923495745;5055.8988820223385;5063.240513922868;5082.263071854561;5149;4944.431390390079;5100.132977393852;5154.793808247703;5164.793408263702;5169.896602068013;5020.849374518771;5038.722870242099;5041.193409054607;5044.218146187347;5105.591552675852;5028.371453568304;5046.571041461517;5052.520010598987;5093.439721630618;5093.668911520739;3846.9230615387537;3907.433422153772;3920.941185882157;3950.20995800841;3988.202359528106;3582.731295152874;3624.293262813726;3626.202235508184;3631.963680363215;3638;4902.950970490321;4932.778024988884;4955.207166853358;4958.355413796184;4959.801607935642;5027.120253955543;5110.131277682803;5114.105031619451;5179.637425380262;5330.040592693353;4884.0476107158765;4889.559939605452;4946.307516947631;4951.752412379366;5013.147764879979;4551.089782043605;4558.2251017327135;4616.722996620214;4620.584147426748;4647.837325693585;5195.038917800219;5263.894722105613;5323.254744335796;5333.040052790535;5409.404965453718;5202.531772140525;5247.816326428557;5256.6320357574605;5264.842054738364;5315.3621565412395;5346.144616861284;5366.195070739421;5375.569954403716;5375.731213439391;5430.8099216527235;4968.701877887338;5054.064997975386;5056.544910958031;5059.898802024012;5063.3417655706;5030.5975521957425;5129.025485157808;5129.512696293846;5148.9742551287;5164.173732202829;4852.8301509447;5073.822416215415;5086.313347698161;5089.491050894881;5091.490850914879;5042.193249080129;5042.773075211551;5083.669561478492;5084.644074914869;5091.821786237464;4753.191957367187;4838.951610483991;4926.236433352836;4944.085344211332;4948.604111671129;5110.4123025852505;5113.488651134857;5116.590672746246;5132.5893928486375;5139.254808052886;4983.053219888209;5019.222020586815;5020.171671674133;5059.367579052619;5122.718250496258 10:03:55 INFO - 2015-11-17 10:03:55,939 DEBUG : BROWSER_OUTPUT: |1;ext.html;502.2817371159242;505.3910038403724;505.40362372400574;513.0278122956998;513.5634710496079;26827.73172268277;34044.148896277606;34872.82563587185;35143.4728479073;35281.11797205071;37169.256614867685;37326;37343;37603.81198094006;37712.811435942785;7408.407327413821;8103.635336409861;8195.71315003975;8234.300084492825;8277.503349799;7361.742339018136;9834.70495885121;10029.1475224606;10087.394756314608;10117.645882394118;9744.31789774716;9864.35881667693;9868.358556693827;9917.504124793768;9998.700038998843;7462.7014919403155;7652.464327497078;9757.951210243938;9834.754131146743;9919.950400248024;9750.171235444996;9986.400815951067;9992.550335234931;9998.800023999553;10045.095941365313;33514.32971340584;34054.14864628379;34442.483362749575;34456.48315275273;34486.31027379463;2709.0518318588533;2713.470873179731;2830.3348713052414;2999.6700362960055;3150.401423729507;24275;24426.51146977068;24612.876935615208;24943;25593.23220303394;2087.8016588424075;2110.89445527723;2139.336805590272;2158.4280165756086;2242.4505996031075;224899;227202.99999999834;227523;229190;230757;44040;45082;49758;49828.75085624549;49921;41116.794416027726;56948;57895;57925.420745792006;58011;14428.134311941318;14617.342219600143;14642.341094650767;14711;14744.55766327012;11198.552057917756;11304;11314.151438642135;11372.658820235407;11376.886231137749;16193.109378984269;16280.104594247194;16317.34730610786;16332.83667163337;16360.754588681179;6757.797266082025;7031.417930965594;7034.19106802714;7075.292470752986;7088.3974862136265;831.2145022953251;868.4615538366253;964.9783703141907;987.8863930647924;1035.694470131313;24227;24709.135180268604;24717.752822471906;24735.3816154594;25072.623910641356;953.6376177052675;960.4765402855461;963.9662611808553;971.1453920550013;1012.9290949633455;12191.268523888595;12387.566435174725;12587.62237132869;13204.339783010812;13918.860811391958;264808;269885;270502;270519;270826;46222.30666540004;46423.30365044527;46551.068978620235;46949.76525117353;46991.530084698716;1216.519474807464;1233.5004323249098;1233.7039110613568;1244.966677657542;1252.2111070025826;21379.686148646986;23997.52004959926;24566.7716614165;24897.751022489545;25716.485670286864;39817;40378.39432408575;40462;40830;40920.38619420651;176967;177687.11156444653;177837;178106;178211;23709.88145059264;23915.52168956646;26956.73043269542;27739.44521109607;28177.295567610974;32585.348293033534;33156.33687326288;33417.331653367284;33734.49398258979;33992.320153596294;28909.85545072261;29674.406511870075;32040.198995025312;32650.34699306048;33024.834875825465;30132.69867301299;30556.541651875683;30566.235844104074;30629;30681.846590767796;29840.552391713707;31158.68841311558;31237;31497.685023149475;31515.52726709147;24860.37849053788;25478.363040923385;26611.201663950113;26936.191914242605;27578.586321204795;20613.175472980914;20642.58714825665;20827.271045513335;20874.37376878696;21063.789362106796 10:03:55 INFO - 2015-11-17 10:03:55,943 DEBUG : BROWSER_OUTPUT: |2;jquery.html;295.47848048194925;297.1234857171345;304.1863016431046;305.0148021889296;305.85777613409766;15715.214239288032;16016.199190040496;16209.918950405247;16611.33554657812;16622.66754664909;10382.273240873143;10715.571377144925;10728.088112510446;10744.194185436085;16596.336146554153;3413.556237689097;3900.7907548659864;3979.323515002442;3999.8400063997406;4000.6999475039343;3940.980295098535;3960.4059391091423;4010.939835902464;4016.377461493473;4019.5176578810583;3003.714647108521;3045.9086227413104;3081.3221091359865;3906.863259785908;3961.3661814109746;4167.916641667165;4169.958300416987;4208.13733184698;4260.957390426087;4267.530571637118;3597.244578638489;3605.531280933462;3634.018814919983;3634.6365363463706;3638.7816730996224;9600.615975360977;9877.061679140543;10064.647737329231;10893.509792059376;11450.770984580346;1396.2111407055083;1464.443511465647;1613.1127879666137;1657.991710041442;1769.9911500442545;8305.584720763938;8318.500889946623;8470.32237421011;8527.872081918777;8554.871676924851;1354.0724603646534;1366.8018137370025;1386.4177045640754;1433.7204245172195;1482.5774654223603;49536.75231623819;53657;53828;53943.190852137246;54023;5771.451712087345;5812.244408226903;5828.708564571754;5829.213056237439;5900.793472228452;6638.502112341594;6640.302768209365;6650.733970641217;6698.497612679069;6735.831604209934;4949.356583644103;4961.181405068123;4972.353594032825;4972.403311602631;4980.228064649985;5334.706591137525;5392.056390131711;5393.460653934653;5401.027814993339;5459.3994660587305;2620.882060307291;2649.271450351169;2652.7082020977678;2669.933251668685;2670.4258584404056;912.1015799437548;916.1296768070359;916.2074805293506;933.7898972731081;981.0679854138597;337.84965690268086;378.209542057102;417.6053629320263;418.12194391777024;419.3981636351784;8959.283257339397;9967.750806229902;10070.496475176213;10089.848652270222;10303.227257955683;347.5013355834335;396.5934916710395;408.5893676854742;415.6508532832435;427.3418934840311;5387.595930305243;5455.5908306876345;5776.740046697909;5802.796902108406;5809.970950145223;430258;448919;468807;470358;477728;61823;66939;67529.66235168891;67702.66148669225;69113;437.6783064447628;444.7531619950894;445.3586834957715;446.2547545598858;446.65161174283463;9583.329166958247;9693.563789629625;9788.070133337322;9839.901600983898;9886.851697224403;30074.849625751733;30526.389472210874;30952.380952380376;30981.690183097882;31780.523292150174;43610.34584481299;43633;43703.34444983264;44269.55730442654;44403.77798110989;5464.808731694372;5529.612927095065;5538.030844602098;5545.168224766156;5547.057000310037;9555.474448905377;10117.949410252902;10140.03669651382;10178;10397;8725.738227853175;8755.474671519729;8757.60590773404;8759.956200218958;8979.50612716307;8061.83876322482;8342.541160236246;8672.826543469222;8811.33914956368;9070.501122438065;9188;9281.071892810665;9281.48951807657;9299.395539289924;9301.674441394518;5345.1982202669915;5568.97215513936;5571.916421253765;5632.183333416713;5647.322321321468;8893.911060889566;9121.863172052292;9194.264458843143;9316.068393160629;9326.906730932875 10:03:55 INFO - 2015-11-17 10:03:55,944 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1106.186952589847;1497.79030935669;1565.9295331710073;1611.2990848980694;1615.1439736939421;5890.263717035371;6229.408206220408;6428.582142160756;6637.236717777457;6638.966805165979;6346.143270658471;6519.67401629919;6534.901976470345;6550.639714815695;6618.3050779668165;1876.4558278099335;1894.1760334254575;1906.313727058265;1922.7884932657396;1923.7980012098737;1904.8095190480979;1938.9127489262946;1955.9217631294732;2002.8297594704468;2041.1427200575795;1919.7216403621467;1920.4142736465371;1929.9131539080774;1955.3449594385897;1957.0606109067655;1836.8622353323487;1869.0841487670943;1870.812918708132;1874.5313671582105;1898.591802762406;1915.9808401916082;1916.3005502991448;1920.1263425141526;1928.0648885290623;1945.6303302372503;5684.459976302244;6409.070684750685;6427.260865000538;6474.838129046764;6509.544331896769;3653.8173091345325;3703.7222208334483;3934.2328245992044;4052.8581499647667;4059.9797001014804;2495.3137887081016;2508.9623655645178;2559.1171045989104;2592.4815036992486;2599.753023462787;804.8551260773058;827.1521690267464;830.5805568188026;844.5608283692445;859.2266959736224;8402.815268030296;8421.957890210571;8486.618102185417;8541.829163416696;8545.145485451467;3527.9294414111573;3547.822608869546;3553.8400771965325;3589.2821435712963;3603.837827297778;7072.787816365517;7103;7155.534890232118;7161.4986950912935;7184.497085203986;4031.5766844481495;4088.6115818997146;4089.488813898263;4097.8770636880945;4102.630763231324;3754.3805272129794;3768.0768211788286;3795.2162483632646;3804.6766024888193;3805.790681512488;2806.3264816443907;2816.9859150704115;2838.7587055100134;2855.4860125177665;2857.7428031477266;890.4167770110588;911.4258017449097;916.0701887583974;927.3740225347864;928.3687092776842;896.171041786358;913.1142791492242;919.5769945824995;937.9718608441758;1154.5381847261162;6100.206973093469;6142.477889379453;6154.476869466056;6154.78458253959;6166.1983942087245;420.92212940606083;426.93595960605535;429.0496550141452;1040.6929955663097;1095.4413249242943;4618.122556714281;4888.340074089952;5001.499850015042;5005.89988200234;5007.173816320266;6564.704588293538;7705.9229407706325;7712.383009359238;7718.768436946901;7837.960810195913;7512.774616761506;7536.849263014709;7592.164861865191;7611.847763044819;7615.4669173157345;5787.826365209051;6015.849603759941;6120.44915957566;6127.356627554132;6152;6140.478059365004;6219.844503887439;6219.937800621936;6228.377162283736;6276.435120839146;6859.382655561023;6873.278305778022;6907.102076729993;7001.719931202695;7054.224035356209;6984.580925144508;7112.431005519443;7137.036500072424;7148;7194.280571942764;5823.242978412779;5899.203607512931;5915.467607915309;5920.703964801656;5936.079907614327;5848.619839710405;6310.179676642191;6313.810585682437;6343.238811342484;6355.555111142361;5835.416458354131;5919.644821310735;5957.076653118774;5980.581359304807;5994;5789.884202316014;5799.797007104731;5875;5913.793017244376;5922.7927022554;5949.6430214187285;5984.551158663205;5991.580589358878;5998.350453625288;6006.699665016819;5289.57683385336;5423.3491980962535;5429.972850135724;5441.102218133963;5452.672839629635;5478.04134276508;5519.061759500974;5532.6680399176175;5538.0585300499815;5579.079451890392 10:03:55 INFO - 2015-11-17 10:03:55,947 DEBUG : BROWSER_OUTPUT: |4;prototype.html;271.796152885336;276.4691791759821;278.6600347575957;284.63993048793265;287.58731220698314;5426.348838139419;5448.863778405542;5504.559635229182;5553.111502159651;5558.638688485245;5376.784928602861;5548.44515548445;5570.693611851357;5572.192032155335;5585.441455854412;4165.4376659151085;4191.601797829201;4198.30727929892;4200.663946884257;4213.325867861143;4029.8388064477385;4154.376843473473;4170.687198460112;4198.433211516452;4203.285441474942;3895.10412605101;4096.733712308705;4111.588841115894;4127.236461254663;4140.068484590958;4059.7158198926086;4062.2687916175078;4079.4084857695466;4085.346344584852;4101.159262351211;3492.336456073338;3558.7508874378805;3571.196480791827;3591.2278860045217;3617.981910090433;5327.733613319358;5381.838544843622;5383.380911195223;5399.352077750656;5401.378841433247;4676.11153880765;4702.694324868872;4735.147673418784;4742.928856067162;4745.549172828576;5585.497305242507;5749.6550206987295;5800.825975220708;5831.679257640828;5834.766609335621;3874.8062596870327;3876.8255428505786;3913.2956067907767;3917.05990562263;3927.3912543555793;6134.570580059398;6136.821428392901;6143.969280153616;6160.045192995093;6162.075688646694;3939.1727737174942;3958.9208215836097;3976.2842688315804;4010.3382941814857;4011.398290256485;3892.844286228519;4004.1791432756213;4019.959800402017;4033.3546632538655;4050.3924411337944;4657.301404789308;4663.930041049387;4694.906101877943;4713.764311784397;4714.750591093363;5601.215829783833;5771.163181338682;5773.595848290579;5837.211976383134;5852.7658893643775;1366.3236697834636;1389.465055953445;1410.379433049455;1417.9858201417853;1422.30307149496;907.9409838360485;909.0909090909091;912.7039603762673;917.5504003038596;920.2729843423754;5594.24477695514;5605.32736071674;5628.97185514078;5629.831105066854;5633.57748168889;6058.606190597597;6061.121137435135;6077.301110372276;6079.574429789872;6089.878202435926;5615.775368985276;5624.690642014647;5628.634138780966;5632.746526406321;5633.042382794934;3165.287810242723;3255.202475393544;3270.8528116234825;3283.113559338965;3286.8471151395875;6214.937850621526;6219.315875253718;6236.34518375564;6244.37556244381;6245.718942647592;6181.072839074175;6186.319504854462;6186.845328866814;6188.845278868064;6209.813705588839;6029.8191054268445;6202.4417802398;6218.409251121137;6223.96888015557;6245.18812554365;6021.337652858095;6036.758529658764;6055.969720151371;6058.151858739692;6063.575549711478;5894.28862723135;5907.054871220584;5929.110633405024;5931.822045338647;5956.880862382642;6210.627362358092;6220;6220.253569571681;6222.564420490522;6251.0623406487575;3927.194925040417;3967.8016099194347;4010.0375909782024;4017.6986725995084;4024.5371782244247;5871.706414679164;5938.287405511193;5949.583529152917;6172.660503672341;6197.4732147767945;5737.827865164052;5819.301683797802;5855.3266374367495;5909.55678324136;5943.346231914399;5819.621724587888;5885.323187833454;5886.999210134373;5907.054871220584;5948.970255148696;5630.662160270397;5715.942840571541;5774.942250577608;5804.1874137619925;5816.76732930678;5863;5919.112133180058;5937.584369094122;5937.584369094122;5968.074948383008;5763.7982670606325;5775.768969241183;5808.82573522795;5831.679257640701;5846.853828654148 10:03:55 INFO - 2015-11-17 10:03:55,948 DEBUG : BROWSER_OUTPUT: |5;yui.html;674.7132468700801;675.5035049238812;678.8744082344766;692.1763101908729;696.3071743615102;12127.878721212785;12238.571649992253;12374.752504949907;12377.195482293644;12393.25640461573;10236.43699596522;10364.844527332096;12165.695857603565;12528.185667931579;12538;768.6579472134888;774.3108633316353;783.2832957843566;784.1413652050995;785.3246208260891;579.9333076696191;593.2436143916498;597.6264834478451;605.3039005144097;753.1226121568367;780.7774784186508;788.3181048393127;798.2416704131069;798.8641930871737;810.0198759501011;788.0661416221739;789.7038610521083;795.932345750612;799.5083023940293;803.148662417836;461.1399739485868;468.2134014855042;577.719805894141;585;588.717415640495;11833.940830295793;11963.760724785456;12003.759924801543;12042.09684273683;12172.756544869053;7943.682252709885;8180.100188979208;8410.495370277802;8466.026406963216;8558.572071396406;7770.378369730408;7820.916683723661;8030.879536806952;8158.061822890384;8251.133630968721;2482.2677310193358;2549.1205534090896;2571.996921200733;2633.578627419604;2650.8144429889917;41540.584594153974;41953;42282;42374;42398.36402453935;5136.101182293084;5534.972325138348;5587.357453892854;5660.15097735343;5789.797357092481;10715.83926241107;10764.515596798163;10826.94586527078;10865;10904.563817447213;5377.919331210035;5453.454654534594;5460.645058071213;5471.863203419946;5732.082866741384;3302.3230237801195;3330.900072997814;3418.4017796885446;3441.380551500754;3484.5470088888787;2345.132301048623;2357.351728274704;2389.0921449849293;2391.605385111437;2411.2645643078677;354.6170136252841;356.17900738797323;356.59348342889126;359.2222837556713;364.76654940837886;416.27568031624753;542.1758926431802;542.6635485998627;556.3963100036506;575.0798722044779;6562.606243625302;7223.927760722326;7545.207753185946;7708.344790692854;7971.880421793678;436.55471419152286;489.9608031357483;524.8346770767196;538.8329617818489;539.5198273536556;3136.373848573336;3374.257663314067;3384.7630665853644;3450.585929688403;3453.568303962005;48770.268445973335;48772.26841597379;48783.26825097627;48963.75518122387;49577.75211123921;43893.341599876025;44766.77616611896;44960.100797983854;45014.32478512825;45207.773961129984;41109.383359249034;41161.382579261335;41359.793201033805;42276.36585451159;42344.15311693749;7277.745278915212;7376.2623737627955;7460;7524.209957954555;7710.190430004769;30706;30872.38255234838;31152;31682.524762128127;31938.36123277568;36910.63089369072;37345.626543734215;38706.225875482894;40763;40827;8720.302375809793;8966.282697384064;9064.682736104469;9224.769380765534;9346.7421617511;9455.952720236355;9504.144626983329;9519.095685909828;9521.76195595088;9617.951910240405;8878.112188781328;8964.775880603038;8986.820263594822;8989.325800564853;8999.820003600022;8965.058668839938;9028.954855225682;9032.23226025769;9049.954750226207;9056.592453339746;8825;8862.158094980967;8890.422122562013;8920.884889388826;8930.955345223232;7741.729039483816;7770.611469426619;8228.670853165806;8320.542370169698;8330.416870818985;7571.659275332733;7738.7678369649;7949.244821741925;8081.555514446762;8181.345492360716 10:03:55 INFO - 2015-11-17 10:03:55,948 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:03:55 INFO - 2015-11-17 10:03:55,949 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:03:55 INFO - 2015-11-17 10:03:55,949 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,933 10:03:55 INFO - 2015-11-17 10:03:55,949 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:03:55 INFO - 2015-11-17 10:03:55,949 DEBUG : BROWSER_OUTPUT: __startTimestamp1447783435934__endTimestamp 10:03:55 INFO - 2015-11-17 10:03:55,949 DEBUG : BROWSER_OUTPUT: 10:03:55 INFO - 2015-11-17 10:03:55,949 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:03:55 INFO - 2015-11-17 10:03:55,950 DEBUG : BROWSER_OUTPUT: Number of tests: 6 10:03:55 INFO - 2015-11-17 10:03:55,950 DEBUG : BROWSER_OUTPUT: 10:03:55 INFO - 2015-11-17 10:03:55,950 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4806.57 Median:4979.10 stddev:522.18 (10.5%) stddev-sans-first:499.37 10:03:55 INFO - 2015-11-17 10:03:55,950 DEBUG : BROWSER_OUTPUT: Values: 2794.9 2830.2 2859.7 2872.0 2875.1 4637.7 4688.4 4746.1 4817.1 4837.5 4686.2 4802.6 4806.9 4917.1 4979.1 4350.7 4446.0 4456.7 4471.1 4534.4 4497.5 4555.8 4557.1 4617.8 4620.8 4233.3 4339.5 4369.6 4497.4 4534.2 4307.0 4371.0 4400.1 4437.0 4462.8 4434.7 4441.7 4472.7 4503.5 4508.9 4576.5 4806.8 4837.8 4856.0 4876.7 4927.3 4997.0 5091.6 5096.6 5106.4 5186.3 5232.8 5241.2 5293.4 5296.3 4667.3 4853.0 4898.5 4915.7 4918.3 5093.5 5173.9 5229.6 5336.7 5366.4 5041.9 5055.9 5063.2 5082.3 5149.0 4944.4 5100.1 5154.8 5164.8 5169.9 5020.8 5038.7 5041.2 5044.2 5105.6 5028.4 5046.6 5052.5 5093.4 5093.7 3846.9 3907.4 3920.9 3950.2 3988.2 3582.7 3624.3 3626.2 3632.0 3638.0 4903.0 4932.8 4955.2 4958.4 4959.8 5027.1 5110.1 5114.1 5179.6 5330.0 4884.0 4889.6 4946.3 4951.8 5013.1 4551.1 4558.2 4616.7 4620.6 4647.8 5195.0 5263.9 5323.3 5333.0 5409.4 5202.5 5247.8 5256.6 5264.8 5315.4 5346.1 5366.2 5375.6 5375.7 5430.8 4968.7 5054.1 5056.5 5059.9 5063.3 5030.6 5129.0 5129.5 5149.0 5164.2 4852.8 5073.8 5086.3 5089.5 5091.5 5042.2 5042.8 5083.7 5084.6 5091.8 4753.2 4839.0 4926.2 4944.1 4948.6 5110.4 5113.5 5116.6 5132.6 5139.3 4983.1 5019.2 5020.2 5059.4 5122.7 10:03:55 INFO - 2015-11-17 10:03:55,950 DEBUG : BROWSER_OUTPUT: 10:03:55 INFO - 2015-11-17 10:03:55,952 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:37752.52 Median:30561.39 stddev:59428.02 (194.5%) stddev-sans-first:59528.91 10:03:55 INFO - 2015-11-17 10:03:55,952 DEBUG : BROWSER_OUTPUT: Values: 502.3 505.4 505.4 513.0 513.6 26827.7 34044.1 34872.8 35143.5 35281.1 37169.3 37326.0 37343.0 37603.8 37712.8 7408.4 8103.6 8195.7 8234.3 8277.5 7361.7 9834.7 10029.1 10087.4 10117.6 9744.3 9864.4 9868.4 9917.5 9998.7 7462.7 7652.5 9758.0 9834.8 9920.0 9750.2 9986.4 9992.6 9998.8 10045.1 33514.3 34054.1 34442.5 34456.5 34486.3 2709.1 2713.5 2830.3 2999.7 3150.4 24275.0 24426.5 24612.9 24943.0 25593.2 2087.8 2110.9 2139.3 2158.4 2242.5 224899.0 227203.0 227523.0 229190.0 230757.0 44040.0 45082.0 49758.0 49828.8 49921.0 41116.8 56948.0 57895.0 57925.4 58011.0 14428.1 14617.3 14642.3 14711.0 14744.6 11198.6 11304.0 11314.2 11372.7 11376.9 16193.1 16280.1 16317.3 16332.8 16360.8 6757.8 7031.4 7034.2 7075.3 7088.4 831.2 868.5 965.0 987.9 1035.7 24227.0 24709.1 24717.8 24735.4 25072.6 953.6 960.5 964.0 971.1 1012.9 12191.3 12387.6 12587.6 13204.3 13918.9 264808.0 269885.0 270502.0 270519.0 270826.0 46222.3 46423.3 46551.1 46949.8 46991.5 1216.5 1233.5 1233.7 1245.0 1252.2 21379.7 23997.5 24566.8 24897.8 25716.5 39817.0 40378.4 40462.0 40830.0 40920.4 176967.0 177687.1 177837.0 178106.0 178211.0 23709.9 23915.5 26956.7 27739.4 28177.3 32585.3 33156.3 33417.3 33734.5 33992.3 28909.9 29674.4 32040.2 32650.3 33024.8 30132.7 30556.5 30566.2 30629.0 30681.8 29840.6 31158.7 31237.0 31497.7 31515.5 24860.4 25478.4 26611.2 26936.2 27578.6 20613.2 20642.6 20827.3 20874.4 21063.8 10:03:55 INFO - 2015-11-17 10:03:55,952 DEBUG : BROWSER_OUTPUT: 10:03:55 INFO - 2015-11-17 10:03:55,952 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:23134.08 Median:224682.83 stddev:75407.11 (33.6%) stddev-sans-first:75599.14 10:03:55 INFO - 2015-11-17 10:03:55,953 DEBUG : BROWSER_OUTPUT: Values: 295.5 297.1 304.2 305.0 305.9 15715.2 16016.2 16209.9 16611.3 16622.7 10382.3 10715.6 10728.1 10744.2 16596.3 3413.6 3900.8 3979.3 3999.8 4000.7 3941.0 3960.4 4010.9 4016.4 4019.5 3003.7 3045.9 3081.3 3906.9 3961.4 4167.9 4170.0 4208.1 4261.0 4267.5 3597.2 3605.5 3634.0 3634.6 3638.8 9600.6 9877.1 10064.6 10893.5 11450.8 1396.2 1464.4 1613.1 1658.0 1770.0 8305.6 8318.5 8470.3 8527.9 8554.9 1354.1 1366.8 1386.4 1433.7 1482.6 49536.8 53657.0 53828.0 53943.2 54023.0 5771.5 5812.2 5828.7 5829.2 5900.8 6638.5 6640.3 6650.7 6698.5 6735.8 4949.4 4961.2 4972.4 4972.4 4980.2 5334.7 5392.1 5393.5 5401.0 5459.4 2620.9 2649.3 2652.7 2669.9 2670.4 912.1 916.1 916.2 933.8 981.1 337.8 378.2 417.6 418.1 419.4 8959.3 9967.8 10070.5 10089.8 10303.2 347.5 396.6 408.6 415.7 427.3 5387.6 5455.6 5776.7 5802.8 5810.0 430258.0 448919.0 468807.0 470358.0 477728.0 61823.0 66939.0 67529.7 67702.7 69113.0 437.7 444.8 445.4 446.3 446.7 9583.3 9693.6 9788.1 9839.9 9886.9 30074.8 30526.4 30952.4 30981.7 31780.5 43610.3 43633.0 43703.3 44269.6 44403.8 5464.8 5529.6 5538.0 5545.2 5547.1 9555.5 10117.9 10140.0 10178.0 10397.0 8725.7 8755.5 8757.6 8760.0 8979.5 8061.8 8342.5 8672.8 8811.3 9070.5 9188.0 9281.1 9281.5 9299.4 9301.7 5345.2 5569.0 5571.9 5632.2 5647.3 8893.9 9121.9 9194.3 9316.1 9326.9 10:03:55 INFO - 2015-11-17 10:03:55,954 DEBUG : BROWSER_OUTPUT: 10:03:55 INFO - 2015-11-17 10:03:55,954 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4535.25 Median:5906.50 stddev:2309.41 (39.1%) stddev-sans-first:2301.51 10:03:55 INFO - 2015-11-17 10:03:55,956 DEBUG : BROWSER_OUTPUT: Values: 1106.2 1497.8 1565.9 1611.3 1615.1 5890.3 6229.4 6428.6 6637.2 6639.0 6346.1 6519.7 6534.9 6550.6 6618.3 1876.5 1894.2 1906.3 1922.8 1923.8 1904.8 1938.9 1955.9 2002.8 2041.1 1919.7 1920.4 1929.9 1955.3 1957.1 1836.9 1869.1 1870.8 1874.5 1898.6 1916.0 1916.3 1920.1 1928.1 1945.6 5684.5 6409.1 6427.3 6474.8 6509.5 3653.8 3703.7 3934.2 4052.9 4060.0 2495.3 2509.0 2559.1 2592.5 2599.8 804.9 827.2 830.6 844.6 859.2 8402.8 8422.0 8486.6 8541.8 8545.1 3527.9 3547.8 3553.8 3589.3 3603.8 7072.8 7103.0 7155.5 7161.5 7184.5 4031.6 4088.6 4089.5 4097.9 4102.6 3754.4 3768.1 3795.2 3804.7 3805.8 2806.3 2817.0 2838.8 2855.5 2857.7 890.4 911.4 916.1 927.4 928.4 896.2 913.1 919.6 938.0 1154.5 6100.2 6142.5 6154.5 6154.8 6166.2 420.9 426.9 429.0 1040.7 1095.4 4618.1 4888.3 5001.5 5005.9 5007.2 6564.7 7705.9 7712.4 7718.8 7838.0 7512.8 7536.8 7592.2 7611.8 7615.5 5787.8 6015.8 6120.4 6127.4 6152.0 6140.5 6219.8 6219.9 6228.4 6276.4 6859.4 6873.3 6907.1 7001.7 7054.2 6984.6 7112.4 7137.0 7148.0 7194.3 5823.2 5899.2 5915.5 5920.7 5936.1 5848.6 6310.2 6313.8 6343.2 6355.6 5835.4 5919.6 5957.1 5980.6 5994.0 5789.9 5799.8 5875.0 5913.8 5922.8 5949.6 5984.6 5991.6 5998.4 6006.7 5289.6 5423.3 5430.0 5441.1 5452.7 5478.0 5519.1 5532.7 5538.1 5579.1 10:03:55 INFO - 2015-11-17 10:03:55,956 DEBUG : BROWSER_OUTPUT: 10:03:55 INFO - 2015-11-17 10:03:55,956 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4851.17 Median:5626.66 stddev:1507.55 (26.8%) stddev-sans-first:1472.07 10:03:55 INFO - 2015-11-17 10:03:55,957 DEBUG : BROWSER_OUTPUT: Values: 271.8 276.5 278.7 284.6 287.6 5426.3 5448.9 5504.6 5553.1 5558.6 5376.8 5548.4 5570.7 5572.2 5585.4 4165.4 4191.6 4198.3 4200.7 4213.3 4029.8 4154.4 4170.7 4198.4 4203.3 3895.1 4096.7 4111.6 4127.2 4140.1 4059.7 4062.3 4079.4 4085.3 4101.2 3492.3 3558.8 3571.2 3591.2 3618.0 5327.7 5381.8 5383.4 5399.4 5401.4 4676.1 4702.7 4735.1 4742.9 4745.5 5585.5 5749.7 5800.8 5831.7 5834.8 3874.8 3876.8 3913.3 3917.1 3927.4 6134.6 6136.8 6144.0 6160.0 6162.1 3939.2 3958.9 3976.3 4010.3 4011.4 3892.8 4004.2 4020.0 4033.4 4050.4 4657.3 4663.9 4694.9 4713.8 4714.8 5601.2 5771.2 5773.6 5837.2 5852.8 1366.3 1389.5 1410.4 1418.0 1422.3 907.9 909.1 912.7 917.6 920.3 5594.2 5605.3 5629.0 5629.8 5633.6 6058.6 6061.1 6077.3 6079.6 6089.9 5615.8 5624.7 5628.6 5632.7 5633.0 3165.3 3255.2 3270.9 3283.1 3286.8 6214.9 6219.3 6236.3 6244.4 6245.7 6181.1 6186.3 6186.8 6188.8 6209.8 6029.8 6202.4 6218.4 6224.0 6245.2 6021.3 6036.8 6056.0 6058.2 6063.6 5894.3 5907.1 5929.1 5931.8 5956.9 6210.6 6220.0 6220.3 6222.6 6251.1 3927.2 3967.8 4010.0 4017.7 4024.5 5871.7 5938.3 5949.6 6172.7 6197.5 5737.8 5819.3 5855.3 5909.6 5943.3 5819.6 5885.3 5887.0 5907.1 5949.0 5630.7 5715.9 5774.9 5804.2 5816.8 5863.0 5919.1 5937.6 5937.6 5968.1 5763.8 5775.8 5808.8 5831.7 5846.9 10:03:55 INFO - 2015-11-17 10:03:55,957 DEBUG : BROWSER_OUTPUT: 10:03:55 INFO - 2015-11-17 10:03:55,957 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11537.95 Median:3045.68 stddev:14029.54 (460.6%) stddev-sans-first:14045.18 10:03:55 INFO - 2015-11-17 10:03:55,957 DEBUG : BROWSER_OUTPUT: Values: 674.7 675.5 678.9 692.2 696.3 12127.9 12238.6 12374.8 12377.2 12393.3 10236.4 10364.8 12165.7 12528.2 12538.0 768.7 774.3 783.3 784.1 785.3 579.9 593.2 597.6 605.3 753.1 780.8 788.3 798.2 798.9 810.0 788.1 789.7 795.9 799.5 803.1 461.1 468.2 577.7 585.0 588.7 11833.9 11963.8 12003.8 12042.1 12172.8 7943.7 8180.1 8410.5 8466.0 8558.6 7770.4 7820.9 8030.9 8158.1 8251.1 2482.3 2549.1 2572.0 2633.6 2650.8 41540.6 41953.0 42282.0 42374.0 42398.4 5136.1 5535.0 5587.4 5660.2 5789.8 10715.8 10764.5 10826.9 10865.0 10904.6 5377.9 5453.5 5460.6 5471.9 5732.1 3302.3 3330.9 3418.4 3441.4 3484.5 2345.1 2357.4 2389.1 2391.6 2411.3 354.6 356.2 356.6 359.2 364.8 416.3 542.2 542.7 556.4 575.1 6562.6 7223.9 7545.2 7708.3 7971.9 436.6 490.0 524.8 538.8 539.5 3136.4 3374.3 3384.8 3450.6 3453.6 48770.3 48772.3 48783.3 48963.8 49577.8 43893.3 44766.8 44960.1 45014.3 45207.8 41109.4 41161.4 41359.8 42276.4 42344.2 7277.7 7376.3 7460.0 7524.2 7710.2 30706.0 30872.4 31152.0 31682.5 31938.4 36910.6 37345.6 38706.2 40763.0 40827.0 8720.3 8966.3 9064.7 9224.8 9346.7 9456.0 9504.1 9519.1 9521.8 9618.0 8878.1 8964.8 8986.8 8989.3 8999.8 8965.1 9029.0 9032.2 9050.0 9056.6 8825.0 8862.2 8890.4 8920.9 8931.0 7741.7 7770.6 8228.7 8320.5 8330.4 7571.7 7738.8 7949.2 8081.6 8181.3 10:03:55 INFO - 2015-11-17 10:03:55,959 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:03:55 INFO - 2015-11-17 10:03:55,959 DEBUG : BROWSER_OUTPUT: 10:03:56 INFO - 2015-11-17 10:03:56,642 INFO : Browser exited with error code: 0 10:03:56 INFO - 2015-11-17 10:03:56,673 INFO : Completed test dromaeo_css (00:18:36) 10:03:56 INFO - 2015-11-17 10:03:56,674 INFO : Starting test kraken 10:03:56 INFO - 2015-11-17 10:03:56,674 DEBUG : operating with platform_type : mac_ 10:03:56 INFO - 2015-11-17 10:03:56,674 INFO : Initialising browser for kraken test... 10:03:56 INFO - 2015-11-17 10:03:56,689 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/tmpn5eWXu/profile http://localhost:49267/getInfo.html 10:03:59 INFO - 2015-11-17 10:03:59,098 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:03:59 INFO - 2015-11-17 10:03:59,098 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:03:59 INFO - 2015-11-17 10:03:59,098 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 10:03:59 INFO - 2015-11-17 10:03:59,099 DEBUG : BROWSER_OUTPUT: __metrics 10:03:59 INFO - 2015-11-17 10:03:59,115 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:03:59 INFO - 2015-11-17 10:03:59,422 DEBUG : BROWSER_OUTPUT: console.error: 10:03:59 INFO - 2015-11-17 10:03:59,422 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 10:03:59 INFO - 2015-11-17 10:03:59,422 DEBUG : BROWSER_OUTPUT: Stack: 10:03:59 INFO - 2015-11-17 10:03:59,422 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 10:03:59 INFO - 2015-11-17 10:03:59,423 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 10:03:59 INFO - 2015-11-17 10:03:59,423 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 10:03:59 INFO - 2015-11-17 10:03:59,423 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 10:03:59 INFO - 2015-11-17 10:03:59,423 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 10:03:59 INFO - 2015-11-17 10:03:59,423 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 10:03:59 INFO - 2015-11-17 10:03:59,423 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 10:03:59 INFO - 2015-11-17 10:03:59,423 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 10:03:59 INFO - 2015-11-17 10:03:59,423 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 10:03:59 INFO - 2015-11-17 10:03:59,423 DEBUG : BROWSER_OUTPUT: 10:03:59 INFO - 2015-11-17 10:03:59,905 INFO : Browser initialized. 10:03:59 INFO - 2015-11-17 10:03:59,905 INFO : Running cycle 1/1 for kraken test... 10:03:59 INFO - 2015-11-17 10:03:59,905 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/tmpn5eWXu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:04:11 INFO - 2015-11-17 10:04:11,976 DEBUG : BROWSER_OUTPUT: RSS: Main: 229335040 10:04:11 INFO - 2015-11-17 10:04:11,976 DEBUG : BROWSER_OUTPUT: 10:04:14 INFO - 2015-11-17 10:04:14,810 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 10:04:15 INFO - 2015-11-17 10:04:15,395 DEBUG : BROWSER_OUTPUT: RSS: Main: 285097984 10:04:15 INFO - 2015-11-17 10:04:15,395 DEBUG : BROWSER_OUTPUT: 10:04:18 INFO - 2015-11-17 10:04:18,344 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 10:04:18 INFO - 2015-11-17 10:04:18,928 DEBUG : BROWSER_OUTPUT: RSS: Main: 299507712 10:04:18 INFO - 2015-11-17 10:04:18,929 DEBUG : BROWSER_OUTPUT: 10:04:22 INFO - 2015-11-17 10:04:22,190 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 10:04:22 INFO - 2015-11-17 10:04:22,772 DEBUG : BROWSER_OUTPUT: RSS: Main: 283365376 10:04:22 INFO - 2015-11-17 10:04:22,772 DEBUG : BROWSER_OUTPUT: 10:04:24 INFO - 2015-11-17 10:04:24,979 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 10:04:25 INFO - 2015-11-17 10:04:25,564 DEBUG : BROWSER_OUTPUT: RSS: Main: 286404608 10:04:25 INFO - 2015-11-17 10:04:25,564 DEBUG : BROWSER_OUTPUT: 10:04:27 INFO - 2015-11-17 10:04:27,954 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:04:28 INFO - 2015-11-17 10:04:28,522 DEBUG : BROWSER_OUTPUT: RSS: Main: 285630464 10:04:28 INFO - 2015-11-17 10:04:28,522 DEBUG : BROWSER_OUTPUT: 10:04:31 INFO - 2015-11-17 10:04:31,910 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 10:04:32 INFO - 2015-11-17 10:04:32,493 DEBUG : BROWSER_OUTPUT: RSS: Main: 285356032 10:04:32 INFO - 2015-11-17 10:04:32,493 DEBUG : BROWSER_OUTPUT: 10:04:35 INFO - 2015-11-17 10:04:35,965 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 10:04:36 INFO - 2015-11-17 10:04:36,554 DEBUG : BROWSER_OUTPUT: RSS: Main: 285908992 10:04:36 INFO - 2015-11-17 10:04:36,554 DEBUG : BROWSER_OUTPUT: 10:04:39 INFO - 2015-11-17 10:04:39,668 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 10:04:40 INFO - 2015-11-17 10:04:40,252 DEBUG : BROWSER_OUTPUT: RSS: Main: 286097408 10:04:40 INFO - 2015-11-17 10:04:40,253 DEBUG : BROWSER_OUTPUT: 10:04:41 INFO - 2015-11-17 10:04:41,958 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:04:42 INFO - 2015-11-17 10:04:42,528 DEBUG : BROWSER_OUTPUT: RSS: Main: 318967808 10:04:42 INFO - 2015-11-17 10:04:42,528 DEBUG : BROWSER_OUTPUT: 10:04:44 INFO - 2015-11-17 10:04:44,516 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:04:45 INFO - 2015-11-17 10:04:45,137 DEBUG : BROWSER_OUTPUT: RSS: Main: 321482752 10:04:45 INFO - 2015-11-17 10:04:45,138 DEBUG : BROWSER_OUTPUT: 10:04:47 INFO - 2015-11-17 10:04:47,413 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:04:48 INFO - 2015-11-17 10:04:48,002 DEBUG : BROWSER_OUTPUT: RSS: Main: 328237056 10:04:48 INFO - 2015-11-17 10:04:48,002 DEBUG : BROWSER_OUTPUT: 10:04:50 INFO - 2015-11-17 10:04:50,831 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:04:51 INFO - 2015-11-17 10:04:51,421 DEBUG : BROWSER_OUTPUT: RSS: Main: 329584640 10:04:51 INFO - 2015-11-17 10:04:51,421 DEBUG : BROWSER_OUTPUT: 10:04:54 INFO - 2015-11-17 10:04:54,331 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:04:54 INFO - 2015-11-17 10:04:54,915 DEBUG : BROWSER_OUTPUT: RSS: Main: 328249344 10:04:54 INFO - 2015-11-17 10:04:54,915 DEBUG : BROWSER_OUTPUT: 10:04:56 INFO - 2015-11-17 10:04:56,790 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 10:04:57 INFO - 2015-11-17 10:04:57,054 DEBUG : BROWSER_OUTPUT: RSS: Main: 387674112 10:04:57 INFO - 2015-11-17 10:04:57,054 DEBUG : BROWSER_OUTPUT: 10:04:57 INFO - 2015-11-17 10:04:57,054 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:04:57 INFO - 2015-11-17 10:04:57,054 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:04:57 INFO - 2015-11-17 10:04:57,054 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:04:57 INFO - 2015-11-17 10:04:57,055 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:04:57 INFO - 2015-11-17 10:04:57,055 DEBUG : BROWSER_OUTPUT: |0;ai-astar;119;121;119;124;121;120;119;120;115;125 10:04:57 INFO - 2015-11-17 10:04:57,055 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;178;152;179;191;148;167;173;149;189;148 10:04:57 INFO - 2015-11-17 10:04:57,055 DEBUG : BROWSER_OUTPUT: |2;audio-dft;179;188;189;181;182;186;182;175;183;188 10:04:57 INFO - 2015-11-17 10:04:57,055 DEBUG : BROWSER_OUTPUT: |3;audio-fft;84;92;107;101;79;81;81;94;95;79 10:04:57 INFO - 2015-11-17 10:04:57,055 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;109;110;155;104;105;102;145;100;100;154 10:04:57 INFO - 2015-11-17 10:04:57,055 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;136;141;132;135;135;143;139;128;135;135 10:04:57 INFO - 2015-11-17 10:04:57,055 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;142;148;145;141;141;148;145;141 10:04:57 INFO - 2015-11-17 10:04:57,055 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;118;110;109;110;109;104;109;109;110;118 10:04:57 INFO - 2015-11-17 10:04:57,055 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;65;67;68;68;68;71;70;80;69;68 10:04:57 INFO - 2015-11-17 10:04:57,055 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;76;78;77;79;82;83;83;78;78;80 10:04:57 INFO - 2015-11-17 10:04:57,055 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;99;97;101;101;100;98;96;100;100;101 10:04:57 INFO - 2015-11-17 10:04:57,055 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;144;148;147;143;151;142;141;141;149;146 10:04:57 INFO - 2015-11-17 10:04:57,055 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;168;163;182;185;175;176;180;179;175;163 10:04:57 INFO - 2015-11-17 10:04:57,056 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;77;80;79;83;83;83;83;81;82;80 10:04:57 INFO - 2015-11-17 10:04:57,056 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:04:57 INFO - 2015-11-17 10:04:57,056 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:04:57 INFO - 2015-11-17 10:04:57,056 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,935 10:04:57 INFO - 2015-11-17 10:04:57,056 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:04:57 INFO - 2015-11-17 10:04:57,056 DEBUG : BROWSER_OUTPUT: __startTimestamp1447783497053__endTimestamp 10:04:57 INFO - 2015-11-17 10:04:57,056 DEBUG : BROWSER_OUTPUT: 10:04:57 INFO - 2015-11-17 10:04:57,058 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:04:57 INFO - 2015-11-17 10:04:57,058 DEBUG : BROWSER_OUTPUT: Number of tests: 14 10:04:57 INFO - 2015-11-17 10:04:57,058 DEBUG : BROWSER_OUTPUT: 10:04:57 INFO - 2015-11-17 10:04:57,058 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:120.30 Median:120.50 stddev:2.79 (2.3%) stddev-sans-first:2.92 10:04:57 INFO - 2015-11-17 10:04:57,059 DEBUG : BROWSER_OUTPUT: Values: 119.0 121.0 119.0 124.0 121.0 120.0 119.0 120.0 115.0 125.0 10:04:57 INFO - 2015-11-17 10:04:57,059 DEBUG : BROWSER_OUTPUT: 10:04:57 INFO - 2015-11-17 10:04:57,059 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:167.40 Median:175.50 stddev:17.10 (9.7%) stddev-sans-first:17.70 10:04:57 INFO - 2015-11-17 10:04:57,059 DEBUG : BROWSER_OUTPUT: Values: 178.0 152.0 179.0 191.0 148.0 167.0 173.0 149.0 189.0 148.0 10:04:57 INFO - 2015-11-17 10:04:57,059 DEBUG : BROWSER_OUTPUT: 10:04:57 INFO - 2015-11-17 10:04:57,060 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:183.30 Median:184.50 stddev:4.47 (2.4%) stddev-sans-first:4.47 10:04:57 INFO - 2015-11-17 10:04:57,060 DEBUG : BROWSER_OUTPUT: Values: 179.0 188.0 189.0 181.0 182.0 186.0 182.0 175.0 183.0 188.0 10:04:57 INFO - 2015-11-17 10:04:57,061 DEBUG : BROWSER_OUTPUT: 10:04:57 INFO - 2015-11-17 10:04:57,062 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:89.30 Median:82.50 stddev:9.94 (12.1%) stddev-sans-first:10.36 10:04:57 INFO - 2015-11-17 10:04:57,062 DEBUG : BROWSER_OUTPUT: Values: 84.0 92.0 107.0 101.0 79.0 81.0 81.0 94.0 95.0 79.0 10:04:57 INFO - 2015-11-17 10:04:57,062 DEBUG : BROWSER_OUTPUT: 10:04:57 INFO - 2015-11-17 10:04:57,062 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:118.40 Median:109.50 stddev:23.11 (21.1%) stddev-sans-first:24.26 10:04:57 INFO - 2015-11-17 10:04:57,062 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 155.0 104.0 105.0 102.0 145.0 100.0 100.0 154.0 10:04:57 INFO - 2015-11-17 10:04:57,063 DEBUG : BROWSER_OUTPUT: 10:04:57 INFO - 2015-11-17 10:04:57,063 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:135.90 Median:135.50 stddev:4.31 (3.2%) stddev-sans-first:4.57 10:04:57 INFO - 2015-11-17 10:04:57,063 DEBUG : BROWSER_OUTPUT: Values: 136.0 141.0 132.0 135.0 135.0 143.0 139.0 128.0 135.0 135.0 10:04:57 INFO - 2015-11-17 10:04:57,063 DEBUG : BROWSER_OUTPUT: 10:04:57 INFO - 2015-11-17 10:04:57,063 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:144.60 Median:146.00 stddev:3.10 (2.1%) stddev-sans-first:3.03 10:04:57 INFO - 2015-11-17 10:04:57,063 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 142.0 148.0 145.0 141.0 141.0 148.0 145.0 141.0 10:04:57 INFO - 2015-11-17 10:04:57,064 DEBUG : BROWSER_OUTPUT: 10:04:57 INFO - 2015-11-17 10:04:57,064 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:110.60 Median:110.00 stddev:4.27 (3.9%) stddev-sans-first:3.60 10:04:57 INFO - 2015-11-17 10:04:57,064 DEBUG : BROWSER_OUTPUT: Values: 118.0 110.0 109.0 110.0 109.0 104.0 109.0 109.0 110.0 118.0 10:04:57 INFO - 2015-11-17 10:04:57,064 DEBUG : BROWSER_OUTPUT: 10:04:57 INFO - 2015-11-17 10:04:57,064 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:69.40 Median:68.50 stddev:4.06 (5.9%) stddev-sans-first:3.98 10:04:57 INFO - 2015-11-17 10:04:57,064 DEBUG : BROWSER_OUTPUT: Values: 65.0 67.0 68.0 68.0 68.0 71.0 70.0 80.0 69.0 68.0 10:04:57 INFO - 2015-11-17 10:04:57,064 DEBUG : BROWSER_OUTPUT: 10:04:57 INFO - 2015-11-17 10:04:57,065 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:79.40 Median:79.50 stddev:2.50 (3.1%) stddev-sans-first:2.33 10:04:57 INFO - 2015-11-17 10:04:57,065 DEBUG : BROWSER_OUTPUT: Values: 76.0 78.0 77.0 79.0 82.0 83.0 83.0 78.0 78.0 80.0 10:04:57 INFO - 2015-11-17 10:04:57,065 DEBUG : BROWSER_OUTPUT: 10:04:57 INFO - 2015-11-17 10:04:57,065 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:99.30 Median:98.50 stddev:1.77 (1.8%) stddev-sans-first:1.87 10:04:57 INFO - 2015-11-17 10:04:57,065 DEBUG : BROWSER_OUTPUT: Values: 99.0 97.0 101.0 101.0 100.0 98.0 96.0 100.0 100.0 101.0 10:04:57 INFO - 2015-11-17 10:04:57,065 DEBUG : BROWSER_OUTPUT: 10:04:57 INFO - 2015-11-17 10:04:57,065 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:145.20 Median:146.50 stddev:3.52 (2.4%) stddev-sans-first:3.71 10:04:57 INFO - 2015-11-17 10:04:57,065 DEBUG : BROWSER_OUTPUT: Values: 144.0 148.0 147.0 143.0 151.0 142.0 141.0 141.0 149.0 146.0 10:04:57 INFO - 2015-11-17 10:04:57,066 DEBUG : BROWSER_OUTPUT: 10:04:57 INFO - 2015-11-17 10:04:57,066 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.60 Median:177.50 stddev:7.65 (4.3%) stddev-sans-first:7.73 10:04:57 INFO - 2015-11-17 10:04:57,066 DEBUG : BROWSER_OUTPUT: Values: 168.0 163.0 182.0 185.0 175.0 176.0 180.0 179.0 175.0 163.0 10:04:57 INFO - 2015-11-17 10:04:57,066 DEBUG : BROWSER_OUTPUT: 10:04:57 INFO - 2015-11-17 10:04:57,066 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:81.10 Median:82.50 stddev:2.08 (2.5%) stddev-sans-first:1.59 10:04:57 INFO - 2015-11-17 10:04:57,066 DEBUG : BROWSER_OUTPUT: Values: 77.0 80.0 79.0 83.0 83.0 83.0 83.0 81.0 82.0 80.0 10:04:57 INFO - 2015-11-17 10:04:57,066 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:04:57 INFO - 2015-11-17 10:04:57,066 DEBUG : BROWSER_OUTPUT: 10:04:57 INFO - 2015-11-17 10:04:57,797 INFO : Browser exited with error code: 0 10:04:57 INFO - 2015-11-17 10:04:57,850 INFO : Completed test kraken (00:01:01) 10:04:57 INFO - 2015-11-17 10:04:57,850 INFO : Starting test v8_7 10:04:57 INFO - 2015-11-17 10:04:57,850 DEBUG : operating with platform_type : mac_ 10:04:57 INFO - 2015-11-17 10:04:57,851 INFO : Initialising browser for v8_7 test... 10:04:57 INFO - 2015-11-17 10:04:57,865 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/tmps_wcQv/profile http://localhost:49267/getInfo.html 10:05:00 INFO - 2015-11-17 10:05:00,232 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:05:00 INFO - 2015-11-17 10:05:00,232 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:05:00 INFO - 2015-11-17 10:05:00,232 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 10:05:00 INFO - 2015-11-17 10:05:00,232 DEBUG : BROWSER_OUTPUT: __metrics 10:05:00 INFO - 2015-11-17 10:05:00,252 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:05:01 INFO - 2015-11-17 10:05:01,003 INFO : Browser initialized. 10:05:01 INFO - 2015-11-17 10:05:01,004 INFO : Running cycle 1/1 for v8_7 test... 10:05:01 INFO - 2015-11-17 10:05:01,004 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/tmps_wcQv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:05:13 INFO - 2015-11-17 10:05:13,057 DEBUG : BROWSER_OUTPUT: RSS: Main: 228720640 10:05:13 INFO - 2015-11-17 10:05:13,057 DEBUG : BROWSER_OUTPUT: 10:05:35 INFO - 2015-11-17 10:05:35,941 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/v8_7/run.html (next: http://localhost:49267/tests/v8_7/run.html) 10:05:36 INFO - 2015-11-17 10:05:36,200 DEBUG : BROWSER_OUTPUT: RSS: Main: 768585728 10:05:36 INFO - 2015-11-17 10:05:36,200 DEBUG : BROWSER_OUTPUT: 10:05:36 INFO - 2015-11-17 10:05:36,200 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:05:36 INFO - 2015-11-17 10:05:36,201 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:05:36 INFO - 2015-11-17 10:05:36,201 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:05:36 INFO - 2015-11-17 10:05:36,201 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:05:36 INFO - 2015-11-17 10:05:36,201 DEBUG : BROWSER_OUTPUT: |0;Richards;188.6080724254998 10:05:36 INFO - 2015-11-17 10:05:36,201 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;217.3913043478261 10:05:36 INFO - 2015-11-17 10:05:36,201 DEBUG : BROWSER_OUTPUT: |2;Encrypt;360.1008282319049 10:05:36 INFO - 2015-11-17 10:05:36,201 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6724.832214765101 10:05:36 INFO - 2015-11-17 10:05:36,202 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2197.802197802198 10:05:36 INFO - 2015-11-17 10:05:36,202 DEBUG : BROWSER_OUTPUT: |5;Earley;1013.1712259371834 10:05:36 INFO - 2015-11-17 10:05:36,202 DEBUG : BROWSER_OUTPUT: |6;Boyer;14385.714285714286 10:05:36 INFO - 2015-11-17 10:05:36,202 DEBUG : BROWSER_OUTPUT: |7;RegExp;33409.83606557377 10:05:36 INFO - 2015-11-17 10:05:36,202 DEBUG : BROWSER_OUTPUT: |8;Splay;763.9419404125287 10:05:36 INFO - 2015-11-17 10:05:36,202 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6464.5161290322585 10:05:36 INFO - 2015-11-17 10:05:36,202 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:05:36 INFO - 2015-11-17 10:05:36,203 DEBUG : BROWSER_OUTPUT: __startTimestamp1447783536192__endTimestamp 10:05:36 INFO - 2015-11-17 10:05:36,203 DEBUG : BROWSER_OUTPUT: 10:05:36 INFO - 2015-11-17 10:05:36,203 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:05:36 INFO - 2015-11-17 10:05:36,203 DEBUG : BROWSER_OUTPUT: Number of tests: 10 10:05:36 INFO - 2015-11-17 10:05:36,203 DEBUG : BROWSER_OUTPUT: 10:05:36 INFO - 2015-11-17 10:05:36,203 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:188.61 Median:188.61 stddev:0.00 (0.0%) 10:05:36 INFO - 2015-11-17 10:05:36,203 DEBUG : BROWSER_OUTPUT: Values: 188.6 10:05:36 INFO - 2015-11-17 10:05:36,203 DEBUG : BROWSER_OUTPUT: 10:05:36 INFO - 2015-11-17 10:05:36,204 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:217.39 Median:217.39 stddev:0.00 (0.0%) 10:05:36 INFO - 2015-11-17 10:05:36,204 DEBUG : BROWSER_OUTPUT: Values: 217.4 10:05:36 INFO - 2015-11-17 10:05:36,204 DEBUG : BROWSER_OUTPUT: 10:05:36 INFO - 2015-11-17 10:05:36,204 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:360.10 Median:360.10 stddev:0.00 (0.0%) 10:05:36 INFO - 2015-11-17 10:05:36,204 DEBUG : BROWSER_OUTPUT: Values: 360.1 10:05:36 INFO - 2015-11-17 10:05:36,204 DEBUG : BROWSER_OUTPUT: 10:05:36 INFO - 2015-11-17 10:05:36,204 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6724.83 Median:6724.83 stddev:0.00 (0.0%) 10:05:36 INFO - 2015-11-17 10:05:36,204 DEBUG : BROWSER_OUTPUT: Values: 6724.8 10:05:36 INFO - 2015-11-17 10:05:36,205 DEBUG : BROWSER_OUTPUT: 10:05:36 INFO - 2015-11-17 10:05:36,205 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2197.80 Median:2197.80 stddev:0.00 (0.0%) 10:05:36 INFO - 2015-11-17 10:05:36,205 DEBUG : BROWSER_OUTPUT: Values: 2197.8 10:05:36 INFO - 2015-11-17 10:05:36,205 DEBUG : BROWSER_OUTPUT: 10:05:36 INFO - 2015-11-17 10:05:36,205 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:1013.17 Median:1013.17 stddev:0.00 (0.0%) 10:05:36 INFO - 2015-11-17 10:05:36,205 DEBUG : BROWSER_OUTPUT: Values: 1013.2 10:05:36 INFO - 2015-11-17 10:05:36,205 DEBUG : BROWSER_OUTPUT: 10:05:36 INFO - 2015-11-17 10:05:36,205 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:14385.71 Median:14385.71 stddev:0.00 (0.0%) 10:05:36 INFO - 2015-11-17 10:05:36,205 DEBUG : BROWSER_OUTPUT: Values: 14385.7 10:05:36 INFO - 2015-11-17 10:05:36,206 DEBUG : BROWSER_OUTPUT: 10:05:36 INFO - 2015-11-17 10:05:36,206 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:33409.84 Median:33409.84 stddev:0.00 (0.0%) 10:05:36 INFO - 2015-11-17 10:05:36,206 DEBUG : BROWSER_OUTPUT: Values: 33409.8 10:05:36 INFO - 2015-11-17 10:05:36,206 DEBUG : BROWSER_OUTPUT: 10:05:36 INFO - 2015-11-17 10:05:36,206 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:763.94 Median:763.94 stddev:0.00 (0.0%) 10:05:36 INFO - 2015-11-17 10:05:36,206 DEBUG : BROWSER_OUTPUT: Values: 763.9 10:05:36 INFO - 2015-11-17 10:05:36,206 DEBUG : BROWSER_OUTPUT: 10:05:36 INFO - 2015-11-17 10:05:36,206 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6464.52 Median:6464.52 stddev:0.00 (0.0%) 10:05:36 INFO - 2015-11-17 10:05:36,207 DEBUG : BROWSER_OUTPUT: Values: 6464.5 10:05:36 INFO - 2015-11-17 10:05:36,207 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:05:36 INFO - 2015-11-17 10:05:36,207 DEBUG : BROWSER_OUTPUT: 10:05:36 INFO - 2015-11-17 10:05:36,928 INFO : Browser exited with error code: 0 10:05:36 INFO - 2015-11-17 10:05:36,950 INFO : Completed test v8_7 (00:00:39) 10:05:37 INFO - 2015-11-17 10:05:37,402 INFO : Completed test suite (00:20:17) 10:05:37 INFO - 2015-11-17 10:05:37,402 DEBUG : Working with test: dromaeo_css 10:05:37 INFO - 2015-11-17 10:05:37,402 DEBUG : Generating results file: dromaeo_css 10:05:37 INFO - 2015-11-17 10:05:37,403 DEBUG : Working with test: kraken 10:05:37 INFO - 2015-11-17 10:05:37,403 DEBUG : Generating results file: kraken 10:05:37 INFO - 2015-11-17 10:05:37,403 INFO : javascript benchmark 10:05:37 INFO - 2015-11-17 10:05:37,403 DEBUG : Working with test: v8_7 10:05:37 INFO - 2015-11-17 10:05:37,403 DEBUG : Generating results file: v8_7 10:05:37 INFO - 2015-11-17 10:05:37,404 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:05:37 INFO - 2015-11-17 10:05:37,458 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,55]] 10:05:37 INFO - 2015-11-17 10:05:37,458 DEBUG : process_Request line: dromaeo_css 5771.58 graph.html#tests=[[72,63,55]] 10:05:37 INFO - 2015-11-17 10:05:37,458 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:05:37 INFO - 2015-11-17 10:05:37,490 DEBUG : process_Request line: kraken 1718.80 graph.html#tests=[[232,63,55]] 10:05:37 INFO - 2015-11-17 10:05:37,490 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:05:37 INFO - 2015-11-17 10:05:37,522 DEBUG : process_Request line: v8_7 16137.87 graph.html#tests=[[230,63,55]] 10:05:37 INFO - 2015-11-17 10:05:37,523 INFO : javascript benchmark 10:05:37 INFO - 2015-11-17 10:05:37,525 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2794.9099851058086, 2830.235836324191, 2859.656841179059, 2872.037867314451, 2875.1087162979484, 4637.7217366958, 4688.367070445489, 4746.121967436026, 4817.132916075109, 4837.467878533363, 4686.156491831469, 4802.639802014845, 4806.9038619227595, 4917.114919314522, 4979.10376132296, 4350.73895566267, 4446.0441005183875, 4456.732596044248, 4471.128130014648, 4534.433195850519, 4497.527759585246, 4555.840545580905, 4557.134144512532, 4617.769111544426, 4620.815167393317, 4233.301505251629, 4339.457567804025, 4369.584889435499, 4497.437820272466, 4534.183846907556, 4307.0, 4370.978145109254, 4400.097979914142, 4436.9556304436865, 4462.754548499831, 4434.733915965053, 4441.71128876622, 4472.731636101845, 4503.549645035503, 4508.864734057984, 4576.496585375606, 4806.807727690888, 4837.782299796518, 4855.951440485585, 4876.68301560401, 4927.334809800667, 4996.950030499721, 5091.643584949055, 5096.643234973553, 5106.412762532282, 5186.273921650972, 5232.843014709527, 5241.161414173752, 5293.3647962244395, 5296.25852380667, 4667.346571479996, 4853.0, 4898.519989844522, 4915.680480768739, 4918.286848407032, 5093.516115968977, 5173.948260517422, 5229.607779416483, 5336.733163341817, 5366.356037275474, 5041.9411923495745, 5055.8988820223385, 5063.240513922868, 5082.263071854561, 5149.0, 4944.431390390079, 5100.132977393852, 5154.793808247703, 5164.793408263702, 5169.896602068013, 5020.849374518771, 5038.722870242099, 5041.193409054607, 5044.218146187347, 5105.591552675852, 5028.371453568304, 5046.571041461517, 5052.520010598987, 5093.439721630618, 5093.668911520739, 3846.9230615387537, 3907.433422153772, 3920.941185882157, 3950.20995800841, 3988.202359528106, 3582.731295152874, 3624.293262813726, 3626.202235508184, 3631.963680363215, 3638.0, 4902.950970490321, 4932.778024988884, 4955.207166853358, 4958.355413796184, 4959.801607935642, 5027.120253955543, 5110.131277682803, 5114.105031619451, 5179.637425380262, 5330.040592693353, 4884.0476107158765, 4889.559939605452, 4946.307516947631, 4951.752412379366, 5013.147764879979, 4551.089782043605, 4558.2251017327135, 4616.722996620214, 4620.584147426748, 4647.837325693585, 5195.038917800219, 5263.894722105613, 5323.254744335796, 5333.040052790535, 5409.404965453718, 5202.531772140525, 5247.816326428557, 5256.6320357574605, 5264.842054738364, 5315.3621565412395, 5346.144616861284, 5366.195070739421, 5375.569954403716, 5375.731213439391, 5430.8099216527235, 4968.701877887338, 5054.064997975386, 5056.544910958031, 5059.898802024012, 5063.3417655706, 5030.5975521957425, 5129.025485157808, 5129.512696293846, 5148.9742551287, 5164.173732202829, 4852.8301509447, 5073.822416215415, 5086.313347698161, 5089.491050894881, 5091.490850914879, 5042.193249080129, 5042.773075211551, 5083.669561478492, 5084.644074914869, 5091.821786237464, 4753.191957367187, 4838.951610483991, 4926.236433352836, 4944.085344211332, 4948.604111671129, 5110.4123025852505, 5113.488651134857, 5116.590672746246, 5132.5893928486375, 5139.254808052886, 4983.053219888209, 5019.222020586815, 5020.171671674133, 5059.367579052619, 5122.718250496258], "unit": "ms", "name": "dojo.html", "value": 4773.091602135145}, {"lowerIsBetter": false, "replicates": [502.2817371159242, 505.3910038403724, 505.40362372400574, 513.0278122956998, 513.5634710496079, 26827.73172268277, 34044.148896277606, 34872.82563587185, 35143.4728479073, 35281.11797205071, 37169.256614867685, 37326.0, 37343.0, 37603.81198094006, 37712.811435942785, 7408.407327413821, 8103.635336409861, 8195.71315003975, 8234.300084492825, 8277.503349799, 7361.742339018136, 9834.70495885121, 10029.1475224606, 10087.394756314608, 10117.645882394118, 9744.31789774716, 9864.35881667693, 9868.358556693827, 9917.504124793768, 9998.700038998843, 7462.7014919403155, 7652.464327497078, 9757.951210243938, 9834.754131146743, 9919.950400248024, 9750.171235444996, 9986.400815951067, 9992.550335234931, 9998.800023999553, 10045.095941365313, 33514.32971340584, 34054.14864628379, 34442.483362749575, 34456.48315275273, 34486.31027379463, 2709.0518318588533, 2713.470873179731, 2830.3348713052414, 2999.6700362960055, 3150.401423729507, 24275.0, 24426.51146977068, 24612.876935615208, 24943.0, 25593.23220303394, 2087.8016588424075, 2110.89445527723, 2139.336805590272, 2158.4280165756086, 2242.4505996031075, 224899.0, 227202.99999999834, 227523.0, 229190.0, 230757.0, 44040.0, 45082.0, 49758.0, 49828.75085624549, 49921.0, 41116.794416027726, 56948.0, 57895.0, 57925.420745792006, 58011.0, 14428.134311941318, 14617.342219600143, 14642.341094650767, 14711.0, 14744.55766327012, 11198.552057917756, 11304.0, 11314.151438642135, 11372.658820235407, 11376.886231137749, 16193.109378984269, 16280.104594247194, 16317.34730610786, 16332.83667163337, 16360.754588681179, 6757.797266082025, 7031.417930965594, 7034.19106802714, 7075.292470752986, 7088.3974862136265, 831.2145022953251, 868.4615538366253, 964.9783703141907, 987.8863930647924, 1035.694470131313, 24227.0, 24709.135180268604, 24717.752822471906, 24735.3816154594, 25072.623910641356, 953.6376177052675, 960.4765402855461, 963.9662611808553, 971.1453920550013, 1012.9290949633455, 12191.268523888595, 12387.566435174725, 12587.62237132869, 13204.339783010812, 13918.860811391958, 264808.0, 269885.0, 270502.0, 270519.0, 270826.0, 46222.30666540004, 46423.30365044527, 46551.068978620235, 46949.76525117353, 46991.530084698716, 1216.519474807464, 1233.5004323249098, 1233.7039110613568, 1244.966677657542, 1252.2111070025826, 21379.686148646986, 23997.52004959926, 24566.7716614165, 24897.751022489545, 25716.485670286864, 39817.0, 40378.39432408575, 40462.0, 40830.0, 40920.38619420651, 176967.0, 177687.11156444653, 177837.0, 178106.0, 178211.0, 23709.88145059264, 23915.52168956646, 26956.73043269542, 27739.44521109607, 28177.295567610974, 32585.348293033534, 33156.33687326288, 33417.331653367284, 33734.49398258979, 33992.320153596294, 28909.85545072261, 29674.406511870075, 32040.198995025312, 32650.34699306048, 33024.834875825465, 30132.69867301299, 30556.541651875683, 30566.235844104074, 30629.0, 30681.846590767796, 29840.552391713707, 31158.68841311558, 31237.0, 31497.685023149475, 31515.52726709147, 24860.37849053788, 25478.363040923385, 26611.201663950113, 26936.191914242605, 27578.586321204795, 20613.175472980914, 20642.58714825665, 20827.271045513335, 20874.37376878696, 21063.789362106796], "unit": "ms", "name": "ext.html", "value": 16091.36167401107}, {"lowerIsBetter": false, "replicates": [295.47848048194925, 297.1234857171345, 304.1863016431046, 305.0148021889296, 305.85777613409766, 15715.214239288032, 16016.199190040496, 16209.918950405247, 16611.33554657812, 16622.66754664909, 10382.273240873143, 10715.571377144925, 10728.088112510446, 10744.194185436085, 16596.336146554153, 3413.556237689097, 3900.7907548659864, 3979.323515002442, 3999.8400063997406, 4000.6999475039343, 3940.980295098535, 3960.4059391091423, 4010.939835902464, 4016.377461493473, 4019.5176578810583, 3003.714647108521, 3045.9086227413104, 3081.3221091359865, 3906.863259785908, 3961.3661814109746, 4167.916641667165, 4169.958300416987, 4208.13733184698, 4260.957390426087, 4267.530571637118, 3597.244578638489, 3605.531280933462, 3634.018814919983, 3634.6365363463706, 3638.7816730996224, 9600.615975360977, 9877.061679140543, 10064.647737329231, 10893.509792059376, 11450.770984580346, 1396.2111407055083, 1464.443511465647, 1613.1127879666137, 1657.991710041442, 1769.9911500442545, 8305.584720763938, 8318.500889946623, 8470.32237421011, 8527.872081918777, 8554.871676924851, 1354.0724603646534, 1366.8018137370025, 1386.4177045640754, 1433.7204245172195, 1482.5774654223603, 49536.75231623819, 53657.0, 53828.0, 53943.190852137246, 54023.0, 5771.451712087345, 5812.244408226903, 5828.708564571754, 5829.213056237439, 5900.793472228452, 6638.502112341594, 6640.302768209365, 6650.733970641217, 6698.497612679069, 6735.831604209934, 4949.356583644103, 4961.181405068123, 4972.353594032825, 4972.403311602631, 4980.228064649985, 5334.706591137525, 5392.056390131711, 5393.460653934653, 5401.027814993339, 5459.3994660587305, 2620.882060307291, 2649.271450351169, 2652.7082020977678, 2669.933251668685, 2670.4258584404056, 912.1015799437548, 916.1296768070359, 916.2074805293506, 933.7898972731081, 981.0679854138597, 337.84965690268086, 378.209542057102, 417.6053629320263, 418.12194391777024, 419.3981636351784, 8959.283257339397, 9967.750806229902, 10070.496475176213, 10089.848652270222, 10303.227257955683, 347.5013355834335, 396.5934916710395, 408.5893676854742, 415.6508532832435, 427.3418934840311, 5387.595930305243, 5455.5908306876345, 5776.740046697909, 5802.796902108406, 5809.970950145223, 430258.0, 448919.0, 468807.0, 470358.0, 477728.0, 61823.0, 66939.0, 67529.66235168891, 67702.66148669225, 69113.0, 437.6783064447628, 444.7531619950894, 445.3586834957715, 446.2547545598858, 446.65161174283463, 9583.329166958247, 9693.563789629625, 9788.070133337322, 9839.901600983898, 9886.851697224403, 30074.849625751733, 30526.389472210874, 30952.380952380376, 30981.690183097882, 31780.523292150174, 43610.34584481299, 43633.0, 43703.34444983264, 44269.55730442654, 44403.77798110989, 5464.808731694372, 5529.612927095065, 5538.030844602098, 5545.168224766156, 5547.057000310037, 9555.474448905377, 10117.949410252902, 10140.03669651382, 10178.0, 10397.0, 8725.738227853175, 8755.474671519729, 8757.60590773404, 8759.956200218958, 8979.50612716307, 8061.83876322482, 8342.541160236246, 8672.826543469222, 8811.33914956368, 9070.501122438065, 9188.0, 9281.071892810665, 9281.48951807657, 9299.395539289924, 9301.674441394518, 5345.1982202669915, 5568.97215513936, 5571.916421253765, 5632.183333416713, 5647.322321321468, 8893.911060889566, 9121.863172052292, 9194.264458843143, 9316.068393160629, 9326.906730932875], "unit": "ms", "name": "jquery.html", "value": 5839.751246390273}, {"lowerIsBetter": false, "replicates": [1106.186952589847, 1497.79030935669, 1565.9295331710073, 1611.2990848980694, 1615.1439736939421, 5890.263717035371, 6229.408206220408, 6428.582142160756, 6637.236717777457, 6638.966805165979, 6346.143270658471, 6519.67401629919, 6534.901976470345, 6550.639714815695, 6618.3050779668165, 1876.4558278099335, 1894.1760334254575, 1906.313727058265, 1922.7884932657396, 1923.7980012098737, 1904.8095190480979, 1938.9127489262946, 1955.9217631294732, 2002.8297594704468, 2041.1427200575795, 1919.7216403621467, 1920.4142736465371, 1929.9131539080774, 1955.3449594385897, 1957.0606109067655, 1836.8622353323487, 1869.0841487670943, 1870.812918708132, 1874.5313671582105, 1898.591802762406, 1915.9808401916082, 1916.3005502991448, 1920.1263425141526, 1928.0648885290623, 1945.6303302372503, 5684.459976302244, 6409.070684750685, 6427.260865000538, 6474.838129046764, 6509.544331896769, 3653.8173091345325, 3703.7222208334483, 3934.2328245992044, 4052.8581499647667, 4059.9797001014804, 2495.3137887081016, 2508.9623655645178, 2559.1171045989104, 2592.4815036992486, 2599.753023462787, 804.8551260773058, 827.1521690267464, 830.5805568188026, 844.5608283692445, 859.2266959736224, 8402.815268030296, 8421.957890210571, 8486.618102185417, 8541.829163416696, 8545.145485451467, 3527.9294414111573, 3547.822608869546, 3553.8400771965325, 3589.2821435712963, 3603.837827297778, 7072.787816365517, 7103.0, 7155.534890232118, 7161.4986950912935, 7184.497085203986, 4031.5766844481495, 4088.6115818997146, 4089.488813898263, 4097.8770636880945, 4102.630763231324, 3754.3805272129794, 3768.0768211788286, 3795.2162483632646, 3804.6766024888193, 3805.790681512488, 2806.3264816443907, 2816.9859150704115, 2838.7587055100134, 2855.4860125177665, 2857.7428031477266, 890.4167770110588, 911.4258017449097, 916.0701887583974, 927.3740225347864, 928.3687092776842, 896.171041786358, 913.1142791492242, 919.5769945824995, 937.9718608441758, 1154.5381847261162, 6100.206973093469, 6142.477889379453, 6154.476869466056, 6154.78458253959, 6166.1983942087245, 420.92212940606083, 426.93595960605535, 429.0496550141452, 1040.6929955663097, 1095.4413249242943, 4618.122556714281, 4888.340074089952, 5001.499850015042, 5005.89988200234, 5007.173816320266, 6564.704588293538, 7705.9229407706325, 7712.383009359238, 7718.768436946901, 7837.960810195913, 7512.774616761506, 7536.849263014709, 7592.164861865191, 7611.847763044819, 7615.4669173157345, 5787.826365209051, 6015.849603759941, 6120.44915957566, 6127.356627554132, 6152.0, 6140.478059365004, 6219.844503887439, 6219.937800621936, 6228.377162283736, 6276.435120839146, 6859.382655561023, 6873.278305778022, 6907.102076729993, 7001.719931202695, 7054.224035356209, 6984.580925144508, 7112.431005519443, 7137.036500072424, 7148.0, 7194.280571942764, 5823.242978412779, 5899.203607512931, 5915.467607915309, 5920.703964801656, 5936.079907614327, 5848.619839710405, 6310.179676642191, 6313.810585682437, 6343.238811342484, 6355.555111142361, 5835.416458354131, 5919.644821310735, 5957.076653118774, 5980.581359304807, 5994.0, 5789.884202316014, 5799.797007104731, 5875.0, 5913.793017244376, 5922.7927022554, 5949.6430214187285, 5984.551158663205, 5991.580589358878, 5998.350453625288, 6006.699665016819, 5289.57683385336, 5423.3491980962535, 5429.972850135724, 5441.102218133963, 5452.672839629635, 5478.04134276508, 5519.061759500974, 5532.6680399176175, 5538.0585300499815, 5579.079451890392], "unit": "ms", "name": "mootools.html", "value": 3719.9351751228}, {"lowerIsBetter": false, "replicates": [271.796152885336, 276.4691791759821, 278.6600347575957, 284.63993048793265, 287.58731220698314, 5426.348838139419, 5448.863778405542, 5504.559635229182, 5553.111502159651, 5558.638688485245, 5376.784928602861, 5548.44515548445, 5570.693611851357, 5572.192032155335, 5585.441455854412, 4165.4376659151085, 4191.601797829201, 4198.30727929892, 4200.663946884257, 4213.325867861143, 4029.8388064477385, 4154.376843473473, 4170.687198460112, 4198.433211516452, 4203.285441474942, 3895.10412605101, 4096.733712308705, 4111.588841115894, 4127.236461254663, 4140.068484590958, 4059.7158198926086, 4062.2687916175078, 4079.4084857695466, 4085.346344584852, 4101.159262351211, 3492.336456073338, 3558.7508874378805, 3571.196480791827, 3591.2278860045217, 3617.981910090433, 5327.733613319358, 5381.838544843622, 5383.380911195223, 5399.352077750656, 5401.378841433247, 4676.11153880765, 4702.694324868872, 4735.147673418784, 4742.928856067162, 4745.549172828576, 5585.497305242507, 5749.6550206987295, 5800.825975220708, 5831.679257640828, 5834.766609335621, 3874.8062596870327, 3876.8255428505786, 3913.2956067907767, 3917.05990562263, 3927.3912543555793, 6134.570580059398, 6136.821428392901, 6143.969280153616, 6160.045192995093, 6162.075688646694, 3939.1727737174942, 3958.9208215836097, 3976.2842688315804, 4010.3382941814857, 4011.398290256485, 3892.844286228519, 4004.1791432756213, 4019.959800402017, 4033.3546632538655, 4050.3924411337944, 4657.301404789308, 4663.930041049387, 4694.906101877943, 4713.764311784397, 4714.750591093363, 5601.215829783833, 5771.163181338682, 5773.595848290579, 5837.211976383134, 5852.7658893643775, 1366.3236697834636, 1389.465055953445, 1410.379433049455, 1417.9858201417853, 1422.30307149496, 907.9409838360485, 909.0909090909091, 912.7039603762673, 917.5504003038596, 920.2729843423754, 5594.24477695514, 5605.32736071674, 5628.97185514078, 5629.831105066854, 5633.57748168889, 6058.606190597597, 6061.121137435135, 6077.301110372276, 6079.574429789872, 6089.878202435926, 5615.775368985276, 5624.690642014647, 5628.634138780966, 5632.746526406321, 5633.042382794934, 3165.287810242723, 3255.202475393544, 3270.8528116234825, 3283.113559338965, 3286.8471151395875, 6214.937850621526, 6219.315875253718, 6236.34518375564, 6244.37556244381, 6245.718942647592, 6181.072839074175, 6186.319504854462, 6186.845328866814, 6188.845278868064, 6209.813705588839, 6029.8191054268445, 6202.4417802398, 6218.409251121137, 6223.96888015557, 6245.18812554365, 6021.337652858095, 6036.758529658764, 6055.969720151371, 6058.151858739692, 6063.575549711478, 5894.28862723135, 5907.054871220584, 5929.110633405024, 5931.822045338647, 5956.880862382642, 6210.627362358092, 6220.0, 6220.253569571681, 6222.564420490522, 6251.0623406487575, 3927.194925040417, 3967.8016099194347, 4010.0375909782024, 4017.6986725995084, 4024.5371782244247, 5871.706414679164, 5938.287405511193, 5949.583529152917, 6172.660503672341, 6197.4732147767945, 5737.827865164052, 5819.301683797802, 5855.3266374367495, 5909.55678324136, 5943.346231914399, 5819.621724587888, 5885.323187833454, 5886.999210134373, 5907.054871220584, 5948.970255148696, 5630.662160270397, 5715.942840571541, 5774.942250577608, 5804.1874137619925, 5816.76732930678, 5863.0, 5919.112133180058, 5937.584369094122, 5937.584369094122, 5968.074948383008, 5763.7982670606325, 5775.768969241183, 5808.82573522795, 5831.679257640701, 5846.853828654148], "unit": "ms", "name": "prototype.html", "value": 4344.855073176197}, {"lowerIsBetter": false, "replicates": [674.7132468700801, 675.5035049238812, 678.8744082344766, 692.1763101908729, 696.3071743615102, 12127.878721212785, 12238.571649992253, 12374.752504949907, 12377.195482293644, 12393.25640461573, 10236.43699596522, 10364.844527332096, 12165.695857603565, 12528.185667931579, 12538.0, 768.6579472134888, 774.3108633316353, 783.2832957843566, 784.1413652050995, 785.3246208260891, 579.9333076696191, 593.2436143916498, 597.6264834478451, 605.3039005144097, 753.1226121568367, 780.7774784186508, 788.3181048393127, 798.2416704131069, 798.8641930871737, 810.0198759501011, 788.0661416221739, 789.7038610521083, 795.932345750612, 799.5083023940293, 803.148662417836, 461.1399739485868, 468.2134014855042, 577.719805894141, 585.0, 588.717415640495, 11833.940830295793, 11963.760724785456, 12003.759924801543, 12042.09684273683, 12172.756544869053, 7943.682252709885, 8180.100188979208, 8410.495370277802, 8466.026406963216, 8558.572071396406, 7770.378369730408, 7820.916683723661, 8030.879536806952, 8158.061822890384, 8251.133630968721, 2482.2677310193358, 2549.1205534090896, 2571.996921200733, 2633.578627419604, 2650.8144429889917, 41540.584594153974, 41953.0, 42282.0, 42374.0, 42398.36402453935, 5136.101182293084, 5534.972325138348, 5587.357453892854, 5660.15097735343, 5789.797357092481, 10715.83926241107, 10764.515596798163, 10826.94586527078, 10865.0, 10904.563817447213, 5377.919331210035, 5453.454654534594, 5460.645058071213, 5471.863203419946, 5732.082866741384, 3302.3230237801195, 3330.900072997814, 3418.4017796885446, 3441.380551500754, 3484.5470088888787, 2345.132301048623, 2357.351728274704, 2389.0921449849293, 2391.605385111437, 2411.2645643078677, 354.6170136252841, 356.17900738797323, 356.59348342889126, 359.2222837556713, 364.76654940837886, 416.27568031624753, 542.1758926431802, 542.6635485998627, 556.3963100036506, 575.0798722044779, 6562.606243625302, 7223.927760722326, 7545.207753185946, 7708.344790692854, 7971.880421793678, 436.55471419152286, 489.9608031357483, 524.8346770767196, 538.8329617818489, 539.5198273536556, 3136.373848573336, 3374.257663314067, 3384.7630665853644, 3450.585929688403, 3453.568303962005, 48770.268445973335, 48772.26841597379, 48783.26825097627, 48963.75518122387, 49577.75211123921, 43893.341599876025, 44766.77616611896, 44960.100797983854, 45014.32478512825, 45207.773961129984, 41109.383359249034, 41161.382579261335, 41359.793201033805, 42276.36585451159, 42344.15311693749, 7277.745278915212, 7376.2623737627955, 7460.0, 7524.209957954555, 7710.190430004769, 30706.0, 30872.38255234838, 31152.0, 31682.524762128127, 31938.36123277568, 36910.63089369072, 37345.626543734215, 38706.225875482894, 40763.0, 40827.0, 8720.302375809793, 8966.282697384064, 9064.682736104469, 9224.769380765534, 9346.7421617511, 9455.952720236355, 9504.144626983329, 9519.095685909828, 9521.76195595088, 9617.951910240405, 8878.112188781328, 8964.775880603038, 8986.820263594822, 8989.325800564853, 8999.820003600022, 8965.058668839938, 9028.954855225682, 9032.23226025769, 9049.954750226207, 9056.592453339746, 8825.0, 8862.158094980967, 8890.422122562013, 8920.884889388826, 8930.955345223232, 7741.729039483816, 7770.611469426619, 8228.670853165806, 8320.542370169698, 8330.416870818985, 7571.659275332733, 7738.7678369649, 7949.244821741925, 8081.555514446762, 8181.345492360716], "unit": "ms", "name": "yui.html", "value": 5098.302640630237}], "name": "dromaeo_css", "value": 5771.574709184645}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [119.0, 121.0, 119.0, 124.0, 121.0, 120.0, 119.0, 120.0, 115.0, 125.0], "unit": "ms", "name": "ai-astar", "value": 120.3}, {"lowerIsBetter": true, "replicates": [178.0, 152.0, 179.0, 191.0, 148.0, 167.0, 173.0, 149.0, 189.0, 148.0], "unit": "ms", "name": "audio-beat-detection", "value": 167.4}, {"lowerIsBetter": true, "replicates": [179.0, 188.0, 189.0, 181.0, 182.0, 186.0, 182.0, 175.0, 183.0, 188.0], "unit": "ms", "name": "audio-dft", "value": 183.3}, {"lowerIsBetter": true, "replicates": [84.0, 92.0, 107.0, 101.0, 79.0, 81.0, 81.0, 94.0, 95.0, 79.0], "unit": "ms", "name": "audio-fft", "value": 89.3}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 155.0, 104.0, 105.0, 102.0, 145.0, 100.0, 100.0, 154.0], "unit": "ms", "name": "audio-oscillator", "value": 118.4}, {"lowerIsBetter": true, "replicates": [136.0, 141.0, 132.0, 135.0, 135.0, 143.0, 139.0, 128.0, 135.0, 135.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 135.9}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 142.0, 148.0, 145.0, 141.0, 141.0, 148.0, 145.0, 141.0], "unit": "ms", "name": "imaging-darkroom", "value": 144.6}, {"lowerIsBetter": true, "replicates": [118.0, 110.0, 109.0, 110.0, 109.0, 104.0, 109.0, 109.0, 110.0, 118.0], "unit": "ms", "name": "imaging-desaturate", "value": 110.6}, {"lowerIsBetter": true, "replicates": [65.0, 67.0, 68.0, 68.0, 68.0, 71.0, 70.0, 80.0, 69.0, 68.0], "unit": "ms", "name": "json-parse-financial", "value": 69.4}, {"lowerIsBetter": true, "replicates": [76.0, 78.0, 77.0, 79.0, 82.0, 83.0, 83.0, 78.0, 78.0, 80.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 79.4}, {"lowerIsBetter": true, "replicates": [99.0, 97.0, 101.0, 101.0, 100.0, 98.0, 96.0, 100.0, 100.0, 101.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 99.3}, {"lowerIsBetter": true, "replicates": [144.0, 148.0, 147.0, 143.0, 151.0, 142.0, 141.0, 141.0, 149.0, 146.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 145.2}, {"lowerIsBetter": true, "replicates": [168.0, 163.0, 182.0, 185.0, 175.0, 176.0, 180.0, 179.0, 175.0, 163.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 174.6}, {"lowerIsBetter": true, "replicates": [77.0, 80.0, 79.0, 83.0, 83.0, 83.0, 83.0, 81.0, 82.0, 80.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 81.1}], "name": "kraken", "value": 1718.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [188.6080724254998], "unit": "score", "name": "Richards", "value": 187.17120399999993}, {"lowerIsBetter": false, "replicates": [217.3913043478261], "unit": "score", "name": "DeltaBlue", "value": 304.14280000000014}, {"lowerIsBetter": false, "replicates": [360.1008282319049], "unit": "score", "name": "Encrypt", "value": 739.1846370000003}, {"lowerIsBetter": false, "replicates": [6724.832214765101], "unit": "score", "name": "Decrypt", "value": 39.581805389221536}, {"lowerIsBetter": false, "replicates": [2197.802197802198], "unit": "score", "name": "RayTrace", "value": 336.69499499999984}, {"lowerIsBetter": false, "replicates": [1013.1712259371834], "unit": "score", "name": "Earley", "value": 657.7989810000001}, {"lowerIsBetter": false, "replicates": [14385.714285714286], "unit": "score", "name": "Boyer", "value": 46.32811320754715}, {"lowerIsBetter": false, "replicates": [33409.83606557377], "unit": "score", "name": "RegExp", "value": 27.26697006869481}, {"lowerIsBetter": false, "replicates": [763.9419404125287], "unit": "score", "name": "Splay", "value": 106.671719}, {"lowerIsBetter": false, "replicates": [6464.5161290322585], "unit": "score", "name": "NavierStokes", "value": 229.56087824351292}], "name": "v8_7", "value": 16137.871411282134}]} 10:05:37 INFO - RETURN: dromaeo_css: 5771.58 10:05:37 INFO - RETURN: kraken: 1718.80 10:05:37 INFO - RETURN: v8_7: 16137.87 10:05:37 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,55]]", "result": "16137.87"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,55]]", "result": "1718.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,55]]", "result": "5771.58"}}} 10:05:37 INFO - Return code: 0 10:05:37 INFO - # TBPL SUCCESS # 10:05:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:05:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:05:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:05:37 INFO - 2015-11-17 10:05:37.617 screenresolution[1660:10944] starting screenresolution argv=screenresolution get 10:05:37 INFO - 2015-11-17 10:05:37.620 screenresolution[1660:10944] Display 0: 1600x1200x32@60 10:05:37 INFO - 2015-11-17 10:05:37.626 screenresolution[1661:10947] starting screenresolution argv=screenresolution list 10:05:37 INFO - Available Modes on Display 0 10:05:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:05:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:05:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:05:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:05:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:05:37 INFO - Intel HD Graphics 3000: 10:05:37 INFO - Chipset Model: Intel HD Graphics 3000 10:05:37 INFO - Type: GPU 10:05:37 INFO - Bus: Built-In 10:05:37 INFO - VRAM (Total): 512 MB 10:05:37 INFO - VRAM (Dynamic, Max): 10 10:05:37 INFO - Vendor: Intel (0x8086) 10:05:37 INFO - Device ID: 0x0116 10:05:37 INFO - Revision ID: 0x0009 10:05:37 INFO - Displays: 10:05:37 INFO - Display: 10:05:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:05:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:05:37 INFO - Display Serial Number: 1600x1200 60 10:05:37 INFO - Main Display: Yes 10:05:37 INFO - Mirror: Off 10:05:37 INFO - Online: Yes 10:05:37 INFO - Rotation: Supported 10:05:37 INFO - Return code: 0 10:05:37 INFO - Running post-action listener: _resource_record_post_action 10:05:37 INFO - Running post-run listener: _resource_record_post_run 10:05:38 INFO - Total resource usage - Wall time: 1258s; CPU: 30.0%; Read bytes: 7692288; Write bytes: 690028544; Read time: 1813; Write time: 50271 10:05:38 INFO - install - Wall time: 40s; CPU: 30.0%; Read bytes: 340128256; Write bytes: 338153472; Read time: 35114; Write time: 7121 10:05:38 INFO - run-tests - Wall time: 1218s; CPU: 30.0%; Read bytes: 5775360; Write bytes: 340676608; Read time: 1310; Write time: 42715 10:05:38 INFO - Running post-run listener: _upload_blobber_files 10:05:38 INFO - Blob upload gear active. 10:05:38 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 10:05:38 INFO - Copying logs to upload dir... 10:05:38 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1324.640106 ========= master_lag: 0.69 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 5 secs) (at 2015-11-17 10:05:39.709588) ========= ========= Started set props: build_url (results: 0, elapsed: 4 secs) (at 2015-11-17 10:05:39.713028) ========= 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.wevk1CWRcm/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.02OtNTM0UO/Listeners TMPDIR=/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/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/pbFhpK7IQh2Jwco9oVW47g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010257 build_url: 'https://queue.taskcluster.net/v1/task/pbFhpK7IQh2Jwco9oVW47g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 4.67 ========= ========= Finished set props: build_url (results: 0, elapsed: 4 secs) (at 2015-11-17 10:05:44.393157) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2015-11-17 10:05:44.393487) ========= 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.wevk1CWRcm/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.02OtNTM0UO/Listeners TMPDIR=/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/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.005378 ========= master_lag: 3.44 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2015-11-17 10:05:47.838914) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 10:05:47.839225) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 10:05:47.903672) ========= ========= Total master_lag: 9.52 =========