builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0008 starttime: 1448334560.13 results: success (0) buildid: 20151123170936 builduid: ea20d8669b9d495884d28cd93d923ab7 revision: 65cd2c7696e438c74bfbb0ad40e18f411dbead38 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 19:09:20.129244) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 19:09:20.129659) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 19:09:20.129936) ========= 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.YoLGzRXRVp/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.obz4xq4jzd/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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.005481 basedir: '/builds/slave/test' ========= master_lag: 0.16 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 19:09:20.290794) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 19:09:20.291084) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 19:09:20.441267) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 19:09:20.441566) ========= 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.YoLGzRXRVp/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.obz4xq4jzd/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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.005360 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 19:09:20.509898) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 19:09:20.510210) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 19:09:20.511445) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 19:09:20.511715) ========= 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.YoLGzRXRVp/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.obz4xq4jzd/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2015-11-23 19:09:20-- 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% 1.41G=0s 2015-11-23 19:09:21 (1.41 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.538141 ========= master_lag: 0.63 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 19:09:21.676658) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 19:09:21.676981) ========= 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.YoLGzRXRVp/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.obz4xq4jzd/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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.027003 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 19:09:21.726905) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 19:09:21.727193) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 65cd2c7696e438c74bfbb0ad40e18f411dbead38 --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 65cd2c7696e438c74bfbb0ad40e18f411dbead38 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.YoLGzRXRVp/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.obz4xq4jzd/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2015-11-23 19:09:21,805 truncating revision to first 12 chars 2015-11-23 19:09:21,806 Setting DEBUG logging. 2015-11-23 19:09:21,806 attempt 1/10 2015-11-23 19:09:21,806 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/65cd2c7696e4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 19:09:22,930 unpacking tar archive at: fx-team-65cd2c7696e4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.368910 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 19:09:23.110590) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 19:09:23.111100) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 19:09:23.122111) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 19:09:23.122499) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 19:09:23.122927) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 38 secs) (at 2015-11-23 19:09:23.123213) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.YoLGzRXRVp/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.obz4xq4jzd/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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 19:09:23 INFO - MultiFileLogger online at 20151123 19:09:23 in /builds/slave/test 19:09:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 19:09:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:09:23 INFO - {'append_to_log': False, 19:09:23 INFO - 'base_work_dir': '/builds/slave/test', 19:09:23 INFO - 'blob_upload_branch': 'Fx-Team', 19:09:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:09:23 INFO - 'branch': 'Fx-Team', 19:09:23 INFO - 'buildbot_json_path': 'buildprops.json', 19:09:23 INFO - 'config_files': ('talos/mac_config.py',), 19:09:23 INFO - 'default_actions': ('clobber', 19:09:23 INFO - 'read-buildbot-config', 19:09:23 INFO - 'download-and-extract', 19:09:23 INFO - 'populate-webroot', 19:09:23 INFO - 'create-virtualenv', 19:09:23 INFO - 'install', 19:09:23 INFO - 'run-tests'), 19:09:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:09:23 INFO - 'download_minidump_stackwalk': True, 19:09:23 INFO - 'download_symbols': 'ondemand', 19:09:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:09:23 INFO - 'tooltool.py': '/tools/tooltool.py', 19:09:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:09:23 INFO - '/tools/misc-python/virtualenv.py')}, 19:09:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:09:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:09:23 INFO - 'installer_path': 'installer.exe', 19:09:23 INFO - 'log_level': 'info', 19:09:23 INFO - 'log_name': 'talos', 19:09:23 INFO - 'log_to_console': True, 19:09:23 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:09:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:09:23 INFO - 'opt_config_files': (), 19:09:23 INFO - 'pip_index': False, 19:09:23 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:09:23 INFO - 'cmd': ('bash', 19:09:23 INFO - '-c', 19:09:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:09:23 INFO - 'enabled': True, 19:09:23 INFO - 'halt_on_failure': False, 19:09:23 INFO - 'name': 'check_screen_resolution'},), 19:09:23 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:09:23 INFO - 'cmd': ('bash', 19:09:23 INFO - '-c', 19:09:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:09:23 INFO - 'enabled': True, 19:09:23 INFO - 'halt_on_failure': False, 19:09:23 INFO - 'name': 'check_screen_resolution'},), 19:09:23 INFO - 'run_cmd_checks_enabled': True, 19:09:23 INFO - 'sps_profile': False, 19:09:23 INFO - 'sps_profile_interval': 0, 19:09:23 INFO - 'suite': 'dromaeojs-e10s', 19:09:23 INFO - 'system_bits': '64', 19:09:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:09:23 INFO - 'title': 't-yosemite-r7-0008', 19:09:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:09:23 INFO - 'use_talos_json': True, 19:09:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:09:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:09:23 INFO - 'work_dir': 'build'} 19:09:23 INFO - ##### 19:09:23 INFO - ##### Running clobber step. 19:09:23 INFO - ##### 19:09:23 INFO - Running pre-action listener: _resource_record_pre_action 19:09:23 INFO - Running main action method: clobber 19:09:23 INFO - rmtree: /builds/slave/test/build 19:09:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:09:24 INFO - Running post-action listener: _resource_record_post_action 19:09:24 INFO - ##### 19:09:24 INFO - ##### Running read-buildbot-config step. 19:09:24 INFO - ##### 19:09:24 INFO - Running pre-action listener: _resource_record_pre_action 19:09:24 INFO - Running main action method: read_buildbot_config 19:09:24 INFO - Using buildbot properties: 19:09:24 INFO - { 19:09:24 INFO - "properties": { 19:09:24 INFO - "buildnumber": 20, 19:09:24 INFO - "product": "firefox", 19:09:24 INFO - "script_repo_revision": "production", 19:09:24 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 19:09:24 INFO - "repository": "", 19:09:24 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 19:09:24 INFO - "buildid": "20151123170936", 19:09:24 INFO - "slavename": "t-yosemite-r7-0008", 19:09:24 INFO - "pgo_build": "False", 19:09:24 INFO - "basedir": "/builds/slave/test", 19:09:24 INFO - "project": "", 19:09:24 INFO - "platform": "yosemite_r7", 19:09:24 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 19:09:24 INFO - "slavebuilddir": "test", 19:09:24 INFO - "scheduler": "tests-fx-team-macosx64-talos", 19:09:24 INFO - "branch": "fx-team", 19:09:24 INFO - "repo_path": "integration/fx-team", 19:09:24 INFO - "stage_platform": "macosx64", 19:09:24 INFO - "builduid": "ea20d8669b9d495884d28cd93d923ab7", 19:09:24 INFO - "revision": "65cd2c7696e438c74bfbb0ad40e18f411dbead38" 19:09:24 INFO - }, 19:09:24 INFO - "sourcestamp": { 19:09:24 INFO - "repository": "", 19:09:24 INFO - "hasPatch": false, 19:09:24 INFO - "project": "", 19:09:24 INFO - "branch": "fx-team-macosx64-talos", 19:09:24 INFO - "changes": [ 19:09:24 INFO - { 19:09:24 INFO - "category": null, 19:09:24 INFO - "files": [ 19:09:24 INFO - { 19:09:24 INFO - "url": null, 19:09:24 INFO - "name": "https://queue.taskcluster.net/v1/task/6LF1i3LMSh2oB4lY8NiSig/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 19:09:24 INFO - } 19:09:24 INFO - ], 19:09:24 INFO - "repository": "", 19:09:24 INFO - "rev": "65cd2c7696e438c74bfbb0ad40e18f411dbead38", 19:09:24 INFO - "who": "maglione.k@gmail.com", 19:09:24 INFO - "when": 1448333953, 19:09:24 INFO - "number": 6698661, 19:09:24 INFO - "comments": "Bug 1226423: [wbext] Add tests for panel popup API injection. r=billm", 19:09:24 INFO - "project": "", 19:09:24 INFO - "at": "Mon 23 Nov 2015 18:59:13", 19:09:24 INFO - "branch": "fx-team-macosx64-talos", 19:09:24 INFO - "revlink": "", 19:09:24 INFO - "properties": [ 19:09:24 INFO - [ 19:09:24 INFO - "buildid", 19:09:24 INFO - "20151123170936", 19:09:24 INFO - "Change" 19:09:24 INFO - ], 19:09:24 INFO - [ 19:09:24 INFO - "builduid", 19:09:24 INFO - "ea20d8669b9d495884d28cd93d923ab7", 19:09:24 INFO - "Change" 19:09:24 INFO - ], 19:09:24 INFO - [ 19:09:24 INFO - "pgo_build", 19:09:24 INFO - "False", 19:09:24 INFO - "Change" 19:09:24 INFO - ] 19:09:24 INFO - ], 19:09:24 INFO - "revision": "65cd2c7696e438c74bfbb0ad40e18f411dbead38" 19:09:24 INFO - } 19:09:24 INFO - ], 19:09:24 INFO - "revision": "65cd2c7696e438c74bfbb0ad40e18f411dbead38" 19:09:24 INFO - } 19:09:24 INFO - } 19:09:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/6LF1i3LMSh2oB4lY8NiSig/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 19:09:24 INFO - Running post-action listener: _resource_record_post_action 19:09:24 INFO - ##### 19:09:24 INFO - ##### Running download-and-extract step. 19:09:24 INFO - ##### 19:09:24 INFO - Running pre-action listener: _resource_record_pre_action 19:09:24 INFO - Running main action method: download_and_extract 19:09:24 INFO - mkdir: /builds/slave/test/build/tests 19:09:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:24 INFO - https://queue.taskcluster.net/v1/task/6LF1i3LMSh2oB4lY8NiSig/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:09:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6LF1i3LMSh2oB4lY8NiSig/artifacts/public/build/test_packages.json 19:09:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6LF1i3LMSh2oB4lY8NiSig/artifacts/public/build/test_packages.json 19:09:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6LF1i3LMSh2oB4lY8NiSig/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 19:09:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6LF1i3LMSh2oB4lY8NiSig/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 19:09:26 INFO - Downloaded 1149 bytes. 19:09:26 INFO - Reading from file /builds/slave/test/build/test_packages.json 19:09:26 INFO - Using the following test package requirements: 19:09:26 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 19:09:26 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:09:26 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 19:09:26 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:09:26 INFO - u'jsshell-mac.zip'], 19:09:26 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:09:26 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 19:09:26 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 19:09:26 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:09:26 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 19:09:26 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:09:26 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 19:09:26 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:09:26 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 19:09:26 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 19:09:26 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:09:26 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 19:09:26 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:09: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')]} 19:09:26 INFO - https://queue.taskcluster.net/v1/task/6LF1i3LMSh2oB4lY8NiSig/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:09:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6LF1i3LMSh2oB4lY8NiSig/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 19:09:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6LF1i3LMSh2oB4lY8NiSig/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 19:09:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6LF1i3LMSh2oB4lY8NiSig/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 19:09:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6LF1i3LMSh2oB4lY8NiSig/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:09:28 INFO - Downloaded 17527010 bytes. 19:09:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 19:09:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 19:09:28 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 19:09:31 INFO - Return code: 0 19:09:31 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip', u'firefox-45.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 19:09: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')]} 19:09:31 INFO - https://queue.taskcluster.net/v1/task/6LF1i3LMSh2oB4lY8NiSig/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:09:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6LF1i3LMSh2oB4lY8NiSig/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 19:09:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6LF1i3LMSh2oB4lY8NiSig/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 19:09:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6LF1i3LMSh2oB4lY8NiSig/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 19:09:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6LF1i3LMSh2oB4lY8NiSig/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:09:36 INFO - Downloaded 17527010 bytes. 19:09:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 19:09:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 19:09:36 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 19:09:39 INFO - Return code: 0 19:09:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:39 INFO - https://queue.taskcluster.net/v1/task/6LF1i3LMSh2oB4lY8NiSig/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 19:09:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6LF1i3LMSh2oB4lY8NiSig/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 19:09:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6LF1i3LMSh2oB4lY8NiSig/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 19:09:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6LF1i3LMSh2oB4lY8NiSig/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 19:09:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6LF1i3LMSh2oB4lY8NiSig/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'}, attempt #1 19:09:41 INFO - Downloaded 11130997 bytes. 19:09:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 19:09:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 19:09:41 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 19:09:42 INFO - Return code: 0 19:09:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:42 INFO - https://queue.taskcluster.net/v1/task/6LF1i3LMSh2oB4lY8NiSig/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 19:09:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6LF1i3LMSh2oB4lY8NiSig/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 19:09:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6LF1i3LMSh2oB4lY8NiSig/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 19:09:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6LF1i3LMSh2oB4lY8NiSig/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 19:09:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6LF1i3LMSh2oB4lY8NiSig/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg'}, attempt #1 19:09:45 INFO - Downloaded 109910082 bytes. 19:09:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/6LF1i3LMSh2oB4lY8NiSig/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 19:09:45 INFO - mkdir: /builds/slave/test/properties 19:09:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:09:45 INFO - Writing to file /builds/slave/test/properties/build_url 19:09:45 INFO - Contents: 19:09:45 INFO - build_url:https://queue.taskcluster.net/v1/task/6LF1i3LMSh2oB4lY8NiSig/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 19:09:45 INFO - Running post-action listener: _resource_record_post_action 19:09:45 INFO - Running post-action listener: set_extra_try_arguments 19:09:45 INFO - ##### 19:09:45 INFO - ##### Running populate-webroot step. 19:09:45 INFO - ##### 19:09:45 INFO - Running pre-action listener: _resource_record_pre_action 19:09:45 INFO - Running main action method: populate_webroot 19:09:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:09:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:09:45 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 19:09:45 INFO - '../fennec_ids.txt'], 19:09:45 INFO - 'tests': ['tcheck2']}, 19:09:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:09:45 INFO - '--tppagecycles', 19:09:45 INFO - '7'], 19:09:45 INFO - 'tests': ['tsvgm']}}, 19:09:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:09:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:09:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:09:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:09:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:09:45 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:09:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:09:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:45 INFO - 'talos_options': ['--e10s'], 19:09:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:09:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:45 INFO - 'tests': ['damp', 'tps']}, 19:09:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:45 INFO - 'talos_options': ['--e10s'], 19:09:45 INFO - 'tests': ['damp', 'tps']}, 19:09:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:09:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:09:45 INFO - 'other': {'tests': ['a11yr', 19:09:45 INFO - 'ts_paint', 19:09:45 INFO - 'tpaint', 19:09:45 INFO - 'sessionrestore', 19:09:45 INFO - 'sessionrestore_no_auto_restore']}, 19:09:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:09:45 INFO - 'tests': ['a11yr', 19:09:45 INFO - 'ts_paint', 19:09:45 INFO - 'tpaint', 19:09:45 INFO - 'sessionrestore', 19:09:45 INFO - 'sessionrestore_no_auto_restore']}, 19:09:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:09:45 INFO - 'tests': ['a11yr', 19:09:45 INFO - 'ts_paint', 19:09:45 INFO - 'tpaint', 19:09:45 INFO - 'sessionrestore', 19:09:45 INFO - 'sessionrestore_no_auto_restore']}, 19:09:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:09:45 INFO - 'tests': ['a11yr', 19:09:45 INFO - 'ts_paint', 19:09:45 INFO - 'tpaint', 19:09:45 INFO - 'sessionrestore', 19:09:45 INFO - 'sessionrestore_no_auto_restore']}, 19:09:45 INFO - 'other_l64': {'tests': ['a11yr', 19:09:45 INFO - 'ts_paint', 19:09:45 INFO - 'tpaint', 19:09:45 INFO - 'sessionrestore', 19:09:45 INFO - 'sessionrestore_no_auto_restore']}, 19:09:45 INFO - 'other_nol64': {'tests': ['a11yr', 19:09:45 INFO - 'ts_paint', 19:09:45 INFO - 'tpaint', 19:09:45 INFO - 'sessionrestore', 19:09:45 INFO - 'sessionrestore_no_auto_restore']}, 19:09:45 INFO - 'svgr': {'tests': ['tsvgx', 19:09:45 INFO - 'tsvgr_opacity', 19:09:45 INFO - 'tart', 19:09:45 INFO - 'tscrollx', 19:09:45 INFO - 'cart']}, 19:09:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:09:45 INFO - 'tests': ['tsvgx', 19:09:45 INFO - 'tsvgr_opacity', 19:09:45 INFO - 'tart', 19:09:45 INFO - 'tscrollx', 19:09:45 INFO - 'cart']}, 19:09:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:45 INFO - 'tests': ['tp5o']}, 19:09:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:45 INFO - 'talos_options': ['--e10s'], 19:09:45 INFO - 'tests': ['tp5o']}, 19:09:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:45 INFO - 'talos_options': ['--xperf_path', 19:09:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:09:45 INFO - 'tests': ['tp5n']}, 19:09:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:45 INFO - 'talos_options': ['--e10s', 19:09:45 INFO - '--xperf_path', 19:09:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:09:45 INFO - 'tests': ['tp5n']}}, 19:09:45 INFO - 'talos.zip': {'path': '', 19:09:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:09:45 INFO - Running post-action listener: _resource_record_post_action 19:09:45 INFO - ##### 19:09:45 INFO - ##### Running create-virtualenv step. 19:09:45 INFO - ##### 19:09:45 INFO - Running pre-action listener: _resource_record_pre_action 19:09:45 INFO - Running main action method: create_virtualenv 19:09:45 INFO - Creating virtualenv /builds/slave/test/build/venv 19:09:45 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 19:09:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:09:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:09:45 INFO - Using real prefix '/tools/python27' 19:09:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:09:45 INFO - Installing distribute.............................................................................................................................................................................................done. 19:09:48 INFO - Installing pip.................done. 19:09:48 INFO - Return code: 0 19:09:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:09:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:48 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 0x10f283490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f260228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb18ac99c80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f1a79f0>, '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 0x10ef06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f19a8c8>, '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.YoLGzRXRVp/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.obz4xq4jzd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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 19:09:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:09:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:09:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YoLGzRXRVp/Render', 19:09:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:09:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:09:48 INFO - 'HOME': '/Users/cltbld', 19:09:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:09:48 INFO - 'LOGNAME': 'cltbld', 19:09:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:48 INFO - 'MOZ_NO_REMOTE': '1', 19:09:48 INFO - 'NO_EM_RESTART': '1', 19:09:48 INFO - 'PAGER': '/bin/cat', 19:09:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:09:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:48 INFO - 'PWD': '/builds/slave/test', 19:09:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:09:48 INFO - 'SHELL': '/bin/bash', 19:09:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.obz4xq4jzd/Listeners', 19:09:48 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 19:09:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:09:48 INFO - 'USER': 'cltbld', 19:09:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:09:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:09:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:48 INFO - 'XPC_FLAGS': '0x0', 19:09:48 INFO - 'XPC_SERVICE_NAME': '0', 19:09:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:09:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:49 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:09:49 INFO - Cleaning up... 19:09:49 INFO - Return code: 0 19:09:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:09:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:49 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 0x10f283490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f260228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb18ac99c80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f1a79f0>, '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 0x10ef06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f19a8c8>, '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.YoLGzRXRVp/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.obz4xq4jzd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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 19:09:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 19:09:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 19:09:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YoLGzRXRVp/Render', 19:09:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:09:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:09:49 INFO - 'HOME': '/Users/cltbld', 19:09:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:09:49 INFO - 'LOGNAME': 'cltbld', 19:09:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:49 INFO - 'MOZ_NO_REMOTE': '1', 19:09:49 INFO - 'NO_EM_RESTART': '1', 19:09:49 INFO - 'PAGER': '/bin/cat', 19:09:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:09:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:49 INFO - 'PWD': '/builds/slave/test', 19:09:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:09:49 INFO - 'SHELL': '/bin/bash', 19:09:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.obz4xq4jzd/Listeners', 19:09:49 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 19:09:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:09:49 INFO - 'USER': 'cltbld', 19:09:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:09:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:09:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:49 INFO - 'XPC_FLAGS': '0x0', 19:09:49 INFO - 'XPC_SERVICE_NAME': '0', 19:09:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:09:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:49 INFO - Downloading/unpacking psutil>=0.7.1 19:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:52 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 19:09:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:09:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:09:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:09:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:09:52 INFO - Installing collected packages: psutil 19:09:52 INFO - Running setup.py install for psutil 19:09:52 INFO - building 'psutil._psutil_osx' extension 19:09:52 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 19:09:53 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 19:09:53 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 19:09:53 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 19:09:53 INFO - building 'psutil._psutil_posix' extension 19:09:53 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 19:09:53 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:09:53 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:09:53 INFO - ^ 19:09:53 INFO - 1 warning generated. 19:09:53 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 19:09:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:09:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:09:53 INFO - Successfully installed psutil 19:09:53 INFO - Cleaning up... 19:09:53 INFO - Return code: 0 19:09:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:09:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:53 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 0x10f283490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f260228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb18ac99c80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f1a79f0>, '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 0x10ef06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f19a8c8>, '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.YoLGzRXRVp/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.obz4xq4jzd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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 19:09:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 19:09:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 19:09:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YoLGzRXRVp/Render', 19:09:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:09:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:09:53 INFO - 'HOME': '/Users/cltbld', 19:09:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:09:53 INFO - 'LOGNAME': 'cltbld', 19:09:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:53 INFO - 'MOZ_NO_REMOTE': '1', 19:09:53 INFO - 'NO_EM_RESTART': '1', 19:09:53 INFO - 'PAGER': '/bin/cat', 19:09:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:09:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:53 INFO - 'PWD': '/builds/slave/test', 19:09:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:09:53 INFO - 'SHELL': '/bin/bash', 19:09:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.obz4xq4jzd/Listeners', 19:09:53 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 19:09:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:09:53 INFO - 'USER': 'cltbld', 19:09:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:09:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:09:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:53 INFO - 'XPC_FLAGS': '0x0', 19:09:53 INFO - 'XPC_SERVICE_NAME': '0', 19:09:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:09:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:09:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:09:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:09:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:09:56 INFO - Installing collected packages: mozsystemmonitor 19:09:56 INFO - Running setup.py install for mozsystemmonitor 19:09:56 INFO - Successfully installed mozsystemmonitor 19:09:56 INFO - Cleaning up... 19:09:56 INFO - Return code: 0 19:09:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:09:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:56 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 0x10f283490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f260228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb18ac99c80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f1a79f0>, '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 0x10ef06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f19a8c8>, '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.YoLGzRXRVp/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.obz4xq4jzd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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 19:09:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:09:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:09:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YoLGzRXRVp/Render', 19:09:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:09:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:09:56 INFO - 'HOME': '/Users/cltbld', 19:09:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:09:56 INFO - 'LOGNAME': 'cltbld', 19:09:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:56 INFO - 'MOZ_NO_REMOTE': '1', 19:09:56 INFO - 'NO_EM_RESTART': '1', 19:09:56 INFO - 'PAGER': '/bin/cat', 19:09:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:09:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:56 INFO - 'PWD': '/builds/slave/test', 19:09:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:09:56 INFO - 'SHELL': '/bin/bash', 19:09:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.obz4xq4jzd/Listeners', 19:09:56 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 19:09:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:09:56 INFO - 'USER': 'cltbld', 19:09:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:09:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:09:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:56 INFO - 'XPC_FLAGS': '0x0', 19:09:56 INFO - 'XPC_SERVICE_NAME': '0', 19:09:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:09:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:56 INFO - Downloading/unpacking blobuploader==1.2.4 19:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:58 INFO - Downloading blobuploader-1.2.4.tar.gz 19:09:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:09:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:09:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:09:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:09:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:09:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:59 INFO - Downloading docopt-0.6.1.tar.gz 19:09:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:09:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:09:59 INFO - Installing collected packages: blobuploader, requests, docopt 19:09:59 INFO - Running setup.py install for blobuploader 19:10:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:10:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:10:00 INFO - Running setup.py install for requests 19:10:00 INFO - Running setup.py install for docopt 19:10:00 INFO - Successfully installed blobuploader requests docopt 19:10:00 INFO - Cleaning up... 19:10:00 INFO - Return code: 0 19:10:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:10:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:00 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 0x10f283490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f260228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb18ac99c80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f1a79f0>, '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 0x10ef06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f19a8c8>, '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.YoLGzRXRVp/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.obz4xq4jzd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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 19:10:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:10:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:10:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YoLGzRXRVp/Render', 19:10:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:10:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:10:00 INFO - 'HOME': '/Users/cltbld', 19:10:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:10:00 INFO - 'LOGNAME': 'cltbld', 19:10:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:00 INFO - 'MOZ_NO_REMOTE': '1', 19:10:00 INFO - 'NO_EM_RESTART': '1', 19:10:00 INFO - 'PAGER': '/bin/cat', 19:10:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:10:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:00 INFO - 'PWD': '/builds/slave/test', 19:10:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:10:00 INFO - 'SHELL': '/bin/bash', 19:10:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.obz4xq4jzd/Listeners', 19:10:00 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 19:10:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:10:00 INFO - 'USER': 'cltbld', 19:10:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:10:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:10:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:00 INFO - 'XPC_FLAGS': '0x0', 19:10:00 INFO - 'XPC_SERVICE_NAME': '0', 19:10:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:10:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:10:01 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-wBgh1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:10:01 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-WJumqS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:10:01 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-ORHYKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:10:01 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-_IgSZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:10:01 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-1Y5uZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:10:01 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-DapKFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:10:01 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-7Mwlf9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:10:01 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-7bDhKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:10:01 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-Sir1LS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:10:02 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-qFfeGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:10:02 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-O_I38_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:10:02 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-ndk5wr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:10:02 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-YpRGOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:10:02 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-ZMor0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:10:02 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-asOJ5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:10:02 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-jWRXO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:10:02 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-FUc5Pp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:10:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:10:02 INFO - Running setup.py install for manifestparser 19:10:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:10:02 INFO - Running setup.py install for mozcrash 19:10:03 INFO - Running setup.py install for mozdebug 19:10:03 INFO - Running setup.py install for mozdevice 19:10:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:10:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:10:03 INFO - Running setup.py install for mozfile 19:10:03 INFO - Running setup.py install for mozhttpd 19:10:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:10:03 INFO - Running setup.py install for mozinfo 19:10:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:10:03 INFO - Running setup.py install for mozInstall 19:10:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:10:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:10:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:10:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:10:03 INFO - Running setup.py install for mozleak 19:10:04 INFO - Running setup.py install for mozlog 19:10:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:10:04 INFO - Running setup.py install for moznetwork 19:10:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:10:04 INFO - Running setup.py install for mozprocess 19:10:04 INFO - Running setup.py install for mozprofile 19:10:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:10:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:10:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:10:04 INFO - Running setup.py install for mozrunner 19:10:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:10:04 INFO - Running setup.py install for mozscreenshot 19:10:05 INFO - Running setup.py install for moztest 19:10:05 INFO - Running setup.py install for mozversion 19:10:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:10:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:10:05 INFO - Cleaning up... 19:10:05 INFO - Return code: 0 19:10:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:10:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:05 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 0x10f283490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f260228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb18ac99c80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f1a79f0>, '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 0x10ef06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f19a8c8>, '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.YoLGzRXRVp/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.obz4xq4jzd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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 19:10:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:10:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:10:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YoLGzRXRVp/Render', 19:10:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:10:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:10:05 INFO - 'HOME': '/Users/cltbld', 19:10:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:10:05 INFO - 'LOGNAME': 'cltbld', 19:10:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:05 INFO - 'MOZ_NO_REMOTE': '1', 19:10:05 INFO - 'NO_EM_RESTART': '1', 19:10:05 INFO - 'PAGER': '/bin/cat', 19:10:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:10:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:05 INFO - 'PWD': '/builds/slave/test', 19:10:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:10:05 INFO - 'SHELL': '/bin/bash', 19:10:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.obz4xq4jzd/Listeners', 19:10:05 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 19:10:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:10:05 INFO - 'USER': 'cltbld', 19:10:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:10:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:10:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:05 INFO - 'XPC_FLAGS': '0x0', 19:10:05 INFO - 'XPC_SERVICE_NAME': '0', 19:10:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:10:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:10:05 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-0I2RJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:10:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 19:10:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:10:05 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-aLciPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:10:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:10:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:10:05 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-tFGgcN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:10:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:10:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:10:05 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-Q_Ag8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:10:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:10:06 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-INs8r7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:10:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 19:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:10:06 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-mCtNqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:10:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 19:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:10:06 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-5kZWde-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:10:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 19:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:10:06 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-F02TZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:10:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 19:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:10:06 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-Iq6jsp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:10:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 19:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:10:06 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-gJMyb5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:10:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:10:06 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-OVIqqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:10:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 19:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:10:06 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-CHgHwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:10:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:10:06 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-VhRl0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:10:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 19:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:10:06 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-vzC7gu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:10:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:10:07 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-Hwdqip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:10:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 19:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:10:07 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-DCrXig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:10:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 19:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:10:07 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-4alMGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:10:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 19:10:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:10:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:10:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:10:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:10:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:10:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:09 INFO - Downloading blessings-1.5.1.tar.gz 19:10:09 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 19:10:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:10:09 INFO - Installing collected packages: blessings 19:10:09 INFO - Running setup.py install for blessings 19:10:09 INFO - Successfully installed blessings 19:10:09 INFO - Cleaning up... 19:10:09 INFO - Return code: 0 19:10:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:10:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:10:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:10:10 INFO - Reading from file tmpfile_stdout 19:10:10 INFO - Current package versions: 19:10:10 INFO - blessings == 1.5.1 19:10:10 INFO - blobuploader == 1.2.4 19:10:10 INFO - docopt == 0.6.1 19:10:10 INFO - manifestparser == 1.1 19:10:10 INFO - mozInstall == 1.12 19:10:10 INFO - mozcrash == 0.16 19:10:10 INFO - mozdebug == 0.1 19:10:10 INFO - mozdevice == 0.47 19:10:10 INFO - mozfile == 1.2 19:10:10 INFO - mozhttpd == 0.7 19:10:10 INFO - mozinfo == 0.9 19:10:10 INFO - mozleak == 0.1 19:10:10 INFO - mozlog == 3.1 19:10:10 INFO - moznetwork == 0.27 19:10:10 INFO - mozprocess == 0.22 19:10:10 INFO - mozprofile == 0.27 19:10:10 INFO - mozrunner == 6.11 19:10:10 INFO - mozscreenshot == 0.1 19:10:10 INFO - mozsystemmonitor == 0.0 19:10:10 INFO - moztest == 0.7 19:10:10 INFO - mozversion == 1.4 19:10:10 INFO - psutil == 3.1.1 19:10:10 INFO - requests == 1.2.3 19:10:10 INFO - wsgiref == 0.1.2 19:10:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:10:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:10 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 0x10f283490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f260228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb18ac99c80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f1a79f0>, '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 0x10ef06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f19a8c8>, '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.YoLGzRXRVp/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.obz4xq4jzd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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 19:10:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 19:10:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:10:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YoLGzRXRVp/Render', 19:10:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:10:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:10:10 INFO - 'HOME': '/Users/cltbld', 19:10:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:10:10 INFO - 'LOGNAME': 'cltbld', 19:10:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:10 INFO - 'MOZ_NO_REMOTE': '1', 19:10:10 INFO - 'NO_EM_RESTART': '1', 19:10:10 INFO - 'PAGER': '/bin/cat', 19:10:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:10:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:10 INFO - 'PWD': '/builds/slave/test', 19:10:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:10:10 INFO - 'SHELL': '/bin/bash', 19:10:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.obz4xq4jzd/Listeners', 19:10:10 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 19:10:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:10:10 INFO - 'USER': 'cltbld', 19:10:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:10:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:10:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:10 INFO - 'XPC_FLAGS': '0x0', 19:10:10 INFO - 'XPC_SERVICE_NAME': '0', 19:10:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:10:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:10:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 19:10:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 19:10:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:10:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 19:10:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 19:10:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 19:10:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 19:10:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:10:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 19:10:10 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:10:10 INFO - Cleaning up... 19:10:10 INFO - Return code: 0 19:10:10 INFO - Running post-action listener: _resource_record_post_action 19:10:10 INFO - Running post-action listener: _start_resource_monitoring 19:10:10 INFO - Starting resource monitoring. 19:10:10 INFO - ##### 19:10:10 INFO - ##### Running install step. 19:10:10 INFO - ##### 19:10:10 INFO - Running pre-action listener: _resource_record_pre_action 19:10:10 INFO - Running main action method: install 19:10:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:10:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:10:10 INFO - Reading from file tmpfile_stdout 19:10:10 INFO - Detecting whether we're running mozinstall >=1.0... 19:10:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:10:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:10:10 INFO - Reading from file tmpfile_stdout 19:10:10 INFO - Output received: 19:10:10 INFO - Usage: mozinstall [options] installer 19:10:10 INFO - Options: 19:10:10 INFO - -h, --help show this help message and exit 19:10:10 INFO - -d DEST, --destination=DEST 19:10:10 INFO - Directory to install application into. [default: 19:10:10 INFO - "/builds/slave/test"] 19:10:10 INFO - --app=APP Application being installed. [default: firefox] 19:10:10 INFO - mkdir: /builds/slave/test/build/application 19:10:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 19:10:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 19:10:41 INFO - Reading from file tmpfile_stdout 19:10:41 INFO - Output received: 19:10:41 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:10:41 INFO - Running post-action listener: _resource_record_post_action 19:10:41 INFO - ##### 19:10:41 INFO - ##### Running run-tests step. 19:10:41 INFO - ##### 19:10:41 INFO - Running pre-action listener: _resource_record_pre_action 19:10:41 INFO - Running main action method: run_tests 19:10:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:10:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:10:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:10:41 INFO - 2015-11-23 19:10:41.444 screenresolution[1642:7536] starting screenresolution argv=screenresolution get 19:10:41 INFO - 2015-11-23 19:10:41.447 screenresolution[1642:7536] Display 0: 1600x1200x32@60 19:10:41 INFO - 2015-11-23 19:10:41.453 screenresolution[1643:7538] starting screenresolution argv=screenresolution list 19:10:41 INFO - Available Modes on Display 0 19:10:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:10:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:10:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:10:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:10:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:10:41 INFO - Intel Iris: 19:10:41 INFO - Chipset Model: Intel Iris 19:10:41 INFO - Type: GPU 19:10:41 INFO - Bus: Built-In 19:10:41 INFO - VRAM (Dynamic, Max): 1536 MB 19:10:41 INFO - Vendor: Intel (0x8086) 19:10:41 INFO - Device ID: 0x0a2e 19:10:41 INFO - Revision ID: 0x0009 19:10:41 INFO - Displays: 19:10:41 INFO - Display: 19:10:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:10:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:10:41 INFO - Display Serial Number: 1600x1200 60 19:10:41 INFO - Main Display: Yes 19:10:41 INFO - Mirror: Off 19:10:41 INFO - Online: Yes 19:10:41 INFO - Rotation: Supported 19:10:41 INFO - Return code: 0 19:10:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:10:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:10:41 INFO - Python 2.7.3 19:10:41 INFO - Return code: 0 19:10:41 INFO - grabbing minidump binary from tooltool 19:10:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:41 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 0x10f1a79f0>, '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 0x10ef06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f19a8c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:10:41 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 19:10:41 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 19:10:41 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:10:41 INFO - Return code: 0 19:10:41 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:10:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:10:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:10:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:10:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:10:41 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-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/6LF1i3LMSh2oB4lY8NiSig/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0008', '--webServer', 'localhost'] in /builds/slave/test/build 19:10:41 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-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/6LF1i3LMSh2oB4lY8NiSig/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0008 --webServer localhost 19:10:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YoLGzRXRVp/Render', 19:10:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:10:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:10:41 INFO - 'HOME': '/Users/cltbld', 19:10:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:10:41 INFO - 'LOGNAME': 'cltbld', 19:10:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:10:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:10:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:41 INFO - 'MOZ_NO_REMOTE': '1', 19:10:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:10:41 INFO - 'NO_EM_RESTART': '1', 19:10:41 INFO - 'PAGER': '/bin/cat', 19:10:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:10:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:41 INFO - 'PWD': '/builds/slave/test', 19:10:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:10:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:10:41 INFO - 'SHELL': '/bin/bash', 19:10:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.obz4xq4jzd/Listeners', 19:10:41 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 19:10:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:10:41 INFO - 'USER': 'cltbld', 19:10:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:10:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:10:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:41 INFO - 'XPC_FLAGS': '0x0', 19:10:41 INFO - 'XPC_SERVICE_NAME': '0', 19:10:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:10:41 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-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/6LF1i3LMSh2oB4lY8NiSig/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0008', '--webServer', 'localhost'] with output_timeout 3600 19:10:42 INFO - mozversion INFO | application_buildid: 20151123170936 19:10:42 INFO - mozversion INFO | application_changeset: 65cd2c7696e438c74bfbb0ad40e18f411dbead38 19:10:42 INFO - mozversion INFO | application_display_name: Nightly 19:10:42 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:10:42 INFO - mozversion INFO | application_name: Firefox 19:10:42 INFO - mozversion INFO | application_remotingname: firefox 19:10:42 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 19:10:42 INFO - mozversion INFO | application_vendor: Mozilla 19:10:42 INFO - mozversion INFO | application_version: 45.0a1 19:10:42 INFO - mozversion INFO | platform_buildid: 20151123170936 19:10:42 INFO - mozversion INFO | platform_changeset: 65cd2c7696e438c74bfbb0ad40e18f411dbead38 19:10:42 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 19:10:42 INFO - mozversion INFO | platform_version: 45.0a1 19:10:42 INFO - 2015-11-23 19:10:42,001 DEBUG : using testdate: 1448334642 19:10:42 INFO - 2015-11-23 19:10:42,001 DEBUG : actual date: 1448334642 19:10:42 INFO - 2015-11-23 19:10:42,078 INFO : starting webserver on 'localhost:49272' 19:10:42 INFO - 2015-11-23 19:10:42,079 INFO : Starting test suite t-yosemite-r7-0008.e 19:10:42 INFO - 2015-11-23 19:10:42,079 INFO : Starting test dromaeo_css 19:10:42 INFO - 2015-11-23 19:10:42,079 DEBUG : operating with platform_type : mac_ 19:10:42 INFO - 2015-11-23 19:10:42,080 INFO : Initialising browser for dromaeo_css test... 19:10:42 INFO - 2015-11-23 19:10:42,092 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/tmp4AdQTw/profile http://localhost:49272/getInfo.html 19:10:44 INFO - 2015-11-23 19:10:44,785 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:10:44 INFO - 2015-11-23 19:10:44,785 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:10:44 INFO - 2015-11-23 19:10:44,785 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 19:10:44 INFO - 2015-11-23 19:10:44,785 DEBUG : BROWSER_OUTPUT: __metrics 19:10:45 INFO - 2015-11-23 19:10:45,370 INFO : Browser initialized. 19:10:45 INFO - 2015-11-23 19:10:45,371 INFO : Running cycle 1/1 for dromaeo_css test... 19:10:45 INFO - 2015-11-23 19:10:45,371 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/tmp4AdQTw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:10:57 INFO - 2015-11-23 19:10:57,210 DEBUG : BROWSER_OUTPUT: RSS: Main: 237232128 19:10:57 INFO - 2015-11-23 19:10:57,211 DEBUG : BROWSER_OUTPUT: 19:11:46 INFO - 2015-11-23 19:11:46,929 DEBUG : BROWSER_OUTPUT: 1448334706927 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 19:13:57 INFO - 2015-11-23 19:13:57,642 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 19:13:59 INFO - 2015-11-23 19:13:59,234 DEBUG : BROWSER_OUTPUT: RSS: Main: 255680512 19:13:59 INFO - 2015-11-23 19:13:59,235 DEBUG : BROWSER_OUTPUT: 19:17:01 INFO - 2015-11-23 19:17:01,223 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 19:17:01 INFO - 2015-11-23 19:17:01,827 DEBUG : BROWSER_OUTPUT: RSS: Main: 264450048 19:17:01 INFO - 2015-11-23 19:17:01,827 DEBUG : BROWSER_OUTPUT: 19:20:03 INFO - 2015-11-23 19:20:03,458 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 19:20:04 INFO - 2015-11-23 19:20:04,042 DEBUG : BROWSER_OUTPUT: RSS: Main: 266428416 19:20:04 INFO - 2015-11-23 19:20:04,042 DEBUG : BROWSER_OUTPUT: 19:23:05 INFO - 2015-11-23 19:23:05,671 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 19:23:06 INFO - 2015-11-23 19:23:06,258 DEBUG : BROWSER_OUTPUT: RSS: Main: 268419072 19:23:06 INFO - 2015-11-23 19:23:06,259 DEBUG : BROWSER_OUTPUT: 19:26:08 INFO - 2015-11-23 19:26:08,825 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 19:26:09 INFO - 2015-11-23 19:26:09,428 DEBUG : BROWSER_OUTPUT: RSS: Main: 271454208 19:26:09 INFO - 2015-11-23 19:26:09,428 DEBUG : BROWSER_OUTPUT: 19:29:11 INFO - 2015-11-23 19:29:11,676 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 19:29:11 INFO - 2015-11-23 19:29:11,936 DEBUG : BROWSER_OUTPUT: RSS: Main: 274448384 19:29:11 INFO - 2015-11-23 19:29:11,936 DEBUG : BROWSER_OUTPUT: 19:29:11 INFO - 2015-11-23 19:29:11,936 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:29:11 INFO - 2015-11-23 19:29:11,937 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:29:11 INFO - 2015-11-23 19:29:11,937 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:29:11 INFO - 2015-11-23 19:29:11,937 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:29:11 INFO - 2015-11-23 19:29:11,937 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3399.8130102844343;3512.8594856205737;3546.538949936508;3553.200529880777;3565.4117070683337;4349.543297953713;4635.490096089427;4808.95191048089;5200.08998425276;5974.6713930733795;5728.627639203449;5839.824805255838;5867.501262392701;5879.8530036749;5968.701564921747;5225.268462415265;5281.207818827178;5306.416294207634;5381.596380271476;5439.211314359415;5440.047991601454;5444.564434845203;5464.12573988162;5484.424135465779;5512.614117011811;5154.123798954187;5183.714895680736;5303.814366497154;5329.946700533003;5352.598555108363;5300.92048619271;5311.229871668586;5338.893222135535;5344.171653393731;5365.812196573102;5268.604854635918;5297.8145764898045;5307.336582927134;5344.679319240858;5392.083345831218;4856.708597484127;4964.453910069926;5613.101903695389;5880.764769409261;5911.615744976562;6222.471089957359;6247.687615619247;6276.435120839101;6292.62244265341;6296.401841825019;6289.308176100625;6294.3705629437145;6309.905351419732;6318.842028949267;6323.399277068717;4878.463369029404;6025.33721290662;6037.516998640098;6113.111460343324;6129.908988904127;6381.425671689571;6483.481321494363;6484.286728459866;6491.123698300669;6497.090407342976;5273.472652734773;6064.818055458255;6302.905456418157;6316.010456706123;6336.936630633727;6192.071189321638;6275.1842260506755;6278.905816412757;6344.651044192521;6360.332165122688;5309.212957875934;6288.654124023131;6289.7484100636375;6320.4311611955145;6325.114483972247;6169.321374648785;6271.655058971709;6302.306746257908;6305.873882522324;6310.5267104967315;5022.372203474566;5072.6702764320935;5076.13705670037;5089.796408143707;5134.589232861362;4551.499335073139;4571;4582.335561343587;4586.793594288265;4654.534546545318;5765.654060756368;5849.853753656193;5897.351291357947;6030.095485677096;6059.545534084961;6333.96833015832;6347.682615869188;6367.554271200971;6384.680765961683;6408.327125651833;5965.075413310944;5981.431763982415;5994.550408719277;6006.729697163551;6009.429104235178;5429.484199001088;5474;5508.834734957958;5590.636608620427;5598.86002849932;6437.967810160919;6456.677166141674;6542.509311801634;6555.803325900326;6583.341665833378;6340.1123842661145;6357.141785859035;6378.6810659467765;6380.425761681471;6381;6311.621302721851;6371.171747672773;6410.974244120918;6445.742170313135;6468.482521398371;6217.782377616762;6291.528135389773;6297.905531416941;6299.527535434952;6324.494040476843;4674.859754207379;5207.557357624644;6341.207349081365;6379.74481020754;6381.202349706286;5751.856203594776;6140.504248697302;6180.443760061616;6183.165272688309;6183.319834818257;6050.2237494006995;6126.326104128631;6224.906626400698;6234.688265586612;6256.217972753406;6100.328963814066;6121.785737499166;6135.877282454237;6190.7214175363115;6218.31598524171;6093.512518998381;6166.630002199882;6177.2587289525545;6189.412005859436;6253.124562561154;6090.634561926298;6110.5587591967305;6153.323134455117;6155.661438620739;6159.538034647509 19:29:11 INFO - 2015-11-23 19:29:11,937 DEBUG : BROWSER_OUTPUT: |1;ext.html;551.8620344913771;572.181780054522;581.9670085598063;599.5203836930455;672.970355356305;40697;41372;41386.58613413865;41409.3788593171;41436.79281603588;43865.34201986965;44202.778986105106;44287.77856110715;44324;44361.77819110908;9735.756606084833;9887.604495820158;9889.75275618108;9915.305928585001;9917.504124793768;9669.613215471372;9729.027097290249;9744.31789774716;9761.804763904718;9767.169790567776;9641.987591302917;9720.270979676518;9767.609295628166;9775.608975640966;9792.90207097927;9721.708348749513;9771.657991970318;9799.853002204973;9823.214142868554;9832.606695732162;9646.180074693659;9692.660756873545;9744.02559744027;9782.217422606174;9783.168430683401;40593.59406405957;41149.38275925864;41219.175616487504;41384.58615413837;41583.584164158274;3189.6331921829055;3244.5619841321354;3372.1401042733946;3535.080878971486;3751.6623503884507;28753.28116797076;28947.855260723773;28995.13014609565;29123.56314655282;29827.552586711216;2737.3293543082073;2749.752522273005;2751.7660998815127;2865.2550336912345;2944.5435957426635;467396;474311;477594;479006;479202.9999999965;46066.76966615146;67832.32167678358;68254.3174568258;68337.65831170812;68422;46141.077178456246;46155;46234.768826155654;46313;46314.30528542075;15100;15135.470258541118;15190.848091519165;15231.390744370323;15249.390024399121;11742.765144697058;12018.519259229708;12067.758644827054;12104.75790484203;12124.757504849853;14666.926665366605;14684.853151468562;14957.626059348604;15025.699486010219;15049.473268435771;6495.772647957298;6582.736690532325;6594.7032383542855;6612.570182938093;6624.27133015368;960.4621412009298;965.5654955270156;1015.5988384588046;1065.4406436620682;1088.3361149698678;30390.84804575963;31435.84282078575;33303.50044749331;33861.814836480604;34037;787.6691789448446;935.5930170375908;979.6620166042704;1103.5955856176517;1120.5797825815318;14564;15821.050736955589;15918;15976.520704378887;16089.115098669452;546977;618229;633742;636717;648197;63412.68293658502;63462;63827.36172638307;63920.041199382045;64134;1379.1311473771661;1385.7852032934911;1393.1432169216062;1417.666848290651;1420.8650178233258;31059.84470077635;31155.53266700956;31212.219694507818;31468.842655786575;31736.841315793274;52559.211611825085;52790.73604631952;53537.46462535325;53578.92842143213;53590.46409535855;497409;502588;502804;503219;504129;29478.852605736833;29927.850360748056;33677.49483757697;34096.82951585226;34851.4772278411;43081;43241;43561;44654.10691786211;44659.553404465536;36081.819590901876;36496.72261470836;36618;38692.6130738689;39191.216175675756;37092.629073708915;37465;38206.808965954995;38251.80874095612;38432;37260;37496;37508.81245593754;37536.812315938245;37691.81154094212;27154.32114197161;27344.042958496357;27505.17484475469;31628.209294766893;34277.48583771295;20710;25266.747332527175;25400.491990160463;25481.87259063693;25505.48989020246 19:29:11 INFO - 2015-11-23 19:29:11,937 DEBUG : BROWSER_OUTPUT: |2;jquery.html;337.5813990651593;360.69701450781355;366.16697014292464;366.6187165348038;367.4066382791791;15985.600359991005;19511.70732439013;19918;20826.89586552067;22016;20362.898185509053;20488.487787805312;20878.582428351423;21106.366808995717;21125.68311475329;5710.14347847822;5923.318818335903;6091.14723938649;6091.969540152293;6105.755769769204;5510.669359838403;5561.138023606348;5601.60788744788;5669.829905102853;5890.528757699374;5408.161734931092;5507.063799154133;5581.944180558204;5652.06740887753;5666.376698563155;5473.507384335389;5476.452354764531;5590.99999999998;5600.27196464459;5612.298462692163;5752.8274151775095;5775.884482310373;5800.0719884818645;5804.448577385142;5806.187133801272;12444.253344799341;12604.991600672016;21759.564808703737;23747.525049498912;23948.880255598786;1566.381279394644;1680.3782600437794;1897.2031746666432;2032.298856894369;2048.3445297504804;9908.752281193028;10120.746981325527;10892.673219803419;14508.202048887308;15006;1481.4000329866421;1587.452328946523;1703.8125806161313;1778.7687600611837;1797.173300281859;81740.77388839232;100440.48898777516;100440.49779751127;101128.49435752847;101393;10377.896221037692;11033.227674062899;11093.944530277297;11131.944340278409;11213.3832639204;11172.21794474379;13297;13300.600981970556;13304.667383315495;13331.266780327174;8009.719659811879;8249.711260105867;8258.380621453414;8306.8338633227;8328.250457458858;8246.670133194604;8249.958750206211;8310.667573297122;8345.958270208732;8378.8324233515;4085.3667681509414;4158.209940111369;4360.127974405132;4409.691321607521;4429.623482004002;1718.4672751447092;1818.4271954334342;1863.506170864722;1882.7646544181978;1893.6307420053233;354.76408188554325;401.8867736370238;728.9211966289921;785.3050050705167;926.7405126564573;9636;11539.249948753471;11890;11944.701382465335;11960.04319654443;373.4771320151809;434.86519179054596;435.675421810753;447.2709483541806;454.86126731346593;11125.777484450266;11570.305781653127;11659.242149260272;11672.824907626393;11691.590794322328;716014;720130;738270;739659;743185;122588;124612;129313.06030409552;131118.68881311064;133077;1245.1719606461602;1248.145020660832;1251.4556168067102;1255.811628255769;1271.192792576702;14923.477678281208;19170.712439313702;19393.4181974541;19539.374072426883;19548.60902781965;53442.46557534375;53498.46501534935;54595.90808183735;54954.725226373615;54991.62520937008;71622.64188679024;71894.28105718875;76619.61690191513;76770.46459070899;76800.23199767931;9696.466694331879;9860.556274967501;9937.552810123707;10103.242256830914;10134.797304054026;11952.521899124285;16393.09837958924;17141.228644711267;19525.902370488056;20020.099095541027;15526.534203973899;15668.68662626764;15781;15894.046357218604;16163.868529202842;14459.421623134956;14629.414823406945;15151.242437878282;15522.223888805289;15704.057756534645;11647.883521165018;13666.794998074838;15499.380024798882;16939.661206776043;17098;8692.956535217283;9998.700038998843;10234.897651023692;10258.640947566799;10264.178865690876;15304.775617950314;15932.123733194321;16156.838431615533;16562.254698538836;16581.502554923372 19:29:11 INFO - 2015-11-23 19:29:11,937 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1463.860933211345;1547.5898886795;1711.8630509559237;1785.919633616487;1852.7961924188346;7221.025161603182;7727.574983375912;7837.686492540306;8415;8592.999999999993;8239.217274358927;8346.791330216747;8434.53610051447;8446.113158118402;8469.280111190556;2320.9883950580224;2343.2267351773958;2353.646952957062;2357.1043003658588;2358.5282943411303;2102.51642122312;2232.631615783394;2330.0446816805115;2377.465070359173;2401.435662619283;2281.0533628544135;2305.3660243433023;2326.2672258238686;2362.7400985891536;2374.382660508263;2337.415646088478;2337.906483740648;2350.1891847312736;2360.846544974588;2361.728401233854;2387.570237357275;2398.568257713611;2401.135591187171;2411.2525117213545;2417.7340492545804;8239.917600823976;8320;8321.334293256525;8355.707550235773;8376.664933402657;4418.8453404130705;4631.675782695213;5094.3886733591835;5107.719075450848;5187.221916712486;3217.7104060634656;3446;3449.120474279068;3522.788632682047;3534.68187863091;1027.542743479152;1035.8498017787379;1047.5076713944434;1048.7535429174138;1075.1774892207468;10698.197635177316;10700.999999999922;10844.295120817122;10880.347179169195;10880.727981800439;4541.636669066466;4636.258198688193;4647.37260469839;4659.767011649404;4670.229412146958;9572;9573.042695730372;9580.904190958141;9613.230941524662;9671.177949874198;5158.561522270649;5163.328767260307;5170.405403378584;5189.273501709764;5213.504717051874;4691.976540117277;4694.295855621615;4704.435467743892;4704.95295047052;4736.3369128322065;3685.9078523037138;3744.5132132823105;3751.3247615429486;3764.322421964073;3773.056735816046;1225.662942690767;1229.2255878796302;1239.3369547292336;1240.9131360804656;1250.7435975624976;1344.0524430276632;1357.4909408971635;1380.1856904426436;1394.8953828462907;1398.9580312590638;7692.153863075057;7787.454878158588;7788.182240864741;7804.297613214838;7818;482.4596451973812;487.64889279718545;488.6066716293347;489.05856226763336;509.9056674515152;5929.762809487572;6149.692515374213;6177.413145751147;6185.8144255672405;6209.5032397408095;9376.8593471098;9886.851697224547;9974.850377244347;10006.149477294512;10028;9795.559199835881;9879.703608891601;9891.752706182404;9936.304458687822;10069.043440873105;7844.411669124838;7872.291493765589;7935.682572697143;7952.244536768998;7970.9202907970175;7662.118856331594;7728.381729461517;7734.6132693366235;7764.184760600056;7781.688732450865;7151.641188174231;8852.424592401474;8916.687915922912;8969.641214351353;8980.506072166094;7797.025371828521;7937.642806073625;8142.67429302845;8786;9125.406848554823;7304.379127774198;7339;7342.77971660851;7374.188839227788;7401.0748656417945;7346.191918889025;7579.962100189464;7812.218778122142;7941.841163176588;7995.360951004914;7293.781186564412;7385.889211661722;7410.370118539984;7539.59957388773;7600.201978792147;6498.155239818982;7177.641117943977;7316.780496585111;7405.44459165554;7417.740379086706;7140.892886606601;7357.2642735726;7363.374113200438;7382.667779950022;7507.737229196952;6846.212685541226;6849.657517124224;6864.107666003388;6871.587704737732;6893.7931862044215;5889.110889110889;6933.0986971693355;6940.305969403019;6963.303669632996;7004.264552221944 19:29:11 INFO - 2015-11-23 19:29:11,937 DEBUG : BROWSER_OUTPUT: |4;prototype.html;328.6368562738174;331.2893842707393;336.6986547040398;340.03091190108177;342.8080275045974;7038.1554213494455;7157.212706602282;7173.497855150142;7228.674709638066;7234.819129521758;6778.627175505345;7065.258147894461;7068.505204635665;7096.148462184545;7141.750038748645;4247.87256382309;5128.8461346159675;5149.922751158736;5155.793768249266;5182.093133701606;4964.032013757319;5177.275181474596;5178.342930262317;5181.1710126379785;5199.298094757216;5031.195008798593;5042.092423363793;5042.495750424965;5047.873803154914;5057.620678449112;5028.949710502885;5048.747562621873;5049.798008079672;5053.671511351788;5060.418051924003;3692.612275711065;4178.8537401191115;4272.6154646081695;4273.914521709548;4284.742915425053;6559.704813283413;6769.559978601375;6844.657767111625;6849.48628852838;6868.278830722752;5978;5993.4006599340155;5994.430529099728;6005.909911351333;6021.066734656135;7558.244175582453;7584.355329796974;7590.506617069873;7595.430342724318;7607.771766847003;4689.50760170184;4779.928301075487;4790.089882922233;4799;4802.68782529138;7172.959920811453;7199.1361036675935;8008.919910800934;8031.2771850533145;8053.436259461899;4843.927341089887;4847.975760121177;4860.441049279378;4861.756912154378;4871.123197824426;4387.605115539617;4685.9531404686195;4944.332515110486;4963.255511673278;4966;4354.912901741947;5770.422957704196;5965.13505541694;5970.582059255898;5978.4021597839865;6195.31851496335;7239.384652304613;7642.159362470124;7677.539347639159;7678.8080297993;1644.597073716923;1681.436718699225;1713.8628909687195;1720.870934679879;1721.5179749670112;1071.8124328242527;1087.0542627913608;1091.9617813376494;1097.6926460591046;1101.5098281264761;7045.859082818315;7061.505694601328;7069.328413800681;7072.717091316393;7092.503524753321;7767.572783496849;7808.648610812527;7831.451798374173;7835.216478352119;7853.057633084067;5417.431169727122;6272.1219029335925;6323.747050118036;7164.677589508485;7175.748848790267;4153.91692166161;4202.579742025773;4218.240716671029;4220;4256.170046840836;6736.360045795642;8259.504429734236;8303.667853285922;8309.086000539935;8372.330213582898;8083.878741818878;8337;8354.331653467829;8356.916430835736;8405.747827565183;8281.751547453587;8326.625301861432;8332.750017499484;8334.791630209173;8357.331413486907;7827;7996.720114795954;8019.957405537243;8023.879641805261;8042.798930026796;7879.763607091796;7886;7890.210978902064;7895.407844411807;7912.36701063925;8311.83376332458;8316.708915187939;8317.41778075529;8351;8363.247307742333;4949.505049495022;5075.822346217865;5114.33513643224;5138.229265610039;5144.331236939174;7765.572893490912;7913.3669306456495;7947.761567152995;7952.443328966917;8018.1180070193395;6578.703958321791;7643;7703.191164927602;7703.422243331661;7716.2669546393;7658.961705191438;7667.504836556818;7676.884846727416;7678.961605191938;7704.26809453101;7180.856382872418;7450.478466507292;7459.738909138154;7471.066116735408;7482.027336446227;7665.6933722650465;7671.53970761756;7675.61621918913;7684.807879803049;7696.345810606162;7276.4542659299705;7486.401087913063;7492.812679683051;7495;7516.24837516244 19:29:11 INFO - 2015-11-23 19:29:11,941 DEBUG : BROWSER_OUTPUT: |5;yui.html;741.8330875552999;773.6402572803648;790.3163763344705;806.4072906413788;837.4807619276054;11949;12057.939710301458;12145.514179432823;12156.513739450433;12256.448459819307;13157.276349800757;13349;14202.431902723905;14271.714565708706;14287.142771433695;934.313279739391;950.1353768071057;963.1572374172599;964.4068897627978;965.1458459263567;935.1583574782716;937.2876613773514;951.8762560867077;953.7138858342504;955.7610597350663;961.0773657289011;982.4841957972051;995.6316163019657;998.8102260570469;1000.9349392289478;980.0297705271801;986.2061040862103;987.8419452887575;991.7818080022383;994.28908330544;664.9228250234603;734.2107234722641;742.265157494077;743.0414764953204;744.0178963767829;10136.087752102347;11284;12698;13152.86847131526;13178.67053323665;10688.305260158142;11013.229073964825;11047.060999815025;11048.337099773958;11615.535378584846;9417.48203848788;9708.95145524275;9991.550380232908;11119.999200072032;12113.576024839176;3374.5152133061374;3500.632433594487;3551.058969373118;3581.6776490116013;3626.909327266813;57309.14036289459;62487;63712.68143659298;69630.25924351932;76847;8788;9379.718608441757;9414.199793017533;9439.008904065111;10205.540750666238;21003.369898903056;21199.68200476994;21240.04419801082;21384.358469245948;21436.678449823266;7289.817754556072;7356.668949897267;7560.319571238615;7620.428467864822;7686.654100565488;4039.2123535910214;4055.878323650295;4057.655099316591;4070.104576993057;4087.141700242923;3445.586529616462;3453.930921381558;3475.6524347565546;3478.7738796978115;3490.267043920754;623.0498489802997;630.4168644004278;630.5082036011918;651.5797310734549;651.9445847102954;503.5166240409248;509.9056674515227;513.0636588226502;561.9803306884239;563.1159080244059;8638.395312328203;8658.567071646392;8690.78273043179;8839.60860978878;8876.378653494194;595.4551585299489;612.4382823799294;622.7260005597523;627.9811605651838;638.2149955554694;3953.584873588289;4155.376693495939;4288.807003684841;4342.457192850894;4526.932096018497;92247;93244.53377733204;94884.52557737168;99947.50026249967;100311;76920.61539692266;77687.22312776913;80559;80772.19227807764;81090.78363824547;68067.95796126124;68406;69069;74711;76077;8839.558022098998;8918.598663060307;9052.547372631474;9097.40866843653;9115.726528204164;54676.72661636826;54887.72556137194;55182.72408637931;55252.171217430965;55273.618159546335;71927.56144876969;75891.62054189693;76381;76413.61793190999;78434.6078269605;10793.29843560166;10890.455477226265;10981.286216395909;11162.386068766296;11939.164258501822;11810.881891180978;12075.51697932073;12312.076594255646;12513.124081314221;12708.555200567936;11552.6534203974;11670;11900.523979040741;11931;12036.398180091135;11140.220184587;11314.094872410024;11455.198136130392;11899.226550274205;12327.630171094881;10861.945690271497;11520.711982200512;11536.653900383002;11559.30644161353;12101.376970664398;9738.367006144577;9784.168345690412;9900.801983960424;9997.200223982209;10199.38803671782;8558.272546833588;8791.868121978303;9138.31462640318;9601.663941762004;10190.43952582615 19:29:11 INFO - 2015-11-23 19:29:11,941 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:29:11 INFO - 2015-11-23 19:29:11,941 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:29:11 INFO - 2015-11-23 19:29:11,941 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,339 19:29:11 INFO - 2015-11-23 19:29:11,941 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:29:11 INFO - 2015-11-23 19:29:11,941 DEBUG : BROWSER_OUTPUT: __startTimestamp1448335751926__endTimestamp 19:29:11 INFO - 2015-11-23 19:29:11,941 DEBUG : BROWSER_OUTPUT: 19:29:11 INFO - 2015-11-23 19:29:11,941 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:29:11 INFO - 2015-11-23 19:29:11,941 DEBUG : BROWSER_OUTPUT: Number of tests: 6 19:29:11 INFO - 2015-11-23 19:29:11,941 DEBUG : BROWSER_OUTPUT: 19:29:11 INFO - 2015-11-23 19:29:11,941 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5809.06 Median:6100.33 stddev:671.15 (11.0%) stddev-sans-first:646.05 19:29:11 INFO - 2015-11-23 19:29:11,942 DEBUG : BROWSER_OUTPUT: Values: 3399.8 3512.9 3546.5 3553.2 3565.4 4349.5 4635.5 4809.0 5200.1 5974.7 5728.6 5839.8 5867.5 5879.9 5968.7 5225.3 5281.2 5306.4 5381.6 5439.2 5440.0 5444.6 5464.1 5484.4 5512.6 5154.1 5183.7 5303.8 5329.9 5352.6 5300.9 5311.2 5338.9 5344.2 5365.8 5268.6 5297.8 5307.3 5344.7 5392.1 4856.7 4964.5 5613.1 5880.8 5911.6 6222.5 6247.7 6276.4 6292.6 6296.4 6289.3 6294.4 6309.9 6318.8 6323.4 4878.5 6025.3 6037.5 6113.1 6129.9 6381.4 6483.5 6484.3 6491.1 6497.1 5273.5 6064.8 6302.9 6316.0 6336.9 6192.1 6275.2 6278.9 6344.7 6360.3 5309.2 6288.7 6289.7 6320.4 6325.1 6169.3 6271.7 6302.3 6305.9 6310.5 5022.4 5072.7 5076.1 5089.8 5134.6 4551.5 4571.0 4582.3 4586.8 4654.5 5765.7 5849.9 5897.4 6030.1 6059.5 6334.0 6347.7 6367.6 6384.7 6408.3 5965.1 5981.4 5994.6 6006.7 6009.4 5429.5 5474.0 5508.8 5590.6 5598.9 6438.0 6456.7 6542.5 6555.8 6583.3 6340.1 6357.1 6378.7 6380.4 6381.0 6311.6 6371.2 6411.0 6445.7 6468.5 6217.8 6291.5 6297.9 6299.5 6324.5 4674.9 5207.6 6341.2 6379.7 6381.2 5751.9 6140.5 6180.4 6183.2 6183.3 6050.2 6126.3 6224.9 6234.7 6256.2 6100.3 6121.8 6135.9 6190.7 6218.3 6093.5 6166.6 6177.3 6189.4 6253.1 6090.6 6110.6 6153.3 6155.7 6159.5 19:29:11 INFO - 2015-11-23 19:29:11,942 DEBUG : BROWSER_OUTPUT: 19:29:11 INFO - 2015-11-23 19:29:11,942 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:66875.53 Median:41385.59 stddev:142836.12 (345.1%) stddev-sans-first:143150.01 19:29:11 INFO - 2015-11-23 19:29:11,943 DEBUG : BROWSER_OUTPUT: Values: 551.9 572.2 582.0 599.5 673.0 40697.0 41372.0 41386.6 41409.4 41436.8 43865.3 44202.8 44287.8 44324.0 44361.8 9735.8 9887.6 9889.8 9915.3 9917.5 9669.6 9729.0 9744.3 9761.8 9767.2 9642.0 9720.3 9767.6 9775.6 9792.9 9721.7 9771.7 9799.9 9823.2 9832.6 9646.2 9692.7 9744.0 9782.2 9783.2 40593.6 41149.4 41219.2 41384.6 41583.6 3189.6 3244.6 3372.1 3535.1 3751.7 28753.3 28947.9 28995.1 29123.6 29827.6 2737.3 2749.8 2751.8 2865.3 2944.5 467396.0 474311.0 477594.0 479006.0 479203.0 46066.8 67832.3 68254.3 68337.7 68422.0 46141.1 46155.0 46234.8 46313.0 46314.3 15100.0 15135.5 15190.8 15231.4 15249.4 11742.8 12018.5 12067.8 12104.8 12124.8 14666.9 14684.9 14957.6 15025.7 15049.5 6495.8 6582.7 6594.7 6612.6 6624.3 960.5 965.6 1015.6 1065.4 1088.3 30390.8 31435.8 33303.5 33861.8 34037.0 787.7 935.6 979.7 1103.6 1120.6 14564.0 15821.1 15918.0 15976.5 16089.1 546977.0 618229.0 633742.0 636717.0 648197.0 63412.7 63462.0 63827.4 63920.0 64134.0 1379.1 1385.8 1393.1 1417.7 1420.9 31059.8 31155.5 31212.2 31468.8 31736.8 52559.2 52790.7 53537.5 53578.9 53590.5 497409.0 502588.0 502804.0 503219.0 504129.0 29478.9 29927.9 33677.5 34096.8 34851.5 43081.0 43241.0 43561.0 44654.1 44659.6 36081.8 36496.7 36618.0 38692.6 39191.2 37092.6 37465.0 38206.8 38251.8 38432.0 37260.0 37496.0 37508.8 37536.8 37691.8 27154.3 27344.0 27505.2 31628.2 34277.5 20710.0 25266.7 25400.5 25481.9 25505.5 19:29:11 INFO - 2015-11-23 19:29:11,944 DEBUG : BROWSER_OUTPUT: 19:29:11 INFO - 2015-11-23 19:29:11,944 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:38294.69 Median:11197.60 stddev:120618.52 (1077.2%) stddev-sans-first:120923.21 19:29:11 INFO - 2015-11-23 19:29:11,945 DEBUG : BROWSER_OUTPUT: Values: 337.6 360.7 366.2 366.6 367.4 15985.6 19511.7 19918.0 20826.9 22016.0 20362.9 20488.5 20878.6 21106.4 21125.7 5710.1 5923.3 6091.1 6092.0 6105.8 5510.7 5561.1 5601.6 5669.8 5890.5 5408.2 5507.1 5581.9 5652.1 5666.4 5473.5 5476.5 5591.0 5600.3 5612.3 5752.8 5775.9 5800.1 5804.4 5806.2 12444.3 12605.0 21759.6 23747.5 23948.9 1566.4 1680.4 1897.2 2032.3 2048.3 9908.8 10120.7 10892.7 14508.2 15006.0 1481.4 1587.5 1703.8 1778.8 1797.2 81740.8 100440.5 100440.5 101128.5 101393.0 10377.9 11033.2 11093.9 11131.9 11213.4 11172.2 13297.0 13300.6 13304.7 13331.3 8009.7 8249.7 8258.4 8306.8 8328.3 8246.7 8250.0 8310.7 8346.0 8378.8 4085.4 4158.2 4360.1 4409.7 4429.6 1718.5 1818.4 1863.5 1882.8 1893.6 354.8 401.9 728.9 785.3 926.7 9636.0 11539.2 11890.0 11944.7 11960.0 373.5 434.9 435.7 447.3 454.9 11125.8 11570.3 11659.2 11672.8 11691.6 716014.0 720130.0 738270.0 739659.0 743185.0 122588.0 124612.0 129313.1 131118.7 133077.0 1245.2 1248.1 1251.5 1255.8 1271.2 14923.5 19170.7 19393.4 19539.4 19548.6 53442.5 53498.5 54595.9 54954.7 54991.6 71622.6 71894.3 76619.6 76770.5 76800.2 9696.5 9860.6 9937.6 10103.2 10134.8 11952.5 16393.1 17141.2 19525.9 20020.1 15526.5 15668.7 15781.0 15894.0 16163.9 14459.4 14629.4 15151.2 15522.2 15704.1 11647.9 13666.8 15499.4 16939.7 17098.0 8693.0 9998.7 10234.9 10258.6 10264.2 15304.8 15932.1 16156.8 16562.3 16581.5 19:29:11 INFO - 2015-11-23 19:29:11,945 DEBUG : BROWSER_OUTPUT: 19:29:11 INFO - 2015-11-23 19:29:11,945 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5725.34 Median:6163.55 stddev:2967.14 (48.1%) stddev-sans-first:2958.17 19:29:11 INFO - 2015-11-23 19:29:11,946 DEBUG : BROWSER_OUTPUT: Values: 1463.9 1547.6 1711.9 1785.9 1852.8 7221.0 7727.6 7837.7 8415.0 8593.0 8239.2 8346.8 8434.5 8446.1 8469.3 2321.0 2343.2 2353.6 2357.1 2358.5 2102.5 2232.6 2330.0 2377.5 2401.4 2281.1 2305.4 2326.3 2362.7 2374.4 2337.4 2337.9 2350.2 2360.8 2361.7 2387.6 2398.6 2401.1 2411.3 2417.7 8239.9 8320.0 8321.3 8355.7 8376.7 4418.8 4631.7 5094.4 5107.7 5187.2 3217.7 3446.0 3449.1 3522.8 3534.7 1027.5 1035.8 1047.5 1048.8 1075.2 10698.2 10701.0 10844.3 10880.3 10880.7 4541.6 4636.3 4647.4 4659.8 4670.2 9572.0 9573.0 9580.9 9613.2 9671.2 5158.6 5163.3 5170.4 5189.3 5213.5 4692.0 4694.3 4704.4 4705.0 4736.3 3685.9 3744.5 3751.3 3764.3 3773.1 1225.7 1229.2 1239.3 1240.9 1250.7 1344.1 1357.5 1380.2 1394.9 1399.0 7692.2 7787.5 7788.2 7804.3 7818.0 482.5 487.6 488.6 489.1 509.9 5929.8 6149.7 6177.4 6185.8 6209.5 9376.9 9886.9 9974.9 10006.1 10028.0 9795.6 9879.7 9891.8 9936.3 10069.0 7844.4 7872.3 7935.7 7952.2 7970.9 7662.1 7728.4 7734.6 7764.2 7781.7 7151.6 8852.4 8916.7 8969.6 8980.5 7797.0 7937.6 8142.7 8786.0 9125.4 7304.4 7339.0 7342.8 7374.2 7401.1 7346.2 7580.0 7812.2 7941.8 7995.4 7293.8 7385.9 7410.4 7539.6 7600.2 6498.2 7177.6 7316.8 7405.4 7417.7 7140.9 7357.3 7363.4 7382.7 7507.7 6846.2 6849.7 6864.1 6871.6 6893.8 5889.1 6933.1 6940.3 6963.3 7004.3 19:29:11 INFO - 2015-11-23 19:29:11,946 DEBUG : BROWSER_OUTPUT: 19:29:11 INFO - 2015-11-23 19:29:11,947 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:6170.34 Median:7066.88 stddev:2043.22 (28.9%) stddev-sans-first:2001.35 19:29:11 INFO - 2015-11-23 19:29:11,948 DEBUG : BROWSER_OUTPUT: Values: 328.6 331.3 336.7 340.0 342.8 7038.2 7157.2 7173.5 7228.7 7234.8 6778.6 7065.3 7068.5 7096.1 7141.8 4247.9 5128.8 5149.9 5155.8 5182.1 4964.0 5177.3 5178.3 5181.2 5199.3 5031.2 5042.1 5042.5 5047.9 5057.6 5028.9 5048.7 5049.8 5053.7 5060.4 3692.6 4178.9 4272.6 4273.9 4284.7 6559.7 6769.6 6844.7 6849.5 6868.3 5978.0 5993.4 5994.4 6005.9 6021.1 7558.2 7584.4 7590.5 7595.4 7607.8 4689.5 4779.9 4790.1 4799.0 4802.7 7173.0 7199.1 8008.9 8031.3 8053.4 4843.9 4848.0 4860.4 4861.8 4871.1 4387.6 4686.0 4944.3 4963.3 4966.0 4354.9 5770.4 5965.1 5970.6 5978.4 6195.3 7239.4 7642.2 7677.5 7678.8 1644.6 1681.4 1713.9 1720.9 1721.5 1071.8 1087.1 1092.0 1097.7 1101.5 7045.9 7061.5 7069.3 7072.7 7092.5 7767.6 7808.6 7831.5 7835.2 7853.1 5417.4 6272.1 6323.7 7164.7 7175.7 4153.9 4202.6 4218.2 4220.0 4256.2 6736.4 8259.5 8303.7 8309.1 8372.3 8083.9 8337.0 8354.3 8356.9 8405.7 8281.8 8326.6 8332.8 8334.8 8357.3 7827.0 7996.7 8020.0 8023.9 8042.8 7879.8 7886.0 7890.2 7895.4 7912.4 8311.8 8316.7 8317.4 8351.0 8363.2 4949.5 5075.8 5114.3 5138.2 5144.3 7765.6 7913.4 7947.8 7952.4 8018.1 6578.7 7643.0 7703.2 7703.4 7716.3 7659.0 7667.5 7676.9 7679.0 7704.3 7180.9 7450.5 7459.7 7471.1 7482.0 7665.7 7671.5 7675.6 7684.8 7696.3 7276.5 7486.4 7492.8 7495.0 7516.2 19:29:11 INFO - 2015-11-23 19:29:11,948 DEBUG : BROWSER_OUTPUT: 19:29:11 INFO - 2015-11-23 19:29:11,948 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:18313.53 Median:622.89 stddev:25982.33 (4171.3%) stddev-sans-first:26021.72 19:29:11 INFO - 2015-11-23 19:29:11,948 DEBUG : BROWSER_OUTPUT: Values: 741.8 773.6 790.3 806.4 837.5 11949.0 12057.9 12145.5 12156.5 12256.4 13157.3 13349.0 14202.4 14271.7 14287.1 934.3 950.1 963.2 964.4 965.1 935.2 937.3 951.9 953.7 955.8 961.1 982.5 995.6 998.8 1000.9 980.0 986.2 987.8 991.8 994.3 664.9 734.2 742.3 743.0 744.0 10136.1 11284.0 12698.0 13152.9 13178.7 10688.3 11013.2 11047.1 11048.3 11615.5 9417.5 9709.0 9991.6 11120.0 12113.6 3374.5 3500.6 3551.1 3581.7 3626.9 57309.1 62487.0 63712.7 69630.3 76847.0 8788.0 9379.7 9414.2 9439.0 10205.5 21003.4 21199.7 21240.0 21384.4 21436.7 7289.8 7356.7 7560.3 7620.4 7686.7 4039.2 4055.9 4057.7 4070.1 4087.1 3445.6 3453.9 3475.7 3478.8 3490.3 623.0 630.4 630.5 651.6 651.9 503.5 509.9 513.1 562.0 563.1 8638.4 8658.6 8690.8 8839.6 8876.4 595.5 612.4 622.7 628.0 638.2 3953.6 4155.4 4288.8 4342.5 4526.9 92247.0 93244.5 94884.5 99947.5 100311.0 76920.6 77687.2 80559.0 80772.2 81090.8 68068.0 68406.0 69069.0 74711.0 76077.0 8839.6 8918.6 9052.5 9097.4 9115.7 54676.7 54887.7 55182.7 55252.2 55273.6 71927.6 75891.6 76381.0 76413.6 78434.6 10793.3 10890.5 10981.3 11162.4 11939.2 11810.9 12075.5 12312.1 12513.1 12708.6 11552.7 11670.0 11900.5 11931.0 12036.4 11140.2 11314.1 11455.2 11899.2 12327.6 10861.9 11520.7 11536.7 11559.3 12101.4 9738.4 9784.2 9900.8 9997.2 10199.4 8558.3 8791.9 9138.3 9601.7 10190.4 19:29:11 INFO - 2015-11-23 19:29:11,948 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:29:11 INFO - 2015-11-23 19:29:11,950 DEBUG : BROWSER_OUTPUT: 19:29:12 INFO - 2015-11-23 19:29:12,450 INFO : Browser exited with error code: 0 19:29:12 INFO - 2015-11-23 19:29:12,475 INFO : Completed test dromaeo_css (00:18:30) 19:29:12 INFO - 2015-11-23 19:29:12,475 INFO : Starting test kraken 19:29:12 INFO - 2015-11-23 19:29:12,475 DEBUG : operating with platform_type : mac_ 19:29:12 INFO - 2015-11-23 19:29:12,475 INFO : Initialising browser for kraken test... 19:29:12 INFO - 2015-11-23 19:29:12,489 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/tmpSHaxpK/profile http://localhost:49272/getInfo.html 19:29:15 INFO - 2015-11-23 19:29:15,327 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:29:15 INFO - 2015-11-23 19:29:15,327 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:29:15 INFO - 2015-11-23 19:29:15,327 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 19:29:15 INFO - 2015-11-23 19:29:15,327 DEBUG : BROWSER_OUTPUT: __metrics 19:29:15 INFO - 2015-11-23 19:29:15,905 INFO : Browser initialized. 19:29:15 INFO - 2015-11-23 19:29:15,906 INFO : Running cycle 1/1 for kraken test... 19:29:15 INFO - 2015-11-23 19:29:15,906 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/tmpSHaxpK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:29:27 INFO - 2015-11-23 19:29:27,757 DEBUG : BROWSER_OUTPUT: RSS: Main: 237150208 19:29:27 INFO - 2015-11-23 19:29:27,757 DEBUG : BROWSER_OUTPUT: 19:29:30 INFO - 2015-11-23 19:29:30,384 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 19:29:31 INFO - 2015-11-23 19:29:31,004 DEBUG : BROWSER_OUTPUT: RSS: Main: 250122240 19:29:31 INFO - 2015-11-23 19:29:31,004 DEBUG : BROWSER_OUTPUT: 19:29:33 INFO - 2015-11-23 19:29:33,592 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 19:29:34 INFO - 2015-11-23 19:29:34,193 DEBUG : BROWSER_OUTPUT: RSS: Main: 259710976 19:29:34 INFO - 2015-11-23 19:29:34,193 DEBUG : BROWSER_OUTPUT: 19:29:37 INFO - 2015-11-23 19:29:37,488 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 19:29:38 INFO - 2015-11-23 19:29:38,078 DEBUG : BROWSER_OUTPUT: RSS: Main: 262184960 19:29:38 INFO - 2015-11-23 19:29:38,078 DEBUG : BROWSER_OUTPUT: 19:29:39 INFO - 2015-11-23 19:29:39,934 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 19:29:40 INFO - 2015-11-23 19:29:40,516 DEBUG : BROWSER_OUTPUT: RSS: Main: 263045120 19:29:40 INFO - 2015-11-23 19:29:40,516 DEBUG : BROWSER_OUTPUT: 19:29:42 INFO - 2015-11-23 19:29:42,586 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:29:43 INFO - 2015-11-23 19:29:43,180 DEBUG : BROWSER_OUTPUT: RSS: Main: 264781824 19:29:43 INFO - 2015-11-23 19:29:43,180 DEBUG : BROWSER_OUTPUT: 19:29:46 INFO - 2015-11-23 19:29:46,034 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 19:29:46 INFO - 2015-11-23 19:29:46,634 DEBUG : BROWSER_OUTPUT: RSS: Main: 266006528 19:29:46 INFO - 2015-11-23 19:29:46,634 DEBUG : BROWSER_OUTPUT: 19:29:49 INFO - 2015-11-23 19:29:49,772 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 19:29:50 INFO - 2015-11-23 19:29:50,370 DEBUG : BROWSER_OUTPUT: RSS: Main: 265908224 19:29:50 INFO - 2015-11-23 19:29:50,370 DEBUG : BROWSER_OUTPUT: 19:29:53 INFO - 2015-11-23 19:29:53,176 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 19:29:53 INFO - 2015-11-23 19:29:53,760 DEBUG : BROWSER_OUTPUT: RSS: Main: 264069120 19:29:53 INFO - 2015-11-23 19:29:53,760 DEBUG : BROWSER_OUTPUT: 19:29:55 INFO - 2015-11-23 19:29:55,358 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:29:55 INFO - 2015-11-23 19:29:55,947 DEBUG : BROWSER_OUTPUT: RSS: Main: 263192576 19:29:55 INFO - 2015-11-23 19:29:55,947 DEBUG : BROWSER_OUTPUT: 19:29:57 INFO - 2015-11-23 19:29:57,701 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:29:58 INFO - 2015-11-23 19:29:58,328 DEBUG : BROWSER_OUTPUT: RSS: Main: 264757248 19:29:58 INFO - 2015-11-23 19:29:58,328 DEBUG : BROWSER_OUTPUT: 19:30:00 INFO - 2015-11-23 19:30:00,346 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:30:00 INFO - 2015-11-23 19:30:00,940 DEBUG : BROWSER_OUTPUT: RSS: Main: 265453568 19:30:00 INFO - 2015-11-23 19:30:00,941 DEBUG : BROWSER_OUTPUT: 19:30:03 INFO - 2015-11-23 19:30:03,519 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:30:04 INFO - 2015-11-23 19:30:04,127 DEBUG : BROWSER_OUTPUT: RSS: Main: 264851456 19:30:04 INFO - 2015-11-23 19:30:04,127 DEBUG : BROWSER_OUTPUT: 19:30:06 INFO - 2015-11-23 19:30:06,562 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:30:07 INFO - 2015-11-23 19:30:07,161 DEBUG : BROWSER_OUTPUT: RSS: Main: 265375744 19:30:07 INFO - 2015-11-23 19:30:07,161 DEBUG : BROWSER_OUTPUT: 19:30:08 INFO - 2015-11-23 19:30:08,852 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 19:30:09 INFO - 2015-11-23 19:30:09,108 DEBUG : BROWSER_OUTPUT: RSS: Main: 264822784 19:30:09 INFO - 2015-11-23 19:30:09,108 DEBUG : BROWSER_OUTPUT: 19:30:09 INFO - 2015-11-23 19:30:09,108 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:30:09 INFO - 2015-11-23 19:30:09,109 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:30:09 INFO - 2015-11-23 19:30:09,109 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:30:09 INFO - 2015-11-23 19:30:09,109 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:30:09 INFO - 2015-11-23 19:30:09,109 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;107;126;163;126;124;114;114;115;114 19:30:09 INFO - 2015-11-23 19:30:09,109 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;174;159;145;153;119;143;139;123;159;128 19:30:09 INFO - 2015-11-23 19:30:09,109 DEBUG : BROWSER_OUTPUT: |2;audio-dft;192;193;196;193;198;208;219;282;215;197 19:30:09 INFO - 2015-11-23 19:30:09,109 DEBUG : BROWSER_OUTPUT: |3;audio-fft;58;59;65;68;116;53;58;58;59;96 19:30:09 INFO - 2015-11-23 19:30:09,109 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;78;76;106;82;110;111;132;78;75;108 19:30:09 INFO - 2015-11-23 19:30:09,109 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;88;100;131;88;89;88;90;80;132;132 19:30:09 INFO - 2015-11-23 19:30:09,109 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;123;153;108;152;150;99;154;121;96;94 19:30:09 INFO - 2015-11-23 19:30:09,109 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;93;93;98;133;94;97;94;92;91;112 19:30:09 INFO - 2015-11-23 19:30:09,109 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;60;59;60;59;60;59;77;87;88 19:30:09 INFO - 2015-11-23 19:30:09,109 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;65;65;65;66;65;67;68;68;68;69 19:30:09 INFO - 2015-11-23 19:30:09,110 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;86;82;86;84;86;83;85;85;87 19:30:09 INFO - 2015-11-23 19:30:09,110 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;127;124;130;125;123;121;125;128;134;139 19:30:09 INFO - 2015-11-23 19:30:09,110 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;139;142;169;121;137;155;116;153;138;115 19:30:09 INFO - 2015-11-23 19:30:09,110 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;65;81;54;62;68;97;61;93;64;54 19:30:09 INFO - 2015-11-23 19:30:09,110 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:30:09 INFO - 2015-11-23 19:30:09,110 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:30:09 INFO - 2015-11-23 19:30:09,110 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,808 19:30:09 INFO - 2015-11-23 19:30:09,110 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:30:09 INFO - 2015-11-23 19:30:09,110 DEBUG : BROWSER_OUTPUT: __startTimestamp1448335809105__endTimestamp 19:30:09 INFO - 2015-11-23 19:30:09,110 DEBUG : BROWSER_OUTPUT: 19:30:09 INFO - 2015-11-23 19:30:09,111 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:30:09 INFO - 2015-11-23 19:30:09,111 DEBUG : BROWSER_OUTPUT: Number of tests: 14 19:30:09 INFO - 2015-11-23 19:30:09,111 DEBUG : BROWSER_OUTPUT: 19:30:09 INFO - 2015-11-23 19:30:09,111 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:121.60 Median:119.50 stddev:15.85 (13.3%) stddev-sans-first:16.51 19:30:09 INFO - 2015-11-23 19:30:09,112 DEBUG : BROWSER_OUTPUT: Values: 113.0 107.0 126.0 163.0 126.0 124.0 114.0 114.0 115.0 114.0 19:30:09 INFO - 2015-11-23 19:30:09,112 DEBUG : BROWSER_OUTPUT: 19:30:09 INFO - 2015-11-23 19:30:09,112 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.20 Median:149.00 stddev:17.57 (11.8%) stddev-sans-first:14.97 19:30:09 INFO - 2015-11-23 19:30:09,112 DEBUG : BROWSER_OUTPUT: Values: 174.0 159.0 145.0 153.0 119.0 143.0 139.0 123.0 159.0 128.0 19:30:09 INFO - 2015-11-23 19:30:09,113 DEBUG : BROWSER_OUTPUT: 19:30:09 INFO - 2015-11-23 19:30:09,113 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:209.30 Median:203.00 stddev:27.28 (13.4%) stddev-sans-first:28.21 19:30:09 INFO - 2015-11-23 19:30:09,113 DEBUG : BROWSER_OUTPUT: Values: 192.0 193.0 196.0 193.0 198.0 208.0 219.0 282.0 215.0 197.0 19:30:09 INFO - 2015-11-23 19:30:09,113 DEBUG : BROWSER_OUTPUT: 19:30:09 INFO - 2015-11-23 19:30:09,113 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:69.00 Median:59.00 stddev:20.48 (34.7%) stddev-sans-first:21.33 19:30:09 INFO - 2015-11-23 19:30:09,113 DEBUG : BROWSER_OUTPUT: Values: 58.0 59.0 65.0 68.0 116.0 53.0 58.0 58.0 59.0 96.0 19:30:09 INFO - 2015-11-23 19:30:09,113 DEBUG : BROWSER_OUTPUT: 19:30:09 INFO - 2015-11-23 19:30:09,113 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:95.60 Median:75.50 stddev:20.12 (26.7%) stddev-sans-first:20.31 19:30:09 INFO - 2015-11-23 19:30:09,113 DEBUG : BROWSER_OUTPUT: Values: 78.0 76.0 106.0 82.0 110.0 111.0 132.0 78.0 75.0 108.0 19:30:09 INFO - 2015-11-23 19:30:09,113 DEBUG : BROWSER_OUTPUT: 19:30:09 INFO - 2015-11-23 19:30:09,113 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:101.80 Median:88.00 stddev:21.16 (24.0%) stddev-sans-first:21.85 19:30:09 INFO - 2015-11-23 19:30:09,114 DEBUG : BROWSER_OUTPUT: Values: 88.0 100.0 131.0 88.0 89.0 88.0 90.0 80.0 132.0 132.0 19:30:09 INFO - 2015-11-23 19:30:09,114 DEBUG : BROWSER_OUTPUT: 19:30:09 INFO - 2015-11-23 19:30:09,114 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:125.00 Median:153.50 stddev:25.31 (16.5%) stddev-sans-first:26.84 19:30:09 INFO - 2015-11-23 19:30:09,114 DEBUG : BROWSER_OUTPUT: Values: 123.0 153.0 108.0 152.0 150.0 99.0 154.0 121.0 96.0 94.0 19:30:09 INFO - 2015-11-23 19:30:09,114 DEBUG : BROWSER_OUTPUT: 19:30:09 INFO - 2015-11-23 19:30:09,114 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:99.70 Median:93.50 stddev:13.17 (14.1%) stddev-sans-first:13.74 19:30:09 INFO - 2015-11-23 19:30:09,114 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 98.0 133.0 94.0 97.0 94.0 92.0 91.0 112.0 19:30:09 INFO - 2015-11-23 19:30:09,114 DEBUG : BROWSER_OUTPUT: 19:30:09 INFO - 2015-11-23 19:30:09,114 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:66.70 Median:60.00 stddev:12.29 (20.5%) stddev-sans-first:12.63 19:30:09 INFO - 2015-11-23 19:30:09,115 DEBUG : BROWSER_OUTPUT: Values: 58.0 60.0 59.0 60.0 59.0 60.0 59.0 77.0 87.0 88.0 19:30:09 INFO - 2015-11-23 19:30:09,115 DEBUG : BROWSER_OUTPUT: 19:30:09 INFO - 2015-11-23 19:30:09,115 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:66.60 Median:67.50 stddev:1.58 (2.3%) stddev-sans-first:1.56 19:30:09 INFO - 2015-11-23 19:30:09,116 DEBUG : BROWSER_OUTPUT: Values: 65.0 65.0 65.0 66.0 65.0 67.0 68.0 68.0 68.0 69.0 19:30:09 INFO - 2015-11-23 19:30:09,116 DEBUG : BROWSER_OUTPUT: 19:30:09 INFO - 2015-11-23 19:30:09,116 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:85.50 stddev:1.64 (1.9%) stddev-sans-first:1.62 19:30:09 INFO - 2015-11-23 19:30:09,116 DEBUG : BROWSER_OUTPUT: Values: 83.0 86.0 82.0 86.0 84.0 86.0 83.0 85.0 85.0 87.0 19:30:09 INFO - 2015-11-23 19:30:09,116 DEBUG : BROWSER_OUTPUT: 19:30:09 INFO - 2015-11-23 19:30:09,116 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:127.60 Median:127.50 stddev:5.46 (4.3%) stddev-sans-first:5.79 19:30:09 INFO - 2015-11-23 19:30:09,116 DEBUG : BROWSER_OUTPUT: Values: 127.0 124.0 130.0 125.0 123.0 121.0 125.0 128.0 134.0 139.0 19:30:09 INFO - 2015-11-23 19:30:09,116 DEBUG : BROWSER_OUTPUT: 19:30:09 INFO - 2015-11-23 19:30:09,117 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.50 Median:140.50 stddev:17.61 (12.5%) stddev-sans-first:18.68 19:30:09 INFO - 2015-11-23 19:30:09,117 DEBUG : BROWSER_OUTPUT: Values: 139.0 142.0 169.0 121.0 137.0 155.0 116.0 153.0 138.0 115.0 19:30:09 INFO - 2015-11-23 19:30:09,117 DEBUG : BROWSER_OUTPUT: 19:30:09 INFO - 2015-11-23 19:30:09,117 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:66.50 stddev:15.28 (23.0%) stddev-sans-first:16.10 19:30:09 INFO - 2015-11-23 19:30:09,117 DEBUG : BROWSER_OUTPUT: Values: 65.0 81.0 54.0 62.0 68.0 97.0 61.0 93.0 64.0 54.0 19:30:09 INFO - 2015-11-23 19:30:09,117 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:30:09 INFO - 2015-11-23 19:30:09,117 DEBUG : BROWSER_OUTPUT: 19:30:09 INFO - 2015-11-23 19:30:09,891 INFO : Browser exited with error code: 0 19:30:09 INFO - 2015-11-23 19:30:09,938 INFO : Completed test kraken (00:00:57) 19:30:09 INFO - 2015-11-23 19:30:09,938 INFO : Starting test v8_7 19:30:09 INFO - 2015-11-23 19:30:09,938 DEBUG : operating with platform_type : mac_ 19:30:09 INFO - 2015-11-23 19:30:09,938 INFO : Initialising browser for v8_7 test... 19:30:09 INFO - 2015-11-23 19:30:09,951 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/tmppThpVK/profile http://localhost:49272/getInfo.html 19:30:12 INFO - 2015-11-23 19:30:12,683 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:30:12 INFO - 2015-11-23 19:30:12,683 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:30:12 INFO - 2015-11-23 19:30:12,683 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 19:30:12 INFO - 2015-11-23 19:30:12,683 DEBUG : BROWSER_OUTPUT: __metrics 19:30:13 INFO - 2015-11-23 19:30:13,301 INFO : Browser initialized. 19:30:13 INFO - 2015-11-23 19:30:13,301 INFO : Running cycle 1/1 for v8_7 test... 19:30:13 INFO - 2015-11-23 19:30:13,302 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/tmppThpVK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:30:25 INFO - 2015-11-23 19:30:25,255 DEBUG : BROWSER_OUTPUT: RSS: Main: 236253184 19:30:25 INFO - 2015-11-23 19:30:25,256 DEBUG : BROWSER_OUTPUT: 19:30:46 INFO - 2015-11-23 19:30:46,670 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/v8_7/run.html (next: http://localhost:49272/tests/v8_7/run.html) 19:30:46 INFO - 2015-11-23 19:30:46,921 DEBUG : BROWSER_OUTPUT: RSS: Main: 247840768 19:30:46 INFO - 2015-11-23 19:30:46,921 DEBUG : BROWSER_OUTPUT: 19:30:46 INFO - 2015-11-23 19:30:46,921 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:30:46 INFO - 2015-11-23 19:30:46,921 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:30:46 INFO - 2015-11-23 19:30:46,921 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:30:46 INFO - 2015-11-23 19:30:46,921 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:30:46 INFO - 2015-11-23 19:30:46,921 DEBUG : BROWSER_OUTPUT: |0;Richards;176.772140710624 19:30:46 INFO - 2015-11-23 19:30:46,922 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;180.7337791433219 19:30:46 INFO - 2015-11-23 19:30:46,922 DEBUG : BROWSER_OUTPUT: |2;Encrypt;285.38812785388126 19:30:46 INFO - 2015-11-23 19:30:46,922 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4901.9607843137255 19:30:46 INFO - 2015-11-23 19:30:46,922 DEBUG : BROWSER_OUTPUT: |4;RayTrace;957.8544061302682 19:30:46 INFO - 2015-11-23 19:30:46,922 DEBUG : BROWSER_OUTPUT: |5;Earley;739.6449704142012 19:30:46 INFO - 2015-11-23 19:30:46,922 DEBUG : BROWSER_OUTPUT: |6;Boyer;13223.684210526315 19:30:46 INFO - 2015-11-23 19:30:46,922 DEBUG : BROWSER_OUTPUT: |7;RegExp;26868.42105263158 19:30:46 INFO - 2015-11-23 19:30:46,922 DEBUG : BROWSER_OUTPUT: |8;Splay;605.6935190793458 19:30:46 INFO - 2015-11-23 19:30:46,922 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4529.411764705882 19:30:46 INFO - 2015-11-23 19:30:46,922 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:30:46 INFO - 2015-11-23 19:30:46,922 DEBUG : BROWSER_OUTPUT: __startTimestamp1448335846919__endTimestamp 19:30:46 INFO - 2015-11-23 19:30:46,922 DEBUG : BROWSER_OUTPUT: 19:30:46 INFO - 2015-11-23 19:30:46,922 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:30:46 INFO - 2015-11-23 19:30:46,922 DEBUG : BROWSER_OUTPUT: Number of tests: 10 19:30:46 INFO - 2015-11-23 19:30:46,923 DEBUG : BROWSER_OUTPUT: 19:30:46 INFO - 2015-11-23 19:30:46,923 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:176.77 Median:176.77 stddev:0.00 (0.0%) 19:30:46 INFO - 2015-11-23 19:30:46,923 DEBUG : BROWSER_OUTPUT: Values: 176.8 19:30:46 INFO - 2015-11-23 19:30:46,923 DEBUG : BROWSER_OUTPUT: 19:30:46 INFO - 2015-11-23 19:30:46,923 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:180.73 Median:180.73 stddev:0.00 (0.0%) 19:30:46 INFO - 2015-11-23 19:30:46,923 DEBUG : BROWSER_OUTPUT: Values: 180.7 19:30:46 INFO - 2015-11-23 19:30:46,923 DEBUG : BROWSER_OUTPUT: 19:30:46 INFO - 2015-11-23 19:30:46,923 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:285.39 Median:285.39 stddev:0.00 (0.0%) 19:30:46 INFO - 2015-11-23 19:30:46,923 DEBUG : BROWSER_OUTPUT: Values: 285.4 19:30:46 INFO - 2015-11-23 19:30:46,923 DEBUG : BROWSER_OUTPUT: 19:30:46 INFO - 2015-11-23 19:30:46,923 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4901.96 Median:4901.96 stddev:0.00 (0.0%) 19:30:46 INFO - 2015-11-23 19:30:46,923 DEBUG : BROWSER_OUTPUT: Values: 4902.0 19:30:46 INFO - 2015-11-23 19:30:46,923 DEBUG : BROWSER_OUTPUT: 19:30:46 INFO - 2015-11-23 19:30:46,923 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:957.85 Median:957.85 stddev:0.00 (0.0%) 19:30:46 INFO - 2015-11-23 19:30:46,924 DEBUG : BROWSER_OUTPUT: Values: 957.9 19:30:46 INFO - 2015-11-23 19:30:46,924 DEBUG : BROWSER_OUTPUT: 19:30:46 INFO - 2015-11-23 19:30:46,924 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:739.64 Median:739.64 stddev:0.00 (0.0%) 19:30:46 INFO - 2015-11-23 19:30:46,924 DEBUG : BROWSER_OUTPUT: Values: 739.6 19:30:46 INFO - 2015-11-23 19:30:46,924 DEBUG : BROWSER_OUTPUT: 19:30:46 INFO - 2015-11-23 19:30:46,924 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:13223.68 Median:13223.68 stddev:0.00 (0.0%) 19:30:46 INFO - 2015-11-23 19:30:46,924 DEBUG : BROWSER_OUTPUT: Values: 13223.7 19:30:46 INFO - 2015-11-23 19:30:46,924 DEBUG : BROWSER_OUTPUT: 19:30:46 INFO - 2015-11-23 19:30:46,924 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26868.42 Median:26868.42 stddev:0.00 (0.0%) 19:30:46 INFO - 2015-11-23 19:30:46,924 DEBUG : BROWSER_OUTPUT: Values: 26868.4 19:30:46 INFO - 2015-11-23 19:30:46,924 DEBUG : BROWSER_OUTPUT: 19:30:46 INFO - 2015-11-23 19:30:46,924 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:605.69 Median:605.69 stddev:0.00 (0.0%) 19:30:46 INFO - 2015-11-23 19:30:46,924 DEBUG : BROWSER_OUTPUT: Values: 605.7 19:30:46 INFO - 2015-11-23 19:30:46,924 DEBUG : BROWSER_OUTPUT: 19:30:46 INFO - 2015-11-23 19:30:46,924 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4529.41 Median:4529.41 stddev:0.00 (0.0%) 19:30:46 INFO - 2015-11-23 19:30:46,925 DEBUG : BROWSER_OUTPUT: Values: 4529.4 19:30:46 INFO - 2015-11-23 19:30:46,925 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:30:46 INFO - 2015-11-23 19:30:46,925 DEBUG : BROWSER_OUTPUT: 19:30:47 INFO - 2015-11-23 19:30:47,531 INFO : Browser exited with error code: 0 19:30:47 INFO - 2015-11-23 19:30:47,549 INFO : Completed test v8_7 (00:00:37) 19:30:48 INFO - 2015-11-23 19:30:48,031 INFO : Completed test suite (00:20:05) 19:30:48 INFO - 2015-11-23 19:30:48,032 DEBUG : Working with test: dromaeo_css 19:30:48 INFO - 2015-11-23 19:30:48,032 DEBUG : Generating results file: dromaeo_css 19:30:48 INFO - 2015-11-23 19:30:48,033 DEBUG : Working with test: kraken 19:30:48 INFO - 2015-11-23 19:30:48,033 DEBUG : Generating results file: kraken 19:30:48 INFO - 2015-11-23 19:30:48,033 INFO : javascript benchmark 19:30:48 INFO - 2015-11-23 19:30:48,033 DEBUG : Working with test: v8_7 19:30:48 INFO - 2015-11-23 19:30:48,033 DEBUG : Generating results file: v8_7 19:30:48 INFO - 2015-11-23 19:30:48,033 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:30:48 INFO - 2015-11-23 19:30:48,545 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 19:30:48 INFO - 2015-11-23 19:30:48,545 DEBUG : process_Request line: dromaeo_css 7573.91 graph.html#tests=[[72,64,61]] 19:30:48 INFO - 2015-11-23 19:30:48,545 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:30:48 INFO - 2015-11-23 19:30:48,572 DEBUG : process_Request line: kraken 1520.20 graph.html#tests=[[232,64,61]] 19:30:48 INFO - 2015-11-23 19:30:48,572 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:30:48 INFO - 2015-11-23 19:30:48,598 DEBUG : process_Request line: v8_7 21409.58 graph.html#tests=[[230,64,61]] 19:30:48 INFO - 2015-11-23 19:30:48,599 INFO : javascript benchmark 19:30:48 INFO - 2015-11-23 19:30:48,601 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3399.8130102844343, 3512.8594856205737, 3546.538949936508, 3553.200529880777, 3565.4117070683337, 4349.543297953713, 4635.490096089427, 4808.95191048089, 5200.08998425276, 5974.6713930733795, 5728.627639203449, 5839.824805255838, 5867.501262392701, 5879.8530036749, 5968.701564921747, 5225.268462415265, 5281.207818827178, 5306.416294207634, 5381.596380271476, 5439.211314359415, 5440.047991601454, 5444.564434845203, 5464.12573988162, 5484.424135465779, 5512.614117011811, 5154.123798954187, 5183.714895680736, 5303.814366497154, 5329.946700533003, 5352.598555108363, 5300.92048619271, 5311.229871668586, 5338.893222135535, 5344.171653393731, 5365.812196573102, 5268.604854635918, 5297.8145764898045, 5307.336582927134, 5344.679319240858, 5392.083345831218, 4856.708597484127, 4964.453910069926, 5613.101903695389, 5880.764769409261, 5911.615744976562, 6222.471089957359, 6247.687615619247, 6276.435120839101, 6292.62244265341, 6296.401841825019, 6289.308176100625, 6294.3705629437145, 6309.905351419732, 6318.842028949267, 6323.399277068717, 4878.463369029404, 6025.33721290662, 6037.516998640098, 6113.111460343324, 6129.908988904127, 6381.425671689571, 6483.481321494363, 6484.286728459866, 6491.123698300669, 6497.090407342976, 5273.472652734773, 6064.818055458255, 6302.905456418157, 6316.010456706123, 6336.936630633727, 6192.071189321638, 6275.1842260506755, 6278.905816412757, 6344.651044192521, 6360.332165122688, 5309.212957875934, 6288.654124023131, 6289.7484100636375, 6320.4311611955145, 6325.114483972247, 6169.321374648785, 6271.655058971709, 6302.306746257908, 6305.873882522324, 6310.5267104967315, 5022.372203474566, 5072.6702764320935, 5076.13705670037, 5089.796408143707, 5134.589232861362, 4551.499335073139, 4571.0, 4582.335561343587, 4586.793594288265, 4654.534546545318, 5765.654060756368, 5849.853753656193, 5897.351291357947, 6030.095485677096, 6059.545534084961, 6333.96833015832, 6347.682615869188, 6367.554271200971, 6384.680765961683, 6408.327125651833, 5965.075413310944, 5981.431763982415, 5994.550408719277, 6006.729697163551, 6009.429104235178, 5429.484199001088, 5474.0, 5508.834734957958, 5590.636608620427, 5598.86002849932, 6437.967810160919, 6456.677166141674, 6542.509311801634, 6555.803325900326, 6583.341665833378, 6340.1123842661145, 6357.141785859035, 6378.6810659467765, 6380.425761681471, 6381.0, 6311.621302721851, 6371.171747672773, 6410.974244120918, 6445.742170313135, 6468.482521398371, 6217.782377616762, 6291.528135389773, 6297.905531416941, 6299.527535434952, 6324.494040476843, 4674.859754207379, 5207.557357624644, 6341.207349081365, 6379.74481020754, 6381.202349706286, 5751.856203594776, 6140.504248697302, 6180.443760061616, 6183.165272688309, 6183.319834818257, 6050.2237494006995, 6126.326104128631, 6224.906626400698, 6234.688265586612, 6256.217972753406, 6100.328963814066, 6121.785737499166, 6135.877282454237, 6190.7214175363115, 6218.31598524171, 6093.512518998381, 6166.630002199882, 6177.2587289525545, 6189.412005859436, 6253.124562561154, 6090.634561926298, 6110.5587591967305, 6153.323134455117, 6155.661438620739, 6159.538034647509], "unit": "ms", "name": "dojo.html", "value": 5769.302438079903}, {"lowerIsBetter": false, "replicates": [551.8620344913771, 572.181780054522, 581.9670085598063, 599.5203836930455, 672.970355356305, 40697.0, 41372.0, 41386.58613413865, 41409.3788593171, 41436.79281603588, 43865.34201986965, 44202.778986105106, 44287.77856110715, 44324.0, 44361.77819110908, 9735.756606084833, 9887.604495820158, 9889.75275618108, 9915.305928585001, 9917.504124793768, 9669.613215471372, 9729.027097290249, 9744.31789774716, 9761.804763904718, 9767.169790567776, 9641.987591302917, 9720.270979676518, 9767.609295628166, 9775.608975640966, 9792.90207097927, 9721.708348749513, 9771.657991970318, 9799.853002204973, 9823.214142868554, 9832.606695732162, 9646.180074693659, 9692.660756873545, 9744.02559744027, 9782.217422606174, 9783.168430683401, 40593.59406405957, 41149.38275925864, 41219.175616487504, 41384.58615413837, 41583.584164158274, 3189.6331921829055, 3244.5619841321354, 3372.1401042733946, 3535.080878971486, 3751.6623503884507, 28753.28116797076, 28947.855260723773, 28995.13014609565, 29123.56314655282, 29827.552586711216, 2737.3293543082073, 2749.752522273005, 2751.7660998815127, 2865.2550336912345, 2944.5435957426635, 467396.0, 474311.0, 477594.0, 479006.0, 479202.9999999965, 46066.76966615146, 67832.32167678358, 68254.3174568258, 68337.65831170812, 68422.0, 46141.077178456246, 46155.0, 46234.768826155654, 46313.0, 46314.30528542075, 15100.0, 15135.470258541118, 15190.848091519165, 15231.390744370323, 15249.390024399121, 11742.765144697058, 12018.519259229708, 12067.758644827054, 12104.75790484203, 12124.757504849853, 14666.926665366605, 14684.853151468562, 14957.626059348604, 15025.699486010219, 15049.473268435771, 6495.772647957298, 6582.736690532325, 6594.7032383542855, 6612.570182938093, 6624.27133015368, 960.4621412009298, 965.5654955270156, 1015.5988384588046, 1065.4406436620682, 1088.3361149698678, 30390.84804575963, 31435.84282078575, 33303.50044749331, 33861.814836480604, 34037.0, 787.6691789448446, 935.5930170375908, 979.6620166042704, 1103.5955856176517, 1120.5797825815318, 14564.0, 15821.050736955589, 15918.0, 15976.520704378887, 16089.115098669452, 546977.0, 618229.0, 633742.0, 636717.0, 648197.0, 63412.68293658502, 63462.0, 63827.36172638307, 63920.041199382045, 64134.0, 1379.1311473771661, 1385.7852032934911, 1393.1432169216062, 1417.666848290651, 1420.8650178233258, 31059.84470077635, 31155.53266700956, 31212.219694507818, 31468.842655786575, 31736.841315793274, 52559.211611825085, 52790.73604631952, 53537.46462535325, 53578.92842143213, 53590.46409535855, 497409.0, 502588.0, 502804.0, 503219.0, 504129.0, 29478.852605736833, 29927.850360748056, 33677.49483757697, 34096.82951585226, 34851.4772278411, 43081.0, 43241.0, 43561.0, 44654.10691786211, 44659.553404465536, 36081.819590901876, 36496.72261470836, 36618.0, 38692.6130738689, 39191.216175675756, 37092.629073708915, 37465.0, 38206.808965954995, 38251.80874095612, 38432.0, 37260.0, 37496.0, 37508.81245593754, 37536.812315938245, 37691.81154094212, 27154.32114197161, 27344.042958496357, 27505.17484475469, 31628.209294766893, 34277.48583771295, 20710.0, 25266.747332527175, 25400.491990160463, 25481.87259063693, 25505.48989020246], "unit": "ms", "name": "ext.html", "value": 19648.082360020268}, {"lowerIsBetter": false, "replicates": [337.5813990651593, 360.69701450781355, 366.16697014292464, 366.6187165348038, 367.4066382791791, 15985.600359991005, 19511.70732439013, 19918.0, 20826.89586552067, 22016.0, 20362.898185509053, 20488.487787805312, 20878.582428351423, 21106.366808995717, 21125.68311475329, 5710.14347847822, 5923.318818335903, 6091.14723938649, 6091.969540152293, 6105.755769769204, 5510.669359838403, 5561.138023606348, 5601.60788744788, 5669.829905102853, 5890.528757699374, 5408.161734931092, 5507.063799154133, 5581.944180558204, 5652.06740887753, 5666.376698563155, 5473.507384335389, 5476.452354764531, 5590.99999999998, 5600.27196464459, 5612.298462692163, 5752.8274151775095, 5775.884482310373, 5800.0719884818645, 5804.448577385142, 5806.187133801272, 12444.253344799341, 12604.991600672016, 21759.564808703737, 23747.525049498912, 23948.880255598786, 1566.381279394644, 1680.3782600437794, 1897.2031746666432, 2032.298856894369, 2048.3445297504804, 9908.752281193028, 10120.746981325527, 10892.673219803419, 14508.202048887308, 15006.0, 1481.4000329866421, 1587.452328946523, 1703.8125806161313, 1778.7687600611837, 1797.173300281859, 81740.77388839232, 100440.48898777516, 100440.49779751127, 101128.49435752847, 101393.0, 10377.896221037692, 11033.227674062899, 11093.944530277297, 11131.944340278409, 11213.3832639204, 11172.21794474379, 13297.0, 13300.600981970556, 13304.667383315495, 13331.266780327174, 8009.719659811879, 8249.711260105867, 8258.380621453414, 8306.8338633227, 8328.250457458858, 8246.670133194604, 8249.958750206211, 8310.667573297122, 8345.958270208732, 8378.8324233515, 4085.3667681509414, 4158.209940111369, 4360.127974405132, 4409.691321607521, 4429.623482004002, 1718.4672751447092, 1818.4271954334342, 1863.506170864722, 1882.7646544181978, 1893.6307420053233, 354.76408188554325, 401.8867736370238, 728.9211966289921, 785.3050050705167, 926.7405126564573, 9636.0, 11539.249948753471, 11890.0, 11944.701382465335, 11960.04319654443, 373.4771320151809, 434.86519179054596, 435.675421810753, 447.2709483541806, 454.86126731346593, 11125.777484450266, 11570.305781653127, 11659.242149260272, 11672.824907626393, 11691.590794322328, 716014.0, 720130.0, 738270.0, 739659.0, 743185.0, 122588.0, 124612.0, 129313.06030409552, 131118.68881311064, 133077.0, 1245.1719606461602, 1248.145020660832, 1251.4556168067102, 1255.811628255769, 1271.192792576702, 14923.477678281208, 19170.712439313702, 19393.4181974541, 19539.374072426883, 19548.60902781965, 53442.46557534375, 53498.46501534935, 54595.90808183735, 54954.725226373615, 54991.62520937008, 71622.64188679024, 71894.28105718875, 76619.61690191513, 76770.46459070899, 76800.23199767931, 9696.466694331879, 9860.556274967501, 9937.552810123707, 10103.242256830914, 10134.797304054026, 11952.521899124285, 16393.09837958924, 17141.228644711267, 19525.902370488056, 20020.099095541027, 15526.534203973899, 15668.68662626764, 15781.0, 15894.046357218604, 16163.868529202842, 14459.421623134956, 14629.414823406945, 15151.242437878282, 15522.223888805289, 15704.057756534645, 11647.883521165018, 13666.794998074838, 15499.380024798882, 16939.661206776043, 17098.0, 8692.956535217283, 9998.700038998843, 10234.897651023692, 10258.640947566799, 10264.178865690876, 15304.775617950314, 15932.123733194321, 16156.838431615533, 16562.254698538836, 16581.502554923372], "unit": "ms", "name": "jquery.html", "value": 9473.370594734151}, {"lowerIsBetter": false, "replicates": [1463.860933211345, 1547.5898886795, 1711.8630509559237, 1785.919633616487, 1852.7961924188346, 7221.025161603182, 7727.574983375912, 7837.686492540306, 8415.0, 8592.999999999993, 8239.217274358927, 8346.791330216747, 8434.53610051447, 8446.113158118402, 8469.280111190556, 2320.9883950580224, 2343.2267351773958, 2353.646952957062, 2357.1043003658588, 2358.5282943411303, 2102.51642122312, 2232.631615783394, 2330.0446816805115, 2377.465070359173, 2401.435662619283, 2281.0533628544135, 2305.3660243433023, 2326.2672258238686, 2362.7400985891536, 2374.382660508263, 2337.415646088478, 2337.906483740648, 2350.1891847312736, 2360.846544974588, 2361.728401233854, 2387.570237357275, 2398.568257713611, 2401.135591187171, 2411.2525117213545, 2417.7340492545804, 8239.917600823976, 8320.0, 8321.334293256525, 8355.707550235773, 8376.664933402657, 4418.8453404130705, 4631.675782695213, 5094.3886733591835, 5107.719075450848, 5187.221916712486, 3217.7104060634656, 3446.0, 3449.120474279068, 3522.788632682047, 3534.68187863091, 1027.542743479152, 1035.8498017787379, 1047.5076713944434, 1048.7535429174138, 1075.1774892207468, 10698.197635177316, 10700.999999999922, 10844.295120817122, 10880.347179169195, 10880.727981800439, 4541.636669066466, 4636.258198688193, 4647.37260469839, 4659.767011649404, 4670.229412146958, 9572.0, 9573.042695730372, 9580.904190958141, 9613.230941524662, 9671.177949874198, 5158.561522270649, 5163.328767260307, 5170.405403378584, 5189.273501709764, 5213.504717051874, 4691.976540117277, 4694.295855621615, 4704.435467743892, 4704.95295047052, 4736.3369128322065, 3685.9078523037138, 3744.5132132823105, 3751.3247615429486, 3764.322421964073, 3773.056735816046, 1225.662942690767, 1229.2255878796302, 1239.3369547292336, 1240.9131360804656, 1250.7435975624976, 1344.0524430276632, 1357.4909408971635, 1380.1856904426436, 1394.8953828462907, 1398.9580312590638, 7692.153863075057, 7787.454878158588, 7788.182240864741, 7804.297613214838, 7818.0, 482.4596451973812, 487.64889279718545, 488.6066716293347, 489.05856226763336, 509.9056674515152, 5929.762809487572, 6149.692515374213, 6177.413145751147, 6185.8144255672405, 6209.5032397408095, 9376.8593471098, 9886.851697224547, 9974.850377244347, 10006.149477294512, 10028.0, 9795.559199835881, 9879.703608891601, 9891.752706182404, 9936.304458687822, 10069.043440873105, 7844.411669124838, 7872.291493765589, 7935.682572697143, 7952.244536768998, 7970.9202907970175, 7662.118856331594, 7728.381729461517, 7734.6132693366235, 7764.184760600056, 7781.688732450865, 7151.641188174231, 8852.424592401474, 8916.687915922912, 8969.641214351353, 8980.506072166094, 7797.025371828521, 7937.642806073625, 8142.67429302845, 8786.0, 9125.406848554823, 7304.379127774198, 7339.0, 7342.77971660851, 7374.188839227788, 7401.0748656417945, 7346.191918889025, 7579.962100189464, 7812.218778122142, 7941.841163176588, 7995.360951004914, 7293.781186564412, 7385.889211661722, 7410.370118539984, 7539.59957388773, 7600.201978792147, 6498.155239818982, 7177.641117943977, 7316.780496585111, 7405.44459165554, 7417.740379086706, 7140.892886606601, 7357.2642735726, 7363.374113200438, 7382.667779950022, 7507.737229196952, 6846.212685541226, 6849.657517124224, 6864.107666003388, 6871.587704737732, 6893.7931862044215, 5889.110889110889, 6933.0986971693355, 6940.305969403019, 6963.303669632996, 7004.264552221944], "unit": "ms", "name": "mootools.html", "value": 4627.373541347079}, {"lowerIsBetter": false, "replicates": [328.6368562738174, 331.2893842707393, 336.6986547040398, 340.03091190108177, 342.8080275045974, 7038.1554213494455, 7157.212706602282, 7173.497855150142, 7228.674709638066, 7234.819129521758, 6778.627175505345, 7065.258147894461, 7068.505204635665, 7096.148462184545, 7141.750038748645, 4247.87256382309, 5128.8461346159675, 5149.922751158736, 5155.793768249266, 5182.093133701606, 4964.032013757319, 5177.275181474596, 5178.342930262317, 5181.1710126379785, 5199.298094757216, 5031.195008798593, 5042.092423363793, 5042.495750424965, 5047.873803154914, 5057.620678449112, 5028.949710502885, 5048.747562621873, 5049.798008079672, 5053.671511351788, 5060.418051924003, 3692.612275711065, 4178.8537401191115, 4272.6154646081695, 4273.914521709548, 4284.742915425053, 6559.704813283413, 6769.559978601375, 6844.657767111625, 6849.48628852838, 6868.278830722752, 5978.0, 5993.4006599340155, 5994.430529099728, 6005.909911351333, 6021.066734656135, 7558.244175582453, 7584.355329796974, 7590.506617069873, 7595.430342724318, 7607.771766847003, 4689.50760170184, 4779.928301075487, 4790.089882922233, 4799.0, 4802.68782529138, 7172.959920811453, 7199.1361036675935, 8008.919910800934, 8031.2771850533145, 8053.436259461899, 4843.927341089887, 4847.975760121177, 4860.441049279378, 4861.756912154378, 4871.123197824426, 4387.605115539617, 4685.9531404686195, 4944.332515110486, 4963.255511673278, 4966.0, 4354.912901741947, 5770.422957704196, 5965.13505541694, 5970.582059255898, 5978.4021597839865, 6195.31851496335, 7239.384652304613, 7642.159362470124, 7677.539347639159, 7678.8080297993, 1644.597073716923, 1681.436718699225, 1713.8628909687195, 1720.870934679879, 1721.5179749670112, 1071.8124328242527, 1087.0542627913608, 1091.9617813376494, 1097.6926460591046, 1101.5098281264761, 7045.859082818315, 7061.505694601328, 7069.328413800681, 7072.717091316393, 7092.503524753321, 7767.572783496849, 7808.648610812527, 7831.451798374173, 7835.216478352119, 7853.057633084067, 5417.431169727122, 6272.1219029335925, 6323.747050118036, 7164.677589508485, 7175.748848790267, 4153.91692166161, 4202.579742025773, 4218.240716671029, 4220.0, 4256.170046840836, 6736.360045795642, 8259.504429734236, 8303.667853285922, 8309.086000539935, 8372.330213582898, 8083.878741818878, 8337.0, 8354.331653467829, 8356.916430835736, 8405.747827565183, 8281.751547453587, 8326.625301861432, 8332.750017499484, 8334.791630209173, 8357.331413486907, 7827.0, 7996.720114795954, 8019.957405537243, 8023.879641805261, 8042.798930026796, 7879.763607091796, 7886.0, 7890.210978902064, 7895.407844411807, 7912.36701063925, 8311.83376332458, 8316.708915187939, 8317.41778075529, 8351.0, 8363.247307742333, 4949.505049495022, 5075.822346217865, 5114.33513643224, 5138.229265610039, 5144.331236939174, 7765.572893490912, 7913.3669306456495, 7947.761567152995, 7952.443328966917, 8018.1180070193395, 6578.703958321791, 7643.0, 7703.191164927602, 7703.422243331661, 7716.2669546393, 7658.961705191438, 7667.504836556818, 7676.884846727416, 7678.961605191938, 7704.26809453101, 7180.856382872418, 7450.478466507292, 7459.738909138154, 7471.066116735408, 7482.027336446227, 7665.6933722650465, 7671.53970761756, 7675.61621918913, 7684.807879803049, 7696.345810606162, 7276.4542659299705, 7486.401087913063, 7492.812679683051, 7495.0, 7516.24837516244], "unit": "ms", "name": "prototype.html", "value": 5478.176784471778}, {"lowerIsBetter": false, "replicates": [741.8330875552999, 773.6402572803648, 790.3163763344705, 806.4072906413788, 837.4807619276054, 11949.0, 12057.939710301458, 12145.514179432823, 12156.513739450433, 12256.448459819307, 13157.276349800757, 13349.0, 14202.431902723905, 14271.714565708706, 14287.142771433695, 934.313279739391, 950.1353768071057, 963.1572374172599, 964.4068897627978, 965.1458459263567, 935.1583574782716, 937.2876613773514, 951.8762560867077, 953.7138858342504, 955.7610597350663, 961.0773657289011, 982.4841957972051, 995.6316163019657, 998.8102260570469, 1000.9349392289478, 980.0297705271801, 986.2061040862103, 987.8419452887575, 991.7818080022383, 994.28908330544, 664.9228250234603, 734.2107234722641, 742.265157494077, 743.0414764953204, 744.0178963767829, 10136.087752102347, 11284.0, 12698.0, 13152.86847131526, 13178.67053323665, 10688.305260158142, 11013.229073964825, 11047.060999815025, 11048.337099773958, 11615.535378584846, 9417.48203848788, 9708.95145524275, 9991.550380232908, 11119.999200072032, 12113.576024839176, 3374.5152133061374, 3500.632433594487, 3551.058969373118, 3581.6776490116013, 3626.909327266813, 57309.14036289459, 62487.0, 63712.68143659298, 69630.25924351932, 76847.0, 8788.0, 9379.718608441757, 9414.199793017533, 9439.008904065111, 10205.540750666238, 21003.369898903056, 21199.68200476994, 21240.04419801082, 21384.358469245948, 21436.678449823266, 7289.817754556072, 7356.668949897267, 7560.319571238615, 7620.428467864822, 7686.654100565488, 4039.2123535910214, 4055.878323650295, 4057.655099316591, 4070.104576993057, 4087.141700242923, 3445.586529616462, 3453.930921381558, 3475.6524347565546, 3478.7738796978115, 3490.267043920754, 623.0498489802997, 630.4168644004278, 630.5082036011918, 651.5797310734549, 651.9445847102954, 503.5166240409248, 509.9056674515227, 513.0636588226502, 561.9803306884239, 563.1159080244059, 8638.395312328203, 8658.567071646392, 8690.78273043179, 8839.60860978878, 8876.378653494194, 595.4551585299489, 612.4382823799294, 622.7260005597523, 627.9811605651838, 638.2149955554694, 3953.584873588289, 4155.376693495939, 4288.807003684841, 4342.457192850894, 4526.932096018497, 92247.0, 93244.53377733204, 94884.52557737168, 99947.50026249967, 100311.0, 76920.61539692266, 77687.22312776913, 80559.0, 80772.19227807764, 81090.78363824547, 68067.95796126124, 68406.0, 69069.0, 74711.0, 76077.0, 8839.558022098998, 8918.598663060307, 9052.547372631474, 9097.40866843653, 9115.726528204164, 54676.72661636826, 54887.72556137194, 55182.72408637931, 55252.171217430965, 55273.618159546335, 71927.56144876969, 75891.62054189693, 76381.0, 76413.61793190999, 78434.6078269605, 10793.29843560166, 10890.455477226265, 10981.286216395909, 11162.386068766296, 11939.164258501822, 11810.881891180978, 12075.51697932073, 12312.076594255646, 12513.124081314221, 12708.555200567936, 11552.6534203974, 11670.0, 11900.523979040741, 11931.0, 12036.398180091135, 11140.220184587, 11314.094872410024, 11455.198136130392, 11899.226550274205, 12327.630171094881, 10861.945690271497, 11520.711982200512, 11536.653900383002, 11559.30644161353, 12101.376970664398, 9738.367006144577, 9784.168345690412, 9900.801983960424, 9997.200223982209, 10199.38803671782, 8558.272546833588, 8791.868121978303, 9138.31462640318, 9601.663941762004, 10190.43952582615], "unit": "ms", "name": "yui.html", "value": 6933.736975178933}], "name": "dromaeo_css", "value": 7573.910184152513}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 107.0, 126.0, 163.0, 126.0, 124.0, 114.0, 114.0, 115.0, 114.0], "unit": "ms", "name": "ai-astar", "value": 121.6}, {"lowerIsBetter": true, "replicates": [174.0, 159.0, 145.0, 153.0, 119.0, 143.0, 139.0, 123.0, 159.0, 128.0], "unit": "ms", "name": "audio-beat-detection", "value": 144.2}, {"lowerIsBetter": true, "replicates": [192.0, 193.0, 196.0, 193.0, 198.0, 208.0, 219.0, 282.0, 215.0, 197.0], "unit": "ms", "name": "audio-dft", "value": 209.3}, {"lowerIsBetter": true, "replicates": [58.0, 59.0, 65.0, 68.0, 116.0, 53.0, 58.0, 58.0, 59.0, 96.0], "unit": "ms", "name": "audio-fft", "value": 69.0}, {"lowerIsBetter": true, "replicates": [78.0, 76.0, 106.0, 82.0, 110.0, 111.0, 132.0, 78.0, 75.0, 108.0], "unit": "ms", "name": "audio-oscillator", "value": 95.6}, {"lowerIsBetter": true, "replicates": [88.0, 100.0, 131.0, 88.0, 89.0, 88.0, 90.0, 80.0, 132.0, 132.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 101.8}, {"lowerIsBetter": true, "replicates": [123.0, 153.0, 108.0, 152.0, 150.0, 99.0, 154.0, 121.0, 96.0, 94.0], "unit": "ms", "name": "imaging-darkroom", "value": 125.0}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 98.0, 133.0, 94.0, 97.0, 94.0, 92.0, 91.0, 112.0], "unit": "ms", "name": "imaging-desaturate", "value": 99.7}, {"lowerIsBetter": true, "replicates": [58.0, 60.0, 59.0, 60.0, 59.0, 60.0, 59.0, 77.0, 87.0, 88.0], "unit": "ms", "name": "json-parse-financial", "value": 66.7}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 65.0, 66.0, 65.0, 67.0, 68.0, 68.0, 68.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 66.6}, {"lowerIsBetter": true, "replicates": [83.0, 86.0, 82.0, 86.0, 84.0, 86.0, 83.0, 85.0, 85.0, 87.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.7}, {"lowerIsBetter": true, "replicates": [127.0, 124.0, 130.0, 125.0, 123.0, 121.0, 125.0, 128.0, 134.0, 139.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 127.6}, {"lowerIsBetter": true, "replicates": [139.0, 142.0, 169.0, 121.0, 137.0, 155.0, 116.0, 153.0, 138.0, 115.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 138.5}, {"lowerIsBetter": true, "replicates": [65.0, 81.0, 54.0, 62.0, 68.0, 97.0, 61.0, 93.0, 64.0, 54.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.9}], "name": "kraken", "value": 1520.1999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [176.772140710624], "unit": "score", "name": "Richards", "value": 199.7034140000001}, {"lowerIsBetter": false, "replicates": [180.7337791433219], "unit": "score", "name": "DeltaBlue", "value": 365.83089400000006}, {"lowerIsBetter": false, "replicates": [285.38812785388126], "unit": "score", "name": "Encrypt", "value": 932.6982240000001}, {"lowerIsBetter": false, "replicates": [4901.9607843137255], "unit": "score", "name": "Decrypt", "value": 54.30092399999998}, {"lowerIsBetter": false, "replicates": [957.8544061302682], "unit": "score", "name": "RayTrace", "value": 772.5485159999996}, {"lowerIsBetter": false, "replicates": [739.6449704142012], "unit": "score", "name": "Earley", "value": 901.0579759999997}, {"lowerIsBetter": false, "replicates": [13223.684210526315], "unit": "score", "name": "Boyer", "value": 50.39919203980103}, {"lowerIsBetter": false, "replicates": [26868.42105263158], "unit": "score", "name": "RegExp", "value": 33.90541625857002}, {"lowerIsBetter": false, "replicates": [605.6935190793458], "unit": "score", "name": "Splay", "value": 134.541641}, {"lowerIsBetter": false, "replicates": [4529.411764705882], "unit": "score", "name": "NavierStokes", "value": 327.63636363636374}], "name": "v8_7", "value": 21409.578805857567}]} 19:30:48 INFO - RETURN: dromaeo_css: 7573.91 19:30:48 INFO - RETURN: kraken: 1520.20 19:30:48 INFO - RETURN: v8_7: 21409.58 19:30:48 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,61]]", "result": "21409.58"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1520.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7573.91"}}} 19:30:48 INFO - Return code: 0 19:30:48 INFO - # TBPL SUCCESS # 19:30:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:30:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:30:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:30:48 INFO - 2015-11-23 19:30:48.676 screenresolution[1678:10704] starting screenresolution argv=screenresolution get 19:30:48 INFO - 2015-11-23 19:30:48.678 screenresolution[1678:10704] Display 0: 1600x1200x32@60 19:30:48 INFO - 2015-11-23 19:30:48.684 screenresolution[1679:10707] starting screenresolution argv=screenresolution list 19:30:48 INFO - Available Modes on Display 0 19:30:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:30:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:30:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:30:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:30:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:30:48 INFO - Intel Iris: 19:30:48 INFO - Chipset Model: Intel Iris 19:30:48 INFO - Type: GPU 19:30:48 INFO - Bus: Built-In 19:30:48 INFO - VRAM (Dynamic, Max): 1536 MB 19:30:48 INFO - Vendor: Intel (0x8086) 19:30:48 INFO - Device ID: 0x0a2e 19:30:48 INFO - Revision ID: 0x0009 19:30:48 INFO - Displays: 19:30:48 INFO - Display: 19:30:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:30:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:30:48 INFO - Display Serial Number: 1600x1200 60 19:30:48 INFO - Main Display: Yes 19:30:48 INFO - Mirror: Off 19:30:48 INFO - Online: Yes 19:30:48 INFO - Rotation: Supported 19:30:48 INFO - Return code: 0 19:30:48 INFO - Running post-action listener: _resource_record_post_action 19:30:48 INFO - Running post-run listener: _resource_record_post_run 19:30:49 INFO - Total resource usage - Wall time: 1238s; CPU: 53.0%; Read bytes: 38614528; Write bytes: 696765952; Read time: 413; Write time: 2466 19:30:49 INFO - install - Wall time: 31s; CPU: 55.0%; Read bytes: 339790336; Write bytes: 338884608; Read time: 26176; Write time: 751 19:30:49 INFO - run-tests - Wall time: 1207s; CPU: 53.0%; Read bytes: 32378368; Write bytes: 346338816; Read time: 331; Write time: 1681 19:30:49 INFO - Running post-run listener: _upload_blobber_files 19:30:49 INFO - Blob upload gear active. 19:30:49 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 19:30:49 INFO - Copying logs to upload dir... 19:30:49 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1286.876100 ========= master_lag: 12.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 38 secs) (at 2015-11-23 19:31:02.030589) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 19:31:02.032092) ========= 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.YoLGzRXRVp/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.obz4xq4jzd/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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/6LF1i3LMSh2oB4lY8NiSig/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.008975 build_url: 'https://queue.taskcluster.net/v1/task/6LF1i3LMSh2oB4lY8NiSig/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.08 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 19:31:02.120234) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 19:31:02.120634) ========= 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.YoLGzRXRVp/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.obz4xq4jzd/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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.005019 ========= master_lag: 1.79 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 19:31:03.916747) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 19:31:03.917052) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 19:31:03.985085) ========= ========= Total master_lag: 14.78 =========