builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0012 starttime: 1448308443.09 results: success (0) buildid: 20151123050554 builduid: 1951b743c8f04fd2b9d29c2608cfd14d revision: 5c614c8507b7c7928ffbe5cc3a884d7c55c9405b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 11:54:03.089858) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 11:54:03.090283) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 11:54:03.090582) ========= 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.4gvmuKfaYO/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.TgyZDApKLC/Listeners TMPDIR=/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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:0:0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005193 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 11:54:03.110921) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 11:54:03.111246) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 11:54:03.125958) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:54:03.126287) ========= 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.4gvmuKfaYO/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.TgyZDApKLC/Listeners TMPDIR=/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.004850 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:54:03.173912) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 11:54:03.174221) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 11:54:03.174576) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:54:03.174840) ========= 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.4gvmuKfaYO/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.TgyZDApKLC/Listeners TMPDIR=/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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:0:0 using PTY: False --2015-11-23 11:54:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 8.06M=0.001s 2015-11-23 11:54:03 (8.06 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.181294 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:54:03.369423) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:54:03.369741) ========= 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.4gvmuKfaYO/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.TgyZDApKLC/Listeners TMPDIR=/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.018633 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:54:03.418423) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:54:03.418757) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5c614c8507b7c7928ffbe5cc3a884d7c55c9405b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 5c614c8507b7c7928ffbe5cc3a884d7c55c9405b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4gvmuKfaYO/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.TgyZDApKLC/Listeners TMPDIR=/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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:0:0 using PTY: False 2015-11-23 11:54:03,513 truncating revision to first 12 chars 2015-11-23 11:54:03,513 Setting DEBUG logging. 2015-11-23 11:54:03,513 attempt 1/10 2015-11-23 11:54:03,513 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5c614c8507b7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 11:54:04,235 unpacking tar archive at: fx-team-5c614c8507b7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.962205 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:54:04.395150) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 11:54:04.395543) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 11:54:04.407659) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 11:54:04.408033) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 11:54:04.408477) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2015-11-23 11:54:04.408768) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4gvmuKfaYO/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.TgyZDApKLC/Listeners TMPDIR=/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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:0:0 using PTY: False 11:54:04 INFO - MultiFileLogger online at 20151123 11:54:04 in /builds/slave/test 11:54:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:54:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:54:04 INFO - {'append_to_log': False, 11:54:04 INFO - 'base_work_dir': '/builds/slave/test', 11:54:04 INFO - 'blob_upload_branch': 'Fx-Team', 11:54:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:54:04 INFO - 'branch': 'Fx-Team', 11:54:04 INFO - 'buildbot_json_path': 'buildprops.json', 11:54:04 INFO - 'config_files': ('talos/mac_config.py',), 11:54:04 INFO - 'default_actions': ('clobber', 11:54:04 INFO - 'read-buildbot-config', 11:54:04 INFO - 'download-and-extract', 11:54:04 INFO - 'populate-webroot', 11:54:04 INFO - 'create-virtualenv', 11:54:04 INFO - 'install', 11:54:04 INFO - 'run-tests'), 11:54:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:54:04 INFO - 'download_minidump_stackwalk': True, 11:54:04 INFO - 'download_symbols': 'ondemand', 11:54:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:54:04 INFO - 'tooltool.py': '/tools/tooltool.py', 11:54:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:54:04 INFO - '/tools/misc-python/virtualenv.py')}, 11:54:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:54:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:54:04 INFO - 'installer_path': 'installer.exe', 11:54:04 INFO - 'log_level': 'info', 11:54:04 INFO - 'log_name': 'talos', 11:54:04 INFO - 'log_to_console': True, 11:54:04 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:54:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:54:04 INFO - 'opt_config_files': (), 11:54:04 INFO - 'pip_index': False, 11:54:04 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:54:04 INFO - 'cmd': ('bash', 11:54:04 INFO - '-c', 11:54:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:54:04 INFO - 'enabled': True, 11:54:04 INFO - 'halt_on_failure': False, 11:54:04 INFO - 'name': 'check_screen_resolution'},), 11:54:04 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:54:04 INFO - 'cmd': ('bash', 11:54:04 INFO - '-c', 11:54:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:54:04 INFO - 'enabled': True, 11:54:04 INFO - 'halt_on_failure': False, 11:54:04 INFO - 'name': 'check_screen_resolution'},), 11:54:04 INFO - 'run_cmd_checks_enabled': True, 11:54:04 INFO - 'sps_profile': False, 11:54:04 INFO - 'sps_profile_interval': 0, 11:54:04 INFO - 'suite': 'dromaeojs', 11:54:04 INFO - 'system_bits': '64', 11:54:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:54:04 INFO - 'title': 't-yosemite-r7-0012', 11:54:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:54:04 INFO - 'use_talos_json': True, 11:54:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:54:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:54:04 INFO - 'work_dir': 'build'} 11:54:04 INFO - ##### 11:54:04 INFO - ##### Running clobber step. 11:54:04 INFO - ##### 11:54:04 INFO - Running pre-action listener: _resource_record_pre_action 11:54:04 INFO - Running main action method: clobber 11:54:04 INFO - rmtree: /builds/slave/test/build 11:54:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:54:05 INFO - Running post-action listener: _resource_record_post_action 11:54:05 INFO - ##### 11:54:05 INFO - ##### Running read-buildbot-config step. 11:54:05 INFO - ##### 11:54:05 INFO - Running pre-action listener: _resource_record_pre_action 11:54:05 INFO - Running main action method: read_buildbot_config 11:54:05 INFO - Using buildbot properties: 11:54:05 INFO - { 11:54:05 INFO - "properties": { 11:54:05 INFO - "buildnumber": 8, 11:54:05 INFO - "product": "firefox", 11:54:05 INFO - "script_repo_revision": "production", 11:54:05 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 11:54:05 INFO - "repository": "", 11:54:05 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 11:54:05 INFO - "buildid": "20151123050554", 11:54:05 INFO - "slavename": "t-yosemite-r7-0012", 11:54:05 INFO - "pgo_build": "False", 11:54:05 INFO - "basedir": "/builds/slave/test", 11:54:05 INFO - "project": "", 11:54:05 INFO - "platform": "yosemite_r7", 11:54:05 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 11:54:05 INFO - "slavebuilddir": "test", 11:54:05 INFO - "scheduler": "tests-fx-team-macosx64-talos", 11:54:05 INFO - "branch": "fx-team", 11:54:05 INFO - "repo_path": "integration/fx-team", 11:54:05 INFO - "stage_platform": "macosx64", 11:54:05 INFO - "builduid": "1951b743c8f04fd2b9d29c2608cfd14d", 11:54:05 INFO - "revision": "5c614c8507b7c7928ffbe5cc3a884d7c55c9405b" 11:54:05 INFO - }, 11:54:05 INFO - "sourcestamp": { 11:54:05 INFO - "repository": "", 11:54:05 INFO - "hasPatch": false, 11:54:05 INFO - "project": "", 11:54:05 INFO - "branch": "fx-team-macosx64-talos", 11:54:05 INFO - "changes": [ 11:54:05 INFO - { 11:54:05 INFO - "category": null, 11:54:05 INFO - "files": [ 11:54:05 INFO - { 11:54:05 INFO - "url": null, 11:54:05 INFO - "name": "https://queue.taskcluster.net/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 11:54:05 INFO - } 11:54:05 INFO - ], 11:54:05 INFO - "repository": "", 11:54:05 INFO - "rev": "5c614c8507b7c7928ffbe5cc3a884d7c55c9405b", 11:54:05 INFO - "who": "pbrosset@mozilla.com", 11:54:05 INFO - "when": 1448289287, 11:54:05 INFO - "number": 6695012, 11:54:05 INFO - "comments": "Bug 1198073 - Introduce a pref to set the max length of attributes or not truncat them; r=pbro", 11:54:05 INFO - "project": "", 11:54:05 INFO - "at": "Mon 23 Nov 2015 06:34:47", 11:54:05 INFO - "branch": "fx-team-macosx64-talos", 11:54:05 INFO - "revlink": "", 11:54:05 INFO - "properties": [ 11:54:05 INFO - [ 11:54:05 INFO - "buildid", 11:54:05 INFO - "20151123050554", 11:54:05 INFO - "Change" 11:54:05 INFO - ], 11:54:05 INFO - [ 11:54:05 INFO - "builduid", 11:54:05 INFO - "1951b743c8f04fd2b9d29c2608cfd14d", 11:54:05 INFO - "Change" 11:54:05 INFO - ], 11:54:05 INFO - [ 11:54:05 INFO - "pgo_build", 11:54:05 INFO - "False", 11:54:05 INFO - "Change" 11:54:05 INFO - ] 11:54:05 INFO - ], 11:54:05 INFO - "revision": "5c614c8507b7c7928ffbe5cc3a884d7c55c9405b" 11:54:05 INFO - } 11:54:05 INFO - ], 11:54:05 INFO - "revision": "5c614c8507b7c7928ffbe5cc3a884d7c55c9405b" 11:54:05 INFO - } 11:54:05 INFO - } 11:54:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 11:54:05 INFO - Running post-action listener: _resource_record_post_action 11:54:05 INFO - ##### 11:54:05 INFO - ##### Running download-and-extract step. 11:54:05 INFO - ##### 11:54:05 INFO - Running pre-action listener: _resource_record_pre_action 11:54:05 INFO - Running main action method: download_and_extract 11:54:05 INFO - mkdir: /builds/slave/test/build/tests 11:54:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:54:05 INFO - https://queue.taskcluster.net/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:54:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/test_packages.json 11:54:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/test_packages.json 11:54:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 11:54:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 11:54:07 INFO - Downloaded 1149 bytes. 11:54:07 INFO - Reading from file /builds/slave/test/build/test_packages.json 11:54:07 INFO - Using the following test package requirements: 11:54:07 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 11:54:07 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:54:07 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 11:54:07 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:54:07 INFO - u'jsshell-mac.zip'], 11:54:07 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:54:07 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 11:54:07 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 11:54:07 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:54:07 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 11:54:07 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:54:07 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 11:54:07 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:54:07 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 11:54:07 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 11:54:07 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:54:07 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 11:54:07 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:54:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:54:07 INFO - https://queue.taskcluster.net/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:54:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:54:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:54:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/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 11:54:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/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 11:54:08 INFO - Downloaded 17525254 bytes. 11:54:08 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 11:54:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:54:08 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 11:54:10 INFO - Return code: 0 11:54:10 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 11:54:10 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')]} 11:54:10 INFO - https://queue.taskcluster.net/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:54:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:54:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:54:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/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 11:54:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/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 11:54:12 INFO - Downloaded 17525254 bytes. 11:54:12 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 11:54:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:54:12 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 11:54:15 INFO - Return code: 0 11:54:15 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')]} 11:54:15 INFO - https://queue.taskcluster.net/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 11:54:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 11:54:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 11:54:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/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 11:54:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/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 11:54:16 INFO - Downloaded 11130997 bytes. 11:54:16 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 11:54:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 11:54:16 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 11:54:16 INFO - Return code: 0 11:54:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:54:16 INFO - https://queue.taskcluster.net/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 11:54:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 11:54:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 11:54:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 11:54:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHG0k_EmRGi4_A98lmq0OA/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 11:54:19 INFO - Downloaded 109634929 bytes. 11:54:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 11:54:19 INFO - mkdir: /builds/slave/test/properties 11:54:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:54:19 INFO - Writing to file /builds/slave/test/properties/build_url 11:54:19 INFO - Contents: 11:54:19 INFO - build_url:https://queue.taskcluster.net/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 11:54:19 INFO - Running post-action listener: _resource_record_post_action 11:54:19 INFO - Running post-action listener: set_extra_try_arguments 11:54:19 INFO - ##### 11:54:19 INFO - ##### Running populate-webroot step. 11:54:19 INFO - ##### 11:54:19 INFO - Running pre-action listener: _resource_record_pre_action 11:54:19 INFO - Running main action method: populate_webroot 11:54:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:54:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:54:19 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 11:54:19 INFO - '../fennec_ids.txt'], 11:54:19 INFO - 'tests': ['tcheck2']}, 11:54:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:54:19 INFO - '--tppagecycles', 11:54:19 INFO - '7'], 11:54:19 INFO - 'tests': ['tsvgm']}}, 11:54:19 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:54:19 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:54:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:54:19 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:54:19 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:54:19 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:54:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:54:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:19 INFO - 'talos_options': ['--e10s'], 11:54:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:54:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:19 INFO - 'tests': ['damp', 'tps']}, 11:54:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:19 INFO - 'talos_options': ['--e10s'], 11:54:19 INFO - 'tests': ['damp', 'tps']}, 11:54:19 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:54:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:54:19 INFO - 'other': {'tests': ['a11yr', 11:54:19 INFO - 'ts_paint', 11:54:19 INFO - 'tpaint', 11:54:19 INFO - 'sessionrestore', 11:54:19 INFO - 'sessionrestore_no_auto_restore']}, 11:54:19 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:54:19 INFO - 'tests': ['a11yr', 11:54:19 INFO - 'ts_paint', 11:54:19 INFO - 'tpaint', 11:54:19 INFO - 'sessionrestore', 11:54:19 INFO - 'sessionrestore_no_auto_restore']}, 11:54:19 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:54:19 INFO - 'tests': ['a11yr', 11:54:19 INFO - 'ts_paint', 11:54:19 INFO - 'tpaint', 11:54:19 INFO - 'sessionrestore', 11:54:19 INFO - 'sessionrestore_no_auto_restore']}, 11:54:19 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:54:19 INFO - 'tests': ['a11yr', 11:54:19 INFO - 'ts_paint', 11:54:19 INFO - 'tpaint', 11:54:19 INFO - 'sessionrestore', 11:54:19 INFO - 'sessionrestore_no_auto_restore']}, 11:54:19 INFO - 'other_l64': {'tests': ['a11yr', 11:54:19 INFO - 'ts_paint', 11:54:19 INFO - 'tpaint', 11:54:19 INFO - 'sessionrestore', 11:54:19 INFO - 'sessionrestore_no_auto_restore']}, 11:54:19 INFO - 'other_nol64': {'tests': ['a11yr', 11:54:19 INFO - 'ts_paint', 11:54:19 INFO - 'tpaint', 11:54:19 INFO - 'sessionrestore', 11:54:19 INFO - 'sessionrestore_no_auto_restore']}, 11:54:19 INFO - 'svgr': {'tests': ['tsvgx', 11:54:19 INFO - 'tsvgr_opacity', 11:54:19 INFO - 'tart', 11:54:19 INFO - 'tscrollx', 11:54:19 INFO - 'cart']}, 11:54:19 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:54:19 INFO - 'tests': ['tsvgx', 11:54:19 INFO - 'tsvgr_opacity', 11:54:19 INFO - 'tart', 11:54:19 INFO - 'tscrollx', 11:54:19 INFO - 'cart']}, 11:54:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:19 INFO - 'tests': ['tp5o']}, 11:54:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:19 INFO - 'talos_options': ['--e10s'], 11:54:19 INFO - 'tests': ['tp5o']}, 11:54:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:19 INFO - 'talos_options': ['--xperf_path', 11:54:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:54:19 INFO - 'tests': ['tp5n']}, 11:54:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:19 INFO - 'talos_options': ['--e10s', 11:54:19 INFO - '--xperf_path', 11:54:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:54:19 INFO - 'tests': ['tp5n']}}, 11:54:19 INFO - 'talos.zip': {'path': '', 11:54:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:54:19 INFO - Running post-action listener: _resource_record_post_action 11:54:19 INFO - ##### 11:54:19 INFO - ##### Running create-virtualenv step. 11:54:19 INFO - ##### 11:54:19 INFO - Running pre-action listener: _resource_record_pre_action 11:54:19 INFO - Running main action method: create_virtualenv 11:54:19 INFO - Creating virtualenv /builds/slave/test/build/venv 11:54:19 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 11:54:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:54:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:54:19 INFO - Using real prefix '/tools/python27' 11:54:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:54:20 INFO - Installing distribute.............................................................................................................................................................................................done. 11:54:23 INFO - Installing pip.................done. 11:54:23 INFO - Return code: 0 11:54:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:54:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:54:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:54:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:23 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 0x10b96e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b94b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9d9d8b9f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8929f0>, '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 0x10b5f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8858c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4gvmuKfaYO/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.TgyZDApKLC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:54:23 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 11:54:23 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 11:54:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4gvmuKfaYO/Render', 11:54:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:54:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:54:23 INFO - 'HOME': '/Users/cltbld', 11:54:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:54:23 INFO - 'LOGNAME': 'cltbld', 11:54:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:23 INFO - 'MOZ_NO_REMOTE': '1', 11:54:23 INFO - 'NO_EM_RESTART': '1', 11:54:23 INFO - 'PAGER': '/bin/cat', 11:54:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:54:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:23 INFO - 'PWD': '/builds/slave/test', 11:54:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:54:23 INFO - 'SHELL': '/bin/bash', 11:54:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TgyZDApKLC/Listeners', 11:54:23 INFO - 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', 11:54:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:54:23 INFO - 'USER': 'cltbld', 11:54:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:54:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:54:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:23 INFO - 'XPC_FLAGS': '0x0', 11:54:23 INFO - 'XPC_SERVICE_NAME': '0', 11:54:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:54:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:23 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 11:54:23 INFO - Cleaning up... 11:54:23 INFO - Return code: 0 11:54:23 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:54:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:54:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:54:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:23 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 0x10b96e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b94b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9d9d8b9f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8929f0>, '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 0x10b5f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8858c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4gvmuKfaYO/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.TgyZDApKLC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:54:23 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 11:54:23 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 11:54:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4gvmuKfaYO/Render', 11:54:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:54:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:54:23 INFO - 'HOME': '/Users/cltbld', 11:54:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:54:23 INFO - 'LOGNAME': 'cltbld', 11:54:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:23 INFO - 'MOZ_NO_REMOTE': '1', 11:54:23 INFO - 'NO_EM_RESTART': '1', 11:54:23 INFO - 'PAGER': '/bin/cat', 11:54:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:54:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:23 INFO - 'PWD': '/builds/slave/test', 11:54:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:54:23 INFO - 'SHELL': '/bin/bash', 11:54:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TgyZDApKLC/Listeners', 11:54:23 INFO - 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', 11:54:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:54:23 INFO - 'USER': 'cltbld', 11:54:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:54:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:54:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:23 INFO - 'XPC_FLAGS': '0x0', 11:54:23 INFO - 'XPC_SERVICE_NAME': '0', 11:54:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:54:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:23 INFO - Downloading/unpacking psutil>=0.7.1 11:54:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:54:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:54:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:54:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:54:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:54:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:54:26 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 11:54:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 11:54:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:54:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:54:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:54:26 INFO - Installing collected packages: psutil 11:54:26 INFO - Running setup.py install for psutil 11:54:26 INFO - building 'psutil._psutil_osx' extension 11:54:26 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 11:54:26 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 11:54:26 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 11:54:26 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 11:54:26 INFO - building 'psutil._psutil_posix' extension 11:54:26 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 11:54:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:54:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:54:26 INFO - ^ 11:54:26 INFO - 1 warning generated. 11:54:26 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 11:54:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:54:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:54:27 INFO - Successfully installed psutil 11:54:27 INFO - Cleaning up... 11:54:27 INFO - Return code: 0 11:54:27 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:54: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')]} 11:54:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54: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')]} 11:54:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:27 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 0x10b96e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b94b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9d9d8b9f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8929f0>, '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 0x10b5f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8858c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4gvmuKfaYO/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.TgyZDApKLC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:54:27 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 11:54:27 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 11:54:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4gvmuKfaYO/Render', 11:54:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:54:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:54:27 INFO - 'HOME': '/Users/cltbld', 11:54:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:54:27 INFO - 'LOGNAME': 'cltbld', 11:54:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:27 INFO - 'MOZ_NO_REMOTE': '1', 11:54:27 INFO - 'NO_EM_RESTART': '1', 11:54:27 INFO - 'PAGER': '/bin/cat', 11:54:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:54:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:27 INFO - 'PWD': '/builds/slave/test', 11:54:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:54:27 INFO - 'SHELL': '/bin/bash', 11:54:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TgyZDApKLC/Listeners', 11:54:27 INFO - 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', 11:54:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:54:27 INFO - 'USER': 'cltbld', 11:54:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:54:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:54:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:27 INFO - 'XPC_FLAGS': '0x0', 11:54:27 INFO - 'XPC_SERVICE_NAME': '0', 11:54:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:54:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:27 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:54:27 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 11:54:27 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 11:54:27 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 11:54:27 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 11:54:27 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 11:54:27 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 11:54:29 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:54:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 11:54:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:54:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:54:29 INFO - Installing collected packages: mozsystemmonitor 11:54:29 INFO - Running setup.py install for mozsystemmonitor 11:54:29 INFO - Successfully installed mozsystemmonitor 11:54:29 INFO - Cleaning up... 11:54:29 INFO - Return code: 0 11:54:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:54:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:54:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:54:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:29 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 0x10b96e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b94b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9d9d8b9f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8929f0>, '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 0x10b5f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8858c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4gvmuKfaYO/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.TgyZDApKLC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:54:29 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 11:54:29 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 11:54:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4gvmuKfaYO/Render', 11:54:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:54:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:54:29 INFO - 'HOME': '/Users/cltbld', 11:54:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:54:29 INFO - 'LOGNAME': 'cltbld', 11:54:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:29 INFO - 'MOZ_NO_REMOTE': '1', 11:54:29 INFO - 'NO_EM_RESTART': '1', 11:54:29 INFO - 'PAGER': '/bin/cat', 11:54:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:54:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:29 INFO - 'PWD': '/builds/slave/test', 11:54:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:54:29 INFO - 'SHELL': '/bin/bash', 11:54:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TgyZDApKLC/Listeners', 11:54:29 INFO - 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', 11:54:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:54:29 INFO - 'USER': 'cltbld', 11:54:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:54:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:54:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:29 INFO - 'XPC_FLAGS': '0x0', 11:54:29 INFO - 'XPC_SERVICE_NAME': '0', 11:54:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:54:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:30 INFO - Downloading/unpacking blobuploader==1.2.4 11:54:30 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 11:54:30 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 11:54:30 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 11:54:30 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 11:54:30 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 11:54:30 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 11:54:32 INFO - Downloading blobuploader-1.2.4.tar.gz 11:54:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 11:54:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:54:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:54:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:54:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:54:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:54:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:54:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:54:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:54:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 11:54:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:54:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:54:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:54:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:54:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:54:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:54:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:54:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:54:33 INFO - Downloading docopt-0.6.1.tar.gz 11:54:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 11:54:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:54:33 INFO - Installing collected packages: blobuploader, requests, docopt 11:54:33 INFO - Running setup.py install for blobuploader 11:54:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:54:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:54:33 INFO - Running setup.py install for requests 11:54:34 INFO - Running setup.py install for docopt 11:54:34 INFO - Successfully installed blobuploader requests docopt 11:54:34 INFO - Cleaning up... 11:54:34 INFO - Return code: 0 11:54:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:54:34 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')]} 11:54:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:34 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')]} 11:54:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:34 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 0x10b96e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b94b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9d9d8b9f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8929f0>, '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 0x10b5f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8858c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4gvmuKfaYO/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.TgyZDApKLC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:54:34 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 11:54:34 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 11:54:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4gvmuKfaYO/Render', 11:54:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:54:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:54:34 INFO - 'HOME': '/Users/cltbld', 11:54:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:54:34 INFO - 'LOGNAME': 'cltbld', 11:54:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:34 INFO - 'MOZ_NO_REMOTE': '1', 11:54:34 INFO - 'NO_EM_RESTART': '1', 11:54:34 INFO - 'PAGER': '/bin/cat', 11:54:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:54:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:34 INFO - 'PWD': '/builds/slave/test', 11:54:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:54:34 INFO - 'SHELL': '/bin/bash', 11:54:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TgyZDApKLC/Listeners', 11:54:34 INFO - 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', 11:54:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:54:34 INFO - 'USER': 'cltbld', 11:54:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:54:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:54:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:34 INFO - 'XPC_FLAGS': '0x0', 11:54:34 INFO - 'XPC_SERVICE_NAME': '0', 11:54:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:54:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:54:34 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-qEaFMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:54:34 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-LdsV3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:54:34 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-ym3nsg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:54:34 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-T8qaIM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:54:34 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-GGu7q6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:54:35 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-qdDrn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:54:35 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-pTndtU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:54:35 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-_8jfR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:54:35 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-gXgh2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:54:35 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-XMKoq3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:54:35 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-0IWArl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:54:35 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-wiRPwa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:54:35 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-sJA9E5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:54:35 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-lhGqgr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:54:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:54:36 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-tV3sxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:54:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:54:36 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-H5q5Cl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:54:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:54:36 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-bzoAdg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:54:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:54:36 INFO - Running setup.py install for manifestparser 11:54:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:54:36 INFO - Running setup.py install for mozcrash 11:54:36 INFO - Running setup.py install for mozdebug 11:54:36 INFO - Running setup.py install for mozdevice 11:54:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:54:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:54:36 INFO - Running setup.py install for mozfile 11:54:37 INFO - Running setup.py install for mozhttpd 11:54:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:54:37 INFO - Running setup.py install for mozinfo 11:54:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:54:37 INFO - Running setup.py install for mozInstall 11:54:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:54:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:54:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:54:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:54:37 INFO - Running setup.py install for mozleak 11:54:37 INFO - Running setup.py install for mozlog 11:54:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:54:37 INFO - Running setup.py install for moznetwork 11:54:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:54:37 INFO - Running setup.py install for mozprocess 11:54:38 INFO - Running setup.py install for mozprofile 11:54:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:54:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:54:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:54:38 INFO - Running setup.py install for mozrunner 11:54:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:54:38 INFO - Running setup.py install for mozscreenshot 11:54:38 INFO - Running setup.py install for moztest 11:54:38 INFO - Running setup.py install for mozversion 11:54:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:54:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:54:38 INFO - Cleaning up... 11:54:38 INFO - Return code: 0 11:54:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:54: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')]} 11:54:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54: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')]} 11:54:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54: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/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 0x10b96e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b94b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9d9d8b9f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8929f0>, '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 0x10b5f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8858c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4gvmuKfaYO/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.TgyZDApKLC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:54: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/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 11:54: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/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 11:54:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4gvmuKfaYO/Render', 11:54:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:54:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:54:38 INFO - 'HOME': '/Users/cltbld', 11:54:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:54:38 INFO - 'LOGNAME': 'cltbld', 11:54:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:38 INFO - 'MOZ_NO_REMOTE': '1', 11:54:38 INFO - 'NO_EM_RESTART': '1', 11:54:38 INFO - 'PAGER': '/bin/cat', 11:54:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:54:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:38 INFO - 'PWD': '/builds/slave/test', 11:54:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:54:38 INFO - 'SHELL': '/bin/bash', 11:54:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TgyZDApKLC/Listeners', 11:54:38 INFO - 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', 11:54:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:54:38 INFO - 'USER': 'cltbld', 11:54:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:54:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:54:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:38 INFO - 'XPC_FLAGS': '0x0', 11:54:38 INFO - 'XPC_SERVICE_NAME': '0', 11:54:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:54:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:54:39 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-2vANsd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:54:39 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)) 11:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:54:39 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-cpkgY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:54:39 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)) 11:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:54:39 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-cu7bnF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:54:39 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)) 11:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:54:39 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-tGgB13-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:54:39 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)) 11:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:54:39 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-mfOa0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:54:39 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)) 11:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:54:39 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-JhqXv2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:54:39 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)) 11:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:54:39 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-Zm9Lem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:54:39 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)) 11:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:54:39 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-BGoz2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:54:39 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)) 11:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:54:39 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-iUFFSk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:54:40 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)) 11:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:54:40 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-M7gNu2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:54:40 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)) 11:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:54:40 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-Kj36qb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:54:40 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)) 11:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:54:40 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-RWeoCt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:54:40 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)) 11:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:54:40 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-7Jc_nx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:54:40 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)) 11:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:54:40 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-4HZNSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:54:40 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)) 11:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:54:40 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-tnmq08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:54:40 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)) 11:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:54:40 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-4GBEbY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:54:40 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)) 11:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:54:40 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-o0QMyz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:54:40 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)) 11:54:40 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)) 11:54:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:54:40 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)) 11:54:40 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)) 11:54:40 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)) 11:54:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:54:40 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 11:54:40 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 11:54:40 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 11:54:40 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 11:54:40 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 11:54:40 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 11:54:43 INFO - Downloading blessings-1.5.1.tar.gz 11:54:43 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 11:54:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:54:43 INFO - Installing collected packages: blessings 11:54:43 INFO - Running setup.py install for blessings 11:54:43 INFO - Successfully installed blessings 11:54:43 INFO - Cleaning up... 11:54:43 INFO - Return code: 0 11:54:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:54:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:54:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:54:43 INFO - Reading from file tmpfile_stdout 11:54:43 INFO - Current package versions: 11:54:43 INFO - blessings == 1.5.1 11:54:43 INFO - blobuploader == 1.2.4 11:54:43 INFO - docopt == 0.6.1 11:54:43 INFO - manifestparser == 1.1 11:54:43 INFO - mozInstall == 1.12 11:54:43 INFO - mozcrash == 0.16 11:54:43 INFO - mozdebug == 0.1 11:54:43 INFO - mozdevice == 0.47 11:54:43 INFO - mozfile == 1.2 11:54:43 INFO - mozhttpd == 0.7 11:54:43 INFO - mozinfo == 0.9 11:54:43 INFO - mozleak == 0.1 11:54:43 INFO - mozlog == 3.0 11:54:43 INFO - moznetwork == 0.27 11:54:43 INFO - mozprocess == 0.22 11:54:43 INFO - mozprofile == 0.27 11:54:43 INFO - mozrunner == 6.11 11:54:43 INFO - mozscreenshot == 0.1 11:54:43 INFO - mozsystemmonitor == 0.0 11:54:43 INFO - moztest == 0.7 11:54:43 INFO - mozversion == 1.4 11:54:43 INFO - psutil == 3.1.1 11:54:43 INFO - requests == 1.2.3 11:54:43 INFO - wsgiref == 0.1.2 11:54:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:54:43 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')]} 11:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:43 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')]} 11:54:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:43 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 0x10b96e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b94b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9d9d8b9f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8929f0>, '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 0x10b5f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8858c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4gvmuKfaYO/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.TgyZDApKLC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:54:43 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 11:54:43 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 11:54:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4gvmuKfaYO/Render', 11:54:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:54:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:54:43 INFO - 'HOME': '/Users/cltbld', 11:54:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:54:43 INFO - 'LOGNAME': 'cltbld', 11:54:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:43 INFO - 'MOZ_NO_REMOTE': '1', 11:54:43 INFO - 'NO_EM_RESTART': '1', 11:54:43 INFO - 'PAGER': '/bin/cat', 11:54:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:54:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:43 INFO - 'PWD': '/builds/slave/test', 11:54:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:54:43 INFO - 'SHELL': '/bin/bash', 11:54:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TgyZDApKLC/Listeners', 11:54:43 INFO - 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', 11:54:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:54:43 INFO - 'USER': 'cltbld', 11:54:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:54:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:54:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:43 INFO - 'XPC_FLAGS': '0x0', 11:54:43 INFO - 'XPC_SERVICE_NAME': '0', 11:54:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:54:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:43 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)) 11:54:43 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)) 11:54:43 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)) 11:54:43 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)) 11:54:43 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)) 11:54:43 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)) 11:54:43 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)) 11:54:43 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)) 11:54:43 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)) 11:54:43 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)) 11:54:43 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)) 11:54:43 INFO - Cleaning up... 11:54:43 INFO - Return code: 0 11:54:43 INFO - Running post-action listener: _resource_record_post_action 11:54:43 INFO - Running post-action listener: _start_resource_monitoring 11:54:43 INFO - Starting resource monitoring. 11:54:43 INFO - ##### 11:54:43 INFO - ##### Running install step. 11:54:43 INFO - ##### 11:54:43 INFO - Running pre-action listener: _resource_record_pre_action 11:54:43 INFO - Running main action method: install 11:54:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:54:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:54:44 INFO - Reading from file tmpfile_stdout 11:54:44 INFO - Detecting whether we're running mozinstall >=1.0... 11:54:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:54:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:54:44 INFO - Reading from file tmpfile_stdout 11:54:44 INFO - Output received: 11:54:44 INFO - Usage: mozinstall [options] installer 11:54:44 INFO - Options: 11:54:44 INFO - -h, --help show this help message and exit 11:54:44 INFO - -d DEST, --destination=DEST 11:54:44 INFO - Directory to install application into. [default: 11:54:44 INFO - "/builds/slave/test"] 11:54:44 INFO - --app=APP Application being installed. [default: firefox] 11:54:44 INFO - mkdir: /builds/slave/test/build/application 11:54:44 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'] 11:54:44 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 11:55:15 INFO - Reading from file tmpfile_stdout 11:55:15 INFO - Output received: 11:55:15 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:55:15 INFO - Running post-action listener: _resource_record_post_action 11:55:15 INFO - ##### 11:55:15 INFO - ##### Running run-tests step. 11:55:15 INFO - ##### 11:55:15 INFO - Running pre-action listener: _resource_record_pre_action 11:55:15 INFO - Running main action method: run_tests 11:55:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:55:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:55:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:55:15 INFO - 2015-11-23 11:55:15.047 screenresolution[1925:9376] starting screenresolution argv=screenresolution get 11:55:15 INFO - 2015-11-23 11:55:15.049 screenresolution[1925:9376] Display 0: 1600x1200x32@60 11:55:15 INFO - 2015-11-23 11:55:15.055 screenresolution[1926:9378] starting screenresolution argv=screenresolution list 11:55:15 INFO - Available Modes on Display 0 11:55:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:55:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:55:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:55:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:55:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:55:15 INFO - Intel Iris: 11:55:15 INFO - Chipset Model: Intel Iris 11:55:15 INFO - Type: GPU 11:55:15 INFO - Bus: Built-In 11:55:15 INFO - VRAM (Dynamic, Max): 1536 MB 11:55:15 INFO - Vendor: Intel (0x8086) 11:55:15 INFO - Device ID: 0x0a2e 11:55:15 INFO - Revision ID: 0x0009 11:55:15 INFO - Displays: 11:55:15 INFO - Display: 11:55:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:55:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:55:15 INFO - Display Serial Number: 1600x1200 60 11:55:15 INFO - Main Display: Yes 11:55:15 INFO - Mirror: Off 11:55:15 INFO - Online: Yes 11:55:15 INFO - Rotation: Supported 11:55:15 INFO - Return code: 0 11:55:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:55:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:55:15 INFO - Python 2.7.3 11:55:15 INFO - Return code: 0 11:55:15 INFO - grabbing minidump binary from tooltool 11:55:15 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')]} 11:55:15 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 0x10b8929f0>, '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 0x10b5f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8858c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:55:15 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 11:55:15 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 11:55:15 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:55:15 INFO - Return code: 0 11:55:15 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:55:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:55:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:55:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:55:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:55:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0012', '--webServer', 'localhost'] in /builds/slave/test/build 11:55:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0012 --webServer localhost 11:55:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4gvmuKfaYO/Render', 11:55:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:15 INFO - 'HOME': '/Users/cltbld', 11:55:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:15 INFO - 'LOGNAME': 'cltbld', 11:55:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:55:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:55:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:15 INFO - 'MOZ_NO_REMOTE': '1', 11:55:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:55:15 INFO - 'NO_EM_RESTART': '1', 11:55:15 INFO - 'PAGER': '/bin/cat', 11:55:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:15 INFO - 'PWD': '/builds/slave/test', 11:55:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:55:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:15 INFO - 'SHELL': '/bin/bash', 11:55:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TgyZDApKLC/Listeners', 11:55:15 INFO - 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', 11:55:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:15 INFO - 'USER': 'cltbld', 11:55:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:15 INFO - 'XPC_FLAGS': '0x0', 11:55:15 INFO - 'XPC_SERVICE_NAME': '0', 11:55:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0012', '--webServer', 'localhost'] with output_timeout 3600 11:55:15 INFO - mozversion INFO | application_buildid: 20151123050554 11:55:15 INFO - mozversion INFO | application_changeset: 5c614c8507b7c7928ffbe5cc3a884d7c55c9405b 11:55:15 INFO - mozversion INFO | application_display_name: Nightly 11:55:15 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:55:15 INFO - mozversion INFO | application_name: Firefox 11:55:15 INFO - mozversion INFO | application_remotingname: firefox 11:55:15 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 11:55:15 INFO - mozversion INFO | application_vendor: Mozilla 11:55:15 INFO - mozversion INFO | application_version: 45.0a1 11:55:15 INFO - mozversion INFO | platform_buildid: 20151123050554 11:55:15 INFO - mozversion INFO | platform_changeset: 5c614c8507b7c7928ffbe5cc3a884d7c55c9405b 11:55:15 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 11:55:15 INFO - mozversion INFO | platform_version: 45.0a1 11:55:15 INFO - 2015-11-23 11:55:15,598 DEBUG : using testdate: 1448308515 11:55:15 INFO - 2015-11-23 11:55:15,598 DEBUG : actual date: 1448308515 11:55:16 INFO - 2015-11-23 11:55:16,015 INFO : starting webserver on 'localhost:49391' 11:55:16 INFO - 2015-11-23 11:55:16,015 INFO : Starting test suite t-yosemite-r7-0012 11:55:16 INFO - 2015-11-23 11:55:16,016 INFO : Starting test dromaeo_css 11:55:16 INFO - 2015-11-23 11:55:16,016 DEBUG : operating with platform_type : mac_ 11:55:16 INFO - 2015-11-23 11:55:16,017 INFO : Initialising browser for dromaeo_css test... 11:55:16 INFO - 2015-11-23 11:55:16,029 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/tmpZHD7F9/profile http://localhost:49391/getInfo.html 11:55:18 INFO - 2015-11-23 11:55:18,148 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:55:18 INFO - 2015-11-23 11:55:18,149 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:55:18 INFO - 2015-11-23 11:55:18,149 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 11:55:18 INFO - 2015-11-23 11:55:18,149 DEBUG : BROWSER_OUTPUT: __metrics 11:55:18 INFO - 2015-11-23 11:55:18,168 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:55:18 INFO - 2015-11-23 11:55:18,814 INFO : Browser initialized. 11:55:18 INFO - 2015-11-23 11:55:18,814 INFO : Running cycle 1/1 for dromaeo_css test... 11:55:18 INFO - 2015-11-23 11:55:18,815 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/tmpZHD7F9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:55:30 INFO - 2015-11-23 11:55:30,713 DEBUG : BROWSER_OUTPUT: RSS: Main: 224301056 11:55:30 INFO - 2015-11-23 11:55:30,713 DEBUG : BROWSER_OUTPUT: 11:56:28 INFO - 2015-11-23 11:56:28,177 DEBUG : BROWSER_OUTPUT: 1448308588176 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] 11:58:33 INFO - 2015-11-23 11:58:33,973 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49391/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49391/tests/dromaeo/cssquery-ext.html) 11:58:35 INFO - 2015-11-23 11:58:35,459 DEBUG : BROWSER_OUTPUT: RSS: Main: 372473856 11:58:35 INFO - 2015-11-23 11:58:35,459 DEBUG : BROWSER_OUTPUT: 12:01:38 INFO - 2015-11-23 12:01:38,230 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49391/tests/dromaeo/cssquery-ext.html (next: http://localhost:49391/tests/dromaeo/cssquery-jquery.html) 12:01:38 INFO - 2015-11-23 12:01:38,817 DEBUG : BROWSER_OUTPUT: RSS: Main: 360390656 12:01:38 INFO - 2015-11-23 12:01:38,818 DEBUG : BROWSER_OUTPUT: 12:04:40 INFO - 2015-11-23 12:04:40,830 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49391/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49391/tests/dromaeo/cssquery-mootools.html) 12:04:41 INFO - 2015-11-23 12:04:41,414 DEBUG : BROWSER_OUTPUT: RSS: Main: 343470080 12:04:41 INFO - 2015-11-23 12:04:41,414 DEBUG : BROWSER_OUTPUT: 12:07:43 INFO - 2015-11-23 12:07:43,557 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49391/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49391/tests/dromaeo/cssquery-prototype.html) 12:07:44 INFO - 2015-11-23 12:07:44,142 DEBUG : BROWSER_OUTPUT: RSS: Main: 317095936 12:07:44 INFO - 2015-11-23 12:07:44,142 DEBUG : BROWSER_OUTPUT: 12:10:47 INFO - 2015-11-23 12:10:47,139 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49391/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49391/tests/dromaeo/cssquery-yui.html) 12:10:47 INFO - 2015-11-23 12:10:47,724 DEBUG : BROWSER_OUTPUT: RSS: Main: 318545920 12:10:47 INFO - 2015-11-23 12:10:47,725 DEBUG : BROWSER_OUTPUT: 12:13:50 INFO - 2015-11-23 12:13:50,676 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49391/tests/dromaeo/cssquery-yui.html (next: http://localhost:49391/tests/dromaeo/cssquery-dojo.html) 12:13:50 INFO - 2015-11-23 12:13:50,935 DEBUG : BROWSER_OUTPUT: RSS: Main: 376852480 12:13:50 INFO - 2015-11-23 12:13:50,935 DEBUG : BROWSER_OUTPUT: 12:13:50 INFO - 2015-11-23 12:13:50,936 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:13:50 INFO - 2015-11-23 12:13:50,936 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:13:50 INFO - 2015-11-23 12:13:50,936 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:13:50 INFO - 2015-11-23 12:13:50,936 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:13:50 INFO - 2015-11-23 12:13:50,936 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3182.7772055956084;3415.795052296861;3447.120984149043;3474.7567670263074;3506.964930350697;5454.781808727646;5585.190147428621;5881.823545293642;5946.167536544882;5951.851203719903;5978.432048955353;6015.248093988252;6026.3069746979;6052;6064.090386442036;5362.865928351793;5381.165919282517;5441.156620723794;5456.590755693339;5486.423925487826;5483.232347471358;5487.176923461473;5497.47773961473;5504.64219825712;5512.669239845602;5447.210154527591;5452.291202143716;5465.371482279549;5466.371367292772;5472.20653005314;5463;5467.234587157801;5480.205370221295;5481.780728770845;5511.311086114236;5315;5325.147976323769;5439.374471935738;5461.726913654302;5472.616916815825;5935.40645935403;6043.123747056696;6052.364501727343;6075.058365953284;6081.027035674271;6315.989441689354;6352.174217351715;6356.110144579762;6360.204974378203;6444.548881578291;6204.627722336674;6234.532410069263;6331.715072821734;6339.175907132043;6343.175387199681;5870.14882841994;5889.705514724246;5922.378150294243;5926.140709597171;6110.266767987825;6397.552171347961;6409.198850143732;6451.580647258007;6458.773942912069;6461.676916154173;6181.536384771161;6257.624542527463;6268.2478102627065;6324.114623952651;6344.333844946214;6372.55392122547;6411.2627047889155;6412.903806442907;6414.422701956846;6429.389208025324;6246.4378205960775;6251.74993000284;6321.525885558602;6325.620462772248;6352.872942541123;6167.074938759222;6237.812865614039;6343.270523889812;6354.9682251589375;6361.840953976095;5104.081265372269;5121.513456221653;5137.511936366114;5143.691378517226;5175;4483.798229079699;4523.909521809545;4550.97724511382;4585.495595484494;4619.676622636383;5798.623089499169;5917.940820591825;5951.9107213391835;5963.165156878041;5967.5524335675;6335.081413195061;6386.329435409215;6390.712417941204;6411.96794016027;6423.74305027803;5936.079907614327;5955.28536575605;5994.850128746729;6021.3677563856045;6033.306169790442;5500.4499550045475;5540.889182216414;5546.639468434539;5574.637648552831;5620.9437905621235;6367;6370.554061215856;6386.680665966683;6419.454346380517;6426.518011149089;6370.8088757337355;6379.617222966637;6387;6392;6396.32838551964;6233.158523599437;6248.937510624835;6282.685865706788;6283.528735344776;6343;5987.251593550806;6128.411459112376;6340.9365906340345;6360.77737279193;6364.745410183541;6370.490360771035;6377.713002914973;6379.266384365857;6398.392152745481;6404.423601875854;6101.267847858286;6102.084687296941;6219.844503887439;6352.047192920914;6403.839904002437;6202.596831205957;6203.4416902479;6227.719752611053;6304.842378940563;6305.085762564311;6278.277998030285;6284.057391391328;6286.717097730521;6294.0558916162945;6302.621842689453;6109.495762817132;6213.409726076015;6218.595791273553;6289.339619339903;6356.555041147075;6060.969695151496;6096.969515152573;6114.436698562323;6172.074188871526;6243.907316219735 12:13:50 INFO - 2015-11-23 12:13:50,937 DEBUG : BROWSER_OUTPUT: |1;ext.html;525.6332841686382;573.2748073686785;621.8992383481238;630.9463695585875;646.1599920103866;32017.83991080044;32437;32533.67466325339;32590.348193036156;32612.67387326126;32982;33404.66595334046;42060.78969605148;42644.786776066074;42658;9717.46553939533;9806.705798826046;9851.029794041184;9857.802843943116;9878.703638890845;8862.33532485063;9205.953970230139;9763.46300953451;9766.658166964122;9796;8730.912690873105;8814.515201663906;11885.108616853728;11965.641030769091;12086.516539338416;9989.500524973795;11694.415279236047;11800.055995520337;11802.114841386887;11811;8845.027047024822;11568.479418426192;11711.414429278588;11734.178607497479;11740.412979351084;32090.35819283601;32435.675643243503;42778;42869;42990.1401971962;3283.3761585298716;3326.7172290355347;3340.9665903341142;3578.355895938756;3975.840966361342;28346.43307133846;28904.71095289041;29044.98342558;29135.708642913723;29173.833046678108;2694.3398867277447;2749.8762555685043;2783.6937936826935;2828.6888442271334;2896.8551572421507;460718.69640651916;627661;630005.8499707473;630035;645438;48035;54086.72956635192;63129;64713.35286647167;68243.65878170676;62444.06781355764;62470.68764656148;62517.37482625207;62546.37453625406;62645.060324095175;13444.798328025088;15808;16368.83631163673;16604.335826566803;16605.41881034158;12716.427760750788;12726.618201453972;12796.424160912782;12812.039097067756;13023.47906083746;16424.589385265463;19603.607927841364;19703;19725.802741972682;19790.307339243056;9026.548672566345;9204.447733136034;9244;9253.676121335855;9261.907380926104;920.6961702638114;938.4088024544493;946.1720994130136;995.2485873165858;995.7361299255703;28971.42057158845;29255.268618284714;29298.853505732335;29911.551326730118;30108.096757097323;1083.6369816111533;1086.8913108689069;1171.1684703860356;1177.60550215677;1237.7648246833073;13173.209607423585;14374.784378234335;14507.766839818734;15061;15215.61960950963;500087;517113;517889;519076;519880;59100;59415.70292148511;59415.70292148511;59482.70258648679;59569;1341.3896677011935;1354.6545630864066;1355.2139758939988;1471.9843308117365;1616.7574863770294;32959.83520082384;33587.99236022923;33670.66329336675;33722.32555348928;34170.4744904805;63061;63433.682831585546;63792.04311935417;63833.36166638274;63873.72252555016;515449;525448;525496;586959;603421;37927.24145517019;38551.42172867465;45143.32285015793;45458;47951;48771;48873.511264886896;49137.26294105663;49213;50672.74663626658;40323.59676403316;40324.39513407242;41093.58906410898;41104.97237569085;41535.376969346085;39583;39779;40398.39402408907;40649.79675101605;40743.1851362977;38899.80550097232;38991;39591.208175836895;39759.2048159041;40016.3997540043;33554.16114597155;35735.64264357323;35918.28163436769;35992.64007359893;36208.81895590505;25819.870900645376;26252.73747262503;27320.316992075357;32885.013449596554;33789.3242135151 12:13:50 INFO - 2015-11-23 12:13:50,940 DEBUG : BROWSER_OUTPUT: |2;jquery.html;323.2936034764042;346.7482388577237;353.28636154966966;359.25633937748853;360.3279883018172;14967.401303947829;16002.919985400056;19307.613847723056;19957.40127796165;20907.268245611405;20913.9543022849;21406;21408.464788380297;22278.443038924033;22337.55324893501;6635.4359879410185;6784.3554862288;6786.185657721056;6788.422984046362;6824.317568243186;4769.833055843029;4914.97542512287;6699.397054265115;6741.426978706816;7632.9236707633045;7341.449391295648;7587.924120758777;7592.54444733315;7596.810079747996;7635.923640763604;7551.433642476809;7587.279208475186;7588.962055189744;7592.658330375119;7608.1631020587965;6437;6968.233494315621;6983.336583024656;7193.992841002264;7194.928050719478;11915.582954596548;12879.742405151845;26878;27538.724612753816;27570.448591028267;1926.9710954335696;2088.3108574170487;2097.192580856366;2110.1242984161554;2191.37545799448;9384.296177786626;9463.242940564738;9601.519924003773;9828.4102953823;9829.459379734111;1623.5048310265365;1675.3549883294897;1700.5748562859285;1739.930402783887;1742.1724680776656;103738;109258;110279;111891;112414;11043.779124417466;11047.502862371213;11057.004869561779;11071.446427678584;11143.108551315876;13130.737385252241;13242.20546767197;13256.40346184424;13259.93370033163;13294.601161965156;7693.730534461751;8187.263146316741;8381.664733410717;8413.15868413166;8457.815905773197;8503.107173746792;8534.359923005799;8542.273906717874;8610.182032706884;8633.95683021581;3903.414487826792;4226.535081141072;4276.3157894737315;4279.079997800488;4330.220560299176;1628.3079691131459;1645.8643535960389;1650.909199994012;1661.2109248107295;1667.7248254037947;848.3806821020567;901.4861528928448;970.4856426094182;984.5963155106515;1053.1345185244068;19008.714869276973;20135.892525910924;20208.393748187576;20259.392218233475;20267.695984560243;838.8196537744415;940.8965013848472;944.5088553951906;1024.9897501024893;1028.6605420211313;8308.459950103224;10352.482375881176;10540.051395374454;10691.251612387214;10709.625163119254;754147;757305;761039;766814;772988;111018;114643;115477;115713.26430103555;116133.25800113005;1136.6135513925306;1155;1171.9238249513585;1172.60717659585;1176.6175992802373;17435;17622.29510819553;17700.822991769917;17814.376496822548;17844.821551784316;47856.282155766996;49725.756856078886;49737.25394119019;49880.501194987584;51316.486835131174;61239.77520449655;63476;64169.037464439;66450;68252.29369265809;9552.88703387359;9647.469389183661;9885.209183265179;9943.955884632009;9950.751231219278;19806.90096549508;19811.702824457934;20109.49726256855;20514.794852051287;20687;11423.143264255048;15447.768283475532;15639.530814075595;16054;16227.432039878548;15272.770908436605;15383.923125381116;15530.223488825739;15649.921750391175;15772.92113539425;16231;16304.918475407547;16603.41888033913;16678.999260044435;17266.482005539852;9661.516924153624;9833.4099954003;9884.456354900261;10028.247881408777;10032.247581431568;13227.66930826737;15971.600709982344;16044.598885027968;16333.265003075128;16394 12:13:50 INFO - 2015-11-23 12:13:50,941 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1585.738353171727;1713.143428285857;1736.6266252755659;1892.4511891551451;1989.313686778061;7538.472306938516;7929.484583502069;8182.754517364474;8244.670213191464;8267.255946964771;8416.831663366744;8508.61711222995;8519.659213631447;8521.488710677364;8562.357823163273;2138.486763176842;2198.670199470076;2294.621387471065;2314.93055208344;2321;1838.549555358939;2048.672212446009;2338.2751347082376;2397.340731298898;2401.2436082634003;2321.454458202321;2353.7293211280667;2364.3143488388346;2366.7988221001237;2381.761823817622;2126.6809978503193;2194.561087782434;2364.869932153731;2394.760523947609;2397.1969390254285;2093.0372028866586;2193.848229679415;2331.0908745589236;2373.1456675596773;2376.9881150594138;8359.080501144868;8515.276201522878;8538.487690738575;8544.31645468361;8550.1449855014;5136.974315128437;5233.921491177597;5259.526642602184;5261.000409922102;5265.052290587692;3452.6202117767025;3521.5950165731015;3539.1859872229275;3557.982210088933;3557.9822100889587;968.7142293023575;1004.9648262310857;1010.9039641234071;1022.4785359466651;1057.8519007338978;11173.497192626352;11179.60871369498;11180.496877640526;11195.552177912874;11215.551377944872;4618.168729628699;4678.602318802872;4727.361806156125;4745.003549254626;4755;9706.951465242628;9719.9028009719;9732.464714440774;9740.46427446483;9749.561269742879;5252.894942101137;5253.737313134328;5264.815731449381;5270.683758974474;5281.339832520935;4810.628970743392;4826.61387089032;4830.203016502238;4838.080764654705;4840.975795121002;3805.847766089381;3873.1285460771664;3893.3575959966856;3898.1034362096875;3945.9605403946166;1285.3958639439636;1288.5443925930965;1290.1549485087282;1298.1626850681446;1300.8829205371374;1381.7650999330137;1396.629893078335;1420.488624095325;1421.8649228323293;1422.3243959119336;7933.722319718782;8054.073781515201;8084.353251739847;8090.959545202236;8093.595320233965;1205.8311836342918;1218.1899037140379;1226.5093962414926;1229.6987238126537;1253.486070711004;5987.520998320124;6110.633361998294;6111.236095488064;6231.781887633911;6347.587406818542;9670.323077384515;9701.951490242503;9845.55694993727;9864;9923.950380248052;9788.804223915482;9796.65711700087;9799.510024498746;9911.603535858629;9919.15687166599;7671.309582137635;7714.845703085907;7738.961305193438;7752.651130699132;8052.718154864551;7952.801179970547;8006.799830004296;8010.599470026592;8013.8397232056195;8022.719204827803;9054.049324820799;9082.863757043517;9269.582868771056;9407.247420206504;9416.199623032118;9331.206847418045;9493.905060949579;9507.572159252712;9635;9652.469114198786;7399.334059934632;7477.588732619758;7480.177180510031;7487.775366739006;7505.211952745101;8004.359651228005;8021.759347219593;8057;8156.265936065783;8168.959155204186;7523.247675232433;7550.509216900884;7595.658195381111;7691.846163076595;7692.346150577264;7403.481756277009;7501.474896757175;7535;7573.9242607573215;7635.23647635232;7547.28300811422;7563.130240022248;7567.545947243183;7628.313451789366;7632.732854350294;6910.136232970879;6957.095577574883;6975.093237879246;6975.3024697529845;6982.476314276551;6384.297727250092;7019.438444924496;7079.716811327489;7091.574505529685;7102.715891364288 12:13:50 INFO - 2015-11-23 12:13:50,944 DEBUG : BROWSER_OUTPUT: |4;prototype.html;314.12672769700237;319.88803918628486;322.5709805958075;329.4202204120748;332.9750268729846;5644.491995720385;6593.307702691221;6640.56836305641;6807.047013418125;6818.079559259499;6555.868882622344;6664;6669.2330382006085;6688.866222675556;6725.192976842785;5028.245763135523;5029.7988080476825;5032.345795046639;5062.443131255577;5090.083784918713;4113;4791.233402655575;5100.183970564711;5113.258577506259;5116.283720279164;4615.976920115411;4862.756862156895;4930.186519224324;4958.826441074563;4986.551210391064;4931.334269873575;4947.529984651453;4975.328330675385;5001.199808030734;5008.7996480140755;3881.146147847469;4238.597333253336;4286.5284818669925;4287;4289.206496798102;6301.338359472281;6484.221893372778;6484.935150648527;6501.284858665543;6508.967455162741;5516.779328826842;5985.700714964234;5988.251468566429;6006;6026.789062382795;6860.588364698134;7251.238619944936;7264.8547029059655;7264.963675181643;7266.164391095039;4798.328234047236;4800.087983283165;4809.7114173149375;4813;4816.7350795706225;7385.6307184640555;7654.425918056112;7705.306522412954;7717.807054823618;7727.536347819093;4879.853604391874;4884.389451318585;4887.900222449992;4891.1685013547785;4891.657583969088;4955.182394904872;4975.129352363322;4985.401751789808;4988.6507944444265;4989.600831933437;5766.423357664284;5929.110633405024;5941.970290148608;5957.582969192115;5990.9700451497465;7286.7085316586745;7317.1219453664835;7318.34134927859;7321.890171647429;7325;1421.8791402730676;1665.6757877487426;1676.4216345361074;1712.905790181552;1734.913254337278;1044.2481413382352;1054.4938429553856;1063.016709543669;1063.409807556798;1089.5097206257217;5654.46282603152;6647.368499992493;6678.599284042876;6684.2981486944145;6704.765333213314;7415.925840741632;7502.437317201232;7515.6242187891485;7527.736529221451;7531.171571127172;5579.330480342385;6438.77464288757;6730.629815360105;6743.35938085881;6747.730090796412;3958.6635136013188;4008.0581063450068;4015.4779878616177;4016.176683779818;4026.355783074694;7555.848883022309;7565.43259255558;7575.734849280248;7591.3926885849;7610.6194690265265;7463.888041679379;7772.8056798579355;7796.688132474751;7799.5320280783335;7802.219778022266;7550.5469671819865;7565.886511702329;7571.167171611009;7575.886361704579;7579.658915348822;7227.241139680468;7462.8507429850015;7499.662515186938;7504.249575042452;7523.548587084792;7386.519876208029;7400.888986665097;7405.185429602847;7406.296401841816;7407.037085178892;7542.773716788286;7548.018757561482;7552.207018263003;7564.205758395289;7567.356774674215;4761.809527618856;4917.852464426073;4924.236743304794;4930.112579735682;4945.579625731853;7450.627468626655;7475.88786168197;7483.663235154322;7491.587962662106;7491.887621685788;7175.46184036189;7191.101112360955;7193.856122877618;7203.387712044535;7205.747798827226;5837.854053648693;6996.510244282851;7157;7189.317014883578;7201.171865235565;6814.488913331619;6969.895451568332;6988.231294557696;6995.440364770704;7031.43748500129;7104;7268.055152830098;7310.19587845326;7330.633468326669;7334.229905859808;6955.513114081966;7140.464465165237;7141.607211603412;7156.677949492389;7161.928380716126 12:13:50 INFO - 2015-11-23 12:13:50,946 DEBUG : BROWSER_OUTPUT: |5;yui.html;721.844803367276;736.5543845973186;738.8189893476095;767.6929228308679;856.7986523167054;15180.31688574014;15199.316030778615;15425.151616661093;15452.69094618107;15468.613284667888;14378.568642940701;14481.131132132054;14494.347754351053;14518.637034074127;14519.056261343005;660.455124522271;763.0728664672449;772.6329993253216;943.448082871521;971.9951400242988;764.644440335244;961.3703024518951;977.5258999385293;977.6578197630807;978.0366339155926;977.5649835823061;1021.7547788530736;1022.5756311130909;1024.4109636958742;1025.0671888581392;775.0157300228734;785.246163682868;792.8572856885759;998.9650362237323;1014.9492525373739;740.7370383513883;749.8687729647345;751.0986815821036;751.7368920877703;752.1613401057836;15289.61775955599;15372;15374.846251537454;15378.231088445533;15405;12226.266424014588;12585.496580136783;12949.158304710163;13032.674183145402;13334.066615336931;10192;10321.43232122233;10437.269391142623;11123;11263.887361126366;3519.5952465466544;3589.782006142772;3625.29306785177;3632.945505817415;3648.799316037617;78120.60939695266;78748;78818;78820.60589697072;78854;9343.392679475812;9379;9481.66814161501;9506.524673766284;10206;21048.579028419652;21081.683774743393;21131.9434028298;21161.941902904793;21198.36404907855;7176.7488137914925;7338.77983660491;7383.963080184565;7387.409007279405;7547.8113047173165;4082.1178276912055;4096.1193343431305;4129.091599848029;4136.338185890243;4150.418941348214;3419.26485805548;3454.222799870009;3461.394256005189;3468.150303175738;3473;620.652434636605;628.544305378606;629.3549112160073;636.0808631527399;645.6545748024878;502.5251137674935;528.5560129491246;530.4509832323527;532.3638252288555;548.9917651235235;7769.883451748228;8490.872636910452;8510.319174466027;8520.446170998865;8737.126287371339;526.476156224559;535.9598030147677;550.6806052489546;551.7599844067844;574.6638216643311;3834.9808250958567;3839.577646458887;3868.323043467382;3999.9400008999887;4051.6758659307184;101031;101961;102890;102960.48519757354;103066;86652.1334786644;86718;86963.69554456562;87257;88579.67130493048;62443;63879.680601596694;64412.033819492746;65698;65803.67098164478;6808.7276508939085;7953.8409231816195;8125.808738590786;8190.50856948585;8229.670813167406;36978.63021369752;51723.741381294356;51834;52168.73915630398;52411.47588524066;71668.28331716824;74161;74505.62747186446;74567;75253;10162.23783216247;10186.185105191418;10286.2799604027;10497.370157790558;10754.085902698358;11188.66434006981;11343.432828358384;11371.260868043883;11962.521499140285;12293.569725059937;10290.485475726333;10340.586376544854;10649.414282214553;10667.733306667395;10869.130469562258;8372.7906802328;10800.891991079989;10816.67549973502;11100.990039870332;11252.718682033015;8506.800782895372;10183.643572474928;10579.735506612089;10600.787984240118;10608.098311643596;9087.454752714859;9519.23219851039;9955.885997521686;10087.848682269625;10091.899081009096;9544;9840.458774767456;9859.901400986186;9862.852057219005;9983.351082179926 12:13:50 INFO - 2015-11-23 12:13:50,946 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:13:50 INFO - 2015-11-23 12:13:50,946 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:13:50 INFO - 2015-11-23 12:13:50,946 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1248 12:13:50 INFO - 2015-11-23 12:13:50,946 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:13:50 INFO - 2015-11-23 12:13:50,946 DEBUG : BROWSER_OUTPUT: __startTimestamp1448309630932__endTimestamp 12:13:50 INFO - 2015-11-23 12:13:50,946 DEBUG : BROWSER_OUTPUT: 12:13:50 INFO - 2015-11-23 12:13:50,946 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:13:50 INFO - 2015-11-23 12:13:50,946 DEBUG : BROWSER_OUTPUT: Number of tests: 6 12:13:50 INFO - 2015-11-23 12:13:50,947 DEBUG : BROWSER_OUTPUT: 12:13:50 INFO - 2015-11-23 12:13:50,947 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5914.70 Median:6128.41 stddev:631.79 (10.3%) stddev-sans-first:596.27 12:13:50 INFO - 2015-11-23 12:13:50,947 DEBUG : BROWSER_OUTPUT: Values: 3182.8 3415.8 3447.1 3474.8 3507.0 5454.8 5585.2 5881.8 5946.2 5951.9 5978.4 6015.2 6026.3 6052.0 6064.1 5362.9 5381.2 5441.2 5456.6 5486.4 5483.2 5487.2 5497.5 5504.6 5512.7 5447.2 5452.3 5465.4 5466.4 5472.2 5463.0 5467.2 5480.2 5481.8 5511.3 5315.0 5325.1 5439.4 5461.7 5472.6 5935.4 6043.1 6052.4 6075.1 6081.0 6316.0 6352.2 6356.1 6360.2 6444.5 6204.6 6234.5 6331.7 6339.2 6343.2 5870.1 5889.7 5922.4 5926.1 6110.3 6397.6 6409.2 6451.6 6458.8 6461.7 6181.5 6257.6 6268.2 6324.1 6344.3 6372.6 6411.3 6412.9 6414.4 6429.4 6246.4 6251.7 6321.5 6325.6 6352.9 6167.1 6237.8 6343.3 6355.0 6361.8 5104.1 5121.5 5137.5 5143.7 5175.0 4483.8 4523.9 4551.0 4585.5 4619.7 5798.6 5917.9 5951.9 5963.2 5967.6 6335.1 6386.3 6390.7 6412.0 6423.7 5936.1 5955.3 5994.9 6021.4 6033.3 5500.4 5540.9 5546.6 5574.6 5620.9 6367.0 6370.6 6386.7 6419.5 6426.5 6370.8 6379.6 6387.0 6392.0 6396.3 6233.2 6248.9 6282.7 6283.5 6343.0 5987.3 6128.4 6340.9 6360.8 6364.7 6370.5 6377.7 6379.3 6398.4 6404.4 6101.3 6102.1 6219.8 6352.0 6403.8 6202.6 6203.4 6227.7 6304.8 6305.1 6278.3 6284.1 6286.7 6294.1 6302.6 6109.5 6213.4 6218.6 6289.3 6356.6 6061.0 6097.0 6114.4 6172.1 6243.9 12:13:50 INFO - 2015-11-23 12:13:50,947 DEBUG : BROWSER_OUTPUT: 12:13:50 INFO - 2015-11-23 12:13:50,947 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:70106.29 Median:21867.52 stddev:148714.11 (680.1%) stddev-sans-first:149039.53 12:13:50 INFO - 2015-11-23 12:13:50,948 DEBUG : BROWSER_OUTPUT: Values: 525.6 573.3 621.9 630.9 646.2 32017.8 32437.0 32533.7 32590.3 32612.7 32982.0 33404.7 42060.8 42644.8 42658.0 9717.5 9806.7 9851.0 9857.8 9878.7 8862.3 9206.0 9763.5 9766.7 9796.0 8730.9 8814.5 11885.1 11965.6 12086.5 9989.5 11694.4 11800.1 11802.1 11811.0 8845.0 11568.5 11711.4 11734.2 11740.4 32090.4 32435.7 42778.0 42869.0 42990.1 3283.4 3326.7 3341.0 3578.4 3975.8 28346.4 28904.7 29045.0 29135.7 29173.8 2694.3 2749.9 2783.7 2828.7 2896.9 460718.7 627661.0 630005.8 630035.0 645438.0 48035.0 54086.7 63129.0 64713.4 68243.7 62444.1 62470.7 62517.4 62546.4 62645.1 13444.8 15808.0 16368.8 16604.3 16605.4 12716.4 12726.6 12796.4 12812.0 13023.5 16424.6 19603.6 19703.0 19725.8 19790.3 9026.5 9204.4 9244.0 9253.7 9261.9 920.7 938.4 946.2 995.2 995.7 28971.4 29255.3 29298.9 29911.6 30108.1 1083.6 1086.9 1171.2 1177.6 1237.8 13173.2 14374.8 14507.8 15061.0 15215.6 500087.0 517113.0 517889.0 519076.0 519880.0 59100.0 59415.7 59415.7 59482.7 59569.0 1341.4 1354.7 1355.2 1472.0 1616.8 32959.8 33588.0 33670.7 33722.3 34170.5 63061.0 63433.7 63792.0 63833.4 63873.7 515449.0 525448.0 525496.0 586959.0 603421.0 37927.2 38551.4 45143.3 45458.0 47951.0 48771.0 48873.5 49137.3 49213.0 50672.7 40323.6 40324.4 41093.6 41105.0 41535.4 39583.0 39779.0 40398.4 40649.8 40743.2 38899.8 38991.0 39591.2 39759.2 40016.4 33554.2 35735.6 35918.3 35992.6 36208.8 25819.9 26252.7 27320.3 32885.0 33789.3 12:13:50 INFO - 2015-11-23 12:13:50,948 DEBUG : BROWSER_OUTPUT: 12:13:50 INFO - 2015-11-23 12:13:50,948 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:39204.68 Median:11758.06 stddev:125336.92 (1066.0%) stddev-sans-first:125654.52 12:13:50 INFO - 2015-11-23 12:13:50,950 DEBUG : BROWSER_OUTPUT: Values: 323.3 346.7 353.3 359.3 360.3 14967.4 16002.9 19307.6 19957.4 20907.3 20914.0 21406.0 21408.5 22278.4 22337.6 6635.4 6784.4 6786.2 6788.4 6824.3 4769.8 4915.0 6699.4 6741.4 7632.9 7341.4 7587.9 7592.5 7596.8 7635.9 7551.4 7587.3 7589.0 7592.7 7608.2 6437.0 6968.2 6983.3 7194.0 7194.9 11915.6 12879.7 26878.0 27538.7 27570.4 1927.0 2088.3 2097.2 2110.1 2191.4 9384.3 9463.2 9601.5 9828.4 9829.5 1623.5 1675.4 1700.6 1739.9 1742.2 103738.0 109258.0 110279.0 111891.0 112414.0 11043.8 11047.5 11057.0 11071.4 11143.1 13130.7 13242.2 13256.4 13259.9 13294.6 7693.7 8187.3 8381.7 8413.2 8457.8 8503.1 8534.4 8542.3 8610.2 8634.0 3903.4 4226.5 4276.3 4279.1 4330.2 1628.3 1645.9 1650.9 1661.2 1667.7 848.4 901.5 970.5 984.6 1053.1 19008.7 20135.9 20208.4 20259.4 20267.7 838.8 940.9 944.5 1025.0 1028.7 8308.5 10352.5 10540.1 10691.3 10709.6 754147.0 757305.0 761039.0 766814.0 772988.0 111018.0 114643.0 115477.0 115713.3 116133.3 1136.6 1155.0 1171.9 1172.6 1176.6 17435.0 17622.3 17700.8 17814.4 17844.8 47856.3 49725.8 49737.3 49880.5 51316.5 61239.8 63476.0 64169.0 66450.0 68252.3 9552.9 9647.5 9885.2 9944.0 9950.8 19806.9 19811.7 20109.5 20514.8 20687.0 11423.1 15447.8 15639.5 16054.0 16227.4 15272.8 15383.9 15530.2 15649.9 15772.9 16231.0 16304.9 16603.4 16679.0 17266.5 9661.5 9833.4 9884.5 10028.2 10032.2 13227.7 15971.6 16044.6 16333.3 16394.0 12:13:50 INFO - 2015-11-23 12:13:50,950 DEBUG : BROWSER_OUTPUT: 12:13:50 INFO - 2015-11-23 12:13:50,950 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5891.50 Median:6933.62 stddev:3034.16 (43.8%) stddev-sans-first:3025.41 12:13:50 INFO - 2015-11-23 12:13:50,951 DEBUG : BROWSER_OUTPUT: Values: 1585.7 1713.1 1736.6 1892.5 1989.3 7538.5 7929.5 8182.8 8244.7 8267.3 8416.8 8508.6 8519.7 8521.5 8562.4 2138.5 2198.7 2294.6 2314.9 2321.0 1838.5 2048.7 2338.3 2397.3 2401.2 2321.5 2353.7 2364.3 2366.8 2381.8 2126.7 2194.6 2364.9 2394.8 2397.2 2093.0 2193.8 2331.1 2373.1 2377.0 8359.1 8515.3 8538.5 8544.3 8550.1 5137.0 5233.9 5259.5 5261.0 5265.1 3452.6 3521.6 3539.2 3558.0 3558.0 968.7 1005.0 1010.9 1022.5 1057.9 11173.5 11179.6 11180.5 11195.6 11215.6 4618.2 4678.6 4727.4 4745.0 4755.0 9707.0 9719.9 9732.5 9740.5 9749.6 5252.9 5253.7 5264.8 5270.7 5281.3 4810.6 4826.6 4830.2 4838.1 4841.0 3805.8 3873.1 3893.4 3898.1 3946.0 1285.4 1288.5 1290.2 1298.2 1300.9 1381.8 1396.6 1420.5 1421.9 1422.3 7933.7 8054.1 8084.4 8091.0 8093.6 1205.8 1218.2 1226.5 1229.7 1253.5 5987.5 6110.6 6111.2 6231.8 6347.6 9670.3 9702.0 9845.6 9864.0 9924.0 9788.8 9796.7 9799.5 9911.6 9919.2 7671.3 7714.8 7739.0 7752.7 8052.7 7952.8 8006.8 8010.6 8013.8 8022.7 9054.0 9082.9 9269.6 9407.2 9416.2 9331.2 9493.9 9507.6 9635.0 9652.5 7399.3 7477.6 7480.2 7487.8 7505.2 8004.4 8021.8 8057.0 8156.3 8169.0 7523.2 7550.5 7595.7 7691.8 7692.3 7403.5 7501.5 7535.0 7573.9 7635.2 7547.3 7563.1 7567.5 7628.3 7632.7 6910.1 6957.1 6975.1 6975.3 6982.5 6384.3 7019.4 7079.7 7091.6 7102.7 12:13:50 INFO - 2015-11-23 12:13:50,951 DEBUG : BROWSER_OUTPUT: 12:13:50 INFO - 2015-11-23 12:13:50,952 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5908.25 Median:6673.92 stddev:1869.61 (28.0%) stddev-sans-first:1827.10 12:13:50 INFO - 2015-11-23 12:13:50,953 DEBUG : BROWSER_OUTPUT: Values: 314.1 319.9 322.6 329.4 333.0 5644.5 6593.3 6640.6 6807.0 6818.1 6555.9 6664.0 6669.2 6688.9 6725.2 5028.2 5029.8 5032.3 5062.4 5090.1 4113.0 4791.2 5100.2 5113.3 5116.3 4616.0 4862.8 4930.2 4958.8 4986.6 4931.3 4947.5 4975.3 5001.2 5008.8 3881.1 4238.6 4286.5 4287.0 4289.2 6301.3 6484.2 6484.9 6501.3 6509.0 5516.8 5985.7 5988.3 6006.0 6026.8 6860.6 7251.2 7264.9 7265.0 7266.2 4798.3 4800.1 4809.7 4813.0 4816.7 7385.6 7654.4 7705.3 7717.8 7727.5 4879.9 4884.4 4887.9 4891.2 4891.7 4955.2 4975.1 4985.4 4988.7 4989.6 5766.4 5929.1 5942.0 5957.6 5991.0 7286.7 7317.1 7318.3 7321.9 7325.0 1421.9 1665.7 1676.4 1712.9 1734.9 1044.2 1054.5 1063.0 1063.4 1089.5 5654.5 6647.4 6678.6 6684.3 6704.8 7415.9 7502.4 7515.6 7527.7 7531.2 5579.3 6438.8 6730.6 6743.4 6747.7 3958.7 4008.1 4015.5 4016.2 4026.4 7555.8 7565.4 7575.7 7591.4 7610.6 7463.9 7772.8 7796.7 7799.5 7802.2 7550.5 7565.9 7571.2 7575.9 7579.7 7227.2 7462.9 7499.7 7504.2 7523.5 7386.5 7400.9 7405.2 7406.3 7407.0 7542.8 7548.0 7552.2 7564.2 7567.4 4761.8 4917.9 4924.2 4930.1 4945.6 7450.6 7475.9 7483.7 7491.6 7491.9 7175.5 7191.1 7193.9 7203.4 7205.7 5837.9 6996.5 7157.0 7189.3 7201.2 6814.5 6969.9 6988.2 6995.4 7031.4 7104.0 7268.1 7310.2 7330.6 7334.2 6955.5 7140.5 7141.6 7156.7 7161.9 12:13:50 INFO - 2015-11-23 12:13:50,953 DEBUG : BROWSER_OUTPUT: 12:13:50 INFO - 2015-11-23 12:13:50,953 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:18707.67 Median:52290.11 stddev:27087.43 (51.8%) stddev-sans-first:27129.76 12:13:50 INFO - 2015-11-23 12:13:50,954 DEBUG : BROWSER_OUTPUT: Values: 721.8 736.6 738.8 767.7 856.8 15180.3 15199.3 15425.2 15452.7 15468.6 14378.6 14481.1 14494.3 14518.6 14519.1 660.5 763.1 772.6 943.4 972.0 764.6 961.4 977.5 977.7 978.0 977.6 1021.8 1022.6 1024.4 1025.1 775.0 785.2 792.9 999.0 1014.9 740.7 749.9 751.1 751.7 752.2 15289.6 15372.0 15374.8 15378.2 15405.0 12226.3 12585.5 12949.2 13032.7 13334.1 10192.0 10321.4 10437.3 11123.0 11263.9 3519.6 3589.8 3625.3 3632.9 3648.8 78120.6 78748.0 78818.0 78820.6 78854.0 9343.4 9379.0 9481.7 9506.5 10206.0 21048.6 21081.7 21131.9 21161.9 21198.4 7176.7 7338.8 7384.0 7387.4 7547.8 4082.1 4096.1 4129.1 4136.3 4150.4 3419.3 3454.2 3461.4 3468.2 3473.0 620.7 628.5 629.4 636.1 645.7 502.5 528.6 530.5 532.4 549.0 7769.9 8490.9 8510.3 8520.4 8737.1 526.5 536.0 550.7 551.8 574.7 3835.0 3839.6 3868.3 3999.9 4051.7 101031.0 101961.0 102890.0 102960.5 103066.0 86652.1 86718.0 86963.7 87257.0 88579.7 62443.0 63879.7 64412.0 65698.0 65803.7 6808.7 7953.8 8125.8 8190.5 8229.7 36978.6 51723.7 51834.0 52168.7 52411.5 71668.3 74161.0 74505.6 74567.0 75253.0 10162.2 10186.2 10286.3 10497.4 10754.1 11188.7 11343.4 11371.3 11962.5 12293.6 10290.5 10340.6 10649.4 10667.7 10869.1 8372.8 10800.9 10816.7 11101.0 11252.7 8506.8 10183.6 10579.7 10600.8 10608.1 9087.5 9519.2 9955.9 10087.8 10091.9 9544.0 9840.5 9859.9 9862.9 9983.4 12:13:50 INFO - 2015-11-23 12:13:50,954 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:13:50 INFO - 2015-11-23 12:13:50,954 DEBUG : BROWSER_OUTPUT: 12:13:51 INFO - 2015-11-23 12:13:51,380 INFO : Browser exited with error code: 0 12:13:51 INFO - 2015-11-23 12:13:51,404 INFO : Completed test dromaeo_css (00:18:35) 12:13:51 INFO - 2015-11-23 12:13:51,404 INFO : Starting test kraken 12:13:51 INFO - 2015-11-23 12:13:51,404 DEBUG : operating with platform_type : mac_ 12:13:51 INFO - 2015-11-23 12:13:51,405 INFO : Initialising browser for kraken test... 12:13:51 INFO - 2015-11-23 12:13:51,417 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/tmpKt7FQp/profile http://localhost:49391/getInfo.html 12:13:53 INFO - 2015-11-23 12:13:53,311 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:13:53 INFO - 2015-11-23 12:13:53,312 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:13:53 INFO - 2015-11-23 12:13:53,312 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 12:13:53 INFO - 2015-11-23 12:13:53,312 DEBUG : BROWSER_OUTPUT: __metrics 12:13:53 INFO - 2015-11-23 12:13:53,327 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:13:54 INFO - 2015-11-23 12:13:54,111 INFO : Browser initialized. 12:13:54 INFO - 2015-11-23 12:13:54,112 INFO : Running cycle 1/1 for kraken test... 12:13:54 INFO - 2015-11-23 12:13:54,112 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/tmpKt7FQp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:14:05 INFO - 2015-11-23 12:14:05,979 DEBUG : BROWSER_OUTPUT: RSS: Main: 224698368 12:14:05 INFO - 2015-11-23 12:14:05,980 DEBUG : BROWSER_OUTPUT: 12:14:08 INFO - 2015-11-23 12:14:08,596 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49391/tests/kraken/driver.html?testName=audio-beat-detection) 12:14:09 INFO - 2015-11-23 12:14:09,199 DEBUG : BROWSER_OUTPUT: RSS: Main: 275853312 12:14:09 INFO - 2015-11-23 12:14:09,199 DEBUG : BROWSER_OUTPUT: 12:14:11 INFO - 2015-11-23 12:14:11,717 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49391/tests/kraken/driver.html?testName=audio-dft) 12:14:12 INFO - 2015-11-23 12:14:12,307 DEBUG : BROWSER_OUTPUT: RSS: Main: 290377728 12:14:12 INFO - 2015-11-23 12:14:12,307 DEBUG : BROWSER_OUTPUT: 12:14:15 INFO - 2015-11-23 12:14:15,512 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49391/tests/kraken/driver.html?testName=audio-fft) 12:14:16 INFO - 2015-11-23 12:14:16,085 DEBUG : BROWSER_OUTPUT: RSS: Main: 275382272 12:14:16 INFO - 2015-11-23 12:14:16,085 DEBUG : BROWSER_OUTPUT: 12:14:17 INFO - 2015-11-23 12:14:17,944 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49391/tests/kraken/driver.html?testName=audio-oscillator) 12:14:18 INFO - 2015-11-23 12:14:18,547 DEBUG : BROWSER_OUTPUT: RSS: Main: 279003136 12:14:18 INFO - 2015-11-23 12:14:18,548 DEBUG : BROWSER_OUTPUT: 12:14:20 INFO - 2015-11-23 12:14:20,543 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49391/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:14:21 INFO - 2015-11-23 12:14:21,129 DEBUG : BROWSER_OUTPUT: RSS: Main: 279330816 12:14:21 INFO - 2015-11-23 12:14:21,129 DEBUG : BROWSER_OUTPUT: 12:14:23 INFO - 2015-11-23 12:14:23,954 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49391/tests/kraken/driver.html?testName=imaging-darkroom) 12:14:24 INFO - 2015-11-23 12:14:24,542 DEBUG : BROWSER_OUTPUT: RSS: Main: 281554944 12:14:24 INFO - 2015-11-23 12:14:24,542 DEBUG : BROWSER_OUTPUT: 12:14:27 INFO - 2015-11-23 12:14:27,328 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49391/tests/kraken/driver.html?testName=imaging-desaturate) 12:14:27 INFO - 2015-11-23 12:14:27,938 DEBUG : BROWSER_OUTPUT: RSS: Main: 281247744 12:14:27 INFO - 2015-11-23 12:14:27,939 DEBUG : BROWSER_OUTPUT: 12:14:30 INFO - 2015-11-23 12:14:30,761 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49391/tests/kraken/driver.html?testName=json-parse-financial) 12:14:31 INFO - 2015-11-23 12:14:31,351 DEBUG : BROWSER_OUTPUT: RSS: Main: 281784320 12:14:31 INFO - 2015-11-23 12:14:31,351 DEBUG : BROWSER_OUTPUT: 12:14:32 INFO - 2015-11-23 12:14:32,881 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49391/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:14:33 INFO - 2015-11-23 12:14:33,463 DEBUG : BROWSER_OUTPUT: RSS: Main: 313241600 12:14:33 INFO - 2015-11-23 12:14:33,463 DEBUG : BROWSER_OUTPUT: 12:14:35 INFO - 2015-11-23 12:14:35,235 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49391/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:14:35 INFO - 2015-11-23 12:14:35,857 DEBUG : BROWSER_OUTPUT: RSS: Main: 315936768 12:14:35 INFO - 2015-11-23 12:14:35,858 DEBUG : BROWSER_OUTPUT: 12:14:37 INFO - 2015-11-23 12:14:37,899 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49391/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:14:38 INFO - 2015-11-23 12:14:38,490 DEBUG : BROWSER_OUTPUT: RSS: Main: 322068480 12:14:38 INFO - 2015-11-23 12:14:38,490 DEBUG : BROWSER_OUTPUT: 12:14:41 INFO - 2015-11-23 12:14:41,038 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49391/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:14:41 INFO - 2015-11-23 12:14:41,656 DEBUG : BROWSER_OUTPUT: RSS: Main: 324751360 12:14:41 INFO - 2015-11-23 12:14:41,656 DEBUG : BROWSER_OUTPUT: 12:14:44 INFO - 2015-11-23 12:14:44,048 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49391/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:14:44 INFO - 2015-11-23 12:14:44,635 DEBUG : BROWSER_OUTPUT: RSS: Main: 323297280 12:14:44 INFO - 2015-11-23 12:14:44,635 DEBUG : BROWSER_OUTPUT: 12:14:46 INFO - 2015-11-23 12:14:46,295 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49391/tests/kraken/driver.html?testName=ai-astar) 12:14:46 INFO - 2015-11-23 12:14:46,553 DEBUG : BROWSER_OUTPUT: RSS: Main: 383582208 12:14:46 INFO - 2015-11-23 12:14:46,553 DEBUG : BROWSER_OUTPUT: 12:14:46 INFO - 2015-11-23 12:14:46,553 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:14:46 INFO - 2015-11-23 12:14:46,554 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:14:46 INFO - 2015-11-23 12:14:46,554 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:14:46 INFO - 2015-11-23 12:14:46,554 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:14:46 INFO - 2015-11-23 12:14:46,554 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;110;103;110;110;114;153;132;102;109 12:14:46 INFO - 2015-11-23 12:14:46,554 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;120;143;154;119;138;137;117;154;118 12:14:46 INFO - 2015-11-23 12:14:46,554 DEBUG : BROWSER_OUTPUT: |2;audio-dft;183;183;182;181;183;186;186;185;179;184 12:14:46 INFO - 2015-11-23 12:14:46,554 DEBUG : BROWSER_OUTPUT: |3;audio-fft;67;68;72;72;55;56;56;71;74;56 12:14:46 INFO - 2015-11-23 12:14:46,554 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;83;87;115;75;75;75;110;73;73;111 12:14:46 INFO - 2015-11-23 12:14:46,554 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;87;88;89;72;106;72;114;129;129;85 12:14:46 INFO - 2015-11-23 12:14:46,554 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;95;94;93;94;94;95;94;93;95;93 12:14:46 INFO - 2015-11-23 12:14:46,554 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;84;84;85;85;87;83;85;99;142;131 12:14:46 INFO - 2015-11-23 12:14:46,554 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;56;55;53;52;53;54;53;63;52;53 12:14:46 INFO - 2015-11-23 12:14:46,554 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;64;64;65;66;66;66;66;68;68 12:14:46 INFO - 2015-11-23 12:14:46,554 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;81;81;81;79;80;82;82;84;81 12:14:46 INFO - 2015-11-23 12:14:46,555 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;120;120;126;133;122;119;124;121;122;125 12:14:46 INFO - 2015-11-23 12:14:46,555 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;132;125;135;132;134;121;131;134;133;124 12:14:46 INFO - 2015-11-23 12:14:46,555 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;64;67;66;64;65;61;65;66;65 12:14:46 INFO - 2015-11-23 12:14:46,555 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:14:46 INFO - 2015-11-23 12:14:46,555 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:14:46 INFO - 2015-11-23 12:14:46,555 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1063 12:14:46 INFO - 2015-11-23 12:14:46,555 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:14:46 INFO - 2015-11-23 12:14:46,555 DEBUG : BROWSER_OUTPUT: __startTimestamp1448309686547__endTimestamp 12:14:46 INFO - 2015-11-23 12:14:46,555 DEBUG : BROWSER_OUTPUT: 12:14:46 INFO - 2015-11-23 12:14:46,555 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:14:46 INFO - 2015-11-23 12:14:46,555 DEBUG : BROWSER_OUTPUT: Number of tests: 14 12:14:46 INFO - 2015-11-23 12:14:46,555 DEBUG : BROWSER_OUTPUT: 12:14:46 INFO - 2015-11-23 12:14:46,555 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:115.10 Median:110.00 stddev:15.66 (14.2%) stddev-sans-first:16.40 12:14:46 INFO - 2015-11-23 12:14:46,555 DEBUG : BROWSER_OUTPUT: Values: 108.0 110.0 103.0 110.0 110.0 114.0 153.0 132.0 102.0 109.0 12:14:46 INFO - 2015-11-23 12:14:46,556 DEBUG : BROWSER_OUTPUT: 12:14:46 INFO - 2015-11-23 12:14:46,556 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:135.00 Median:140.50 stddev:15.34 (10.9%) stddev-sans-first:15.28 12:14:46 INFO - 2015-11-23 12:14:46,556 DEBUG : BROWSER_OUTPUT: Values: 150.0 120.0 143.0 154.0 119.0 138.0 137.0 117.0 154.0 118.0 12:14:46 INFO - 2015-11-23 12:14:46,556 DEBUG : BROWSER_OUTPUT: 12:14:46 INFO - 2015-11-23 12:14:46,556 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:183.20 Median:183.50 stddev:2.20 (1.2%) stddev-sans-first:2.33 12:14:46 INFO - 2015-11-23 12:14:46,556 DEBUG : BROWSER_OUTPUT: Values: 183.0 183.0 182.0 181.0 183.0 186.0 186.0 185.0 179.0 184.0 12:14:46 INFO - 2015-11-23 12:14:46,556 DEBUG : BROWSER_OUTPUT: 12:14:46 INFO - 2015-11-23 12:14:46,556 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:64.70 Median:69.50 stddev:7.96 (11.5%) stddev-sans-first:8.40 12:14:46 INFO - 2015-11-23 12:14:46,556 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 72.0 72.0 55.0 56.0 56.0 71.0 74.0 56.0 12:14:46 INFO - 2015-11-23 12:14:46,556 DEBUG : BROWSER_OUTPUT: 12:14:46 INFO - 2015-11-23 12:14:46,556 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:87.70 Median:75.00 stddev:17.40 (23.2%) stddev-sans-first:18.37 12:14:46 INFO - 2015-11-23 12:14:46,556 DEBUG : BROWSER_OUTPUT: Values: 83.0 87.0 115.0 75.0 75.0 75.0 110.0 73.0 73.0 111.0 12:14:46 INFO - 2015-11-23 12:14:46,556 DEBUG : BROWSER_OUTPUT: 12:14:46 INFO - 2015-11-23 12:14:46,556 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:97.10 Median:78.50 stddev:21.23 (27.0%) stddev-sans-first:22.20 12:14:46 INFO - 2015-11-23 12:14:46,556 DEBUG : BROWSER_OUTPUT: Values: 87.0 88.0 89.0 72.0 106.0 72.0 114.0 129.0 129.0 85.0 12:14:46 INFO - 2015-11-23 12:14:46,557 DEBUG : BROWSER_OUTPUT: 12:14:46 INFO - 2015-11-23 12:14:46,557 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:94.00 Median:94.00 stddev:0.82 (0.9%) stddev-sans-first:0.78 12:14:46 INFO - 2015-11-23 12:14:46,557 DEBUG : BROWSER_OUTPUT: Values: 95.0 94.0 93.0 94.0 94.0 95.0 94.0 93.0 95.0 93.0 12:14:46 INFO - 2015-11-23 12:14:46,557 DEBUG : BROWSER_OUTPUT: 12:14:46 INFO - 2015-11-23 12:14:46,557 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.50 Median:85.00 stddev:21.73 (25.6%) stddev-sans-first:22.57 12:14:46 INFO - 2015-11-23 12:14:46,557 DEBUG : BROWSER_OUTPUT: Values: 84.0 84.0 85.0 85.0 87.0 83.0 85.0 99.0 142.0 131.0 12:14:46 INFO - 2015-11-23 12:14:46,557 DEBUG : BROWSER_OUTPUT: 12:14:46 INFO - 2015-11-23 12:14:46,557 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:54.40 Median:53.50 stddev:3.27 (6.1%) stddev-sans-first:3.42 12:14:46 INFO - 2015-11-23 12:14:46,557 DEBUG : BROWSER_OUTPUT: Values: 56.0 55.0 53.0 52.0 53.0 54.0 53.0 63.0 52.0 53.0 12:14:46 INFO - 2015-11-23 12:14:46,557 DEBUG : BROWSER_OUTPUT: 12:14:46 INFO - 2015-11-23 12:14:46,557 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:1.49 (2.3%) stddev-sans-first:1.45 12:14:46 INFO - 2015-11-23 12:14:46,557 DEBUG : BROWSER_OUTPUT: Values: 64.0 64.0 64.0 65.0 66.0 66.0 66.0 66.0 68.0 68.0 12:14:46 INFO - 2015-11-23 12:14:46,557 DEBUG : BROWSER_OUTPUT: 12:14:46 INFO - 2015-11-23 12:14:46,557 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:81.00 stddev:1.32 (1.6%) stddev-sans-first:1.39 12:14:46 INFO - 2015-11-23 12:14:46,558 DEBUG : BROWSER_OUTPUT: Values: 81.0 81.0 81.0 81.0 79.0 80.0 82.0 82.0 84.0 81.0 12:14:46 INFO - 2015-11-23 12:14:46,558 DEBUG : BROWSER_OUTPUT: 12:14:46 INFO - 2015-11-23 12:14:46,558 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.20 Median:123.00 stddev:4.13 (3.4%) stddev-sans-first:4.22 12:14:46 INFO - 2015-11-23 12:14:46,558 DEBUG : BROWSER_OUTPUT: Values: 120.0 120.0 126.0 133.0 122.0 119.0 124.0 121.0 122.0 125.0 12:14:46 INFO - 2015-11-23 12:14:46,558 DEBUG : BROWSER_OUTPUT: 12:14:46 INFO - 2015-11-23 12:14:46,558 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:130.10 Median:132.50 stddev:4.91 (3.7%) stddev-sans-first:5.16 12:14:46 INFO - 2015-11-23 12:14:46,558 DEBUG : BROWSER_OUTPUT: Values: 132.0 125.0 135.0 132.0 134.0 121.0 131.0 134.0 133.0 124.0 12:14:46 INFO - 2015-11-23 12:14:46,558 DEBUG : BROWSER_OUTPUT: 12:14:46 INFO - 2015-11-23 12:14:46,558 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.50 stddev:1.66 (2.5%) stddev-sans-first:1.72 12:14:46 INFO - 2015-11-23 12:14:46,558 DEBUG : BROWSER_OUTPUT: Values: 66.0 64.0 67.0 66.0 64.0 65.0 61.0 65.0 66.0 65.0 12:14:46 INFO - 2015-11-23 12:14:46,558 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:14:46 INFO - 2015-11-23 12:14:46,558 DEBUG : BROWSER_OUTPUT: 12:14:47 INFO - 2015-11-23 12:14:47,199 INFO : Browser exited with error code: 0 12:14:47 INFO - 2015-11-23 12:14:47,246 INFO : Completed test kraken (00:00:55) 12:14:47 INFO - 2015-11-23 12:14:47,246 INFO : Starting test v8_7 12:14:47 INFO - 2015-11-23 12:14:47,246 DEBUG : operating with platform_type : mac_ 12:14:47 INFO - 2015-11-23 12:14:47,246 INFO : Initialising browser for v8_7 test... 12:14:47 INFO - 2015-11-23 12:14:47,259 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/tmpqdw912/profile http://localhost:49391/getInfo.html 12:14:49 INFO - 2015-11-23 12:14:49,246 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:14:49 INFO - 2015-11-23 12:14:49,246 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:14:49 INFO - 2015-11-23 12:14:49,246 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 12:14:49 INFO - 2015-11-23 12:14:49,246 DEBUG : BROWSER_OUTPUT: __metrics 12:14:49 INFO - 2015-11-23 12:14:49,264 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:14:49 INFO - 2015-11-23 12:14:49,915 INFO : Browser initialized. 12:14:49 INFO - 2015-11-23 12:14:49,916 INFO : Running cycle 1/1 for v8_7 test... 12:14:49 INFO - 2015-11-23 12:14:49,916 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/tmpqdw912/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:15:01 INFO - 2015-11-23 12:15:01,816 DEBUG : BROWSER_OUTPUT: RSS: Main: 226258944 12:15:01 INFO - 2015-11-23 12:15:01,816 DEBUG : BROWSER_OUTPUT: 12:15:23 INFO - 2015-11-23 12:15:23,252 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49391/tests/v8_7/run.html (next: http://localhost:49391/tests/v8_7/run.html) 12:15:23 INFO - 2015-11-23 12:15:23,514 DEBUG : BROWSER_OUTPUT: RSS: Main: 685944832 12:15:23 INFO - 2015-11-23 12:15:23,514 DEBUG : BROWSER_OUTPUT: 12:15:23 INFO - 2015-11-23 12:15:23,514 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:15:23 INFO - 2015-11-23 12:15:23,514 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:15:23 INFO - 2015-11-23 12:15:23,514 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:15:23 INFO - 2015-11-23 12:15:23,514 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:15:23 INFO - 2015-11-23 12:15:23,514 DEBUG : BROWSER_OUTPUT: |0;Richards;149.2537313432836 12:15:23 INFO - 2015-11-23 12:15:23,514 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;162.07901554404145 12:15:23 INFO - 2015-11-23 12:15:23,514 DEBUG : BROWSER_OUTPUT: |2;Encrypt;282.0078962210942 12:15:23 INFO - 2015-11-23 12:15:23,514 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4812.5 12:15:23 INFO - 2015-11-23 12:15:23,515 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1706.4846416382252 12:15:23 INFO - 2015-11-23 12:15:23,515 DEBUG : BROWSER_OUTPUT: |5;Earley;790.5138339920949 12:15:23 INFO - 2015-11-23 12:15:23,515 DEBUG : BROWSER_OUTPUT: |6;Boyer;12625 12:15:23 INFO - 2015-11-23 12:15:23,515 DEBUG : BROWSER_OUTPUT: |7;RegExp;26921.052631578947 12:15:23 INFO - 2015-11-23 12:15:23,515 DEBUG : BROWSER_OUTPUT: |8;Splay;738.0073800738007 12:15:23 INFO - 2015-11-23 12:15:23,515 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4538.461538461538 12:15:23 INFO - 2015-11-23 12:15:23,515 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:15:23 INFO - 2015-11-23 12:15:23,515 DEBUG : BROWSER_OUTPUT: __startTimestamp1448309723511__endTimestamp 12:15:23 INFO - 2015-11-23 12:15:23,515 DEBUG : BROWSER_OUTPUT: 12:15:23 INFO - 2015-11-23 12:15:23,515 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:15:23 INFO - 2015-11-23 12:15:23,515 DEBUG : BROWSER_OUTPUT: Number of tests: 10 12:15:23 INFO - 2015-11-23 12:15:23,515 DEBUG : BROWSER_OUTPUT: 12:15:23 INFO - 2015-11-23 12:15:23,515 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:149.25 Median:149.25 stddev:0.00 (0.0%) 12:15:23 INFO - 2015-11-23 12:15:23,515 DEBUG : BROWSER_OUTPUT: Values: 149.3 12:15:23 INFO - 2015-11-23 12:15:23,515 DEBUG : BROWSER_OUTPUT: 12:15:23 INFO - 2015-11-23 12:15:23,516 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:162.08 Median:162.08 stddev:0.00 (0.0%) 12:15:23 INFO - 2015-11-23 12:15:23,516 DEBUG : BROWSER_OUTPUT: Values: 162.1 12:15:23 INFO - 2015-11-23 12:15:23,516 DEBUG : BROWSER_OUTPUT: 12:15:23 INFO - 2015-11-23 12:15:23,516 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:282.01 Median:282.01 stddev:0.00 (0.0%) 12:15:23 INFO - 2015-11-23 12:15:23,516 DEBUG : BROWSER_OUTPUT: Values: 282.0 12:15:23 INFO - 2015-11-23 12:15:23,516 DEBUG : BROWSER_OUTPUT: 12:15:23 INFO - 2015-11-23 12:15:23,516 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4812.50 Median:4812.50 stddev:0.00 (0.0%) 12:15:23 INFO - 2015-11-23 12:15:23,516 DEBUG : BROWSER_OUTPUT: Values: 4812.5 12:15:23 INFO - 2015-11-23 12:15:23,516 DEBUG : BROWSER_OUTPUT: 12:15:23 INFO - 2015-11-23 12:15:23,516 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1706.48 Median:1706.48 stddev:0.00 (0.0%) 12:15:23 INFO - 2015-11-23 12:15:23,516 DEBUG : BROWSER_OUTPUT: Values: 1706.5 12:15:23 INFO - 2015-11-23 12:15:23,516 DEBUG : BROWSER_OUTPUT: 12:15:23 INFO - 2015-11-23 12:15:23,516 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:790.51 Median:790.51 stddev:0.00 (0.0%) 12:15:23 INFO - 2015-11-23 12:15:23,516 DEBUG : BROWSER_OUTPUT: Values: 790.5 12:15:23 INFO - 2015-11-23 12:15:23,516 DEBUG : BROWSER_OUTPUT: 12:15:23 INFO - 2015-11-23 12:15:23,517 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12625.00 Median:12625.00 stddev:0.00 (0.0%) 12:15:23 INFO - 2015-11-23 12:15:23,517 DEBUG : BROWSER_OUTPUT: Values: 12625.0 12:15:23 INFO - 2015-11-23 12:15:23,517 DEBUG : BROWSER_OUTPUT: 12:15:23 INFO - 2015-11-23 12:15:23,517 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26921.05 Median:26921.05 stddev:0.00 (0.0%) 12:15:23 INFO - 2015-11-23 12:15:23,517 DEBUG : BROWSER_OUTPUT: Values: 26921.1 12:15:23 INFO - 2015-11-23 12:15:23,517 DEBUG : BROWSER_OUTPUT: 12:15:23 INFO - 2015-11-23 12:15:23,517 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:738.01 Median:738.01 stddev:0.00 (0.0%) 12:15:23 INFO - 2015-11-23 12:15:23,517 DEBUG : BROWSER_OUTPUT: Values: 738.0 12:15:23 INFO - 2015-11-23 12:15:23,517 DEBUG : BROWSER_OUTPUT: 12:15:23 INFO - 2015-11-23 12:15:23,517 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4538.46 Median:4538.46 stddev:0.00 (0.0%) 12:15:23 INFO - 2015-11-23 12:15:23,517 DEBUG : BROWSER_OUTPUT: Values: 4538.5 12:15:23 INFO - 2015-11-23 12:15:23,517 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:15:23 INFO - 2015-11-23 12:15:23,517 DEBUG : BROWSER_OUTPUT: 12:15:24 INFO - 2015-11-23 12:15:24,152 INFO : Browser exited with error code: 0 12:15:24 INFO - 2015-11-23 12:15:24,169 INFO : Completed test v8_7 (00:00:36) 12:15:24 INFO - 2015-11-23 12:15:24,554 INFO : Completed test suite (00:20:08) 12:15:24 INFO - 2015-11-23 12:15:24,554 DEBUG : Working with test: dromaeo_css 12:15:24 INFO - 2015-11-23 12:15:24,554 DEBUG : Generating results file: dromaeo_css 12:15:24 INFO - 2015-11-23 12:15:24,555 DEBUG : Working with test: kraken 12:15:24 INFO - 2015-11-23 12:15:24,555 DEBUG : Generating results file: kraken 12:15:24 INFO - 2015-11-23 12:15:24,555 INFO : javascript benchmark 12:15:24 INFO - 2015-11-23 12:15:24,555 DEBUG : Working with test: v8_7 12:15:24 INFO - 2015-11-23 12:15:24,555 DEBUG : Generating results file: v8_7 12:15:24 INFO - 2015-11-23 12:15:24,556 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:15:25 INFO - 2015-11-23 12:15:25,034 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 12:15:25 INFO - 2015-11-23 12:15:25,034 DEBUG : process_Request line: dromaeo_css 7754.18 graph.html#tests=[[72,64,59]] 12:15:25 INFO - 2015-11-23 12:15:25,034 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:15:25 INFO - 2015-11-23 12:15:25,067 DEBUG : process_Request line: kraken 1392.80 graph.html#tests=[[232,64,59]] 12:15:25 INFO - 2015-11-23 12:15:25,067 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:15:25 INFO - 2015-11-23 12:15:25,098 DEBUG : process_Request line: v8_7 20380.52 graph.html#tests=[[230,64,59]] 12:15:25 INFO - 2015-11-23 12:15:25,099 INFO : javascript benchmark 12:15:25 INFO - 2015-11-23 12:15:25,101 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3182.7772055956084, 3415.795052296861, 3447.120984149043, 3474.7567670263074, 3506.964930350697, 5454.781808727646, 5585.190147428621, 5881.823545293642, 5946.167536544882, 5951.851203719903, 5978.432048955353, 6015.248093988252, 6026.3069746979, 6052.0, 6064.090386442036, 5362.865928351793, 5381.165919282517, 5441.156620723794, 5456.590755693339, 5486.423925487826, 5483.232347471358, 5487.176923461473, 5497.47773961473, 5504.64219825712, 5512.669239845602, 5447.210154527591, 5452.291202143716, 5465.371482279549, 5466.371367292772, 5472.20653005314, 5463.0, 5467.234587157801, 5480.205370221295, 5481.780728770845, 5511.311086114236, 5315.0, 5325.147976323769, 5439.374471935738, 5461.726913654302, 5472.616916815825, 5935.40645935403, 6043.123747056696, 6052.364501727343, 6075.058365953284, 6081.027035674271, 6315.989441689354, 6352.174217351715, 6356.110144579762, 6360.204974378203, 6444.548881578291, 6204.627722336674, 6234.532410069263, 6331.715072821734, 6339.175907132043, 6343.175387199681, 5870.14882841994, 5889.705514724246, 5922.378150294243, 5926.140709597171, 6110.266767987825, 6397.552171347961, 6409.198850143732, 6451.580647258007, 6458.773942912069, 6461.676916154173, 6181.536384771161, 6257.624542527463, 6268.2478102627065, 6324.114623952651, 6344.333844946214, 6372.55392122547, 6411.2627047889155, 6412.903806442907, 6414.422701956846, 6429.389208025324, 6246.4378205960775, 6251.74993000284, 6321.525885558602, 6325.620462772248, 6352.872942541123, 6167.074938759222, 6237.812865614039, 6343.270523889812, 6354.9682251589375, 6361.840953976095, 5104.081265372269, 5121.513456221653, 5137.511936366114, 5143.691378517226, 5175.0, 4483.798229079699, 4523.909521809545, 4550.97724511382, 4585.495595484494, 4619.676622636383, 5798.623089499169, 5917.940820591825, 5951.9107213391835, 5963.165156878041, 5967.5524335675, 6335.081413195061, 6386.329435409215, 6390.712417941204, 6411.96794016027, 6423.74305027803, 5936.079907614327, 5955.28536575605, 5994.850128746729, 6021.3677563856045, 6033.306169790442, 5500.4499550045475, 5540.889182216414, 5546.639468434539, 5574.637648552831, 5620.9437905621235, 6367.0, 6370.554061215856, 6386.680665966683, 6419.454346380517, 6426.518011149089, 6370.8088757337355, 6379.617222966637, 6387.0, 6392.0, 6396.32838551964, 6233.158523599437, 6248.937510624835, 6282.685865706788, 6283.528735344776, 6343.0, 5987.251593550806, 6128.411459112376, 6340.9365906340345, 6360.77737279193, 6364.745410183541, 6370.490360771035, 6377.713002914973, 6379.266384365857, 6398.392152745481, 6404.423601875854, 6101.267847858286, 6102.084687296941, 6219.844503887439, 6352.047192920914, 6403.839904002437, 6202.596831205957, 6203.4416902479, 6227.719752611053, 6304.842378940563, 6305.085762564311, 6278.277998030285, 6284.057391391328, 6286.717097730521, 6294.0558916162945, 6302.621842689453, 6109.495762817132, 6213.409726076015, 6218.595791273553, 6289.339619339903, 6356.555041147075, 6060.969695151496, 6096.969515152573, 6114.436698562323, 6172.074188871526, 6243.907316219735], "unit": "ms", "name": "dojo.html", "value": 5874.062862068874}, {"lowerIsBetter": false, "replicates": [525.6332841686382, 573.2748073686785, 621.8992383481238, 630.9463695585875, 646.1599920103866, 32017.83991080044, 32437.0, 32533.67466325339, 32590.348193036156, 32612.67387326126, 32982.0, 33404.66595334046, 42060.78969605148, 42644.786776066074, 42658.0, 9717.46553939533, 9806.705798826046, 9851.029794041184, 9857.802843943116, 9878.703638890845, 8862.33532485063, 9205.953970230139, 9763.46300953451, 9766.658166964122, 9796.0, 8730.912690873105, 8814.515201663906, 11885.108616853728, 11965.641030769091, 12086.516539338416, 9989.500524973795, 11694.415279236047, 11800.055995520337, 11802.114841386887, 11811.0, 8845.027047024822, 11568.479418426192, 11711.414429278588, 11734.178607497479, 11740.412979351084, 32090.35819283601, 32435.675643243503, 42778.0, 42869.0, 42990.1401971962, 3283.3761585298716, 3326.7172290355347, 3340.9665903341142, 3578.355895938756, 3975.840966361342, 28346.43307133846, 28904.71095289041, 29044.98342558, 29135.708642913723, 29173.833046678108, 2694.3398867277447, 2749.8762555685043, 2783.6937936826935, 2828.6888442271334, 2896.8551572421507, 460718.69640651916, 627661.0, 630005.8499707473, 630035.0, 645438.0, 48035.0, 54086.72956635192, 63129.0, 64713.35286647167, 68243.65878170676, 62444.06781355764, 62470.68764656148, 62517.37482625207, 62546.37453625406, 62645.060324095175, 13444.798328025088, 15808.0, 16368.83631163673, 16604.335826566803, 16605.41881034158, 12716.427760750788, 12726.618201453972, 12796.424160912782, 12812.039097067756, 13023.47906083746, 16424.589385265463, 19603.607927841364, 19703.0, 19725.802741972682, 19790.307339243056, 9026.548672566345, 9204.447733136034, 9244.0, 9253.676121335855, 9261.907380926104, 920.6961702638114, 938.4088024544493, 946.1720994130136, 995.2485873165858, 995.7361299255703, 28971.42057158845, 29255.268618284714, 29298.853505732335, 29911.551326730118, 30108.096757097323, 1083.6369816111533, 1086.8913108689069, 1171.1684703860356, 1177.60550215677, 1237.7648246833073, 13173.209607423585, 14374.784378234335, 14507.766839818734, 15061.0, 15215.61960950963, 500087.0, 517113.0, 517889.0, 519076.0, 519880.0, 59100.0, 59415.70292148511, 59415.70292148511, 59482.70258648679, 59569.0, 1341.3896677011935, 1354.6545630864066, 1355.2139758939988, 1471.9843308117365, 1616.7574863770294, 32959.83520082384, 33587.99236022923, 33670.66329336675, 33722.32555348928, 34170.4744904805, 63061.0, 63433.682831585546, 63792.04311935417, 63833.36166638274, 63873.72252555016, 515449.0, 525448.0, 525496.0, 586959.0, 603421.0, 37927.24145517019, 38551.42172867465, 45143.32285015793, 45458.0, 47951.0, 48771.0, 48873.511264886896, 49137.26294105663, 49213.0, 50672.74663626658, 40323.59676403316, 40324.39513407242, 41093.58906410898, 41104.97237569085, 41535.376969346085, 39583.0, 39779.0, 40398.39402408907, 40649.79675101605, 40743.1851362977, 38899.80550097232, 38991.0, 39591.208175836895, 39759.2048159041, 40016.3997540043, 33554.16114597155, 35735.64264357323, 35918.28163436769, 35992.64007359893, 36208.81895590505, 25819.870900645376, 26252.73747262503, 27320.316992075357, 32885.013449596554, 33789.3242135151], "unit": "ms", "name": "ext.html", "value": 20808.322278060605}, {"lowerIsBetter": false, "replicates": [323.2936034764042, 346.7482388577237, 353.28636154966966, 359.25633937748853, 360.3279883018172, 14967.401303947829, 16002.919985400056, 19307.613847723056, 19957.40127796165, 20907.268245611405, 20913.9543022849, 21406.0, 21408.464788380297, 22278.443038924033, 22337.55324893501, 6635.4359879410185, 6784.3554862288, 6786.185657721056, 6788.422984046362, 6824.317568243186, 4769.833055843029, 4914.97542512287, 6699.397054265115, 6741.426978706816, 7632.9236707633045, 7341.449391295648, 7587.924120758777, 7592.54444733315, 7596.810079747996, 7635.923640763604, 7551.433642476809, 7587.279208475186, 7588.962055189744, 7592.658330375119, 7608.1631020587965, 6437.0, 6968.233494315621, 6983.336583024656, 7193.992841002264, 7194.928050719478, 11915.582954596548, 12879.742405151845, 26878.0, 27538.724612753816, 27570.448591028267, 1926.9710954335696, 2088.3108574170487, 2097.192580856366, 2110.1242984161554, 2191.37545799448, 9384.296177786626, 9463.242940564738, 9601.519924003773, 9828.4102953823, 9829.459379734111, 1623.5048310265365, 1675.3549883294897, 1700.5748562859285, 1739.930402783887, 1742.1724680776656, 103738.0, 109258.0, 110279.0, 111891.0, 112414.0, 11043.779124417466, 11047.502862371213, 11057.004869561779, 11071.446427678584, 11143.108551315876, 13130.737385252241, 13242.20546767197, 13256.40346184424, 13259.93370033163, 13294.601161965156, 7693.730534461751, 8187.263146316741, 8381.664733410717, 8413.15868413166, 8457.815905773197, 8503.107173746792, 8534.359923005799, 8542.273906717874, 8610.182032706884, 8633.95683021581, 3903.414487826792, 4226.535081141072, 4276.3157894737315, 4279.079997800488, 4330.220560299176, 1628.3079691131459, 1645.8643535960389, 1650.909199994012, 1661.2109248107295, 1667.7248254037947, 848.3806821020567, 901.4861528928448, 970.4856426094182, 984.5963155106515, 1053.1345185244068, 19008.714869276973, 20135.892525910924, 20208.393748187576, 20259.392218233475, 20267.695984560243, 838.8196537744415, 940.8965013848472, 944.5088553951906, 1024.9897501024893, 1028.6605420211313, 8308.459950103224, 10352.482375881176, 10540.051395374454, 10691.251612387214, 10709.625163119254, 754147.0, 757305.0, 761039.0, 766814.0, 772988.0, 111018.0, 114643.0, 115477.0, 115713.26430103555, 116133.25800113005, 1136.6135513925306, 1155.0, 1171.9238249513585, 1172.60717659585, 1176.6175992802373, 17435.0, 17622.29510819553, 17700.822991769917, 17814.376496822548, 17844.821551784316, 47856.282155766996, 49725.756856078886, 49737.25394119019, 49880.501194987584, 51316.486835131174, 61239.77520449655, 63476.0, 64169.037464439, 66450.0, 68252.29369265809, 9552.88703387359, 9647.469389183661, 9885.209183265179, 9943.955884632009, 9950.751231219278, 19806.90096549508, 19811.702824457934, 20109.49726256855, 20514.794852051287, 20687.0, 11423.143264255048, 15447.768283475532, 15639.530814075595, 16054.0, 16227.432039878548, 15272.770908436605, 15383.923125381116, 15530.223488825739, 15649.921750391175, 15772.92113539425, 16231.0, 16304.918475407547, 16603.41888033913, 16678.999260044435, 17266.482005539852, 9661.516924153624, 9833.4099954003, 9884.456354900261, 10028.247881408777, 10032.247581431568, 13227.66930826737, 15971.600709982344, 16044.598885027968, 16333.265003075128, 16394.0], "unit": "ms", "name": "jquery.html", "value": 10137.522903880938}, {"lowerIsBetter": false, "replicates": [1585.738353171727, 1713.143428285857, 1736.6266252755659, 1892.4511891551451, 1989.313686778061, 7538.472306938516, 7929.484583502069, 8182.754517364474, 8244.670213191464, 8267.255946964771, 8416.831663366744, 8508.61711222995, 8519.659213631447, 8521.488710677364, 8562.357823163273, 2138.486763176842, 2198.670199470076, 2294.621387471065, 2314.93055208344, 2321.0, 1838.549555358939, 2048.672212446009, 2338.2751347082376, 2397.340731298898, 2401.2436082634003, 2321.454458202321, 2353.7293211280667, 2364.3143488388346, 2366.7988221001237, 2381.761823817622, 2126.6809978503193, 2194.561087782434, 2364.869932153731, 2394.760523947609, 2397.1969390254285, 2093.0372028866586, 2193.848229679415, 2331.0908745589236, 2373.1456675596773, 2376.9881150594138, 8359.080501144868, 8515.276201522878, 8538.487690738575, 8544.31645468361, 8550.1449855014, 5136.974315128437, 5233.921491177597, 5259.526642602184, 5261.000409922102, 5265.052290587692, 3452.6202117767025, 3521.5950165731015, 3539.1859872229275, 3557.982210088933, 3557.9822100889587, 968.7142293023575, 1004.9648262310857, 1010.9039641234071, 1022.4785359466651, 1057.8519007338978, 11173.497192626352, 11179.60871369498, 11180.496877640526, 11195.552177912874, 11215.551377944872, 4618.168729628699, 4678.602318802872, 4727.361806156125, 4745.003549254626, 4755.0, 9706.951465242628, 9719.9028009719, 9732.464714440774, 9740.46427446483, 9749.561269742879, 5252.894942101137, 5253.737313134328, 5264.815731449381, 5270.683758974474, 5281.339832520935, 4810.628970743392, 4826.61387089032, 4830.203016502238, 4838.080764654705, 4840.975795121002, 3805.847766089381, 3873.1285460771664, 3893.3575959966856, 3898.1034362096875, 3945.9605403946166, 1285.3958639439636, 1288.5443925930965, 1290.1549485087282, 1298.1626850681446, 1300.8829205371374, 1381.7650999330137, 1396.629893078335, 1420.488624095325, 1421.8649228323293, 1422.3243959119336, 7933.722319718782, 8054.073781515201, 8084.353251739847, 8090.959545202236, 8093.595320233965, 1205.8311836342918, 1218.1899037140379, 1226.5093962414926, 1229.6987238126537, 1253.486070711004, 5987.520998320124, 6110.633361998294, 6111.236095488064, 6231.781887633911, 6347.587406818542, 9670.323077384515, 9701.951490242503, 9845.55694993727, 9864.0, 9923.950380248052, 9788.804223915482, 9796.65711700087, 9799.510024498746, 9911.603535858629, 9919.15687166599, 7671.309582137635, 7714.845703085907, 7738.961305193438, 7752.651130699132, 8052.718154864551, 7952.801179970547, 8006.799830004296, 8010.599470026592, 8013.8397232056195, 8022.719204827803, 9054.049324820799, 9082.863757043517, 9269.582868771056, 9407.247420206504, 9416.199623032118, 9331.206847418045, 9493.905060949579, 9507.572159252712, 9635.0, 9652.469114198786, 7399.334059934632, 7477.588732619758, 7480.177180510031, 7487.775366739006, 7505.211952745101, 8004.359651228005, 8021.759347219593, 8057.0, 8156.265936065783, 8168.959155204186, 7523.247675232433, 7550.509216900884, 7595.658195381111, 7691.846163076595, 7692.346150577264, 7403.481756277009, 7501.474896757175, 7535.0, 7573.9242607573215, 7635.23647635232, 7547.28300811422, 7563.130240022248, 7567.545947243183, 7628.313451789366, 7632.732854350294, 6910.136232970879, 6957.095577574883, 6975.093237879246, 6975.3024697529845, 6982.476314276551, 6384.297727250092, 7019.438444924496, 7079.716811327489, 7091.574505529685, 7102.715891364288], "unit": "ms", "name": "mootools.html", "value": 4838.281866186177}, {"lowerIsBetter": false, "replicates": [314.12672769700237, 319.88803918628486, 322.5709805958075, 329.4202204120748, 332.9750268729846, 5644.491995720385, 6593.307702691221, 6640.56836305641, 6807.047013418125, 6818.079559259499, 6555.868882622344, 6664.0, 6669.2330382006085, 6688.866222675556, 6725.192976842785, 5028.245763135523, 5029.7988080476825, 5032.345795046639, 5062.443131255577, 5090.083784918713, 4113.0, 4791.233402655575, 5100.183970564711, 5113.258577506259, 5116.283720279164, 4615.976920115411, 4862.756862156895, 4930.186519224324, 4958.826441074563, 4986.551210391064, 4931.334269873575, 4947.529984651453, 4975.328330675385, 5001.199808030734, 5008.7996480140755, 3881.146147847469, 4238.597333253336, 4286.5284818669925, 4287.0, 4289.206496798102, 6301.338359472281, 6484.221893372778, 6484.935150648527, 6501.284858665543, 6508.967455162741, 5516.779328826842, 5985.700714964234, 5988.251468566429, 6006.0, 6026.789062382795, 6860.588364698134, 7251.238619944936, 7264.8547029059655, 7264.963675181643, 7266.164391095039, 4798.328234047236, 4800.087983283165, 4809.7114173149375, 4813.0, 4816.7350795706225, 7385.6307184640555, 7654.425918056112, 7705.306522412954, 7717.807054823618, 7727.536347819093, 4879.853604391874, 4884.389451318585, 4887.900222449992, 4891.1685013547785, 4891.657583969088, 4955.182394904872, 4975.129352363322, 4985.401751789808, 4988.6507944444265, 4989.600831933437, 5766.423357664284, 5929.110633405024, 5941.970290148608, 5957.582969192115, 5990.9700451497465, 7286.7085316586745, 7317.1219453664835, 7318.34134927859, 7321.890171647429, 7325.0, 1421.8791402730676, 1665.6757877487426, 1676.4216345361074, 1712.905790181552, 1734.913254337278, 1044.2481413382352, 1054.4938429553856, 1063.016709543669, 1063.409807556798, 1089.5097206257217, 5654.46282603152, 6647.368499992493, 6678.599284042876, 6684.2981486944145, 6704.765333213314, 7415.925840741632, 7502.437317201232, 7515.6242187891485, 7527.736529221451, 7531.171571127172, 5579.330480342385, 6438.77464288757, 6730.629815360105, 6743.35938085881, 6747.730090796412, 3958.6635136013188, 4008.0581063450068, 4015.4779878616177, 4016.176683779818, 4026.355783074694, 7555.848883022309, 7565.43259255558, 7575.734849280248, 7591.3926885849, 7610.6194690265265, 7463.888041679379, 7772.8056798579355, 7796.688132474751, 7799.5320280783335, 7802.219778022266, 7550.5469671819865, 7565.886511702329, 7571.167171611009, 7575.886361704579, 7579.658915348822, 7227.241139680468, 7462.8507429850015, 7499.662515186938, 7504.249575042452, 7523.548587084792, 7386.519876208029, 7400.888986665097, 7405.185429602847, 7406.296401841816, 7407.037085178892, 7542.773716788286, 7548.018757561482, 7552.207018263003, 7564.205758395289, 7567.356774674215, 4761.809527618856, 4917.852464426073, 4924.236743304794, 4930.112579735682, 4945.579625731853, 7450.627468626655, 7475.88786168197, 7483.663235154322, 7491.587962662106, 7491.887621685788, 7175.46184036189, 7191.101112360955, 7193.856122877618, 7203.387712044535, 7205.747798827226, 5837.854053648693, 6996.510244282851, 7157.0, 7189.317014883578, 7201.171865235565, 6814.488913331619, 6969.895451568332, 6988.231294557696, 6995.440364770704, 7031.43748500129, 7104.0, 7268.055152830098, 7310.19587845326, 7330.633468326669, 7334.229905859808, 6955.513114081966, 7140.464465165237, 7141.607211603412, 7156.677949492389, 7161.928380716126], "unit": "ms", "name": "prototype.html", "value": 5271.205992698059}, {"lowerIsBetter": false, "replicates": [721.844803367276, 736.5543845973186, 738.8189893476095, 767.6929228308679, 856.7986523167054, 15180.31688574014, 15199.316030778615, 15425.151616661093, 15452.69094618107, 15468.613284667888, 14378.568642940701, 14481.131132132054, 14494.347754351053, 14518.637034074127, 14519.056261343005, 660.455124522271, 763.0728664672449, 772.6329993253216, 943.448082871521, 971.9951400242988, 764.644440335244, 961.3703024518951, 977.5258999385293, 977.6578197630807, 978.0366339155926, 977.5649835823061, 1021.7547788530736, 1022.5756311130909, 1024.4109636958742, 1025.0671888581392, 775.0157300228734, 785.246163682868, 792.8572856885759, 998.9650362237323, 1014.9492525373739, 740.7370383513883, 749.8687729647345, 751.0986815821036, 751.7368920877703, 752.1613401057836, 15289.61775955599, 15372.0, 15374.846251537454, 15378.231088445533, 15405.0, 12226.266424014588, 12585.496580136783, 12949.158304710163, 13032.674183145402, 13334.066615336931, 10192.0, 10321.43232122233, 10437.269391142623, 11123.0, 11263.887361126366, 3519.5952465466544, 3589.782006142772, 3625.29306785177, 3632.945505817415, 3648.799316037617, 78120.60939695266, 78748.0, 78818.0, 78820.60589697072, 78854.0, 9343.392679475812, 9379.0, 9481.66814161501, 9506.524673766284, 10206.0, 21048.579028419652, 21081.683774743393, 21131.9434028298, 21161.941902904793, 21198.36404907855, 7176.7488137914925, 7338.77983660491, 7383.963080184565, 7387.409007279405, 7547.8113047173165, 4082.1178276912055, 4096.1193343431305, 4129.091599848029, 4136.338185890243, 4150.418941348214, 3419.26485805548, 3454.222799870009, 3461.394256005189, 3468.150303175738, 3473.0, 620.652434636605, 628.544305378606, 629.3549112160073, 636.0808631527399, 645.6545748024878, 502.5251137674935, 528.5560129491246, 530.4509832323527, 532.3638252288555, 548.9917651235235, 7769.883451748228, 8490.872636910452, 8510.319174466027, 8520.446170998865, 8737.126287371339, 526.476156224559, 535.9598030147677, 550.6806052489546, 551.7599844067844, 574.6638216643311, 3834.9808250958567, 3839.577646458887, 3868.323043467382, 3999.9400008999887, 4051.6758659307184, 101031.0, 101961.0, 102890.0, 102960.48519757354, 103066.0, 86652.1334786644, 86718.0, 86963.69554456562, 87257.0, 88579.67130493048, 62443.0, 63879.680601596694, 64412.033819492746, 65698.0, 65803.67098164478, 6808.7276508939085, 7953.8409231816195, 8125.808738590786, 8190.50856948585, 8229.670813167406, 36978.63021369752, 51723.741381294356, 51834.0, 52168.73915630398, 52411.47588524066, 71668.28331716824, 74161.0, 74505.62747186446, 74567.0, 75253.0, 10162.23783216247, 10186.185105191418, 10286.2799604027, 10497.370157790558, 10754.085902698358, 11188.66434006981, 11343.432828358384, 11371.260868043883, 11962.521499140285, 12293.569725059937, 10290.485475726333, 10340.586376544854, 10649.414282214553, 10667.733306667395, 10869.130469562258, 8372.7906802328, 10800.891991079989, 10816.67549973502, 11100.990039870332, 11252.718682033015, 8506.800782895372, 10183.643572474928, 10579.735506612089, 10600.787984240118, 10608.098311643596, 9087.454752714859, 9519.23219851039, 9955.885997521686, 10087.848682269625, 10091.899081009096, 9544.0, 9840.458774767456, 9859.901400986186, 9862.852057219005, 9983.351082179926], "unit": "ms", "name": "yui.html", "value": 6878.099533373355}], "name": "dromaeo_css", "value": 7754.176216505905}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 110.0, 103.0, 110.0, 110.0, 114.0, 153.0, 132.0, 102.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 115.1}, {"lowerIsBetter": true, "replicates": [150.0, 120.0, 143.0, 154.0, 119.0, 138.0, 137.0, 117.0, 154.0, 118.0], "unit": "ms", "name": "audio-beat-detection", "value": 135.0}, {"lowerIsBetter": true, "replicates": [183.0, 183.0, 182.0, 181.0, 183.0, 186.0, 186.0, 185.0, 179.0, 184.0], "unit": "ms", "name": "audio-dft", "value": 183.2}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 72.0, 72.0, 55.0, 56.0, 56.0, 71.0, 74.0, 56.0], "unit": "ms", "name": "audio-fft", "value": 64.7}, {"lowerIsBetter": true, "replicates": [83.0, 87.0, 115.0, 75.0, 75.0, 75.0, 110.0, 73.0, 73.0, 111.0], "unit": "ms", "name": "audio-oscillator", "value": 87.7}, {"lowerIsBetter": true, "replicates": [87.0, 88.0, 89.0, 72.0, 106.0, 72.0, 114.0, 129.0, 129.0, 85.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 97.1}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 93.0, 94.0, 94.0, 95.0, 94.0, 93.0, 95.0, 93.0], "unit": "ms", "name": "imaging-darkroom", "value": 94.0}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 85.0, 85.0, 87.0, 83.0, 85.0, 99.0, 142.0, 131.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 53.0, 52.0, 53.0, 54.0, 53.0, 63.0, 52.0, 53.0], "unit": "ms", "name": "json-parse-financial", "value": 54.4}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 64.0, 65.0, 66.0, 66.0, 66.0, 66.0, 68.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 65.7}, {"lowerIsBetter": true, "replicates": [81.0, 81.0, 81.0, 81.0, 79.0, 80.0, 82.0, 82.0, 84.0, 81.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 81.2}, {"lowerIsBetter": true, "replicates": [120.0, 120.0, 126.0, 133.0, 122.0, 119.0, 124.0, 121.0, 122.0, 125.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 123.2}, {"lowerIsBetter": true, "replicates": [132.0, 125.0, 135.0, 132.0, 134.0, 121.0, 131.0, 134.0, 133.0, 124.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 130.1}, {"lowerIsBetter": true, "replicates": [66.0, 64.0, 67.0, 66.0, 64.0, 65.0, 61.0, 65.0, 66.0, 65.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 64.9}], "name": "kraken", "value": 1392.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [149.2537313432836], "unit": "score", "name": "Richards", "value": 236.52340000000007}, {"lowerIsBetter": false, "replicates": [162.07901554404145], "unit": "score", "name": "DeltaBlue", "value": 407.936831168831}, {"lowerIsBetter": false, "replicates": [282.0078962210942], "unit": "score", "name": "Encrypt", "value": 943.8778259999998}, {"lowerIsBetter": false, "replicates": [4812.5], "unit": "score", "name": "Decrypt", "value": 55.31033766233766}, {"lowerIsBetter": false, "replicates": [1706.4846416382252], "unit": "score", "name": "RayTrace", "value": 433.633554}, {"lowerIsBetter": false, "replicates": [790.5138339920949], "unit": "score", "name": "Earley", "value": 843.0756950000003}, {"lowerIsBetter": false, "replicates": [12625.0], "unit": "score", "name": "Boyer", "value": 52.78914851485148}, {"lowerIsBetter": false, "replicates": [26921.052631578947], "unit": "score", "name": "RegExp", "value": 33.83913000977518}, {"lowerIsBetter": false, "replicates": [738.0073800738007], "unit": "score", "name": "Splay", "value": 110.420305}, {"lowerIsBetter": false, "replicates": [4538.461538461538], "unit": "score", "name": "NavierStokes", "value": 326.98305084745743}], "name": "v8_7", "value": 20380.515222767535}]} 12:15:25 INFO - RETURN: dromaeo_css: 7754.18 12:15:25 INFO - RETURN: kraken: 1392.80 12:15:25 INFO - RETURN: v8_7: 20380.52 12:15:25 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,59]]", "result": "20380.52"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1392.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7754.18"}}} 12:15:25 INFO - Return code: 0 12:15:25 INFO - # TBPL SUCCESS # 12:15:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:15:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:15:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:15:25 INFO - 2015-11-23 12:15:25.218 screenresolution[1952:11607] starting screenresolution argv=screenresolution get 12:15:25 INFO - 2015-11-23 12:15:25.220 screenresolution[1952:11607] Display 0: 1600x1200x32@60 12:15:25 INFO - 2015-11-23 12:15:25.226 screenresolution[1953:11610] starting screenresolution argv=screenresolution list 12:15:25 INFO - Available Modes on Display 0 12:15:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:15:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:15:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:15:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:15:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:15:25 INFO - Intel Iris: 12:15:25 INFO - Chipset Model: Intel Iris 12:15:25 INFO - Type: GPU 12:15:25 INFO - Bus: Built-In 12:15:25 INFO - VRAM (Dynamic, Max): 1536 MB 12:15:25 INFO - Vendor: Intel (0x8086) 12:15:25 INFO - Device ID: 0x0a2e 12:15:25 INFO - Revision ID: 0x0009 12:15:25 INFO - Displays: 12:15:25 INFO - Display: 12:15:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:15:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:15:25 INFO - Display Serial Number: 1600x1200 60 12:15:25 INFO - Main Display: Yes 12:15:25 INFO - Mirror: Off 12:15:25 INFO - Online: Yes 12:15:25 INFO - Rotation: Supported 12:15:25 INFO - Return code: 0 12:15:25 INFO - Running post-action listener: _resource_record_post_action 12:15:25 INFO - Running post-run listener: _resource_record_post_run 12:15:26 INFO - Total resource usage - Wall time: 1241s; CPU: 53.0%; Read bytes: 3006464; Write bytes: 692835840; Read time: 43; Write time: 2217 12:15:26 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 344107520; Write bytes: 351136256; Read time: 27025; Write time: 674 12:15:26 INFO - run-tests - Wall time: 1210s; CPU: 53.0%; Read bytes: 3006464; Write bytes: 340593664; Read time: 43; Write time: 1539 12:15:26 INFO - Running post-run listener: _upload_blobber_files 12:15:26 INFO - Blob upload gear active. 12:15:26 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 12:15:26 INFO - Copying logs to upload dir... 12:15:26 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1282.114115 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2015-11-23 12:15:26.542854) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 12:15:26.546770) ========= 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.4gvmuKfaYO/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.TgyZDApKLC/Listeners TMPDIR=/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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:0:0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009389 build_url: 'https://queue.taskcluster.net/v1/task/PHG0k_EmRGi4_A98lmq0OA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 12:15:26.573001) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:15:26.573394) ========= 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.4gvmuKfaYO/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.TgyZDApKLC/Listeners TMPDIR=/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005181 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:15:26.621914) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 12:15:26.622417) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 12:15:26.622822) ========= ========= Total master_lag: 0.20 =========