builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0057 starttime: 1448101945.11 results: success (0) buildid: 20151121014332 builduid: 366d0f62097c4c84bad0a3f63b5705d4 revision: 489332006384610e3322739f66729448da0e98d9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-21 02:32:25.105862) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-21 02:32:25.106337) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-21 02:32:25.106667) ========= 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.l0KNwrl4to/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.6TFMYnmUtV/Listeners TMPDIR=/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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.005651 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-21 02:32:25.172600) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-21 02:32:25.172954) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-21 02:32:25.242415) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 02:32:25.242746) ========= 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.l0KNwrl4to/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.6TFMYnmUtV/Listeners TMPDIR=/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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.005689 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 02:32:25.291730) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-21 02:32:25.292057) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-21 02:32:25.292487) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 02:32:25.292801) ========= 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.l0KNwrl4to/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.6TFMYnmUtV/Listeners TMPDIR=/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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-21 02:32:25-- 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.10M=0.001s 2015-11-21 02:32:25 (8.10 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.691534 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 02:32:25.999852) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 02:32:26.000211) ========= 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.l0KNwrl4to/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.6TFMYnmUtV/Listeners TMPDIR=/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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.019963 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 02:32:26.057060) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 02:32:26.057484) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 489332006384610e3322739f66729448da0e98d9 --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 489332006384610e3322739f66729448da0e98d9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.l0KNwrl4to/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.6TFMYnmUtV/Listeners TMPDIR=/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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-21 02:32:26,139 truncating revision to first 12 chars 2015-11-21 02:32:26,139 Setting DEBUG logging. 2015-11-21 02:32:26,139 attempt 1/10 2015-11-21 02:32:26,139 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/489332006384?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-21 02:32:26,863 unpacking tar archive at: fx-team-489332006384/testing/mozharness/ program finished with exit code 0 elapsedTime=0.968432 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 02:32:27.044493) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-21 02:32:27.044854) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-21 02:32:27.055765) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-21 02:32:27.056083) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-21 02:32:27.056548) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 55 secs) (at 2015-11-21 02:32:27.056884) ========= /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.l0KNwrl4to/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.6TFMYnmUtV/Listeners TMPDIR=/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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 02:32:27 INFO - MultiFileLogger online at 20151121 02:32:27 in /builds/slave/test 02:32:27 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 02:32:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:32:27 INFO - {'append_to_log': False, 02:32:27 INFO - 'base_work_dir': '/builds/slave/test', 02:32:27 INFO - 'blob_upload_branch': 'Fx-Team', 02:32:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:32:27 INFO - 'branch': 'Fx-Team', 02:32:27 INFO - 'buildbot_json_path': 'buildprops.json', 02:32:27 INFO - 'config_files': ('talos/mac_config.py',), 02:32:27 INFO - 'default_actions': ('clobber', 02:32:27 INFO - 'read-buildbot-config', 02:32:27 INFO - 'download-and-extract', 02:32:27 INFO - 'populate-webroot', 02:32:27 INFO - 'create-virtualenv', 02:32:27 INFO - 'install', 02:32:27 INFO - 'run-tests'), 02:32:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:32:27 INFO - 'download_minidump_stackwalk': True, 02:32:27 INFO - 'download_symbols': 'ondemand', 02:32:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:32:27 INFO - 'tooltool.py': '/tools/tooltool.py', 02:32:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:32:27 INFO - '/tools/misc-python/virtualenv.py')}, 02:32:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:32:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:32:27 INFO - 'installer_path': 'installer.exe', 02:32:27 INFO - 'log_level': 'info', 02:32:27 INFO - 'log_name': 'talos', 02:32:27 INFO - 'log_to_console': True, 02:32:27 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:32:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:32:27 INFO - 'opt_config_files': (), 02:32:27 INFO - 'pip_index': False, 02:32:27 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:32:27 INFO - 'cmd': ('bash', 02:32:27 INFO - '-c', 02:32:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:32:27 INFO - 'enabled': True, 02:32:27 INFO - 'halt_on_failure': False, 02:32:27 INFO - 'name': 'check_screen_resolution'},), 02:32:27 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:32:27 INFO - 'cmd': ('bash', 02:32:27 INFO - '-c', 02:32:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:32:27 INFO - 'enabled': True, 02:32:27 INFO - 'halt_on_failure': False, 02:32:27 INFO - 'name': 'check_screen_resolution'},), 02:32:27 INFO - 'run_cmd_checks_enabled': True, 02:32:27 INFO - 'sps_profile': False, 02:32:27 INFO - 'sps_profile_interval': 0, 02:32:27 INFO - 'suite': 'dromaeojs', 02:32:27 INFO - 'system_bits': '64', 02:32:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:32:27 INFO - 'title': 't-yosemite-r7-0057', 02:32:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:32:27 INFO - 'use_talos_json': True, 02:32:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:32:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:32:27 INFO - 'work_dir': 'build'} 02:32:27 INFO - ##### 02:32:27 INFO - ##### Running clobber step. 02:32:27 INFO - ##### 02:32:27 INFO - Running pre-action listener: _resource_record_pre_action 02:32:27 INFO - Running main action method: clobber 02:32:27 INFO - rmtree: /builds/slave/test/build 02:32:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:32:28 INFO - Running post-action listener: _resource_record_post_action 02:32:28 INFO - ##### 02:32:28 INFO - ##### Running read-buildbot-config step. 02:32:28 INFO - ##### 02:32:28 INFO - Running pre-action listener: _resource_record_pre_action 02:32:28 INFO - Running main action method: read_buildbot_config 02:32:28 INFO - Using buildbot properties: 02:32:28 INFO - { 02:32:28 INFO - "properties": { 02:32:28 INFO - "buildnumber": 10, 02:32:28 INFO - "product": "firefox", 02:32:28 INFO - "script_repo_revision": "production", 02:32:28 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 02:32:28 INFO - "repository": "", 02:32:28 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 02:32:28 INFO - "buildid": "20151121014332", 02:32:28 INFO - "slavename": "t-yosemite-r7-0057", 02:32:28 INFO - "pgo_build": "False", 02:32:28 INFO - "basedir": "/builds/slave/test", 02:32:28 INFO - "project": "", 02:32:28 INFO - "platform": "yosemite_r7", 02:32:28 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 02:32:28 INFO - "slavebuilddir": "test", 02:32:28 INFO - "scheduler": "tests-fx-team-macosx64-talos", 02:32:28 INFO - "branch": "fx-team", 02:32:28 INFO - "repo_path": "integration/fx-team", 02:32:28 INFO - "stage_platform": "macosx64", 02:32:28 INFO - "builduid": "366d0f62097c4c84bad0a3f63b5705d4", 02:32:28 INFO - "revision": "489332006384610e3322739f66729448da0e98d9" 02:32:28 INFO - }, 02:32:28 INFO - "sourcestamp": { 02:32:28 INFO - "repository": "", 02:32:28 INFO - "hasPatch": false, 02:32:28 INFO - "project": "", 02:32:28 INFO - "branch": "fx-team-macosx64-talos", 02:32:28 INFO - "changes": [ 02:32:28 INFO - { 02:32:28 INFO - "category": null, 02:32:28 INFO - "files": [ 02:32:28 INFO - { 02:32:28 INFO - "url": null, 02:32:28 INFO - "name": "https://queue.taskcluster.net/v1/task/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 02:32:28 INFO - } 02:32:28 INFO - ], 02:32:28 INFO - "repository": "", 02:32:28 INFO - "rev": "489332006384610e3322739f66729448da0e98d9", 02:32:28 INFO - "who": "dgottwald@mozilla.com", 02:32:28 INFO - "when": 1448101888, 02:32:28 INFO - "number": 6692178, 02:32:28 INFO - "comments": "Bug 644529 - Remove gap between bookmarks toolbar menu buttons and their popups. r=gijs", 02:32:28 INFO - "project": "", 02:32:28 INFO - "at": "Sat 21 Nov 2015 02:31:28", 02:32:28 INFO - "branch": "fx-team-macosx64-talos", 02:32:28 INFO - "revlink": "", 02:32:28 INFO - "properties": [ 02:32:28 INFO - [ 02:32:28 INFO - "buildid", 02:32:28 INFO - "20151121014332", 02:32:28 INFO - "Change" 02:32:28 INFO - ], 02:32:28 INFO - [ 02:32:28 INFO - "builduid", 02:32:28 INFO - "366d0f62097c4c84bad0a3f63b5705d4", 02:32:28 INFO - "Change" 02:32:28 INFO - ], 02:32:28 INFO - [ 02:32:28 INFO - "pgo_build", 02:32:28 INFO - "False", 02:32:28 INFO - "Change" 02:32:28 INFO - ] 02:32:28 INFO - ], 02:32:28 INFO - "revision": "489332006384610e3322739f66729448da0e98d9" 02:32:28 INFO - } 02:32:28 INFO - ], 02:32:28 INFO - "revision": "489332006384610e3322739f66729448da0e98d9" 02:32:28 INFO - } 02:32:28 INFO - } 02:32:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 02:32:28 INFO - Running post-action listener: _resource_record_post_action 02:32:28 INFO - ##### 02:32:28 INFO - ##### Running download-and-extract step. 02:32:28 INFO - ##### 02:32:28 INFO - Running pre-action listener: _resource_record_pre_action 02:32:28 INFO - Running main action method: download_and_extract 02:32:28 INFO - mkdir: /builds/slave/test/build/tests 02:32:28 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')]} 02:32:28 INFO - https://queue.taskcluster.net/v1/task/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:32:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/test_packages.json 02:32:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/test_packages.json 02:32:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 02:32:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 02:32:40 INFO - Downloaded 1149 bytes. 02:32:40 INFO - Reading from file /builds/slave/test/build/test_packages.json 02:32:40 INFO - Using the following test package requirements: 02:32:40 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 02:32:40 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 02:32:40 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 02:32:40 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 02:32:40 INFO - u'jsshell-mac.zip'], 02:32:40 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 02:32:40 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 02:32:40 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 02:32:40 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 02:32:40 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 02:32:40 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 02:32:40 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 02:32:40 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 02:32:40 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 02:32:40 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 02:32:40 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 02:32:40 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 02:32:40 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 02:32:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:32:40 INFO - https://queue.taskcluster.net/v1/task/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:32:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 02:32:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 02:32:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nl1e7m18QGeoKefNA5LIqw/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 02:32:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nl1e7m18QGeoKefNA5LIqw/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 02:32:48 INFO - Downloaded 17525290 bytes. 02:32:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 02:32:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 02:32:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 02:32:51 INFO - Return code: 0 02:32:51 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 02:32:51 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')]} 02:32:51 INFO - https://queue.taskcluster.net/v1/task/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:32:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 02:32:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 02:32:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nl1e7m18QGeoKefNA5LIqw/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 02:32:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nl1e7m18QGeoKefNA5LIqw/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 02:32:54 INFO - Downloaded 17525290 bytes. 02:32:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 02:32:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 02:32:54 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 02:32:58 INFO - Return code: 0 02:32:58 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')]} 02:32:58 INFO - https://queue.taskcluster.net/v1/task/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:32:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 02:32:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 02:32:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nl1e7m18QGeoKefNA5LIqw/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 02:32:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nl1e7m18QGeoKefNA5LIqw/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 02:32:58 INFO - Downloaded 11130997 bytes. 02:32:58 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 02:32:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 02:32:58 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 02:32:59 INFO - Return code: 0 02:32:59 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')]} 02:32:59 INFO - https://queue.taskcluster.net/v1/task/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 02:32:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 02:32:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 02:32:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 02:32:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nl1e7m18QGeoKefNA5LIqw/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 02:33:15 INFO - Downloaded 109635538 bytes. 02:33:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 02:33:15 INFO - mkdir: /builds/slave/test/properties 02:33:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:33:15 INFO - Writing to file /builds/slave/test/properties/build_url 02:33:15 INFO - Contents: 02:33:15 INFO - build_url:https://queue.taskcluster.net/v1/task/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 02:33:15 INFO - Running post-action listener: _resource_record_post_action 02:33:15 INFO - Running post-action listener: set_extra_try_arguments 02:33:15 INFO - ##### 02:33:15 INFO - ##### Running populate-webroot step. 02:33:15 INFO - ##### 02:33:15 INFO - Running pre-action listener: _resource_record_pre_action 02:33:15 INFO - Running main action method: populate_webroot 02:33:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:33:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:33:15 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 02:33:15 INFO - '../fennec_ids.txt'], 02:33:15 INFO - 'tests': ['tcheck2']}, 02:33:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:33:15 INFO - '--tppagecycles', 02:33:15 INFO - '7'], 02:33:15 INFO - 'tests': ['tsvgm']}}, 02:33:15 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:33:15 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:33:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:33:15 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:33:15 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:33:15 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:33:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:33:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:15 INFO - 'talos_options': ['--e10s'], 02:33:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:33:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:15 INFO - 'tests': ['damp', 'tps']}, 02:33:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:15 INFO - 'talos_options': ['--e10s'], 02:33:15 INFO - 'tests': ['damp', 'tps']}, 02:33:15 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:33:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:33:15 INFO - 'other': {'tests': ['a11yr', 02:33:15 INFO - 'ts_paint', 02:33:15 INFO - 'tpaint', 02:33:15 INFO - 'sessionrestore', 02:33:15 INFO - 'sessionrestore_no_auto_restore']}, 02:33:15 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:33:15 INFO - 'tests': ['a11yr', 02:33:15 INFO - 'ts_paint', 02:33:15 INFO - 'tpaint', 02:33:15 INFO - 'sessionrestore', 02:33:15 INFO - 'sessionrestore_no_auto_restore']}, 02:33:15 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:33:15 INFO - 'tests': ['a11yr', 02:33:15 INFO - 'ts_paint', 02:33:15 INFO - 'tpaint', 02:33:15 INFO - 'sessionrestore', 02:33:15 INFO - 'sessionrestore_no_auto_restore']}, 02:33:15 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:33:15 INFO - 'tests': ['a11yr', 02:33:15 INFO - 'ts_paint', 02:33:15 INFO - 'tpaint', 02:33:15 INFO - 'sessionrestore', 02:33:15 INFO - 'sessionrestore_no_auto_restore']}, 02:33:15 INFO - 'other_l64': {'tests': ['a11yr', 02:33:15 INFO - 'ts_paint', 02:33:15 INFO - 'tpaint', 02:33:15 INFO - 'sessionrestore', 02:33:15 INFO - 'sessionrestore_no_auto_restore']}, 02:33:15 INFO - 'other_nol64': {'tests': ['a11yr', 02:33:15 INFO - 'ts_paint', 02:33:15 INFO - 'tpaint', 02:33:15 INFO - 'sessionrestore', 02:33:15 INFO - 'sessionrestore_no_auto_restore']}, 02:33:15 INFO - 'svgr': {'tests': ['tsvgx', 02:33:15 INFO - 'tsvgr_opacity', 02:33:15 INFO - 'tart', 02:33:15 INFO - 'tscrollx', 02:33:15 INFO - 'cart']}, 02:33:15 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:33:15 INFO - 'tests': ['tsvgx', 02:33:15 INFO - 'tsvgr_opacity', 02:33:15 INFO - 'tart', 02:33:15 INFO - 'tscrollx', 02:33:15 INFO - 'cart']}, 02:33:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:15 INFO - 'tests': ['tp5o']}, 02:33:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:15 INFO - 'talos_options': ['--e10s'], 02:33:15 INFO - 'tests': ['tp5o']}, 02:33:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:15 INFO - 'talos_options': ['--xperf_path', 02:33:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:33:15 INFO - 'tests': ['tp5n']}, 02:33:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:15 INFO - 'talos_options': ['--e10s', 02:33:15 INFO - '--xperf_path', 02:33:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:33:15 INFO - 'tests': ['tp5n']}}, 02:33:15 INFO - 'talos.zip': {'path': '', 02:33:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:33:15 INFO - Running post-action listener: _resource_record_post_action 02:33:15 INFO - ##### 02:33:15 INFO - ##### Running create-virtualenv step. 02:33:15 INFO - ##### 02:33:15 INFO - Running pre-action listener: _resource_record_pre_action 02:33:15 INFO - Running main action method: create_virtualenv 02:33:15 INFO - Creating virtualenv /builds/slave/test/build/venv 02:33:15 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 02:33:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:33:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:33:15 INFO - Using real prefix '/tools/python27' 02:33:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:33:16 INFO - Installing distribute.............................................................................................................................................................................................done. 02:33:19 INFO - Installing pip.................done. 02:33:19 INFO - Return code: 0 02:33:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:33:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11016c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110149228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4bacc6190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100909f0>, '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 0x10fdefdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100838c8>, '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.l0KNwrl4to/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.6TFMYnmUtV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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 02:33:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:33:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:33:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.l0KNwrl4to/Render', 02:33:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:33:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:33:19 INFO - 'HOME': '/Users/cltbld', 02:33:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:33:19 INFO - 'LOGNAME': 'cltbld', 02:33:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:19 INFO - 'MOZ_NO_REMOTE': '1', 02:33:19 INFO - 'NO_EM_RESTART': '1', 02:33:19 INFO - 'PAGER': '/bin/cat', 02:33:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:33:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:19 INFO - 'PWD': '/builds/slave/test', 02:33:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:33:19 INFO - 'SHELL': '/bin/bash', 02:33:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6TFMYnmUtV/Listeners', 02:33:19 INFO - 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/', 02:33:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:33:19 INFO - 'USER': 'cltbld', 02:33:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:33:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:33:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:19 INFO - 'XPC_FLAGS': '0x0', 02:33:19 INFO - 'XPC_SERVICE_NAME': '0', 02:33:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:33:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:19 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 02:33:19 INFO - Cleaning up... 02:33:19 INFO - Return code: 0 02:33:19 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:33:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x11016c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110149228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4bacc6190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100909f0>, '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 0x10fdefdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100838c8>, '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.l0KNwrl4to/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.6TFMYnmUtV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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 02:33:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:33:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:33:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.l0KNwrl4to/Render', 02:33:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:33:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:33:19 INFO - 'HOME': '/Users/cltbld', 02:33:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:33:19 INFO - 'LOGNAME': 'cltbld', 02:33:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:19 INFO - 'MOZ_NO_REMOTE': '1', 02:33:19 INFO - 'NO_EM_RESTART': '1', 02:33:19 INFO - 'PAGER': '/bin/cat', 02:33:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:33:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:19 INFO - 'PWD': '/builds/slave/test', 02:33:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:33:19 INFO - 'SHELL': '/bin/bash', 02:33:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6TFMYnmUtV/Listeners', 02:33:19 INFO - 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/', 02:33:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:33:19 INFO - 'USER': 'cltbld', 02:33:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:33:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:33:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:19 INFO - 'XPC_FLAGS': '0x0', 02:33:19 INFO - 'XPC_SERVICE_NAME': '0', 02:33:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:33:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:19 INFO - Downloading/unpacking psutil>=0.7.1 02:33:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:22 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 02:33:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 02:33:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:33:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:33:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:33:22 INFO - Installing collected packages: psutil 02:33:22 INFO - Running setup.py install for psutil 02:33:22 INFO - building 'psutil._psutil_osx' extension 02:33:22 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 02:33:23 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 02:33:23 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 02:33:23 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 02:33:23 INFO - building 'psutil._psutil_posix' extension 02:33:23 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 02:33:23 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:33:23 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:33:23 INFO - ^ 02:33:23 INFO - 1 warning generated. 02:33:23 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 02:33:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:33:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:33:23 INFO - Successfully installed psutil 02:33:23 INFO - Cleaning up... 02:33:23 INFO - Return code: 0 02:33:23 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:33: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')]} 02:33:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33: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')]} 02:33:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33: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', '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 0x11016c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110149228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4bacc6190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100909f0>, '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 0x10fdefdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100838c8>, '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.l0KNwrl4to/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.6TFMYnmUtV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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 02:33: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 02:33: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 mozsystemmonitor==0.0.0 02:33:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.l0KNwrl4to/Render', 02:33:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:33:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:33:23 INFO - 'HOME': '/Users/cltbld', 02:33:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:33:23 INFO - 'LOGNAME': 'cltbld', 02:33:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:23 INFO - 'MOZ_NO_REMOTE': '1', 02:33:23 INFO - 'NO_EM_RESTART': '1', 02:33:23 INFO - 'PAGER': '/bin/cat', 02:33:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:33:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:23 INFO - 'PWD': '/builds/slave/test', 02:33:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:33:23 INFO - 'SHELL': '/bin/bash', 02:33:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6TFMYnmUtV/Listeners', 02:33:23 INFO - 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/', 02:33:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:33:23 INFO - 'USER': 'cltbld', 02:33:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:33:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:33:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:23 INFO - 'XPC_FLAGS': '0x0', 02:33:23 INFO - 'XPC_SERVICE_NAME': '0', 02:33:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:33:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:23 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:33: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 02:33: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 02:33: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 02:33: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 02:33: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 02:33: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 02:33:25 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:33:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 02:33:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:33:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:33:26 INFO - Installing collected packages: mozsystemmonitor 02:33:26 INFO - Running setup.py install for mozsystemmonitor 02:33:26 INFO - Successfully installed mozsystemmonitor 02:33:26 INFO - Cleaning up... 02:33:26 INFO - Return code: 0 02:33:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:33:26 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')]} 02:33:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:26 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')]} 02:33:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:26 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 0x11016c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110149228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4bacc6190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100909f0>, '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 0x10fdefdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100838c8>, '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.l0KNwrl4to/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.6TFMYnmUtV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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 02:33:26 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 02:33:26 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 02:33:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.l0KNwrl4to/Render', 02:33:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:33:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:33:26 INFO - 'HOME': '/Users/cltbld', 02:33:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:33:26 INFO - 'LOGNAME': 'cltbld', 02:33:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:26 INFO - 'MOZ_NO_REMOTE': '1', 02:33:26 INFO - 'NO_EM_RESTART': '1', 02:33:26 INFO - 'PAGER': '/bin/cat', 02:33:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:33:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:26 INFO - 'PWD': '/builds/slave/test', 02:33:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:33:26 INFO - 'SHELL': '/bin/bash', 02:33:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6TFMYnmUtV/Listeners', 02:33:26 INFO - 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/', 02:33:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:33:26 INFO - 'USER': 'cltbld', 02:33:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:33:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:33:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:26 INFO - 'XPC_FLAGS': '0x0', 02:33:26 INFO - 'XPC_SERVICE_NAME': '0', 02:33:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:33:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:26 INFO - Downloading/unpacking blobuploader==1.2.4 02:33:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:28 INFO - Downloading blobuploader-1.2.4.tar.gz 02:33:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 02:33:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:33:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:33:28 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 02:33:28 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 02:33:28 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 02:33:28 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 02:33:28 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 02:33:28 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 02:33:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 02:33:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:33:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:33:29 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 02:33:29 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 02:33:29 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 02:33:29 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 02:33:29 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 02:33:29 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 02:33:29 INFO - Downloading docopt-0.6.1.tar.gz 02:33:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 02:33:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:33:29 INFO - Installing collected packages: blobuploader, requests, docopt 02:33:29 INFO - Running setup.py install for blobuploader 02:33:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:33:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:33:29 INFO - Running setup.py install for requests 02:33:30 INFO - Running setup.py install for docopt 02:33:30 INFO - Successfully installed blobuploader requests docopt 02:33:30 INFO - Cleaning up... 02:33:30 INFO - Return code: 0 02:33:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:33:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:31 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 0x11016c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110149228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4bacc6190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100909f0>, '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 0x10fdefdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100838c8>, '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.l0KNwrl4to/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.6TFMYnmUtV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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 02:33:31 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 02:33:31 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 02:33:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.l0KNwrl4to/Render', 02:33:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:33:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:33:31 INFO - 'HOME': '/Users/cltbld', 02:33:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:33:31 INFO - 'LOGNAME': 'cltbld', 02:33:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:31 INFO - 'MOZ_NO_REMOTE': '1', 02:33:31 INFO - 'NO_EM_RESTART': '1', 02:33:31 INFO - 'PAGER': '/bin/cat', 02:33:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:33:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:31 INFO - 'PWD': '/builds/slave/test', 02:33:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:33:31 INFO - 'SHELL': '/bin/bash', 02:33:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6TFMYnmUtV/Listeners', 02:33:31 INFO - 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/', 02:33:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:33:31 INFO - 'USER': 'cltbld', 02:33:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:33:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:33:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:31 INFO - 'XPC_FLAGS': '0x0', 02:33:31 INFO - 'XPC_SERVICE_NAME': '0', 02:33:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:33:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:33:31 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-Q33wMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:33:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:33:31 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-pflzoQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:33:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:33:31 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-KOgplq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:33:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:33:31 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-dO0RRg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:33:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:33:31 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-uvrTlG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:33:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:33:31 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-noqqfl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:33:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:33:31 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-9YauYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:33:32 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-6DTzki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:33:32 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-KmLSG7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:33:32 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-M9He0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:33:32 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-SkvjKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:33:32 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-xcnI1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:33:32 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-w9PqRT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:33:32 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-QDD3AR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:33:32 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-gHSZsh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:33:32 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-q_lx71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:33:32 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-raBDpX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:33:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:33:33 INFO - Running setup.py install for manifestparser 02:33:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:33:33 INFO - Running setup.py install for mozcrash 02:33:33 INFO - Running setup.py install for mozdebug 02:33:33 INFO - Running setup.py install for mozdevice 02:33:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:33:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:33:33 INFO - Running setup.py install for mozfile 02:33:33 INFO - Running setup.py install for mozhttpd 02:33:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:33:33 INFO - Running setup.py install for mozinfo 02:33:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:33:34 INFO - Running setup.py install for mozInstall 02:33:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:33:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:33:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:33:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:33:34 INFO - Running setup.py install for mozleak 02:33:34 INFO - Running setup.py install for mozlog 02:33:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:33:34 INFO - Running setup.py install for moznetwork 02:33:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:33:34 INFO - Running setup.py install for mozprocess 02:33:34 INFO - Running setup.py install for mozprofile 02:33:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:33:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:33:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:33:35 INFO - Running setup.py install for mozrunner 02:33:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:33:35 INFO - Running setup.py install for mozscreenshot 02:33:35 INFO - Running setup.py install for moztest 02:33:35 INFO - Running setup.py install for mozversion 02:33:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:33:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:33:35 INFO - Cleaning up... 02:33:35 INFO - Return code: 0 02:33:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:33:35 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')]} 02:33:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:35 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')]} 02:33:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:35 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 0x11016c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110149228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4bacc6190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100909f0>, '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 0x10fdefdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100838c8>, '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.l0KNwrl4to/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.6TFMYnmUtV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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 02:33:35 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 02:33:35 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 02:33:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.l0KNwrl4to/Render', 02:33:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:33:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:33:35 INFO - 'HOME': '/Users/cltbld', 02:33:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:33:35 INFO - 'LOGNAME': 'cltbld', 02:33:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:35 INFO - 'MOZ_NO_REMOTE': '1', 02:33:35 INFO - 'NO_EM_RESTART': '1', 02:33:35 INFO - 'PAGER': '/bin/cat', 02:33:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:33:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:35 INFO - 'PWD': '/builds/slave/test', 02:33:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:33:35 INFO - 'SHELL': '/bin/bash', 02:33:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6TFMYnmUtV/Listeners', 02:33:35 INFO - 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/', 02:33:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:33:35 INFO - 'USER': 'cltbld', 02:33:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:33:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:33:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:35 INFO - 'XPC_FLAGS': '0x0', 02:33:35 INFO - 'XPC_SERVICE_NAME': '0', 02:33:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:33:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:33:35 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-vxa5Eb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:33:36 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)) 02:33:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:33:36 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-7QOO4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:33:36 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)) 02:33:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:33:36 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-rkzi8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:33:36 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)) 02:33:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:33:36 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-tXJCAm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:33:36 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)) 02:33:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:33:36 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-8vbF8J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:33:36 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)) 02:33:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:33:36 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-vnPfQi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:33:36 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)) 02:33:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:33:36 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-2n6O4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:33:36 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)) 02:33:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:33:36 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-pFleQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:33:36 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)) 02:33:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:33:36 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-rJqMVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:33:36 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)) 02:33:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:33:36 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-STS2gz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:33:36 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)) 02:33:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:33:36 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-AEJnrE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:33:37 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)) 02:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:33:37 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-gS7pa9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:33:37 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)) 02:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:33:37 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-lUNTaf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:33:37 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)) 02:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:33:37 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-MslfjT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:33:37 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)) 02:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:33:37 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-lrPTjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:33:37 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)) 02:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:33:37 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-cr6_kE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:33:37 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)) 02:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:33:37 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-wsjEAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:33:37 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)) 02:33:37 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)) 02:33:37 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)) 02:33:37 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)) 02:33:37 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)) 02:33:37 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)) 02:33:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:33:37 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 02:33:37 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 02:33:37 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 02:33:37 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 02:33:37 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 02:33:37 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 02:33:39 INFO - Downloading blessings-1.5.1.tar.gz 02:33:39 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 02:33:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:33:39 INFO - Installing collected packages: blessings 02:33:39 INFO - Running setup.py install for blessings 02:33:40 INFO - Successfully installed blessings 02:33:40 INFO - Cleaning up... 02:33:40 INFO - Return code: 0 02:33:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:33:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:33:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:33:40 INFO - Reading from file tmpfile_stdout 02:33:40 INFO - Current package versions: 02:33:40 INFO - blessings == 1.5.1 02:33:40 INFO - blobuploader == 1.2.4 02:33:40 INFO - docopt == 0.6.1 02:33:40 INFO - manifestparser == 1.1 02:33:40 INFO - mozInstall == 1.12 02:33:40 INFO - mozcrash == 0.16 02:33:40 INFO - mozdebug == 0.1 02:33:40 INFO - mozdevice == 0.47 02:33:40 INFO - mozfile == 1.2 02:33:40 INFO - mozhttpd == 0.7 02:33:40 INFO - mozinfo == 0.9 02:33:40 INFO - mozleak == 0.1 02:33:40 INFO - mozlog == 3.0 02:33:40 INFO - moznetwork == 0.27 02:33:40 INFO - mozprocess == 0.22 02:33:40 INFO - mozprofile == 0.27 02:33:40 INFO - mozrunner == 6.11 02:33:40 INFO - mozscreenshot == 0.1 02:33:40 INFO - mozsystemmonitor == 0.0 02:33:40 INFO - moztest == 0.7 02:33:40 INFO - mozversion == 1.4 02:33:40 INFO - psutil == 3.1.1 02:33:40 INFO - requests == 1.2.3 02:33:40 INFO - wsgiref == 0.1.2 02:33:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:33:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11016c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110149228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4bacc6190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100909f0>, '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 0x10fdefdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100838c8>, '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.l0KNwrl4to/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.6TFMYnmUtV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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 02:33:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:33:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:33:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.l0KNwrl4to/Render', 02:33:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:33:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:33:40 INFO - 'HOME': '/Users/cltbld', 02:33:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:33:40 INFO - 'LOGNAME': 'cltbld', 02:33:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:40 INFO - 'MOZ_NO_REMOTE': '1', 02:33:40 INFO - 'NO_EM_RESTART': '1', 02:33:40 INFO - 'PAGER': '/bin/cat', 02:33:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:33:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:40 INFO - 'PWD': '/builds/slave/test', 02:33:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:33:40 INFO - 'SHELL': '/bin/bash', 02:33:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6TFMYnmUtV/Listeners', 02:33:40 INFO - 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/', 02:33:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:33:40 INFO - 'USER': 'cltbld', 02:33:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:33:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:33:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:40 INFO - 'XPC_FLAGS': '0x0', 02:33:40 INFO - 'XPC_SERVICE_NAME': '0', 02:33:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:33:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:33:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:33:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:33:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:33:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:33:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:33:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:33:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:33:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:33:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:33:40 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:33:40 INFO - Cleaning up... 02:33:40 INFO - Return code: 0 02:33:40 INFO - Running post-action listener: _resource_record_post_action 02:33:40 INFO - Running post-action listener: _start_resource_monitoring 02:33:40 INFO - Starting resource monitoring. 02:33:40 INFO - ##### 02:33:40 INFO - ##### Running install step. 02:33:40 INFO - ##### 02:33:40 INFO - Running pre-action listener: _resource_record_pre_action 02:33:40 INFO - Running main action method: install 02:33:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:33:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:33:41 INFO - Reading from file tmpfile_stdout 02:33:41 INFO - Detecting whether we're running mozinstall >=1.0... 02:33:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:33:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:33:41 INFO - Reading from file tmpfile_stdout 02:33:41 INFO - Output received: 02:33:41 INFO - Usage: mozinstall [options] installer 02:33:41 INFO - Options: 02:33:41 INFO - -h, --help show this help message and exit 02:33:41 INFO - -d DEST, --destination=DEST 02:33:41 INFO - Directory to install application into. [default: 02:33:41 INFO - "/builds/slave/test"] 02:33:41 INFO - --app=APP Application being installed. [default: firefox] 02:33:41 INFO - mkdir: /builds/slave/test/build/application 02:33:41 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'] 02:33:41 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 02:34:12 INFO - Reading from file tmpfile_stdout 02:34:12 INFO - Output received: 02:34:12 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 02:34:12 INFO - Running post-action listener: _resource_record_post_action 02:34:12 INFO - ##### 02:34:12 INFO - ##### Running run-tests step. 02:34:12 INFO - ##### 02:34:12 INFO - Running pre-action listener: _resource_record_pre_action 02:34:12 INFO - Running main action method: run_tests 02:34:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:34:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:34:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:34:12 INFO - 2015-11-21 02:34:12.031 screenresolution[2228:25463] starting screenresolution argv=screenresolution get 02:34:12 INFO - 2015-11-21 02:34:12.033 screenresolution[2228:25463] Display 0: 1600x1200x32@60 02:34:12 INFO - 2015-11-21 02:34:12.039 screenresolution[2229:25465] starting screenresolution argv=screenresolution list 02:34:12 INFO - Available Modes on Display 0 02:34:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:34:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:34:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:34:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:34:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:34:12 INFO - Intel Iris: 02:34:12 INFO - Chipset Model: Intel Iris 02:34:12 INFO - Type: GPU 02:34:12 INFO - Bus: Built-In 02:34:12 INFO - VRAM (Dynamic, Max): 1536 MB 02:34:12 INFO - Vendor: Intel (0x8086) 02:34:12 INFO - Device ID: 0x0a2e 02:34:12 INFO - Revision ID: 0x0009 02:34:12 INFO - Displays: 02:34:12 INFO - Display: 02:34:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:34:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:34:12 INFO - Display Serial Number: 1600x1200 60 02:34:12 INFO - Main Display: Yes 02:34:12 INFO - Mirror: Off 02:34:12 INFO - Online: Yes 02:34:12 INFO - Rotation: Supported 02:34:12 INFO - Return code: 0 02:34:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:34:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:34:12 INFO - Python 2.7.3 02:34:12 INFO - Return code: 0 02:34:12 INFO - grabbing minidump binary from tooltool 02:34:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:34:12 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 0x1100909f0>, '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 0x10fdefdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100838c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:34:12 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 02:34:12 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 02:34:12 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:34:12 INFO - Return code: 0 02:34:12 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:34:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:34:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:34:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:34:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:34:12 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/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0057', '--webServer', 'localhost'] in /builds/slave/test/build 02:34:12 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/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0057 --webServer localhost 02:34:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.l0KNwrl4to/Render', 02:34:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:34:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:34:12 INFO - 'HOME': '/Users/cltbld', 02:34:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:34:12 INFO - 'LOGNAME': 'cltbld', 02:34:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:34:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:34:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:12 INFO - 'MOZ_NO_REMOTE': '1', 02:34:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:34:12 INFO - 'NO_EM_RESTART': '1', 02:34:12 INFO - 'PAGER': '/bin/cat', 02:34:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:34:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:12 INFO - 'PWD': '/builds/slave/test', 02:34:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:34:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:34:12 INFO - 'SHELL': '/bin/bash', 02:34:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6TFMYnmUtV/Listeners', 02:34:12 INFO - 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/', 02:34:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:34:12 INFO - 'USER': 'cltbld', 02:34:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:34:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:34:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:12 INFO - 'XPC_FLAGS': '0x0', 02:34:12 INFO - 'XPC_SERVICE_NAME': '0', 02:34:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:34:12 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/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0057', '--webServer', 'localhost'] with output_timeout 3600 02:34:12 INFO - mozversion INFO | application_buildid: 20151121014332 02:34:12 INFO - mozversion INFO | application_changeset: 489332006384610e3322739f66729448da0e98d9 02:34:12 INFO - mozversion INFO | application_display_name: Nightly 02:34:12 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:34:12 INFO - mozversion INFO | application_name: Firefox 02:34:12 INFO - mozversion INFO | application_remotingname: firefox 02:34:12 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 02:34:12 INFO - mozversion INFO | application_vendor: Mozilla 02:34:12 INFO - mozversion INFO | application_version: 45.0a1 02:34:12 INFO - mozversion INFO | platform_buildid: 20151121014332 02:34:12 INFO - mozversion INFO | platform_changeset: 489332006384610e3322739f66729448da0e98d9 02:34:12 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 02:34:12 INFO - mozversion INFO | platform_version: 45.0a1 02:34:12 INFO - 2015-11-21 02:34:12,580 DEBUG : using testdate: 1448102052 02:34:12 INFO - 2015-11-21 02:34:12,580 DEBUG : actual date: 1448102052 02:34:12 INFO - 2015-11-21 02:34:12,924 INFO : starting webserver on 'localhost:57698' 02:34:12 INFO - 2015-11-21 02:34:12,925 INFO : Starting test suite t-yosemite-r7-0057 02:34:12 INFO - 2015-11-21 02:34:12,925 INFO : Starting test dromaeo_css 02:34:12 INFO - 2015-11-21 02:34:12,925 DEBUG : operating with platform_type : mac_ 02:34:12 INFO - 2015-11-21 02:34:12,926 INFO : Initialising browser for dromaeo_css test... 02:34:12 INFO - 2015-11-21 02:34:12,938 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/tmpAlRwsi/profile http://localhost:57698/getInfo.html 02:34:14 INFO - 2015-11-21 02:34:14,895 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:34:14 INFO - 2015-11-21 02:34:14,896 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:34:14 INFO - 2015-11-21 02:34:14,896 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 02:34:14 INFO - 2015-11-21 02:34:14,896 DEBUG : BROWSER_OUTPUT: __metrics 02:34:14 INFO - 2015-11-21 02:34:14,912 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:34:15 INFO - 2015-11-21 02:34:15,544 INFO : Browser initialized. 02:34:15 INFO - 2015-11-21 02:34:15,544 INFO : Running cycle 1/1 for dromaeo_css test... 02:34:15 INFO - 2015-11-21 02:34:15,544 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/tmpAlRwsi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:34:27 INFO - 2015-11-21 02:34:27,474 DEBUG : BROWSER_OUTPUT: RSS: Main: 226095104 02:34:27 INFO - 2015-11-21 02:34:27,474 DEBUG : BROWSER_OUTPUT: 02:35:19 INFO - 2015-11-21 02:35:19,248 DEBUG : BROWSER_OUTPUT: 1448102119245 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] 02:37:29 INFO - 2015-11-21 02:37:29,813 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57698/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57698/tests/dromaeo/cssquery-ext.html) 02:37:31 INFO - 2015-11-21 02:37:31,359 DEBUG : BROWSER_OUTPUT: RSS: Main: 380653568 02:37:31 INFO - 2015-11-21 02:37:31,359 DEBUG : BROWSER_OUTPUT: 02:40:34 INFO - 2015-11-21 02:40:34,071 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57698/tests/dromaeo/cssquery-ext.html (next: http://localhost:57698/tests/dromaeo/cssquery-jquery.html) 02:40:34 INFO - 2015-11-21 02:40:34,672 DEBUG : BROWSER_OUTPUT: RSS: Main: 363606016 02:40:34 INFO - 2015-11-21 02:40:34,672 DEBUG : BROWSER_OUTPUT: 02:43:36 INFO - 2015-11-21 02:43:36,666 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57698/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57698/tests/dromaeo/cssquery-mootools.html) 02:43:37 INFO - 2015-11-21 02:43:37,258 DEBUG : BROWSER_OUTPUT: RSS: Main: 331067392 02:43:37 INFO - 2015-11-21 02:43:37,258 DEBUG : BROWSER_OUTPUT: 02:46:39 INFO - 2015-11-21 02:46:39,358 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57698/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57698/tests/dromaeo/cssquery-prototype.html) 02:46:39 INFO - 2015-11-21 02:46:39,942 DEBUG : BROWSER_OUTPUT: RSS: Main: 314572800 02:46:39 INFO - 2015-11-21 02:46:39,943 DEBUG : BROWSER_OUTPUT: 02:49:43 INFO - 2015-11-21 02:49:43,039 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57698/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57698/tests/dromaeo/cssquery-yui.html) 02:49:43 INFO - 2015-11-21 02:49:43,641 DEBUG : BROWSER_OUTPUT: RSS: Main: 318603264 02:49:43 INFO - 2015-11-21 02:49:43,642 DEBUG : BROWSER_OUTPUT: 02:52:46 INFO - 2015-11-21 02:52:46,169 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57698/tests/dromaeo/cssquery-yui.html (next: http://localhost:57698/tests/dromaeo/cssquery-dojo.html) 02:52:46 INFO - 2015-11-21 02:52:46,425 DEBUG : BROWSER_OUTPUT: RSS: Main: 378621952 02:52:46 INFO - 2015-11-21 02:52:46,425 DEBUG : BROWSER_OUTPUT: 02:52:46 INFO - 2015-11-21 02:52:46,426 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:52:46 INFO - 2015-11-21 02:52:46,426 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:52:46 INFO - 2015-11-21 02:52:46,426 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:52:46 INFO - 2015-11-21 02:52:46,426 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:52:46 INFO - 2015-11-21 02:52:46,426 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2949.4690955627984;3473.94789078164;3512.3502152101864;3515.314513669834;3548.414511605585;5858.238429004234;5889.175515427838;5927.2590926134235;5950.04799232123;6015.1578778970925;5909.113632955059;5928.792492262772;5974.283086029672;6108.099244189802;6109.404666050349;5289.206619007141;5363.973180134094;5368.0605893968595;5405.594580406466;5455.290812194429;5415.566754659618;5475.917861232085;5525.613207075487;5530.142827861688;5575.832725018256;5257.737113144328;5349.384820745625;5360.276362691065;5461.617686761928;5465.562754979592;5392.245085688007;5402.324709411324;5409.26974858393;5419.051665958481;5422.322209723785;5272.261883336336;5350.170723537858;5353.330833645794;5373;5373.220882971987;5801.680907550083;5815.88368232633;5839.970800146015;5848.561357898175;5853.50245229156;5294.258803767476;6204.069389591552;6312.684365781693;6318.842028949267;6336.873262534724;6366.681665916685;6373.794184137371;6449.161608990801;6455.5158363122955;6461.289258181596;5956.702164891738;6097.664628445478;6189.845253868644;6197.938020619781;6211.9068213976825;5569.331680198402;6415.069814876817;6564.310747371553;6565.179352580927;6567.408933196035;6338.968305158444;6344.714487848058;6355.936440635627;6360.950443176916;6369.808905732835;5884.734782021886;6275.246970363585;6410.551261411656;6423.614583125028;6428.325025872309;6185.690715464209;6197.938020619736;6322.810315690536;6339.302676705559;6340.461060809883;6327.17746692927;6335.524835637346;6347;6350.333215012357;6366.395192456709;5116.718580478035;5138.845834624967;5145.639805213599;5155.7679904404395;5194.870128246824;4447.666425018137;4494.775261236925;4494.865154045318;4596.149712303235;4596.4714057883775;5034.949650503448;6054.51563874889;6056.545759068087;6068.2111325528285;6077.604955677867;6364.713587888464;6426.935730642634;6433.581817181962;6439.22729272481;6439.452646525004;5758.596898217168;5934.970325148347;5963.880722385615;5981.162637230791;6048.516118710492;5577.3028371453565;5620.57845661577;5628.015097357946;5634.352049514277;5650.434956504317;6407.711652975534;6412.198475190601;6415.903761443582;6433.420992110732;6442.2269327679105;6169.876602468015;6233.625982441068;6306.716197771019;6318.778842740482;6424.132742079946;6257.937420625735;6316.115743795965;6321.494280457644;6335.683215839282;6337.429631333202;6287;6287.779927702509;6291.402316779899;6293.213348331458;6294.433500984934;6257.43683068526;6308.495320374267;6312.210973628296;6312.873742525216;6319.873602528016;6127.5866022601795;6183.474404675653;6210.192674952227;6243.875122497616;6261.123442718114;6296.653684047421;6304.621722696653;6314.273858506331;6320.241571011508;6335;6175.62946223228;6198.318184999556;6209.006558950547;6231.40801623845;6235.095911092775;4922.778474968563;6162.322144564184;6175.536834737323;6307.621542707452;6312.7159277833525;6140.723667435065;6200.348963358782;6224.097505861534;6233.096201050913;6266.467350275278 02:52:46 INFO - 2015-11-21 02:52:46,426 DEBUG : BROWSER_OUTPUT: |1;ext.html;549.7965752671512;553.382977979553;554.7198664674339;620.8230654263534;630.3633330336362;32404.351912961727;32954.17614559637;41431.64967678392;41765.95585110374;41766;44461.55538444615;44688.55311446884;44859;44883.32675009877;44939;8789;8892.466452012899;9736.464494452803;9950.800983980316;9954.601815927354;8789.692360767374;12006.21959572625;12123.454444550016;12144.149909506337;12199.695007624792;11886.286822790616;11980.940095299511;11987.700307492296;11991.820122698167;11994.760104797899;8921.910780892173;9052.366334356597;11897.7620447591;11938.761224775542;11956.88043119575;8738.781530461725;11937.28376297425;12063;12074.456649450796;12090.939545302217;41397.37903931444;41862.74411767652;41950.580494194975;41974;41977.16045679069;3135.106494649014;3193.409219294438;3199.728023118038;3550.5029295898594;3697.0757310672334;29228.707712922813;29411.558826617616;29585.408291834257;29655.851720741473;29698.554521682192;2725.9454810903867;2751.697313295536;2776.5418705913703;2828.169969523598;2895.4498645257545;509584;511130;511520;511555;512162;57114.42885571091;58136;58191.54521137005;58206.70896645574;58367.70816145892;70520.64739676268;71145;71173.64413177902;71242.51953544907;71484.64257678678;16534.007959522467;16599.6680066398;16744.995300282022;16771.496855094367;16779.748303775454;12615.432305546088;12665.936670316589;12690.048246381559;12776.808347874789;12806.487740490276;19188.328408505637;20055.395568354495;20477.692834607493;20558.486037849172;20611.660242084516;7819.452638315377;7975.04299484054;8361.16388361159;9454.810903781887;9485.4782986935;994.5922171909482;1052.4264275969615;1076.1713480620035;1134.6879608107672;1176.6940595445246;29314.79622666006;29652.555211671843;29861.55207671887;30462.69537304643;30498.54252186219;1048.505879122263;1048.5700862646431;1066.2642776484356;1075.596346767476;1081.8701755789355;14449;14501.202433866029;14664.706705865823;14758.852411475962;14805.259737013323;544575;544981;545890;546632;546934;57167.42832571621;57325.71337143371;57399;57624.711876441186;57739;1472.4699108320997;1473.3149085675213;1484.665950161205;1498.3257534109475;1500.9793340528545;28661.71338286674;28712.856435717687;28853;29321;29359.853200733858;47848.760756195996;48470.75764621155;51607.741961289954;55565.7221713905;56652;450984;451501;461356;461412;462148;27910.883564657186;30985.380292393576;31201.375972480877;31223.907163249176;31290.374192516476;33810.15474613154;37309.81345093257;42306.57693423027;42391.48910641597;43399.566004339555;35357.823210883784;37194;37747.245055099294;38015.42976855294;38107;36468.08829779277;36877.815610921774;38833.223335532566;39123.608763911994;39880;31040.111476063044;36420.22180037881;37860;37929.81035094807;37938.62061379351;29177.190281908144;31226.687733122377;33247;34042.489362660075;34091.488627671104;24344;24384.902679379826;24456.633150503112;24507.877460612584;24539.50920981606 02:52:46 INFO - 2015-11-21 02:52:46,427 DEBUG : BROWSER_OUTPUT: |2;jquery.html;361.42352947049466;362.9872954446595;363.7617360628786;368.13855577947595;373.4081480852849;15801.920990395032;17636.82363176368;19694.90152549237;20947.581048379023;21655.700657960515;9780.853287200698;11711.941440292787;12008.7598248035;15741.92129039356;19635.60728785427;3945.072907866649;5185.507376799198;5305.787768489276;5333.413324534298;5360.517553420192;4062.7765472898977;4068.9796551017203;4790.23356262998;5741.33974592923;5741.856453588673;5574.080276754331;5687.118496633028;5702.885942281152;5718.71406429679;5737.196792449061;5742.655440673552;5785.739641716133;5787.479126878559;5788.305403351583;5792.218050563162;5411.702356370398;5547.72261386929;5557.444255574451;5576.191452239443;5578.721063946787;14034.087784293988;23976.160834370712;24179.03283868643;25269.62095568568;25300.240992770247;2035.8778473291502;2099.202303124818;2156.2453141400542;2214.205746983456;2493.501299740059;9818.361806482628;9872.950635246778;9914.504274786232;11471.426428678533;15102.924485377613;1675.790526184227;1686.8481836634762;1690.5351028467269;1701.5916180116683;1737.218251786701;105412;105707;107007;108079.99999999921;108663;11019.228653994143;11239.494222759995;11250.09999200062;11252.43737813106;11294.661160165208;13328.6667833303;13361.73276534464;13364.329458817649;13369.264690441925;13380.732385352434;8530.616122274512;8539.701110461228;8550.529720865288;8632.913670863336;8641.351898607629;8776.385653004356;8786.428882122642;8814.603342849587;8848.823023539622;8878.245349145265;4050.9392359114636;4159.459270294842;4389.385486031958;4408.096340250305;4443.577860103285;1750.483607335839;1776.2273411066228;1788.4902802701167;1800.2708902894349;1804.4676820338032;874.7463235661714;1005.703317521333;1016.832222683249;1035.7669524357111;1035.8239099353127;15994.840051599567;20437;20788.896055519624;21185.89407052955;21750.782492175193;889.74642226965;890.3589415620743;952.6141912525438;988.1896844587513;1024.7591815923251;10385.324953878126;10736.463176841127;10750.354978701303;10763.78472430547;10770.784584308427;756482;759322;773487;780700;792904;120347.39826300813;126821;131217;132410;134234;1160.512584714422;1164.7845148647527;1178.8231765235284;1203.3141109567637;1205.1021988618536;17558.91220543889;17851.46445606634;17879.821201787814;18261.08694565293;18312.26750929948;51719.741401292755;52406.73796630993;52478.47521524889;52573.21140182824;53710.73144634252;74414.88377674448;75267;77728.61135694286;79763.20236797558;81172.59413702894;9462.195713364441;9698.36960597559;9907.851382229417;9985.550650220612;9985.60057597688;19900.60198795987;19911.402657920287;20120.29578964729;20390.184392624127;20642.896785515975;15087.849121508645;16097.839021609634;16129.741836142715;16252.756208656643;16370.854040217071;13563.728725425239;15620.84379156194;15724;15778.76331855046;16216.756748648544;16430.507084787474;16516.224321263286;16669.49991500257;16789.41237056697;16965.66068678595;8337.791555211168;9633.807323853624;9654.662086826927;9866.16137628281;9972.800543989224;15754.606134846721;15932;16026.759598605797;16193.59516012109;16411.753823692416 02:52:46 INFO - 2015-11-21 02:52:46,432 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1465.9706805863877;1612.9516114516562;1614.9111798851059;1912.718478619325;1926.4605910345103;7610.809729756759;8096.797580060502;8345.123762004985;8449.155084491547;8449.197326254012;8489.066202717697;8624.482531048141;8636.784080397993;8662.263707584863;8701.56492175392;2135.893205339735;2176.3035828534876;2397.352714767012;2431.5623187826186;2435.512897420514;2175.673648952662;2405.891734871935;2441.9865755711357;2442.670239517669;2445.205308274818;2363.243761996162;2401.9159329423474;2406.6630671705975;2428.5142971405703;2435.512897420523;2155.6227660159566;2209.767974362701;2216.024949022425;2396.8442051266697;2434.817388695855;2401.9159329423387;2442.303943376129;2445.5597992361368;2447.5227330670527;2449.6570480132796;8541.359398045171;8700.477971321741;8709.25971292441;8716.25911797498;8731.995820480663;5209.348831396075;5314.441983591744;5319.494648008433;5321.042212401766;5366.91949620756;3508.614052454228;3562.2341196642847;3635.127569383329;3642.763220390666;3643.9635603643887;1028.300755486269;1030.7371620236866;1053.0522529723235;1059.3961441978076;1060.390275591538;11641.18511704181;11649.70875728105;11668.941655291754;11669.124815638861;11681.766364672743;4651.720896746206;4766.332713420124;4814.470408255089;4827.951720482821;4835.516448355207;9890.406575605486;9902.356346837576;9934;9943.651972180938;9966.950165249127;5345.1982202669915;5357.866053348697;5359.464053594687;5370.570354371641;5370.758315875795;4852.611791056777;4880.072786170687;4892.926606100911;4896.143174944371;4900.068986892479;3860.0735823402742;3872.593377695358;3885.3589157788647;3914.941275880864;3938.468306778548;1281.9679508012375;1300.4018151650157;1302.6482849630547;1305.3668970549277;1306.4524177853225;1349.966250843717;1370.0888908875686;1372.8558501357213;1393.2685340196479;1417.2205287092058;7963.084245311863;8099.878501822477;8133.837323253501;8137.186281371815;8142.389320800964;495.6505663507291;500.129774192909;506.9467705890902;508.3061620887462;510.85440649415483;5970;6105.053716673922;6113.877722445526;6125.693715314216;6314.147590075373;8581.597152797227;10140.340877842917;10401.479926003669;10417.479126043667;10509.789804203872;10365;10473;10474.266801323987;10481;10484.056434920742;7841.372690184771;7966;8048.959755201186;8101.432899696964;8117.95941020303;7889.921100788919;7898.486598371088;7899.407544434075;7922.881156782538;7927.563983980936;7886.684532618631;9041.547922603711;9063.864042039242;9204.98745138021;9368.203702685349;9392.154706076486;9454.669086581936;9461.952690236505;9590.520473976134;9597.568109434953;7283.890741638986;7354.080739907512;7362.079740032496;7364.3372096511575;7372.41020718352;8003.799905002189;8080.191980801873;8111.472754270953;8163.387745918961;8207.220314070153;7607.087149542091;7661.892979430701;7706.7687969361;7779.611019449118;7821.6089195541135;7315.487915846053;7418.443616728659;7636.8472630548185;7641.656125474478;7710.383169346551;7688.0005599271735;7729.729459468892;7783.143854176149;7788.649510771916;7805.102413222552;7040;7047.01341812157;7087.716491340495;7099.716011359695;7100;5987.191729116687;6317.778877739257;7228.241034691492;7229.132504099542;7231.096112985877 02:52:46 INFO - 2015-11-21 02:52:46,432 DEBUG : BROWSER_OUTPUT: |4;prototype.html;317.81884325934215;323.7038110129232;326.6782219513779;328.906261715411;333.74968773419937;6689.933100668992;6821.829454263646;6921.584704917708;6954.37410633043;6971.965140174292;5259.8422047338545;6706.56407333523;6714.6978385972625;6718.193816741998;6795.49033822464;4970.329005584245;5047.141985862394;5065.366829146356;5066.442691303953;5073.315102461176;4782.019685964369;4844.539768721966;4935.333729946465;5061.367329083864;5078.39059312883;3806.448065030569;4065.918681626366;4979.701217926918;5012.448630650625;5030.6730062546;4364.061726728753;4716.245400735866;5038.7984480620735;5052.242163675442;5059.3422855028975;4282.785860706952;4283.1433713257165;4286.87139385819;4287.099709061101;4289.892752681177;6376.48988080957;6518.217813862319;6564.048213009087;6602.93397066028;6632.63520506372;5948.791792287249;5991;5992.640441573476;5997.5201983841625;5998.340182579913;6967.407770339527;7325.853482930312;7336.486445948785;7346.4122870170795;7353.1176258848745;4469.173202957463;4680.672352935296;4681.016986432854;4714.222153344694;4857.222844344888;7834.138244793068;7841.294283514511;7844.843103137962;7851.646675899598;7858.646360913715;4102.466679331667;4901.36282283308;4903.092927808367;4905.166121759309;4909.582685471703;4852.272159176152;4970.950290497121;4974.925376119361;4977.178765503651;4996.525330093636;5999.5800293979;6005.819825405245;6010.278766547955;6010.579259451796;6013.067974463877;7418.295261950214;7418.33235008841;7424.85150296991;7429.442791790637;7434.628268586549;1720.4064597713768;1745.7381392790928;1747.4582879307202;1747.6455746796335;1748.650269946016;1118.2619471149003;1132.2357408749062;1137.0846468592863;1139.9886001140048;1140.4126874659557;6745.9662701686175;6747.392734653905;6748.93251067483;6752.527323087336;6759.5606285591275;7464.776056718199;7516.398688104939;7521.962390188014;7606.23937606246;7616.771496855104;6822.351876571718;6855.622940738307;6901.689423975933;6905.689243984033;6908.205556361083;3992.0766447336005;4043.211573743151;4089.2026054919006;4099.385092236188;4102.405151253111;7702.3453006493955;7731.420143489261;7764.961175194087;7768.611569421506;7779.844403111906;5740.741666625012;7973.006748312921;7979.800504987422;7989.480683755537;8015.238552337519;6779.6271205084195;7282.96358518204;7521.473496855277;7714.228577142241;7734.6132693366235;7706.7687969361;7724.150343462327;7727.459077864495;7733.845323093619;7737.729179478692;7562.2437756223935;7576.545407275581;7581.469297149147;7583.734569290048;7592.316691497792;6682.766103186365;7548.773536793905;7759.456838021284;7765.339946104645;7769.378449724121;4961.900761984813;4962.255661650781;4967.677100988424;4970.179920313108;4975.179095449355;7536.246375362639;7708.691652333844;7711.344535714527;7717.691292348468;7720.996270484801;7374.446916481393;7386;7390.1501327345895;7400;7408.925910741039;5964.642121472725;7368.37368823656;7379.963100184679;7387.963060184665;7388.926110738824;7012.158540975116;7169.605671688108;7185;7188.353048225685;7227.674754636159;7379.446541509516;7400.888986665097;7412.11054673421;7413.221611730691;7435.92564074374;6259.405356491126;6587.880060389841;6895.827604309932;7044.119485064367;7169.533980291264 02:52:46 INFO - 2015-11-21 02:52:46,436 DEBUG : BROWSER_OUTPUT: |5;yui.html;728.490056960128;795.7851380127362;811.1766556944702;821.174719406996;843.4096132707107;15120.395184192634;15548;15597.532074037783;15603.765943510842;15610.609734756637;14095.71808563828;14196.858031419682;14210.289485525735;14211;14228.217448040354;748.397539980317;756.4591317208195;757.5076200469683;760.2739383888373;942.9387089839139;940.3652534539193;947.166493485735;953.1040821627682;953.8235426446095;955.2692190474293;995.6664517386648;1001.1140140975217;1001.9899801001969;1003.4531180506605;1006.3006210683578;793.9955955716024;796.55791035975;800.6157044618558;807.3944541593804;997.4264797741291;589.5961266532396;590.7459792289313;739.6486668832315;741.6180666956468;744.2408743082026;14979.251037448194;15186;15201.391944322324;15203.93572449929;15206.16366099864;10465.430185472163;12525.874741252563;12629.557965471256;12695.619131426072;12971.41628626714;8352.749417517483;10165.135963443116;10225.991226632146;10310.381377117397;10356.896431035668;3009.6388433387915;3534.734894882894;3556.1287484566187;3566.251087271676;3629.274145170976;52765.73617131928;70976.6451167746;71240.28759712388;73468.53062938711;73714.63142684306;9517;9750.317477776487;9774.413535187912;10025.348352357074;10184.134348580306;21688.24091156802;21984.560308793734;22038.669419958715;22074.44813879634;22085.779142208692;7349.04462419882;7470.0662417197855;7615.961920190474;7671.109779841224;7720.922790772132;3867.9226415472094;3921.1569512554365;3943.3690609502914;3946.1713040261293;3965;3584.534010578608;3631.745777795582;3632.5277713897026;3634.909127271839;3642.307961487309;640.4524131867187;658.0228360884083;658.5916731626422;658.601546064624;660.9107770450928;478.93198168085365;491.8499857543412;503.71827543553775;516.2797896933756;526.7339993303434;7807.843843123106;8425.07324194338;8516.616752246164;8545.188207120314;8611.48331100136;527.4909712127815;591.9970400148057;601.2064075420403;610.6000569626901;610.851062771414;3770.490983717163;3836.5776931831324;3891.630295121959;3926.980365098156;4031.113155105872;86954.00028996619;87433.56283218543;88751.55624221837;88808;97631.51184244033;69540.65229673819;70034.64982675156;82182.76725849116;83000.16999830045;83485.58257208676;71617.2838271621;71772.64113679502;73519.52960940752;73702.26297737061;74941;8198.918010819816;8406.621702023302;8682.262951373166;8692.695755648521;8890.86663700058;49864.75067624639;52777;52810.943781123395;54597.727011366274;54879;69848.65075674793;69872.65063674649;71215.93176102258;74204.2579574219;74238.62880685779;10948.507317170586;11009.669709908716;11213.215074944676;11257.04315133223;11816.527338906348;11962;12020.03839692805;12034.037277017993;12046.397680116135;12047.457864396298;11115.166362522681;11287.43562821872;11322.37726924994;11370.658880233606;11399.487023083815;11398.373089480157;11542.769144617228;11546.59586914454;11559.30644161353;11560.132990025613;11133.498992545194;11197.440127993405;11202.551897923991;11213.831792523282;11219.495122719334;9491.572879220314;9869.358491698016;9899.455529945923;10010.899891000996;10083.546240419051;9710.465924373944;9731.318807683394;9848.803023939625;9911.65309214174;10053.296269261082 02:52:46 INFO - 2015-11-21 02:52:46,436 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:52:46 INFO - 2015-11-21 02:52:46,436 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:52:46 INFO - 2015-11-21 02:52:46,436 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1334 02:52:46 INFO - 2015-11-21 02:52:46,436 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:52:46 INFO - 2015-11-21 02:52:46,436 DEBUG : BROWSER_OUTPUT: __startTimestamp1448103166420__endTimestamp 02:52:46 INFO - 2015-11-21 02:52:46,436 DEBUG : BROWSER_OUTPUT: 02:52:46 INFO - 2015-11-21 02:52:46,436 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:52:46 INFO - 2015-11-21 02:52:46,437 DEBUG : BROWSER_OUTPUT: Number of tests: 6 02:52:46 INFO - 2015-11-21 02:52:46,437 DEBUG : BROWSER_OUTPUT: 02:52:46 INFO - 2015-11-21 02:52:46,437 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5893.18 Median:6183.47 stddev:650.24 (10.5%) stddev-sans-first:609.85 02:52:46 INFO - 2015-11-21 02:52:46,437 DEBUG : BROWSER_OUTPUT: Values: 2949.5 3473.9 3512.4 3515.3 3548.4 5858.2 5889.2 5927.3 5950.0 6015.2 5909.1 5928.8 5974.3 6108.1 6109.4 5289.2 5364.0 5368.1 5405.6 5455.3 5415.6 5475.9 5525.6 5530.1 5575.8 5257.7 5349.4 5360.3 5461.6 5465.6 5392.2 5402.3 5409.3 5419.1 5422.3 5272.3 5350.2 5353.3 5373.0 5373.2 5801.7 5815.9 5840.0 5848.6 5853.5 5294.3 6204.1 6312.7 6318.8 6336.9 6366.7 6373.8 6449.2 6455.5 6461.3 5956.7 6097.7 6189.8 6197.9 6211.9 5569.3 6415.1 6564.3 6565.2 6567.4 6339.0 6344.7 6355.9 6361.0 6369.8 5884.7 6275.2 6410.6 6423.6 6428.3 6185.7 6197.9 6322.8 6339.3 6340.5 6327.2 6335.5 6347.0 6350.3 6366.4 5116.7 5138.8 5145.6 5155.8 5194.9 4447.7 4494.8 4494.9 4596.1 4596.5 5034.9 6054.5 6056.5 6068.2 6077.6 6364.7 6426.9 6433.6 6439.2 6439.5 5758.6 5935.0 5963.9 5981.2 6048.5 5577.3 5620.6 5628.0 5634.4 5650.4 6407.7 6412.2 6415.9 6433.4 6442.2 6169.9 6233.6 6306.7 6318.8 6424.1 6257.9 6316.1 6321.5 6335.7 6337.4 6287.0 6287.8 6291.4 6293.2 6294.4 6257.4 6308.5 6312.2 6312.9 6319.9 6127.6 6183.5 6210.2 6243.9 6261.1 6296.7 6304.6 6314.3 6320.2 6335.0 6175.6 6198.3 6209.0 6231.4 6235.1 4922.8 6162.3 6175.5 6307.6 6312.7 6140.7 6200.3 6224.1 6233.1 6266.5 02:52:46 INFO - 2015-11-21 02:52:46,437 DEBUG : BROWSER_OUTPUT: 02:52:46 INFO - 2015-11-21 02:52:46,437 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:65092.67 Median:34066.99 stddev:134580.29 (395.0%) stddev-sans-first:134870.58 02:52:46 INFO - 2015-11-21 02:52:46,437 DEBUG : BROWSER_OUTPUT: Values: 549.8 553.4 554.7 620.8 630.4 32404.4 32954.2 41431.6 41766.0 41766.0 44461.6 44688.6 44859.0 44883.3 44939.0 8789.0 8892.5 9736.5 9950.8 9954.6 8789.7 12006.2 12123.5 12144.1 12199.7 11886.3 11980.9 11987.7 11991.8 11994.8 8921.9 9052.4 11897.8 11938.8 11956.9 8738.8 11937.3 12063.0 12074.5 12090.9 41397.4 41862.7 41950.6 41974.0 41977.2 3135.1 3193.4 3199.7 3550.5 3697.1 29228.7 29411.6 29585.4 29655.9 29698.6 2725.9 2751.7 2776.5 2828.2 2895.4 509584.0 511130.0 511520.0 511555.0 512162.0 57114.4 58136.0 58191.5 58206.7 58367.7 70520.6 71145.0 71173.6 71242.5 71484.6 16534.0 16599.7 16745.0 16771.5 16779.7 12615.4 12665.9 12690.0 12776.8 12806.5 19188.3 20055.4 20477.7 20558.5 20611.7 7819.5 7975.0 8361.2 9454.8 9485.5 994.6 1052.4 1076.2 1134.7 1176.7 29314.8 29652.6 29861.6 30462.7 30498.5 1048.5 1048.6 1066.3 1075.6 1081.9 14449.0 14501.2 14664.7 14758.9 14805.3 544575.0 544981.0 545890.0 546632.0 546934.0 57167.4 57325.7 57399.0 57624.7 57739.0 1472.5 1473.3 1484.7 1498.3 1501.0 28661.7 28712.9 28853.0 29321.0 29359.9 47848.8 48470.8 51607.7 55565.7 56652.0 450984.0 451501.0 461356.0 461412.0 462148.0 27910.9 30985.4 31201.4 31223.9 31290.4 33810.2 37309.8 42306.6 42391.5 43399.6 35357.8 37194.0 37747.2 38015.4 38107.0 36468.1 36877.8 38833.2 39123.6 39880.0 31040.1 36420.2 37860.0 37929.8 37938.6 29177.2 31226.7 33247.0 34042.5 34091.5 24344.0 24384.9 24456.6 24507.9 24539.5 02:52:46 INFO - 2015-11-21 02:52:46,437 DEBUG : BROWSER_OUTPUT: 02:52:46 INFO - 2015-11-21 02:52:46,437 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:40003.99 Median:11642.55 stddev:127360.19 (1093.9%) stddev-sans-first:127682.68 02:52:46 INFO - 2015-11-21 02:52:46,439 DEBUG : BROWSER_OUTPUT: Values: 361.4 363.0 363.8 368.1 373.4 15801.9 17636.8 19694.9 20947.6 21655.7 9780.9 11711.9 12008.8 15741.9 19635.6 3945.1 5185.5 5305.8 5333.4 5360.5 4062.8 4069.0 4790.2 5741.3 5741.9 5574.1 5687.1 5702.9 5718.7 5737.2 5742.7 5785.7 5787.5 5788.3 5792.2 5411.7 5547.7 5557.4 5576.2 5578.7 14034.1 23976.2 24179.0 25269.6 25300.2 2035.9 2099.2 2156.2 2214.2 2493.5 9818.4 9873.0 9914.5 11471.4 15102.9 1675.8 1686.8 1690.5 1701.6 1737.2 105412.0 105707.0 107007.0 108080.0 108663.0 11019.2 11239.5 11250.1 11252.4 11294.7 13328.7 13361.7 13364.3 13369.3 13380.7 8530.6 8539.7 8550.5 8632.9 8641.4 8776.4 8786.4 8814.6 8848.8 8878.2 4050.9 4159.5 4389.4 4408.1 4443.6 1750.5 1776.2 1788.5 1800.3 1804.5 874.7 1005.7 1016.8 1035.8 1035.8 15994.8 20437.0 20788.9 21185.9 21750.8 889.7 890.4 952.6 988.2 1024.8 10385.3 10736.5 10750.4 10763.8 10770.8 756482.0 759322.0 773487.0 780700.0 792904.0 120347.4 126821.0 131217.0 132410.0 134234.0 1160.5 1164.8 1178.8 1203.3 1205.1 17558.9 17851.5 17879.8 18261.1 18312.3 51719.7 52406.7 52478.5 52573.2 53710.7 74414.9 75267.0 77728.6 79763.2 81172.6 9462.2 9698.4 9907.9 9985.6 9985.6 19900.6 19911.4 20120.3 20390.2 20642.9 15087.8 16097.8 16129.7 16252.8 16370.9 13563.7 15620.8 15724.0 15778.8 16216.8 16430.5 16516.2 16669.5 16789.4 16965.7 8337.8 9633.8 9654.7 9866.2 9972.8 15754.6 15932.0 16026.8 16193.6 16411.8 02:52:46 INFO - 2015-11-21 02:52:46,439 DEBUG : BROWSER_OUTPUT: 02:52:46 INFO - 2015-11-21 02:52:46,439 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5945.64 Median:5363.19 stddev:3123.99 (58.2%) stddev-sans-first:3114.61 02:52:46 INFO - 2015-11-21 02:52:46,440 DEBUG : BROWSER_OUTPUT: Values: 1466.0 1613.0 1614.9 1912.7 1926.5 7610.8 8096.8 8345.1 8449.2 8449.2 8489.1 8624.5 8636.8 8662.3 8701.6 2135.9 2176.3 2397.4 2431.6 2435.5 2175.7 2405.9 2442.0 2442.7 2445.2 2363.2 2401.9 2406.7 2428.5 2435.5 2155.6 2209.8 2216.0 2396.8 2434.8 2401.9 2442.3 2445.6 2447.5 2449.7 8541.4 8700.5 8709.3 8716.3 8732.0 5209.3 5314.4 5319.5 5321.0 5366.9 3508.6 3562.2 3635.1 3642.8 3644.0 1028.3 1030.7 1053.1 1059.4 1060.4 11641.2 11649.7 11668.9 11669.1 11681.8 4651.7 4766.3 4814.5 4828.0 4835.5 9890.4 9902.4 9934.0 9943.7 9967.0 5345.2 5357.9 5359.5 5370.6 5370.8 4852.6 4880.1 4892.9 4896.1 4900.1 3860.1 3872.6 3885.4 3914.9 3938.5 1282.0 1300.4 1302.6 1305.4 1306.5 1350.0 1370.1 1372.9 1393.3 1417.2 7963.1 8099.9 8133.8 8137.2 8142.4 495.7 500.1 506.9 508.3 510.9 5970.0 6105.1 6113.9 6125.7 6314.1 8581.6 10140.3 10401.5 10417.5 10509.8 10365.0 10473.0 10474.3 10481.0 10484.1 7841.4 7966.0 8049.0 8101.4 8118.0 7889.9 7898.5 7899.4 7922.9 7927.6 7886.7 9041.5 9063.9 9205.0 9368.2 9392.2 9454.7 9462.0 9590.5 9597.6 7283.9 7354.1 7362.1 7364.3 7372.4 8003.8 8080.2 8111.5 8163.4 8207.2 7607.1 7661.9 7706.8 7779.6 7821.6 7315.5 7418.4 7636.8 7641.7 7710.4 7688.0 7729.7 7783.1 7788.6 7805.1 7040.0 7047.0 7087.7 7099.7 7100.0 5987.2 6317.8 7228.2 7229.1 7231.1 02:52:46 INFO - 2015-11-21 02:52:46,440 DEBUG : BROWSER_OUTPUT: 02:52:46 INFO - 2015-11-21 02:52:46,440 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5969.33 Median:6746.68 stddev:1913.09 (28.4%) stddev-sans-first:1870.84 02:52:46 INFO - 2015-11-21 02:52:46,441 DEBUG : BROWSER_OUTPUT: Values: 317.8 323.7 326.7 328.9 333.7 6689.9 6821.8 6921.6 6954.4 6972.0 5259.8 6706.6 6714.7 6718.2 6795.5 4970.3 5047.1 5065.4 5066.4 5073.3 4782.0 4844.5 4935.3 5061.4 5078.4 3806.4 4065.9 4979.7 5012.4 5030.7 4364.1 4716.2 5038.8 5052.2 5059.3 4282.8 4283.1 4286.9 4287.1 4289.9 6376.5 6518.2 6564.0 6602.9 6632.6 5948.8 5991.0 5992.6 5997.5 5998.3 6967.4 7325.9 7336.5 7346.4 7353.1 4469.2 4680.7 4681.0 4714.2 4857.2 7834.1 7841.3 7844.8 7851.6 7858.6 4102.5 4901.4 4903.1 4905.2 4909.6 4852.3 4971.0 4974.9 4977.2 4996.5 5999.6 6005.8 6010.3 6010.6 6013.1 7418.3 7418.3 7424.9 7429.4 7434.6 1720.4 1745.7 1747.5 1747.6 1748.7 1118.3 1132.2 1137.1 1140.0 1140.4 6746.0 6747.4 6748.9 6752.5 6759.6 7464.8 7516.4 7522.0 7606.2 7616.8 6822.4 6855.6 6901.7 6905.7 6908.2 3992.1 4043.2 4089.2 4099.4 4102.4 7702.3 7731.4 7765.0 7768.6 7779.8 5740.7 7973.0 7979.8 7989.5 8015.2 6779.6 7283.0 7521.5 7714.2 7734.6 7706.8 7724.2 7727.5 7733.8 7737.7 7562.2 7576.5 7581.5 7583.7 7592.3 6682.8 7548.8 7759.5 7765.3 7769.4 4961.9 4962.3 4967.7 4970.2 4975.2 7536.2 7708.7 7711.3 7717.7 7721.0 7374.4 7386.0 7390.2 7400.0 7408.9 5964.6 7368.4 7380.0 7388.0 7388.9 7012.2 7169.6 7185.0 7188.4 7227.7 7379.4 7400.9 7412.1 7413.2 7435.9 6259.4 6587.9 6895.8 7044.1 7169.5 02:52:46 INFO - 2015-11-21 02:52:46,441 DEBUG : BROWSER_OUTPUT: 02:52:46 INFO - 2015-11-21 02:52:46,442 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:18222.75 Median:52771.37 stddev:25293.75 (47.9%) stddev-sans-first:25330.60 02:52:46 INFO - 2015-11-21 02:52:46,443 DEBUG : BROWSER_OUTPUT: Values: 728.5 795.8 811.2 821.2 843.4 15120.4 15548.0 15597.5 15603.8 15610.6 14095.7 14196.9 14210.3 14211.0 14228.2 748.4 756.5 757.5 760.3 942.9 940.4 947.2 953.1 953.8 955.3 995.7 1001.1 1002.0 1003.5 1006.3 794.0 796.6 800.6 807.4 997.4 589.6 590.7 739.6 741.6 744.2 14979.3 15186.0 15201.4 15203.9 15206.2 10465.4 12525.9 12629.6 12695.6 12971.4 8352.7 10165.1 10226.0 10310.4 10356.9 3009.6 3534.7 3556.1 3566.3 3629.3 52765.7 70976.6 71240.3 73468.5 73714.6 9517.0 9750.3 9774.4 10025.3 10184.1 21688.2 21984.6 22038.7 22074.4 22085.8 7349.0 7470.1 7616.0 7671.1 7720.9 3867.9 3921.2 3943.4 3946.2 3965.0 3584.5 3631.7 3632.5 3634.9 3642.3 640.5 658.0 658.6 658.6 660.9 478.9 491.8 503.7 516.3 526.7 7807.8 8425.1 8516.6 8545.2 8611.5 527.5 592.0 601.2 610.6 610.9 3770.5 3836.6 3891.6 3927.0 4031.1 86954.0 87433.6 88751.6 88808.0 97631.5 69540.7 70034.6 82182.8 83000.2 83485.6 71617.3 71772.6 73519.5 73702.3 74941.0 8198.9 8406.6 8682.3 8692.7 8890.9 49864.8 52777.0 52810.9 54597.7 54879.0 69848.7 69872.7 71215.9 74204.3 74238.6 10948.5 11009.7 11213.2 11257.0 11816.5 11962.0 12020.0 12034.0 12046.4 12047.5 11115.2 11287.4 11322.4 11370.7 11399.5 11398.4 11542.8 11546.6 11559.3 11560.1 11133.5 11197.4 11202.6 11213.8 11219.5 9491.6 9869.4 9899.5 10010.9 10083.5 9710.5 9731.3 9848.8 9911.7 10053.3 02:52:46 INFO - 2015-11-21 02:52:46,443 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:52:46 INFO - 2015-11-21 02:52:46,443 DEBUG : BROWSER_OUTPUT: 02:52:46 INFO - 2015-11-21 02:52:46,895 INFO : Browser exited with error code: 0 02:52:46 INFO - 2015-11-21 02:52:46,920 INFO : Completed test dromaeo_css (00:18:33) 02:52:46 INFO - 2015-11-21 02:52:46,920 INFO : Starting test kraken 02:52:46 INFO - 2015-11-21 02:52:46,920 DEBUG : operating with platform_type : mac_ 02:52:46 INFO - 2015-11-21 02:52:46,920 INFO : Initialising browser for kraken test... 02:52:46 INFO - 2015-11-21 02:52:46,933 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/tmp2MFqhT/profile http://localhost:57698/getInfo.html 02:52:48 INFO - 2015-11-21 02:52:48,990 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:52:48 INFO - 2015-11-21 02:52:48,990 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:52:48 INFO - 2015-11-21 02:52:48,991 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 02:52:48 INFO - 2015-11-21 02:52:48,991 DEBUG : BROWSER_OUTPUT: __metrics 02:52:49 INFO - 2015-11-21 02:52:49,007 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:52:49 INFO - 2015-11-21 02:52:49,265 DEBUG : BROWSER_OUTPUT: console.error: 02:52:49 INFO - 2015-11-21 02:52:49,265 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 02:52:49 INFO - 2015-11-21 02:52:49,265 DEBUG : BROWSER_OUTPUT: Stack: 02:52:49 INFO - 2015-11-21 02:52:49,265 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 02:52:49 INFO - 2015-11-21 02:52:49,265 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 02:52:49 INFO - 2015-11-21 02:52:49,265 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 02:52:49 INFO - 2015-11-21 02:52:49,265 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 02:52:49 INFO - 2015-11-21 02:52:49,266 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 02:52:49 INFO - 2015-11-21 02:52:49,266 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 02:52:49 INFO - 2015-11-21 02:52:49,266 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 02:52:49 INFO - 2015-11-21 02:52:49,266 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 02:52:49 INFO - 2015-11-21 02:52:49,266 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 02:52:49 INFO - 2015-11-21 02:52:49,266 DEBUG : BROWSER_OUTPUT: 02:52:49 INFO - 2015-11-21 02:52:49,644 INFO : Browser initialized. 02:52:49 INFO - 2015-11-21 02:52:49,645 INFO : Running cycle 1/1 for kraken test... 02:52:49 INFO - 2015-11-21 02:52:49,645 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/tmp2MFqhT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:53:01 INFO - 2015-11-21 02:53:01,571 DEBUG : BROWSER_OUTPUT: RSS: Main: 225538048 02:53:01 INFO - 2015-11-21 02:53:01,571 DEBUG : BROWSER_OUTPUT: 02:53:04 INFO - 2015-11-21 02:53:04,096 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57698/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57698/tests/kraken/driver.html?testName=audio-beat-detection) 02:53:04 INFO - 2015-11-21 02:53:04,687 DEBUG : BROWSER_OUTPUT: RSS: Main: 275234816 02:53:04 INFO - 2015-11-21 02:53:04,687 DEBUG : BROWSER_OUTPUT: 02:53:07 INFO - 2015-11-21 02:53:07,273 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57698/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57698/tests/kraken/driver.html?testName=audio-dft) 02:53:07 INFO - 2015-11-21 02:53:07,865 DEBUG : BROWSER_OUTPUT: RSS: Main: 289349632 02:53:07 INFO - 2015-11-21 02:53:07,865 DEBUG : BROWSER_OUTPUT: 02:53:11 INFO - 2015-11-21 02:53:11,198 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57698/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57698/tests/kraken/driver.html?testName=audio-fft) 02:53:11 INFO - 2015-11-21 02:53:11,777 DEBUG : BROWSER_OUTPUT: RSS: Main: 275562496 02:53:11 INFO - 2015-11-21 02:53:11,777 DEBUG : BROWSER_OUTPUT: 02:53:13 INFO - 2015-11-21 02:53:13,627 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57698/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57698/tests/kraken/driver.html?testName=audio-oscillator) 02:53:14 INFO - 2015-11-21 02:53:14,210 DEBUG : BROWSER_OUTPUT: RSS: Main: 277401600 02:53:14 INFO - 2015-11-21 02:53:14,211 DEBUG : BROWSER_OUTPUT: 02:53:16 INFO - 2015-11-21 02:53:16,213 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57698/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57698/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:53:16 INFO - 2015-11-21 02:53:16,816 DEBUG : BROWSER_OUTPUT: RSS: Main: 279031808 02:53:16 INFO - 2015-11-21 02:53:16,816 DEBUG : BROWSER_OUTPUT: 02:53:19 INFO - 2015-11-21 02:53:19,606 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57698/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57698/tests/kraken/driver.html?testName=imaging-darkroom) 02:53:20 INFO - 2015-11-21 02:53:20,198 DEBUG : BROWSER_OUTPUT: RSS: Main: 280866816 02:53:20 INFO - 2015-11-21 02:53:20,198 DEBUG : BROWSER_OUTPUT: 02:53:22 INFO - 2015-11-21 02:53:22,965 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57698/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57698/tests/kraken/driver.html?testName=imaging-desaturate) 02:53:23 INFO - 2015-11-21 02:53:23,553 DEBUG : BROWSER_OUTPUT: RSS: Main: 281030656 02:53:23 INFO - 2015-11-21 02:53:23,553 DEBUG : BROWSER_OUTPUT: 02:53:26 INFO - 2015-11-21 02:53:26,268 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57698/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57698/tests/kraken/driver.html?testName=json-parse-financial) 02:53:26 INFO - 2015-11-21 02:53:26,878 DEBUG : BROWSER_OUTPUT: RSS: Main: 279425024 02:53:26 INFO - 2015-11-21 02:53:26,879 DEBUG : BROWSER_OUTPUT: 02:53:28 INFO - 2015-11-21 02:53:28,375 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57698/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57698/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:53:28 INFO - 2015-11-21 02:53:28,959 DEBUG : BROWSER_OUTPUT: RSS: Main: 312721408 02:53:28 INFO - 2015-11-21 02:53:28,959 DEBUG : BROWSER_OUTPUT: 02:53:30 INFO - 2015-11-21 02:53:30,725 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57698/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57698/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:53:31 INFO - 2015-11-21 02:53:31,350 DEBUG : BROWSER_OUTPUT: RSS: Main: 314793984 02:53:31 INFO - 2015-11-21 02:53:31,351 DEBUG : BROWSER_OUTPUT: 02:53:33 INFO - 2015-11-21 02:53:33,374 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57698/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57698/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:53:33 INFO - 2015-11-21 02:53:33,967 DEBUG : BROWSER_OUTPUT: RSS: Main: 322596864 02:53:33 INFO - 2015-11-21 02:53:33,968 DEBUG : BROWSER_OUTPUT: 02:53:36 INFO - 2015-11-21 02:53:36,543 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57698/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57698/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:53:37 INFO - 2015-11-21 02:53:37,153 DEBUG : BROWSER_OUTPUT: RSS: Main: 324034560 02:53:37 INFO - 2015-11-21 02:53:37,154 DEBUG : BROWSER_OUTPUT: 02:53:39 INFO - 2015-11-21 02:53:39,560 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57698/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57698/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:53:40 INFO - 2015-11-21 02:53:40,154 DEBUG : BROWSER_OUTPUT: RSS: Main: 322768896 02:53:40 INFO - 2015-11-21 02:53:40,154 DEBUG : BROWSER_OUTPUT: 02:53:41 INFO - 2015-11-21 02:53:41,933 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57698/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57698/tests/kraken/driver.html?testName=ai-astar) 02:53:42 INFO - 2015-11-21 02:53:42,189 DEBUG : BROWSER_OUTPUT: RSS: Main: 383008768 02:53:42 INFO - 2015-11-21 02:53:42,189 DEBUG : BROWSER_OUTPUT: 02:53:42 INFO - 2015-11-21 02:53:42,189 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:53:42 INFO - 2015-11-21 02:53:42,189 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:53:42 INFO - 2015-11-21 02:53:42,190 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:53:42 INFO - 2015-11-21 02:53:42,190 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:53:42 INFO - 2015-11-21 02:53:42,190 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;109;105;110;111;110;98;111;110;110 02:53:42 INFO - 2015-11-21 02:53:42,190 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;119;143;173;144;141;139;117;156;118 02:53:42 INFO - 2015-11-21 02:53:42,190 DEBUG : BROWSER_OUTPUT: |2;audio-dft;183;180;183;180;181;186;205;263;184;179 02:53:42 INFO - 2015-11-21 02:53:42,190 DEBUG : BROWSER_OUTPUT: |3;audio-fft;67;65;73;73;55;56;57;74;73;54 02:53:42 INFO - 2015-11-21 02:53:42,190 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;83;86;115;74;77;76;107;74;73;107 02:53:42 INFO - 2015-11-21 02:53:42,190 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;86;85;85;86;90;86;86;85;93;132 02:53:42 INFO - 2015-11-21 02:53:42,190 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;93;94;93;94;94;94;95;93;94;94 02:53:42 INFO - 2015-11-21 02:53:42,190 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;87;85;86;86;87;84;85;87;87;104 02:53:42 INFO - 2015-11-21 02:53:42,190 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;53;53;54;54;54;54;64;52;53 02:53:42 INFO - 2015-11-21 02:53:42,190 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;64;64;64;66;67;67;68;68;68 02:53:42 INFO - 2015-11-21 02:53:42,191 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;81;81;79;80;77;82;81;83;80 02:53:42 INFO - 2015-11-21 02:53:42,191 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;122;122;130;109;120;128;119;138;125;129 02:53:42 INFO - 2015-11-21 02:53:42,191 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;136;134;134;134;134;133;131;134;134;126 02:53:42 INFO - 2015-11-21 02:53:42,191 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;65;64;66;65;65;65;66;87;94;91 02:53:42 INFO - 2015-11-21 02:53:42,191 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:53:42 INFO - 2015-11-21 02:53:42,191 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:53:42 INFO - 2015-11-21 02:53:42,191 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1080 02:53:42 INFO - 2015-11-21 02:53:42,191 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:53:42 INFO - 2015-11-21 02:53:42,191 DEBUG : BROWSER_OUTPUT: __startTimestamp1448103222185__endTimestamp 02:53:42 INFO - 2015-11-21 02:53:42,191 DEBUG : BROWSER_OUTPUT: 02:53:42 INFO - 2015-11-21 02:53:42,192 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:53:42 INFO - 2015-11-21 02:53:42,192 DEBUG : BROWSER_OUTPUT: Number of tests: 14 02:53:42 INFO - 2015-11-21 02:53:42,192 DEBUG : BROWSER_OUTPUT: 02:53:42 INFO - 2015-11-21 02:53:42,192 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.20 Median:110.00 stddev:3.99 (3.6%) stddev-sans-first:4.24 02:53:42 INFO - 2015-11-21 02:53:42,192 DEBUG : BROWSER_OUTPUT: Values: 108.0 109.0 105.0 110.0 111.0 110.0 98.0 111.0 110.0 110.0 02:53:42 INFO - 2015-11-21 02:53:42,192 DEBUG : BROWSER_OUTPUT: 02:53:42 INFO - 2015-11-21 02:53:42,192 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:140.00 Median:143.50 stddev:18.03 (12.6%) stddev-sans-first:18.76 02:53:42 INFO - 2015-11-21 02:53:42,192 DEBUG : BROWSER_OUTPUT: Values: 150.0 119.0 143.0 173.0 144.0 141.0 139.0 117.0 156.0 118.0 02:53:42 INFO - 2015-11-21 02:53:42,192 DEBUG : BROWSER_OUTPUT: 02:53:42 INFO - 2015-11-21 02:53:42,192 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:192.40 Median:183.50 stddev:25.92 (14.1%) stddev-sans-first:27.27 02:53:42 INFO - 2015-11-21 02:53:42,193 DEBUG : BROWSER_OUTPUT: Values: 183.0 180.0 183.0 180.0 181.0 186.0 205.0 263.0 184.0 179.0 02:53:42 INFO - 2015-11-21 02:53:42,193 DEBUG : BROWSER_OUTPUT: 02:53:42 INFO - 2015-11-21 02:53:42,193 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:64.70 Median:70.00 stddev:8.45 (12.1%) stddev-sans-first:8.92 02:53:42 INFO - 2015-11-21 02:53:42,193 DEBUG : BROWSER_OUTPUT: Values: 67.0 65.0 73.0 73.0 55.0 56.0 57.0 74.0 73.0 54.0 02:53:42 INFO - 2015-11-21 02:53:42,193 DEBUG : BROWSER_OUTPUT: 02:53:42 INFO - 2015-11-21 02:53:42,193 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:87.20 Median:75.00 stddev:16.18 (21.6%) stddev-sans-first:17.09 02:53:42 INFO - 2015-11-21 02:53:42,193 DEBUG : BROWSER_OUTPUT: Values: 83.0 86.0 115.0 74.0 77.0 76.0 107.0 74.0 73.0 107.0 02:53:42 INFO - 2015-11-21 02:53:42,193 DEBUG : BROWSER_OUTPUT: 02:53:42 INFO - 2015-11-21 02:53:42,193 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:91.40 Median:86.00 stddev:14.50 (16.9%) stddev-sans-first:15.25 02:53:42 INFO - 2015-11-21 02:53:42,193 DEBUG : BROWSER_OUTPUT: Values: 86.0 85.0 85.0 86.0 90.0 86.0 86.0 85.0 93.0 132.0 02:53:42 INFO - 2015-11-21 02:53:42,193 DEBUG : BROWSER_OUTPUT: 02:53:42 INFO - 2015-11-21 02:53:42,195 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:93.80 Median:94.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 02:53:42 INFO - 2015-11-21 02:53:42,195 DEBUG : BROWSER_OUTPUT: Values: 93.0 94.0 93.0 94.0 94.0 94.0 95.0 93.0 94.0 94.0 02:53:42 INFO - 2015-11-21 02:53:42,195 DEBUG : BROWSER_OUTPUT: 02:53:42 INFO - 2015-11-21 02:53:42,195 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:87.80 Median:86.50 stddev:5.79 (6.7%) stddev-sans-first:6.13 02:53:42 INFO - 2015-11-21 02:53:42,195 DEBUG : BROWSER_OUTPUT: Values: 87.0 85.0 86.0 86.0 87.0 84.0 85.0 87.0 87.0 104.0 02:53:42 INFO - 2015-11-21 02:53:42,195 DEBUG : BROWSER_OUTPUT: 02:53:42 INFO - 2015-11-21 02:53:42,195 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:54.80 Median:54.00 stddev:3.49 (6.5%) stddev-sans-first:3.61 02:53:42 INFO - 2015-11-21 02:53:42,195 DEBUG : BROWSER_OUTPUT: Values: 57.0 53.0 53.0 54.0 54.0 54.0 54.0 64.0 52.0 53.0 02:53:42 INFO - 2015-11-21 02:53:42,195 DEBUG : BROWSER_OUTPUT: 02:53:42 INFO - 2015-11-21 02:53:42,195 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:67.00 stddev:1.83 (2.7%) stddev-sans-first:1.79 02:53:42 INFO - 2015-11-21 02:53:42,196 DEBUG : BROWSER_OUTPUT: Values: 64.0 64.0 64.0 64.0 66.0 67.0 67.0 68.0 68.0 68.0 02:53:42 INFO - 2015-11-21 02:53:42,196 DEBUG : BROWSER_OUTPUT: 02:53:42 INFO - 2015-11-21 02:53:42,196 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:81.00 stddev:1.71 (2.1%) stddev-sans-first:1.74 02:53:42 INFO - 2015-11-21 02:53:42,196 DEBUG : BROWSER_OUTPUT: Values: 82.0 81.0 81.0 79.0 80.0 77.0 82.0 81.0 83.0 80.0 02:53:42 INFO - 2015-11-21 02:53:42,196 DEBUG : BROWSER_OUTPUT: 02:53:42 INFO - 2015-11-21 02:53:42,196 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.20 Median:126.50 stddev:7.80 (6.2%) stddev-sans-first:8.23 02:53:42 INFO - 2015-11-21 02:53:42,196 DEBUG : BROWSER_OUTPUT: Values: 122.0 122.0 130.0 109.0 120.0 128.0 119.0 138.0 125.0 129.0 02:53:42 INFO - 2015-11-21 02:53:42,196 DEBUG : BROWSER_OUTPUT: 02:53:42 INFO - 2015-11-21 02:53:42,196 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:133.00 Median:134.00 stddev:2.75 (2.1%) stddev-sans-first:2.69 02:53:42 INFO - 2015-11-21 02:53:42,196 DEBUG : BROWSER_OUTPUT: Values: 136.0 134.0 134.0 134.0 134.0 133.0 131.0 134.0 134.0 126.0 02:53:42 INFO - 2015-11-21 02:53:42,196 DEBUG : BROWSER_OUTPUT: 02:53:42 INFO - 2015-11-21 02:53:42,196 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.80 Median:66.00 stddev:12.45 (18.9%) stddev-sans-first:12.88 02:53:42 INFO - 2015-11-21 02:53:42,196 DEBUG : BROWSER_OUTPUT: Values: 65.0 64.0 66.0 65.0 65.0 65.0 66.0 87.0 94.0 91.0 02:53:42 INFO - 2015-11-21 02:53:42,197 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:53:42 INFO - 2015-11-21 02:53:42,197 DEBUG : BROWSER_OUTPUT: 02:53:42 INFO - 2015-11-21 02:53:42,810 INFO : Browser exited with error code: 0 02:53:42 INFO - 2015-11-21 02:53:42,857 INFO : Completed test kraken (00:00:55) 02:53:42 INFO - 2015-11-21 02:53:42,857 INFO : Starting test v8_7 02:53:42 INFO - 2015-11-21 02:53:42,857 DEBUG : operating with platform_type : mac_ 02:53:42 INFO - 2015-11-21 02:53:42,857 INFO : Initialising browser for v8_7 test... 02:53:42 INFO - 2015-11-21 02:53:42,869 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/tmpEhqO0K/profile http://localhost:57698/getInfo.html 02:53:44 INFO - 2015-11-21 02:53:44,880 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:53:44 INFO - 2015-11-21 02:53:44,880 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:53:44 INFO - 2015-11-21 02:53:44,880 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 02:53:44 INFO - 2015-11-21 02:53:44,880 DEBUG : BROWSER_OUTPUT: __metrics 02:53:44 INFO - 2015-11-21 02:53:44,897 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:53:45 INFO - 2015-11-21 02:53:45,516 INFO : Browser initialized. 02:53:45 INFO - 2015-11-21 02:53:45,516 INFO : Running cycle 1/1 for v8_7 test... 02:53:45 INFO - 2015-11-21 02:53:45,516 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/tmpEhqO0K/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:53:57 INFO - 2015-11-21 02:53:57,324 DEBUG : BROWSER_OUTPUT: RSS: Main: 226066432 02:53:57 INFO - 2015-11-21 02:53:57,324 DEBUG : BROWSER_OUTPUT: 02:54:18 INFO - 2015-11-21 02:54:18,719 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57698/tests/v8_7/run.html (next: http://localhost:57698/tests/v8_7/run.html) 02:54:18 INFO - 2015-11-21 02:54:18,968 DEBUG : BROWSER_OUTPUT: RSS: Main: 694661120 02:54:18 INFO - 2015-11-21 02:54:18,968 DEBUG : BROWSER_OUTPUT: 02:54:18 INFO - 2015-11-21 02:54:18,968 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:54:18 INFO - 2015-11-21 02:54:18,968 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:54:18 INFO - 2015-11-21 02:54:18,968 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:54:18 INFO - 2015-11-21 02:54:18,969 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:54:18 INFO - 2015-11-21 02:54:18,969 DEBUG : BROWSER_OUTPUT: |0;Richards;147.03720041170416 02:54:18 INFO - 2015-11-21 02:54:18,969 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;160.48788316482106 02:54:18 INFO - 2015-11-21 02:54:18,969 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.9552071668533 02:54:18 INFO - 2015-11-21 02:54:18,969 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4677.570093457944 02:54:18 INFO - 2015-11-21 02:54:18,969 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1708.1911262798635 02:54:18 INFO - 2015-11-21 02:54:18,969 DEBUG : BROWSER_OUTPUT: |5;Earley;783.2550860719875 02:54:18 INFO - 2015-11-21 02:54:18,969 DEBUG : BROWSER_OUTPUT: |6;Boyer;12543.20987654321 02:54:18 INFO - 2015-11-21 02:54:18,969 DEBUG : BROWSER_OUTPUT: |7;RegExp;28055.555555555555 02:54:18 INFO - 2015-11-21 02:54:18,969 DEBUG : BROWSER_OUTPUT: |8;Splay;765.6967840735069 02:54:18 INFO - 2015-11-21 02:54:18,969 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4509.009009009009 02:54:18 INFO - 2015-11-21 02:54:18,969 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:54:18 INFO - 2015-11-21 02:54:18,969 DEBUG : BROWSER_OUTPUT: __startTimestamp1448103258965__endTimestamp 02:54:18 INFO - 2015-11-21 02:54:18,969 DEBUG : BROWSER_OUTPUT: 02:54:18 INFO - 2015-11-21 02:54:18,970 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:54:18 INFO - 2015-11-21 02:54:18,970 DEBUG : BROWSER_OUTPUT: Number of tests: 10 02:54:18 INFO - 2015-11-21 02:54:18,970 DEBUG : BROWSER_OUTPUT: 02:54:18 INFO - 2015-11-21 02:54:18,970 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:147.04 Median:147.04 stddev:0.00 (0.0%) 02:54:18 INFO - 2015-11-21 02:54:18,970 DEBUG : BROWSER_OUTPUT: Values: 147.0 02:54:18 INFO - 2015-11-21 02:54:18,970 DEBUG : BROWSER_OUTPUT: 02:54:18 INFO - 2015-11-21 02:54:18,970 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:160.49 Median:160.49 stddev:0.00 (0.0%) 02:54:18 INFO - 2015-11-21 02:54:18,970 DEBUG : BROWSER_OUTPUT: Values: 160.5 02:54:18 INFO - 2015-11-21 02:54:18,970 DEBUG : BROWSER_OUTPUT: 02:54:18 INFO - 2015-11-21 02:54:18,970 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.96 Median:279.96 stddev:0.00 (0.0%) 02:54:18 INFO - 2015-11-21 02:54:18,970 DEBUG : BROWSER_OUTPUT: Values: 280.0 02:54:18 INFO - 2015-11-21 02:54:18,970 DEBUG : BROWSER_OUTPUT: 02:54:18 INFO - 2015-11-21 02:54:18,970 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4677.57 Median:4677.57 stddev:0.00 (0.0%) 02:54:18 INFO - 2015-11-21 02:54:18,970 DEBUG : BROWSER_OUTPUT: Values: 4677.6 02:54:18 INFO - 2015-11-21 02:54:18,971 DEBUG : BROWSER_OUTPUT: 02:54:18 INFO - 2015-11-21 02:54:18,971 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1708.19 Median:1708.19 stddev:0.00 (0.0%) 02:54:18 INFO - 2015-11-21 02:54:18,971 DEBUG : BROWSER_OUTPUT: Values: 1708.2 02:54:18 INFO - 2015-11-21 02:54:18,971 DEBUG : BROWSER_OUTPUT: 02:54:18 INFO - 2015-11-21 02:54:18,971 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:783.26 Median:783.26 stddev:0.00 (0.0%) 02:54:18 INFO - 2015-11-21 02:54:18,971 DEBUG : BROWSER_OUTPUT: Values: 783.3 02:54:18 INFO - 2015-11-21 02:54:18,971 DEBUG : BROWSER_OUTPUT: 02:54:18 INFO - 2015-11-21 02:54:18,971 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12543.21 Median:12543.21 stddev:0.00 (0.0%) 02:54:18 INFO - 2015-11-21 02:54:18,971 DEBUG : BROWSER_OUTPUT: Values: 12543.2 02:54:18 INFO - 2015-11-21 02:54:18,971 DEBUG : BROWSER_OUTPUT: 02:54:18 INFO - 2015-11-21 02:54:18,971 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:28055.56 Median:28055.56 stddev:0.00 (0.0%) 02:54:18 INFO - 2015-11-21 02:54:18,971 DEBUG : BROWSER_OUTPUT: Values: 28055.6 02:54:18 INFO - 2015-11-21 02:54:18,971 DEBUG : BROWSER_OUTPUT: 02:54:18 INFO - 2015-11-21 02:54:18,971 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:765.70 Median:765.70 stddev:0.00 (0.0%) 02:54:18 INFO - 2015-11-21 02:54:18,971 DEBUG : BROWSER_OUTPUT: Values: 765.7 02:54:18 INFO - 2015-11-21 02:54:18,972 DEBUG : BROWSER_OUTPUT: 02:54:18 INFO - 2015-11-21 02:54:18,972 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4509.01 Median:4509.01 stddev:0.00 (0.0%) 02:54:18 INFO - 2015-11-21 02:54:18,972 DEBUG : BROWSER_OUTPUT: Values: 4509.0 02:54:18 INFO - 2015-11-21 02:54:18,972 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:54:18 INFO - 2015-11-21 02:54:18,972 DEBUG : BROWSER_OUTPUT: 02:54:19 INFO - 2015-11-21 02:54:19,619 INFO : Browser exited with error code: 0 02:54:19 INFO - 2015-11-21 02:54:19,637 INFO : Completed test v8_7 (00:00:36) 02:54:20 INFO - 2015-11-21 02:54:20,120 INFO : Completed test suite (00:20:07) 02:54:20 INFO - 2015-11-21 02:54:20,121 DEBUG : Working with test: dromaeo_css 02:54:20 INFO - 2015-11-21 02:54:20,121 DEBUG : Generating results file: dromaeo_css 02:54:20 INFO - 2015-11-21 02:54:20,122 DEBUG : Working with test: kraken 02:54:20 INFO - 2015-11-21 02:54:20,122 DEBUG : Generating results file: kraken 02:54:20 INFO - 2015-11-21 02:54:20,122 INFO : javascript benchmark 02:54:20 INFO - 2015-11-21 02:54:20,122 DEBUG : Working with test: v8_7 02:54:20 INFO - 2015-11-21 02:54:20,122 DEBUG : Generating results file: v8_7 02:54:20 INFO - 2015-11-21 02:54:20,122 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:54:20 INFO - 2015-11-21 02:54:20,544 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 02:54:20 INFO - 2015-11-21 02:54:20,544 DEBUG : process_Request line: dromaeo_css 7694.53 graph.html#tests=[[72,64,59]] 02:54:20 INFO - 2015-11-21 02:54:20,544 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:54:20 INFO - 2015-11-21 02:54:20,570 DEBUG : process_Request line: kraken 1396.90 graph.html#tests=[[232,64,59]] 02:54:20 INFO - 2015-11-21 02:54:20,570 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:54:20 INFO - 2015-11-21 02:54:20,600 DEBUG : process_Request line: v8_7 20389.73 graph.html#tests=[[230,64,59]] 02:54:20 INFO - 2015-11-21 02:54:20,601 INFO : javascript benchmark 02:54:20 INFO - 2015-11-21 02:54:20,603 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2949.4690955627984, 3473.94789078164, 3512.3502152101864, 3515.314513669834, 3548.414511605585, 5858.238429004234, 5889.175515427838, 5927.2590926134235, 5950.04799232123, 6015.1578778970925, 5909.113632955059, 5928.792492262772, 5974.283086029672, 6108.099244189802, 6109.404666050349, 5289.206619007141, 5363.973180134094, 5368.0605893968595, 5405.594580406466, 5455.290812194429, 5415.566754659618, 5475.917861232085, 5525.613207075487, 5530.142827861688, 5575.832725018256, 5257.737113144328, 5349.384820745625, 5360.276362691065, 5461.617686761928, 5465.562754979592, 5392.245085688007, 5402.324709411324, 5409.26974858393, 5419.051665958481, 5422.322209723785, 5272.261883336336, 5350.170723537858, 5353.330833645794, 5373.0, 5373.220882971987, 5801.680907550083, 5815.88368232633, 5839.970800146015, 5848.561357898175, 5853.50245229156, 5294.258803767476, 6204.069389591552, 6312.684365781693, 6318.842028949267, 6336.873262534724, 6366.681665916685, 6373.794184137371, 6449.161608990801, 6455.5158363122955, 6461.289258181596, 5956.702164891738, 6097.664628445478, 6189.845253868644, 6197.938020619781, 6211.9068213976825, 5569.331680198402, 6415.069814876817, 6564.310747371553, 6565.179352580927, 6567.408933196035, 6338.968305158444, 6344.714487848058, 6355.936440635627, 6360.950443176916, 6369.808905732835, 5884.734782021886, 6275.246970363585, 6410.551261411656, 6423.614583125028, 6428.325025872309, 6185.690715464209, 6197.938020619736, 6322.810315690536, 6339.302676705559, 6340.461060809883, 6327.17746692927, 6335.524835637346, 6347.0, 6350.333215012357, 6366.395192456709, 5116.718580478035, 5138.845834624967, 5145.639805213599, 5155.7679904404395, 5194.870128246824, 4447.666425018137, 4494.775261236925, 4494.865154045318, 4596.149712303235, 4596.4714057883775, 5034.949650503448, 6054.51563874889, 6056.545759068087, 6068.2111325528285, 6077.604955677867, 6364.713587888464, 6426.935730642634, 6433.581817181962, 6439.22729272481, 6439.452646525004, 5758.596898217168, 5934.970325148347, 5963.880722385615, 5981.162637230791, 6048.516118710492, 5577.3028371453565, 5620.57845661577, 5628.015097357946, 5634.352049514277, 5650.434956504317, 6407.711652975534, 6412.198475190601, 6415.903761443582, 6433.420992110732, 6442.2269327679105, 6169.876602468015, 6233.625982441068, 6306.716197771019, 6318.778842740482, 6424.132742079946, 6257.937420625735, 6316.115743795965, 6321.494280457644, 6335.683215839282, 6337.429631333202, 6287.0, 6287.779927702509, 6291.402316779899, 6293.213348331458, 6294.433500984934, 6257.43683068526, 6308.495320374267, 6312.210973628296, 6312.873742525216, 6319.873602528016, 6127.5866022601795, 6183.474404675653, 6210.192674952227, 6243.875122497616, 6261.123442718114, 6296.653684047421, 6304.621722696653, 6314.273858506331, 6320.241571011508, 6335.0, 6175.62946223228, 6198.318184999556, 6209.006558950547, 6231.40801623845, 6235.095911092775, 4922.778474968563, 6162.322144564184, 6175.536834737323, 6307.621542707452, 6312.7159277833525, 6140.723667435065, 6200.348963358782, 6224.097505861534, 6233.096201050913, 6266.467350275278], "unit": "ms", "name": "dojo.html", "value": 5852.494404618715}, {"lowerIsBetter": false, "replicates": [549.7965752671512, 553.382977979553, 554.7198664674339, 620.8230654263534, 630.3633330336362, 32404.351912961727, 32954.17614559637, 41431.64967678392, 41765.95585110374, 41766.0, 44461.55538444615, 44688.55311446884, 44859.0, 44883.32675009877, 44939.0, 8789.0, 8892.466452012899, 9736.464494452803, 9950.800983980316, 9954.601815927354, 8789.692360767374, 12006.21959572625, 12123.454444550016, 12144.149909506337, 12199.695007624792, 11886.286822790616, 11980.940095299511, 11987.700307492296, 11991.820122698167, 11994.760104797899, 8921.910780892173, 9052.366334356597, 11897.7620447591, 11938.761224775542, 11956.88043119575, 8738.781530461725, 11937.28376297425, 12063.0, 12074.456649450796, 12090.939545302217, 41397.37903931444, 41862.74411767652, 41950.580494194975, 41974.0, 41977.16045679069, 3135.106494649014, 3193.409219294438, 3199.728023118038, 3550.5029295898594, 3697.0757310672334, 29228.707712922813, 29411.558826617616, 29585.408291834257, 29655.851720741473, 29698.554521682192, 2725.9454810903867, 2751.697313295536, 2776.5418705913703, 2828.169969523598, 2895.4498645257545, 509584.0, 511130.0, 511520.0, 511555.0, 512162.0, 57114.42885571091, 58136.0, 58191.54521137005, 58206.70896645574, 58367.70816145892, 70520.64739676268, 71145.0, 71173.64413177902, 71242.51953544907, 71484.64257678678, 16534.007959522467, 16599.6680066398, 16744.995300282022, 16771.496855094367, 16779.748303775454, 12615.432305546088, 12665.936670316589, 12690.048246381559, 12776.808347874789, 12806.487740490276, 19188.328408505637, 20055.395568354495, 20477.692834607493, 20558.486037849172, 20611.660242084516, 7819.452638315377, 7975.04299484054, 8361.16388361159, 9454.810903781887, 9485.4782986935, 994.5922171909482, 1052.4264275969615, 1076.1713480620035, 1134.6879608107672, 1176.6940595445246, 29314.79622666006, 29652.555211671843, 29861.55207671887, 30462.69537304643, 30498.54252186219, 1048.505879122263, 1048.5700862646431, 1066.2642776484356, 1075.596346767476, 1081.8701755789355, 14449.0, 14501.202433866029, 14664.706705865823, 14758.852411475962, 14805.259737013323, 544575.0, 544981.0, 545890.0, 546632.0, 546934.0, 57167.42832571621, 57325.71337143371, 57399.0, 57624.711876441186, 57739.0, 1472.4699108320997, 1473.3149085675213, 1484.665950161205, 1498.3257534109475, 1500.9793340528545, 28661.71338286674, 28712.856435717687, 28853.0, 29321.0, 29359.853200733858, 47848.760756195996, 48470.75764621155, 51607.741961289954, 55565.7221713905, 56652.0, 450984.0, 451501.0, 461356.0, 461412.0, 462148.0, 27910.883564657186, 30985.380292393576, 31201.375972480877, 31223.907163249176, 31290.374192516476, 33810.15474613154, 37309.81345093257, 42306.57693423027, 42391.48910641597, 43399.566004339555, 35357.823210883784, 37194.0, 37747.245055099294, 38015.42976855294, 38107.0, 36468.08829779277, 36877.815610921774, 38833.223335532566, 39123.608763911994, 39880.0, 31040.111476063044, 36420.22180037881, 37860.0, 37929.81035094807, 37938.62061379351, 29177.190281908144, 31226.687733122377, 33247.0, 34042.489362660075, 34091.488627671104, 24344.0, 24384.902679379826, 24456.633150503112, 24507.877460612584, 24539.50920981606], "unit": "ms", "name": "ext.html", "value": 20289.940352775397}, {"lowerIsBetter": false, "replicates": [361.42352947049466, 362.9872954446595, 363.7617360628786, 368.13855577947595, 373.4081480852849, 15801.920990395032, 17636.82363176368, 19694.90152549237, 20947.581048379023, 21655.700657960515, 9780.853287200698, 11711.941440292787, 12008.7598248035, 15741.92129039356, 19635.60728785427, 3945.072907866649, 5185.507376799198, 5305.787768489276, 5333.413324534298, 5360.517553420192, 4062.7765472898977, 4068.9796551017203, 4790.23356262998, 5741.33974592923, 5741.856453588673, 5574.080276754331, 5687.118496633028, 5702.885942281152, 5718.71406429679, 5737.196792449061, 5742.655440673552, 5785.739641716133, 5787.479126878559, 5788.305403351583, 5792.218050563162, 5411.702356370398, 5547.72261386929, 5557.444255574451, 5576.191452239443, 5578.721063946787, 14034.087784293988, 23976.160834370712, 24179.03283868643, 25269.62095568568, 25300.240992770247, 2035.8778473291502, 2099.202303124818, 2156.2453141400542, 2214.205746983456, 2493.501299740059, 9818.361806482628, 9872.950635246778, 9914.504274786232, 11471.426428678533, 15102.924485377613, 1675.790526184227, 1686.8481836634762, 1690.5351028467269, 1701.5916180116683, 1737.218251786701, 105412.0, 105707.0, 107007.0, 108079.99999999921, 108663.0, 11019.228653994143, 11239.494222759995, 11250.09999200062, 11252.43737813106, 11294.661160165208, 13328.6667833303, 13361.73276534464, 13364.329458817649, 13369.264690441925, 13380.732385352434, 8530.616122274512, 8539.701110461228, 8550.529720865288, 8632.913670863336, 8641.351898607629, 8776.385653004356, 8786.428882122642, 8814.603342849587, 8848.823023539622, 8878.245349145265, 4050.9392359114636, 4159.459270294842, 4389.385486031958, 4408.096340250305, 4443.577860103285, 1750.483607335839, 1776.2273411066228, 1788.4902802701167, 1800.2708902894349, 1804.4676820338032, 874.7463235661714, 1005.703317521333, 1016.832222683249, 1035.7669524357111, 1035.8239099353127, 15994.840051599567, 20437.0, 20788.896055519624, 21185.89407052955, 21750.782492175193, 889.74642226965, 890.3589415620743, 952.6141912525438, 988.1896844587513, 1024.7591815923251, 10385.324953878126, 10736.463176841127, 10750.354978701303, 10763.78472430547, 10770.784584308427, 756482.0, 759322.0, 773487.0, 780700.0, 792904.0, 120347.39826300813, 126821.0, 131217.0, 132410.0, 134234.0, 1160.512584714422, 1164.7845148647527, 1178.8231765235284, 1203.3141109567637, 1205.1021988618536, 17558.91220543889, 17851.46445606634, 17879.821201787814, 18261.08694565293, 18312.26750929948, 51719.741401292755, 52406.73796630993, 52478.47521524889, 52573.21140182824, 53710.73144634252, 74414.88377674448, 75267.0, 77728.61135694286, 79763.20236797558, 81172.59413702894, 9462.195713364441, 9698.36960597559, 9907.851382229417, 9985.550650220612, 9985.60057597688, 19900.60198795987, 19911.402657920287, 20120.29578964729, 20390.184392624127, 20642.896785515975, 15087.849121508645, 16097.839021609634, 16129.741836142715, 16252.756208656643, 16370.854040217071, 13563.728725425239, 15620.84379156194, 15724.0, 15778.76331855046, 16216.756748648544, 16430.507084787474, 16516.224321263286, 16669.49991500257, 16789.41237056697, 16965.66068678595, 8337.791555211168, 9633.807323853624, 9654.662086826927, 9866.16137628281, 9972.800543989224, 15754.606134846721, 15932.0, 16026.759598605797, 16193.59516012109, 16411.753823692416], "unit": "ms", "name": "jquery.html", "value": 9945.972089479676}, {"lowerIsBetter": false, "replicates": [1465.9706805863877, 1612.9516114516562, 1614.9111798851059, 1912.718478619325, 1926.4605910345103, 7610.809729756759, 8096.797580060502, 8345.123762004985, 8449.155084491547, 8449.197326254012, 8489.066202717697, 8624.482531048141, 8636.784080397993, 8662.263707584863, 8701.56492175392, 2135.893205339735, 2176.3035828534876, 2397.352714767012, 2431.5623187826186, 2435.512897420514, 2175.673648952662, 2405.891734871935, 2441.9865755711357, 2442.670239517669, 2445.205308274818, 2363.243761996162, 2401.9159329423474, 2406.6630671705975, 2428.5142971405703, 2435.512897420523, 2155.6227660159566, 2209.767974362701, 2216.024949022425, 2396.8442051266697, 2434.817388695855, 2401.9159329423387, 2442.303943376129, 2445.5597992361368, 2447.5227330670527, 2449.6570480132796, 8541.359398045171, 8700.477971321741, 8709.25971292441, 8716.25911797498, 8731.995820480663, 5209.348831396075, 5314.441983591744, 5319.494648008433, 5321.042212401766, 5366.91949620756, 3508.614052454228, 3562.2341196642847, 3635.127569383329, 3642.763220390666, 3643.9635603643887, 1028.300755486269, 1030.7371620236866, 1053.0522529723235, 1059.3961441978076, 1060.390275591538, 11641.18511704181, 11649.70875728105, 11668.941655291754, 11669.124815638861, 11681.766364672743, 4651.720896746206, 4766.332713420124, 4814.470408255089, 4827.951720482821, 4835.516448355207, 9890.406575605486, 9902.356346837576, 9934.0, 9943.651972180938, 9966.950165249127, 5345.1982202669915, 5357.866053348697, 5359.464053594687, 5370.570354371641, 5370.758315875795, 4852.611791056777, 4880.072786170687, 4892.926606100911, 4896.143174944371, 4900.068986892479, 3860.0735823402742, 3872.593377695358, 3885.3589157788647, 3914.941275880864, 3938.468306778548, 1281.9679508012375, 1300.4018151650157, 1302.6482849630547, 1305.3668970549277, 1306.4524177853225, 1349.966250843717, 1370.0888908875686, 1372.8558501357213, 1393.2685340196479, 1417.2205287092058, 7963.084245311863, 8099.878501822477, 8133.837323253501, 8137.186281371815, 8142.389320800964, 495.6505663507291, 500.129774192909, 506.9467705890902, 508.3061620887462, 510.85440649415483, 5970.0, 6105.053716673922, 6113.877722445526, 6125.693715314216, 6314.147590075373, 8581.597152797227, 10140.340877842917, 10401.479926003669, 10417.479126043667, 10509.789804203872, 10365.0, 10473.0, 10474.266801323987, 10481.0, 10484.056434920742, 7841.372690184771, 7966.0, 8048.959755201186, 8101.432899696964, 8117.95941020303, 7889.921100788919, 7898.486598371088, 7899.407544434075, 7922.881156782538, 7927.563983980936, 7886.684532618631, 9041.547922603711, 9063.864042039242, 9204.98745138021, 9368.203702685349, 9392.154706076486, 9454.669086581936, 9461.952690236505, 9590.520473976134, 9597.568109434953, 7283.890741638986, 7354.080739907512, 7362.079740032496, 7364.3372096511575, 7372.41020718352, 8003.799905002189, 8080.191980801873, 8111.472754270953, 8163.387745918961, 8207.220314070153, 7607.087149542091, 7661.892979430701, 7706.7687969361, 7779.611019449118, 7821.6089195541135, 7315.487915846053, 7418.443616728659, 7636.8472630548185, 7641.656125474478, 7710.383169346551, 7688.0005599271735, 7729.729459468892, 7783.143854176149, 7788.649510771916, 7805.102413222552, 7040.0, 7047.01341812157, 7087.716491340495, 7099.716011359695, 7100.0, 5987.191729116687, 6317.778877739257, 7228.241034691492, 7229.132504099542, 7231.096112985877], "unit": "ms", "name": "mootools.html", "value": 4778.730830156432}, {"lowerIsBetter": false, "replicates": [317.81884325934215, 323.7038110129232, 326.6782219513779, 328.906261715411, 333.74968773419937, 6689.933100668992, 6821.829454263646, 6921.584704917708, 6954.37410633043, 6971.965140174292, 5259.8422047338545, 6706.56407333523, 6714.6978385972625, 6718.193816741998, 6795.49033822464, 4970.329005584245, 5047.141985862394, 5065.366829146356, 5066.442691303953, 5073.315102461176, 4782.019685964369, 4844.539768721966, 4935.333729946465, 5061.367329083864, 5078.39059312883, 3806.448065030569, 4065.918681626366, 4979.701217926918, 5012.448630650625, 5030.6730062546, 4364.061726728753, 4716.245400735866, 5038.7984480620735, 5052.242163675442, 5059.3422855028975, 4282.785860706952, 4283.1433713257165, 4286.87139385819, 4287.099709061101, 4289.892752681177, 6376.48988080957, 6518.217813862319, 6564.048213009087, 6602.93397066028, 6632.63520506372, 5948.791792287249, 5991.0, 5992.640441573476, 5997.5201983841625, 5998.340182579913, 6967.407770339527, 7325.853482930312, 7336.486445948785, 7346.4122870170795, 7353.1176258848745, 4469.173202957463, 4680.672352935296, 4681.016986432854, 4714.222153344694, 4857.222844344888, 7834.138244793068, 7841.294283514511, 7844.843103137962, 7851.646675899598, 7858.646360913715, 4102.466679331667, 4901.36282283308, 4903.092927808367, 4905.166121759309, 4909.582685471703, 4852.272159176152, 4970.950290497121, 4974.925376119361, 4977.178765503651, 4996.525330093636, 5999.5800293979, 6005.819825405245, 6010.278766547955, 6010.579259451796, 6013.067974463877, 7418.295261950214, 7418.33235008841, 7424.85150296991, 7429.442791790637, 7434.628268586549, 1720.4064597713768, 1745.7381392790928, 1747.4582879307202, 1747.6455746796335, 1748.650269946016, 1118.2619471149003, 1132.2357408749062, 1137.0846468592863, 1139.9886001140048, 1140.4126874659557, 6745.9662701686175, 6747.392734653905, 6748.93251067483, 6752.527323087336, 6759.5606285591275, 7464.776056718199, 7516.398688104939, 7521.962390188014, 7606.23937606246, 7616.771496855104, 6822.351876571718, 6855.622940738307, 6901.689423975933, 6905.689243984033, 6908.205556361083, 3992.0766447336005, 4043.211573743151, 4089.2026054919006, 4099.385092236188, 4102.405151253111, 7702.3453006493955, 7731.420143489261, 7764.961175194087, 7768.611569421506, 7779.844403111906, 5740.741666625012, 7973.006748312921, 7979.800504987422, 7989.480683755537, 8015.238552337519, 6779.6271205084195, 7282.96358518204, 7521.473496855277, 7714.228577142241, 7734.6132693366235, 7706.7687969361, 7724.150343462327, 7727.459077864495, 7733.845323093619, 7737.729179478692, 7562.2437756223935, 7576.545407275581, 7581.469297149147, 7583.734569290048, 7592.316691497792, 6682.766103186365, 7548.773536793905, 7759.456838021284, 7765.339946104645, 7769.378449724121, 4961.900761984813, 4962.255661650781, 4967.677100988424, 4970.179920313108, 4975.179095449355, 7536.246375362639, 7708.691652333844, 7711.344535714527, 7717.691292348468, 7720.996270484801, 7374.446916481393, 7386.0, 7390.1501327345895, 7400.0, 7408.925910741039, 5964.642121472725, 7368.37368823656, 7379.963100184679, 7387.963060184665, 7388.926110738824, 7012.158540975116, 7169.605671688108, 7185.0, 7188.353048225685, 7227.674754636159, 7379.446541509516, 7400.888986665097, 7412.11054673421, 7413.221611730691, 7435.92564074374, 6259.405356491126, 6587.880060389841, 6895.827604309932, 7044.119485064367, 7169.533980291264], "unit": "ms", "name": "prototype.html", "value": 5329.577478205975}, {"lowerIsBetter": false, "replicates": [728.490056960128, 795.7851380127362, 811.1766556944702, 821.174719406996, 843.4096132707107, 15120.395184192634, 15548.0, 15597.532074037783, 15603.765943510842, 15610.609734756637, 14095.71808563828, 14196.858031419682, 14210.289485525735, 14211.0, 14228.217448040354, 748.397539980317, 756.4591317208195, 757.5076200469683, 760.2739383888373, 942.9387089839139, 940.3652534539193, 947.166493485735, 953.1040821627682, 953.8235426446095, 955.2692190474293, 995.6664517386648, 1001.1140140975217, 1001.9899801001969, 1003.4531180506605, 1006.3006210683578, 793.9955955716024, 796.55791035975, 800.6157044618558, 807.3944541593804, 997.4264797741291, 589.5961266532396, 590.7459792289313, 739.6486668832315, 741.6180666956468, 744.2408743082026, 14979.251037448194, 15186.0, 15201.391944322324, 15203.93572449929, 15206.16366099864, 10465.430185472163, 12525.874741252563, 12629.557965471256, 12695.619131426072, 12971.41628626714, 8352.749417517483, 10165.135963443116, 10225.991226632146, 10310.381377117397, 10356.896431035668, 3009.6388433387915, 3534.734894882894, 3556.1287484566187, 3566.251087271676, 3629.274145170976, 52765.73617131928, 70976.6451167746, 71240.28759712388, 73468.53062938711, 73714.63142684306, 9517.0, 9750.317477776487, 9774.413535187912, 10025.348352357074, 10184.134348580306, 21688.24091156802, 21984.560308793734, 22038.669419958715, 22074.44813879634, 22085.779142208692, 7349.04462419882, 7470.0662417197855, 7615.961920190474, 7671.109779841224, 7720.922790772132, 3867.9226415472094, 3921.1569512554365, 3943.3690609502914, 3946.1713040261293, 3965.0, 3584.534010578608, 3631.745777795582, 3632.5277713897026, 3634.909127271839, 3642.307961487309, 640.4524131867187, 658.0228360884083, 658.5916731626422, 658.601546064624, 660.9107770450928, 478.93198168085365, 491.8499857543412, 503.71827543553775, 516.2797896933756, 526.7339993303434, 7807.843843123106, 8425.07324194338, 8516.616752246164, 8545.188207120314, 8611.48331100136, 527.4909712127815, 591.9970400148057, 601.2064075420403, 610.6000569626901, 610.851062771414, 3770.490983717163, 3836.5776931831324, 3891.630295121959, 3926.980365098156, 4031.113155105872, 86954.00028996619, 87433.56283218543, 88751.55624221837, 88808.0, 97631.51184244033, 69540.65229673819, 70034.64982675156, 82182.76725849116, 83000.16999830045, 83485.58257208676, 71617.2838271621, 71772.64113679502, 73519.52960940752, 73702.26297737061, 74941.0, 8198.918010819816, 8406.621702023302, 8682.262951373166, 8692.695755648521, 8890.86663700058, 49864.75067624639, 52777.0, 52810.943781123395, 54597.727011366274, 54879.0, 69848.65075674793, 69872.65063674649, 71215.93176102258, 74204.2579574219, 74238.62880685779, 10948.507317170586, 11009.669709908716, 11213.215074944676, 11257.04315133223, 11816.527338906348, 11962.0, 12020.03839692805, 12034.037277017993, 12046.397680116135, 12047.457864396298, 11115.166362522681, 11287.43562821872, 11322.37726924994, 11370.658880233606, 11399.487023083815, 11398.373089480157, 11542.769144617228, 11546.59586914454, 11559.30644161353, 11560.132990025613, 11133.498992545194, 11197.440127993405, 11202.551897923991, 11213.831792523282, 11219.495122719334, 9491.572879220314, 9869.358491698016, 9899.455529945923, 10010.899891000996, 10083.546240419051, 9710.465924373944, 9731.318807683394, 9848.803023939625, 9911.65309214174, 10053.296269261082], "unit": "ms", "name": "yui.html", "value": 6898.948957960741}], "name": "dromaeo_css", "value": 7694.531907715425}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 109.0, 105.0, 110.0, 111.0, 110.0, 98.0, 111.0, 110.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 108.2}, {"lowerIsBetter": true, "replicates": [150.0, 119.0, 143.0, 173.0, 144.0, 141.0, 139.0, 117.0, 156.0, 118.0], "unit": "ms", "name": "audio-beat-detection", "value": 140.0}, {"lowerIsBetter": true, "replicates": [183.0, 180.0, 183.0, 180.0, 181.0, 186.0, 205.0, 263.0, 184.0, 179.0], "unit": "ms", "name": "audio-dft", "value": 192.4}, {"lowerIsBetter": true, "replicates": [67.0, 65.0, 73.0, 73.0, 55.0, 56.0, 57.0, 74.0, 73.0, 54.0], "unit": "ms", "name": "audio-fft", "value": 64.7}, {"lowerIsBetter": true, "replicates": [83.0, 86.0, 115.0, 74.0, 77.0, 76.0, 107.0, 74.0, 73.0, 107.0], "unit": "ms", "name": "audio-oscillator", "value": 87.2}, {"lowerIsBetter": true, "replicates": [86.0, 85.0, 85.0, 86.0, 90.0, 86.0, 86.0, 85.0, 93.0, 132.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 91.4}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 93.0, 94.0, 94.0, 94.0, 95.0, 93.0, 94.0, 94.0], "unit": "ms", "name": "imaging-darkroom", "value": 93.8}, {"lowerIsBetter": true, "replicates": [87.0, 85.0, 86.0, 86.0, 87.0, 84.0, 85.0, 87.0, 87.0, 104.0], "unit": "ms", "name": "imaging-desaturate", "value": 87.8}, {"lowerIsBetter": true, "replicates": [57.0, 53.0, 53.0, 54.0, 54.0, 54.0, 54.0, 64.0, 52.0, 53.0], "unit": "ms", "name": "json-parse-financial", "value": 54.8}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 64.0, 64.0, 66.0, 67.0, 67.0, 68.0, 68.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 66.0}, {"lowerIsBetter": true, "replicates": [82.0, 81.0, 81.0, 79.0, 80.0, 77.0, 82.0, 81.0, 83.0, 80.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 80.6}, {"lowerIsBetter": true, "replicates": [122.0, 122.0, 130.0, 109.0, 120.0, 128.0, 119.0, 138.0, 125.0, 129.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.2}, {"lowerIsBetter": true, "replicates": [136.0, 134.0, 134.0, 134.0, 134.0, 133.0, 131.0, 134.0, 134.0, 126.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 133.0}, {"lowerIsBetter": true, "replicates": [65.0, 64.0, 66.0, 65.0, 65.0, 65.0, 66.0, 87.0, 94.0, 91.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 72.8}], "name": "kraken", "value": 1396.8999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [147.03720041170416], "unit": "score", "name": "Richards", "value": 240.08890199999996}, {"lowerIsBetter": false, "replicates": [160.48788316482106], "unit": "score", "name": "DeltaBlue", "value": 411.98125799999985}, {"lowerIsBetter": false, "replicates": [279.9552071668533], "unit": "score", "name": "Encrypt", "value": 950.7985320000004}, {"lowerIsBetter": false, "replicates": [4677.570093457944], "unit": "score", "name": "Decrypt", "value": 56.905828171828176}, {"lowerIsBetter": false, "replicates": [1708.1911262798635], "unit": "score", "name": "RayTrace", "value": 433.2003536463537}, {"lowerIsBetter": false, "replicates": [783.2550860719875], "unit": "score", "name": "Earley", "value": 850.8888251748249}, {"lowerIsBetter": false, "replicates": [12543.20987654321], "unit": "score", "name": "Boyer", "value": 53.133369094488174}, {"lowerIsBetter": false, "replicates": [28055.555555555555], "unit": "score", "name": "RegExp", "value": 32.470752475247544}, {"lowerIsBetter": false, "replicates": [765.6967840735069], "unit": "score", "name": "Splay", "value": 106.42724599999998}, {"lowerIsBetter": false, "replicates": [4509.009009009009], "unit": "score", "name": "NavierStokes", "value": 329.11888111888123}], "name": "v8_7", "value": 20389.734472698306}]} 02:54:20 INFO - RETURN: dromaeo_css: 7694.53 02:54:20 INFO - RETURN: kraken: 1396.90 02:54:20 INFO - RETURN: v8_7: 20389.73 02:54:20 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,59]]", "result": "20389.73"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1396.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7694.53"}}} 02:54:20 INFO - Return code: 0 02:54:20 INFO - # TBPL SUCCESS # 02:54:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:54:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:54:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:54:20 INFO - 2015-11-21 02:54:20.714 screenresolution[2253:27914] starting screenresolution argv=screenresolution get 02:54:20 INFO - 2015-11-21 02:54:20.717 screenresolution[2253:27914] Display 0: 1600x1200x32@60 02:54:20 INFO - 2015-11-21 02:54:20.723 screenresolution[2254:27917] starting screenresolution argv=screenresolution list 02:54:20 INFO - Available Modes on Display 0 02:54:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:54:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:54:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:54:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:54:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:54:20 INFO - Intel Iris: 02:54:20 INFO - Chipset Model: Intel Iris 02:54:20 INFO - Type: GPU 02:54:20 INFO - Bus: Built-In 02:54:20 INFO - VRAM (Dynamic, Max): 1536 MB 02:54:20 INFO - Vendor: Intel (0x8086) 02:54:20 INFO - Device ID: 0x0a2e 02:54:20 INFO - Revision ID: 0x0009 02:54:20 INFO - Displays: 02:54:20 INFO - Display: 02:54:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:54:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:54:20 INFO - Display Serial Number: 1600x1200 60 02:54:20 INFO - Main Display: Yes 02:54:20 INFO - Mirror: Off 02:54:20 INFO - Online: Yes 02:54:20 INFO - Rotation: Supported 02:54:20 INFO - Return code: 0 02:54:20 INFO - Running post-action listener: _resource_record_post_action 02:54:20 INFO - Running post-run listener: _resource_record_post_run 02:54:22 INFO - Total resource usage - Wall time: 1239s; CPU: 52.0%; Read bytes: 0; Write bytes: 691490816; Read time: 0; Write time: 2194 02:54:22 INFO - install - Wall time: 31s; CPU: 55.0%; Read bytes: 342229504; Write bytes: 339006976; Read time: 26916; Write time: 649 02:54:22 INFO - run-tests - Wall time: 1209s; CPU: 52.0%; Read bytes: 0; Write bytes: 342104576; Read time: 0; Write time: 1489 02:54:22 INFO - Running post-run listener: _upload_blobber_files 02:54:22 INFO - Blob upload gear active. 02:54:22 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 02:54:22 INFO - Copying logs to upload dir... 02:54:22 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1314.993497 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 55 secs) (at 2015-11-21 02:54:22.081558) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-21 02:54:22.085291) ========= 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.l0KNwrl4to/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.6TFMYnmUtV/Listeners TMPDIR=/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009423 build_url: 'https://queue.taskcluster.net/v1/task/Nl1e7m18QGeoKefNA5LIqw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-21 02:54:22.109393) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 02:54:22.109745) ========= 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.l0KNwrl4to/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.6TFMYnmUtV/Listeners TMPDIR=/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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.005282 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 02:54:22.159070) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-21 02:54:22.159423) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-21 02:54:22.159868) ========= ========= Total master_lag: 0.26 =========