builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0015 starttime: 1448313564.18 results: success (0) buildid: 20151123103724 builduid: 48943e07b05b45138aa68a4a6a380980 revision: a5cf6e488f2d4266e5437a18dc1e3930570558c4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 13:19:24.183783) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 13:19:24.184232) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 13:19:24.184508) ========= 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.hLCjwmXX3D/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.W3CAEKRSBN/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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.005599 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 13:19:24.204825) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 13:19:24.205215) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 13:19:24.219336) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 13:19:24.219695) ========= 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.hLCjwmXX3D/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.W3CAEKRSBN/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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.005444 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 13:19:24.268546) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 13:19:24.268843) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 13:19:24.269200) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 13:19:24.269467) ========= 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.hLCjwmXX3D/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.W3CAEKRSBN/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 13:19:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.41G=0s 2015-11-23 13:19:24 (1.41 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.179675 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 13:19:24.462634) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 13:19:24.462977) ========= 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.hLCjwmXX3D/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.W3CAEKRSBN/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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.020375 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 13:19:24.512181) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 13:19:24.512561) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a5cf6e488f2d4266e5437a18dc1e3930570558c4 --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 a5cf6e488f2d4266e5437a18dc1e3930570558c4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.hLCjwmXX3D/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.W3CAEKRSBN/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 13:19:24,559 truncating revision to first 12 chars 2015-11-23 13:19:24,559 Setting DEBUG logging. 2015-11-23 13:19:24,559 attempt 1/10 2015-11-23 13:19:24,560 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a5cf6e488f2d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 13:19:25,443 unpacking tar archive at: fx-team-a5cf6e488f2d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.122805 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 13:19:25.649326) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 13:19:25.649645) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 13:19:25.661163) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 13:19:25.661524) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 13:19:25.661946) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2015-11-23 13:19:25.662239) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.hLCjwmXX3D/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.W3CAEKRSBN/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 13:19:25 INFO - MultiFileLogger online at 20151123 13:19:25 in /builds/slave/test 13:19:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 13:19:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:19:25 INFO - {'append_to_log': False, 13:19:25 INFO - 'base_work_dir': '/builds/slave/test', 13:19:25 INFO - 'blob_upload_branch': 'Fx-Team', 13:19:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:19:25 INFO - 'branch': 'Fx-Team', 13:19:25 INFO - 'buildbot_json_path': 'buildprops.json', 13:19:25 INFO - 'config_files': ('talos/mac_config.py',), 13:19:25 INFO - 'default_actions': ('clobber', 13:19:25 INFO - 'read-buildbot-config', 13:19:25 INFO - 'download-and-extract', 13:19:25 INFO - 'populate-webroot', 13:19:25 INFO - 'create-virtualenv', 13:19:25 INFO - 'install', 13:19:25 INFO - 'run-tests'), 13:19:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:19:25 INFO - 'download_minidump_stackwalk': True, 13:19:25 INFO - 'download_symbols': 'ondemand', 13:19:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:19:25 INFO - 'tooltool.py': '/tools/tooltool.py', 13:19:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:19:25 INFO - '/tools/misc-python/virtualenv.py')}, 13:19:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:19:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:19:25 INFO - 'installer_path': 'installer.exe', 13:19:25 INFO - 'log_level': 'info', 13:19:25 INFO - 'log_name': 'talos', 13:19:25 INFO - 'log_to_console': True, 13:19:25 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:19:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:19:25 INFO - 'opt_config_files': (), 13:19:25 INFO - 'pip_index': False, 13:19:25 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:19:25 INFO - 'cmd': ('bash', 13:19:25 INFO - '-c', 13:19:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:19:25 INFO - 'enabled': True, 13:19:25 INFO - 'halt_on_failure': False, 13:19:25 INFO - 'name': 'check_screen_resolution'},), 13:19:25 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:19:25 INFO - 'cmd': ('bash', 13:19:25 INFO - '-c', 13:19:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:19:25 INFO - 'enabled': True, 13:19:25 INFO - 'halt_on_failure': False, 13:19:25 INFO - 'name': 'check_screen_resolution'},), 13:19:25 INFO - 'run_cmd_checks_enabled': True, 13:19:25 INFO - 'sps_profile': False, 13:19:25 INFO - 'sps_profile_interval': 0, 13:19:25 INFO - 'suite': 'dromaeojs', 13:19:25 INFO - 'system_bits': '64', 13:19:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:19:25 INFO - 'title': 't-yosemite-r7-0015', 13:19:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:19:25 INFO - 'use_talos_json': True, 13:19:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:19:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:19:25 INFO - 'work_dir': 'build'} 13:19:25 INFO - ##### 13:19:25 INFO - ##### Running clobber step. 13:19:25 INFO - ##### 13:19:25 INFO - Running pre-action listener: _resource_record_pre_action 13:19:25 INFO - Running main action method: clobber 13:19:25 INFO - rmtree: /builds/slave/test/build 13:19:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:19:27 INFO - Running post-action listener: _resource_record_post_action 13:19:27 INFO - ##### 13:19:27 INFO - ##### Running read-buildbot-config step. 13:19:27 INFO - ##### 13:19:27 INFO - Running pre-action listener: _resource_record_pre_action 13:19:27 INFO - Running main action method: read_buildbot_config 13:19:27 INFO - Using buildbot properties: 13:19:27 INFO - { 13:19:27 INFO - "properties": { 13:19:27 INFO - "buildnumber": 20, 13:19:27 INFO - "product": "firefox", 13:19:27 INFO - "script_repo_revision": "production", 13:19:27 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 13:19:27 INFO - "repository": "", 13:19:27 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 13:19:27 INFO - "buildid": "20151123103724", 13:19:27 INFO - "slavename": "t-yosemite-r7-0015", 13:19:27 INFO - "pgo_build": "False", 13:19:27 INFO - "basedir": "/builds/slave/test", 13:19:27 INFO - "project": "", 13:19:27 INFO - "platform": "yosemite_r7", 13:19:27 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 13:19:27 INFO - "slavebuilddir": "test", 13:19:27 INFO - "scheduler": "tests-fx-team-macosx64-talos", 13:19:27 INFO - "branch": "fx-team", 13:19:27 INFO - "repo_path": "integration/fx-team", 13:19:27 INFO - "stage_platform": "macosx64", 13:19:27 INFO - "builduid": "48943e07b05b45138aa68a4a6a380980", 13:19:27 INFO - "revision": "a5cf6e488f2d4266e5437a18dc1e3930570558c4" 13:19:27 INFO - }, 13:19:27 INFO - "sourcestamp": { 13:19:27 INFO - "repository": "", 13:19:27 INFO - "hasPatch": false, 13:19:27 INFO - "project": "", 13:19:27 INFO - "branch": "fx-team-macosx64-talos", 13:19:27 INFO - "changes": [ 13:19:27 INFO - { 13:19:27 INFO - "category": null, 13:19:27 INFO - "files": [ 13:19:27 INFO - { 13:19:27 INFO - "url": null, 13:19:27 INFO - "name": "https://queue.taskcluster.net/v1/task/qu-D8N0BTSiWI5kAqH51Pw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 13:19:27 INFO - } 13:19:27 INFO - ], 13:19:27 INFO - "repository": "", 13:19:27 INFO - "rev": "a5cf6e488f2d4266e5437a18dc1e3930570558c4", 13:19:27 INFO - "who": "dtownsend@mozilla.com", 13:19:27 INFO - "when": 1448310290, 13:19:27 INFO - "number": 6696605, 13:19:27 INFO - "comments": "Bug 1226868: Fix test metadata to correctly check things and verify that it has done so afterwards. r=bz", 13:19:27 INFO - "project": "", 13:19:27 INFO - "at": "Mon 23 Nov 2015 12:24:50", 13:19:27 INFO - "branch": "fx-team-macosx64-talos", 13:19:27 INFO - "revlink": "", 13:19:27 INFO - "properties": [ 13:19:27 INFO - [ 13:19:27 INFO - "buildid", 13:19:27 INFO - "20151123103724", 13:19:27 INFO - "Change" 13:19:27 INFO - ], 13:19:27 INFO - [ 13:19:27 INFO - "builduid", 13:19:27 INFO - "48943e07b05b45138aa68a4a6a380980", 13:19:27 INFO - "Change" 13:19:27 INFO - ], 13:19:27 INFO - [ 13:19:27 INFO - "pgo_build", 13:19:27 INFO - "False", 13:19:27 INFO - "Change" 13:19:27 INFO - ] 13:19:27 INFO - ], 13:19:27 INFO - "revision": "a5cf6e488f2d4266e5437a18dc1e3930570558c4" 13:19:27 INFO - } 13:19:27 INFO - ], 13:19:27 INFO - "revision": "a5cf6e488f2d4266e5437a18dc1e3930570558c4" 13:19:27 INFO - } 13:19:27 INFO - } 13:19:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/qu-D8N0BTSiWI5kAqH51Pw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 13:19:27 INFO - Running post-action listener: _resource_record_post_action 13:19:27 INFO - ##### 13:19:27 INFO - ##### Running download-and-extract step. 13:19:27 INFO - ##### 13:19:27 INFO - Running pre-action listener: _resource_record_pre_action 13:19:27 INFO - Running main action method: download_and_extract 13:19:27 INFO - mkdir: /builds/slave/test/build/tests 13:19:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:27 INFO - https://queue.taskcluster.net/v1/task/qu-D8N0BTSiWI5kAqH51Pw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 13:19:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qu-D8N0BTSiWI5kAqH51Pw/artifacts/public/build/test_packages.json 13:19:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qu-D8N0BTSiWI5kAqH51Pw/artifacts/public/build/test_packages.json 13:19:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qu-D8N0BTSiWI5kAqH51Pw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 13:19:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qu-D8N0BTSiWI5kAqH51Pw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 13:19:29 INFO - Downloaded 1149 bytes. 13:19:29 INFO - Reading from file /builds/slave/test/build/test_packages.json 13:19:29 INFO - Using the following test package requirements: 13:19:29 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 13:19:29 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 13:19:29 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 13:19:29 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 13:19:29 INFO - u'jsshell-mac.zip'], 13:19:29 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 13:19:29 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 13:19:29 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 13:19:29 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 13:19:29 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 13:19:29 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 13:19:29 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 13:19:29 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 13:19:29 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 13:19:29 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 13:19:29 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 13:19:29 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 13:19:29 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:19:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:29 INFO - https://queue.taskcluster.net/v1/task/qu-D8N0BTSiWI5kAqH51Pw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:19:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qu-D8N0BTSiWI5kAqH51Pw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 13:19:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qu-D8N0BTSiWI5kAqH51Pw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 13:19:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qu-D8N0BTSiWI5kAqH51Pw/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 13:19:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qu-D8N0BTSiWI5kAqH51Pw/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 13:19:30 INFO - Downloaded 17526977 bytes. 13:19:30 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 13:19:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 13:19:30 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 13:19:33 INFO - Return code: 0 13:19:33 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 13:19:33 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')]} 13:19:33 INFO - https://queue.taskcluster.net/v1/task/qu-D8N0BTSiWI5kAqH51Pw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:19:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qu-D8N0BTSiWI5kAqH51Pw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 13:19:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qu-D8N0BTSiWI5kAqH51Pw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 13:19:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qu-D8N0BTSiWI5kAqH51Pw/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 13:19:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qu-D8N0BTSiWI5kAqH51Pw/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 13:19:34 INFO - Downloaded 17526977 bytes. 13:19:34 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 13:19:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 13:19:34 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 13:19:37 INFO - Return code: 0 13:19:37 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')]} 13:19:37 INFO - https://queue.taskcluster.net/v1/task/qu-D8N0BTSiWI5kAqH51Pw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 13:19:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qu-D8N0BTSiWI5kAqH51Pw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 13:19:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qu-D8N0BTSiWI5kAqH51Pw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 13:19:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qu-D8N0BTSiWI5kAqH51Pw/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 13:19:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qu-D8N0BTSiWI5kAqH51Pw/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 13:19:38 INFO - Downloaded 11130997 bytes. 13:19:38 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 13:19:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 13:19:38 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 13:19:38 INFO - Return code: 0 13:19:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:38 INFO - https://queue.taskcluster.net/v1/task/qu-D8N0BTSiWI5kAqH51Pw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 13:19:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qu-D8N0BTSiWI5kAqH51Pw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 13:19:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qu-D8N0BTSiWI5kAqH51Pw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 13:19:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qu-D8N0BTSiWI5kAqH51Pw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 13:19:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qu-D8N0BTSiWI5kAqH51Pw/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 13:19:41 INFO - Downloaded 109888014 bytes. 13:19:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/qu-D8N0BTSiWI5kAqH51Pw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 13:19:41 INFO - mkdir: /builds/slave/test/properties 13:19:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:19:41 INFO - Writing to file /builds/slave/test/properties/build_url 13:19:41 INFO - Contents: 13:19:41 INFO - build_url:https://queue.taskcluster.net/v1/task/qu-D8N0BTSiWI5kAqH51Pw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 13:19:41 INFO - Running post-action listener: _resource_record_post_action 13:19:41 INFO - Running post-action listener: set_extra_try_arguments 13:19:41 INFO - ##### 13:19:41 INFO - ##### Running populate-webroot step. 13:19:41 INFO - ##### 13:19:41 INFO - Running pre-action listener: _resource_record_pre_action 13:19:41 INFO - Running main action method: populate_webroot 13:19:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:19:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:19:41 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 13:19:41 INFO - '../fennec_ids.txt'], 13:19:41 INFO - 'tests': ['tcheck2']}, 13:19:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:19:41 INFO - '--tppagecycles', 13:19:41 INFO - '7'], 13:19:41 INFO - 'tests': ['tsvgm']}}, 13:19:41 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:19:41 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:19:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:19:41 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:19:41 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:19:41 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:19:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:19:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:19:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:19:41 INFO - 'talos_options': ['--e10s'], 13:19:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:19:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:19:41 INFO - 'tests': ['damp', 'tps']}, 13:19:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:19:41 INFO - 'talos_options': ['--e10s'], 13:19:41 INFO - 'tests': ['damp', 'tps']}, 13:19:41 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:19:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:19:41 INFO - 'other': {'tests': ['a11yr', 13:19:41 INFO - 'ts_paint', 13:19:41 INFO - 'tpaint', 13:19:41 INFO - 'sessionrestore', 13:19:41 INFO - 'sessionrestore_no_auto_restore']}, 13:19:41 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:19:41 INFO - 'tests': ['a11yr', 13:19:41 INFO - 'ts_paint', 13:19:41 INFO - 'tpaint', 13:19:41 INFO - 'sessionrestore', 13:19:41 INFO - 'sessionrestore_no_auto_restore']}, 13:19:41 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:19:41 INFO - 'tests': ['a11yr', 13:19:41 INFO - 'ts_paint', 13:19:41 INFO - 'tpaint', 13:19:41 INFO - 'sessionrestore', 13:19:41 INFO - 'sessionrestore_no_auto_restore']}, 13:19:41 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:19:41 INFO - 'tests': ['a11yr', 13:19:41 INFO - 'ts_paint', 13:19:41 INFO - 'tpaint', 13:19:41 INFO - 'sessionrestore', 13:19:41 INFO - 'sessionrestore_no_auto_restore']}, 13:19:41 INFO - 'other_l64': {'tests': ['a11yr', 13:19:41 INFO - 'ts_paint', 13:19:41 INFO - 'tpaint', 13:19:41 INFO - 'sessionrestore', 13:19:41 INFO - 'sessionrestore_no_auto_restore']}, 13:19:41 INFO - 'other_nol64': {'tests': ['a11yr', 13:19:41 INFO - 'ts_paint', 13:19:41 INFO - 'tpaint', 13:19:41 INFO - 'sessionrestore', 13:19:41 INFO - 'sessionrestore_no_auto_restore']}, 13:19:41 INFO - 'svgr': {'tests': ['tsvgx', 13:19:41 INFO - 'tsvgr_opacity', 13:19:41 INFO - 'tart', 13:19:41 INFO - 'tscrollx', 13:19:41 INFO - 'cart']}, 13:19:41 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:19:41 INFO - 'tests': ['tsvgx', 13:19:41 INFO - 'tsvgr_opacity', 13:19:41 INFO - 'tart', 13:19:41 INFO - 'tscrollx', 13:19:41 INFO - 'cart']}, 13:19:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:19:41 INFO - 'tests': ['tp5o']}, 13:19:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:19:41 INFO - 'talos_options': ['--e10s'], 13:19:41 INFO - 'tests': ['tp5o']}, 13:19:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:19:41 INFO - 'talos_options': ['--xperf_path', 13:19:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:19:41 INFO - 'tests': ['tp5n']}, 13:19:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:19:41 INFO - 'talos_options': ['--e10s', 13:19:41 INFO - '--xperf_path', 13:19:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:19:41 INFO - 'tests': ['tp5n']}}, 13:19:41 INFO - 'talos.zip': {'path': '', 13:19:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:19:41 INFO - Running post-action listener: _resource_record_post_action 13:19:41 INFO - ##### 13:19:41 INFO - ##### Running create-virtualenv step. 13:19:41 INFO - ##### 13:19:41 INFO - Running pre-action listener: _resource_record_pre_action 13:19:41 INFO - Running main action method: create_virtualenv 13:19:41 INFO - Creating virtualenv /builds/slave/test/build/venv 13:19:41 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 13:19:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:19:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:19:41 INFO - Using real prefix '/tools/python27' 13:19:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:19:42 INFO - Installing distribute.............................................................................................................................................................................................done. 13:19:45 INFO - Installing pip.................done. 13:19:45 INFO - Return code: 0 13:19:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:19:45 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')]} 13:19:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:45 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')]} 13:19:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:45 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 0x10e061490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e03e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6e3626a40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df859f0>, '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 0x10dce4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df788c8>, '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.hLCjwmXX3D/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.W3CAEKRSBN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 13:19:45 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 13:19:45 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 13:19:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hLCjwmXX3D/Render', 13:19:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:19:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:19:45 INFO - 'HOME': '/Users/cltbld', 13:19:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:19:45 INFO - 'LOGNAME': 'cltbld', 13:19:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:45 INFO - 'MOZ_NO_REMOTE': '1', 13:19:45 INFO - 'NO_EM_RESTART': '1', 13:19:45 INFO - 'PAGER': '/bin/cat', 13:19:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:19:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:45 INFO - 'PWD': '/builds/slave/test', 13:19:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:19:45 INFO - 'SHELL': '/bin/bash', 13:19:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W3CAEKRSBN/Listeners', 13:19:45 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 13:19:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:19:45 INFO - 'USER': 'cltbld', 13:19:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:19:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:19:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:45 INFO - 'XPC_FLAGS': '0x0', 13:19:45 INFO - 'XPC_SERVICE_NAME': '0', 13:19:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:19:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:45 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 13:19:45 INFO - Cleaning up... 13:19:45 INFO - Return code: 0 13:19:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:19:45 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')]} 13:19:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:45 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')]} 13:19:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:45 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 0x10e061490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e03e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6e3626a40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df859f0>, '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 0x10dce4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df788c8>, '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.hLCjwmXX3D/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.W3CAEKRSBN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 13:19:45 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 13:19:45 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 13:19:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hLCjwmXX3D/Render', 13:19:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:19:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:19:45 INFO - 'HOME': '/Users/cltbld', 13:19:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:19:45 INFO - 'LOGNAME': 'cltbld', 13:19:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:45 INFO - 'MOZ_NO_REMOTE': '1', 13:19:45 INFO - 'NO_EM_RESTART': '1', 13:19:45 INFO - 'PAGER': '/bin/cat', 13:19:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:19:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:45 INFO - 'PWD': '/builds/slave/test', 13:19:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:19:45 INFO - 'SHELL': '/bin/bash', 13:19:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W3CAEKRSBN/Listeners', 13:19:45 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 13:19:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:19:45 INFO - 'USER': 'cltbld', 13:19:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:19:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:19:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:45 INFO - 'XPC_FLAGS': '0x0', 13:19:45 INFO - 'XPC_SERVICE_NAME': '0', 13:19:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:19:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:45 INFO - Downloading/unpacking psutil>=0.7.1 13:19:45 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 13:19:45 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 13:19:45 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 13:19:45 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 13:19:45 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 13:19:45 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 13:19:48 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 13:19:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 13:19:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:19:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:19:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:19:48 INFO - Installing collected packages: psutil 13:19:48 INFO - Running setup.py install for psutil 13:19:48 INFO - building 'psutil._psutil_osx' extension 13:19:48 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 13:19:48 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 13:19:49 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 13:19:49 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 13:19:49 INFO - building 'psutil._psutil_posix' extension 13:19:49 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 13:19:49 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:19:49 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:19:49 INFO - ^ 13:19:49 INFO - 1 warning generated. 13:19:49 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 13:19:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:19:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:19:49 INFO - Successfully installed psutil 13:19:49 INFO - Cleaning up... 13:19:49 INFO - Return code: 0 13:19:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:19: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')]} 13:19:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19: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')]} 13:19:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19: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', '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 0x10e061490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e03e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6e3626a40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df859f0>, '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 0x10dce4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df788c8>, '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.hLCjwmXX3D/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.W3CAEKRSBN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 13:19: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 13:19: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 mozsystemmonitor==0.0.0 13:19:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hLCjwmXX3D/Render', 13:19:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:19:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:19:49 INFO - 'HOME': '/Users/cltbld', 13:19:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:19:49 INFO - 'LOGNAME': 'cltbld', 13:19:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:49 INFO - 'MOZ_NO_REMOTE': '1', 13:19:49 INFO - 'NO_EM_RESTART': '1', 13:19:49 INFO - 'PAGER': '/bin/cat', 13:19:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:19:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:49 INFO - 'PWD': '/builds/slave/test', 13:19:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:19:49 INFO - 'SHELL': '/bin/bash', 13:19:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W3CAEKRSBN/Listeners', 13:19:49 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 13:19:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:19:49 INFO - 'USER': 'cltbld', 13:19:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:19:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:19:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:49 INFO - 'XPC_FLAGS': '0x0', 13:19:49 INFO - 'XPC_SERVICE_NAME': '0', 13:19:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:19:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:19: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 13:19: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 13:19: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 13:19: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 13:19: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 13:19: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 13:19:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:19:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 13:19:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:19:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:19:51 INFO - Installing collected packages: mozsystemmonitor 13:19:51 INFO - Running setup.py install for mozsystemmonitor 13:19:52 INFO - Successfully installed mozsystemmonitor 13:19:52 INFO - Cleaning up... 13:19:52 INFO - Return code: 0 13:19:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:19:52 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')]} 13:19:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:52 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')]} 13:19:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:52 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 0x10e061490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e03e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6e3626a40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df859f0>, '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 0x10dce4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df788c8>, '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.hLCjwmXX3D/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.W3CAEKRSBN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 13:19:52 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 13:19:52 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 13:19:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hLCjwmXX3D/Render', 13:19:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:19:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:19:52 INFO - 'HOME': '/Users/cltbld', 13:19:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:19:52 INFO - 'LOGNAME': 'cltbld', 13:19:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:52 INFO - 'MOZ_NO_REMOTE': '1', 13:19:52 INFO - 'NO_EM_RESTART': '1', 13:19:52 INFO - 'PAGER': '/bin/cat', 13:19:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:19:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:52 INFO - 'PWD': '/builds/slave/test', 13:19:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:19:52 INFO - 'SHELL': '/bin/bash', 13:19:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W3CAEKRSBN/Listeners', 13:19:52 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 13:19:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:19:52 INFO - 'USER': 'cltbld', 13:19:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:19:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:19:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:52 INFO - 'XPC_FLAGS': '0x0', 13:19:52 INFO - 'XPC_SERVICE_NAME': '0', 13:19:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:19:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:52 INFO - Downloading/unpacking blobuploader==1.2.4 13:19:52 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 13:19:52 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 13:19:52 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 13:19:52 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 13:19:52 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 13:19:52 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 13:19:54 INFO - Downloading blobuploader-1.2.4.tar.gz 13:19:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 13:19:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:19:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:19:54 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 13:19:54 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 13:19:54 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 13:19:54 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 13:19:54 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 13:19:54 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 13:19:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 13:19:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:19:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:19:55 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 13:19:55 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 13:19:55 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 13:19:55 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 13:19:55 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 13:19:55 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 13:19:55 INFO - Downloading docopt-0.6.1.tar.gz 13:19:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 13:19:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:19:55 INFO - Installing collected packages: blobuploader, requests, docopt 13:19:55 INFO - Running setup.py install for blobuploader 13:19:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:19:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:19:55 INFO - Running setup.py install for requests 13:19:56 INFO - Running setup.py install for docopt 13:19:56 INFO - Successfully installed blobuploader requests docopt 13:19:56 INFO - Cleaning up... 13:19:56 INFO - Return code: 0 13:19:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:19: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')]} 13:19:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19: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')]} 13:19:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:56 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 0x10e061490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e03e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6e3626a40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df859f0>, '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 0x10dce4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df788c8>, '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.hLCjwmXX3D/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.W3CAEKRSBN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 13:19:56 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 13:19:56 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 13:19:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hLCjwmXX3D/Render', 13:19:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:19:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:19:56 INFO - 'HOME': '/Users/cltbld', 13:19:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:19:56 INFO - 'LOGNAME': 'cltbld', 13:19:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:56 INFO - 'MOZ_NO_REMOTE': '1', 13:19:56 INFO - 'NO_EM_RESTART': '1', 13:19:56 INFO - 'PAGER': '/bin/cat', 13:19:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:19:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:56 INFO - 'PWD': '/builds/slave/test', 13:19:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:19:56 INFO - 'SHELL': '/bin/bash', 13:19:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W3CAEKRSBN/Listeners', 13:19:56 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 13:19:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:19:56 INFO - 'USER': 'cltbld', 13:19:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:19:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:19:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:56 INFO - 'XPC_FLAGS': '0x0', 13:19:56 INFO - 'XPC_SERVICE_NAME': '0', 13:19:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:19:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:19:56 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-HZs1GD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:19:57 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-msWELh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:19:57 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-kdabJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:19:57 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-YUh8iZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:19:57 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-sq0swR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:19:57 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-TTvmBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:19:57 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-CJ3nop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:19:57 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-jCJYdP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:19:57 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-qEuw7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:19:57 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-y6MRVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:19:58 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-GblGQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:19:58 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-trf5DN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:19:58 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-PJYOnm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:19:58 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-fJcHYZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:19:58 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-51BXwO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:19:58 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-wiGP1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:19:58 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-R2oNqh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:19:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:19:58 INFO - Running setup.py install for manifestparser 13:19:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:19:58 INFO - Running setup.py install for mozcrash 13:19:59 INFO - Running setup.py install for mozdebug 13:19:59 INFO - Running setup.py install for mozdevice 13:19:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:19:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:19:59 INFO - Running setup.py install for mozfile 13:19:59 INFO - Running setup.py install for mozhttpd 13:19:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:19:59 INFO - Running setup.py install for mozinfo 13:19:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:19:59 INFO - Running setup.py install for mozInstall 13:19:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:19:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:19:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:19:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:19:59 INFO - Running setup.py install for mozleak 13:20:00 INFO - Running setup.py install for mozlog 13:20:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:20:00 INFO - Running setup.py install for moznetwork 13:20:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:20:00 INFO - Running setup.py install for mozprocess 13:20:00 INFO - Running setup.py install for mozprofile 13:20:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:20:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:20:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:20:00 INFO - Running setup.py install for mozrunner 13:20:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:20:00 INFO - Running setup.py install for mozscreenshot 13:20:01 INFO - Running setup.py install for moztest 13:20:01 INFO - Running setup.py install for mozversion 13:20:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:20:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:20:01 INFO - Cleaning up... 13:20:01 INFO - Return code: 0 13:20:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:20:01 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')]} 13:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:20:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:01 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')]} 13:20:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:20:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:01 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 0x10e061490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e03e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6e3626a40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df859f0>, '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 0x10dce4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df788c8>, '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.hLCjwmXX3D/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.W3CAEKRSBN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 13:20:01 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 13:20:01 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 13:20:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hLCjwmXX3D/Render', 13:20:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:20:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:20:01 INFO - 'HOME': '/Users/cltbld', 13:20:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:20:01 INFO - 'LOGNAME': 'cltbld', 13:20:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:20:01 INFO - 'MOZ_NO_REMOTE': '1', 13:20:01 INFO - 'NO_EM_RESTART': '1', 13:20:01 INFO - 'PAGER': '/bin/cat', 13:20:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:20:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:20:01 INFO - 'PWD': '/builds/slave/test', 13:20:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:20:01 INFO - 'SHELL': '/bin/bash', 13:20:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W3CAEKRSBN/Listeners', 13:20:01 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 13:20:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:20:01 INFO - 'USER': 'cltbld', 13:20:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:20:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:20:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:20:01 INFO - 'XPC_FLAGS': '0x0', 13:20:01 INFO - 'XPC_SERVICE_NAME': '0', 13:20:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:20:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:20:01 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-VGISoq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:20:01 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)) 13:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:20:01 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-8CgNdA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:20:01 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)) 13:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:20:01 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-cE_NI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:20:01 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)) 13:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:20:01 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-dpU706-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:20:02 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)) 13:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:20:02 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-JDHAIk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:20:02 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)) 13:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:20:02 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-JXFUDq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:20:02 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)) 13:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:20:02 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-QLrGHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:20:02 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)) 13:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:20:02 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-kEN5Dg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:20:02 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)) 13:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:20:02 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-ZQv9sK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:20:02 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)) 13:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:20:02 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-k1Gyr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:20:02 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)) 13:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:20:02 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-kHeNkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:20:02 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)) 13:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:20:02 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-Qct433-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:20:02 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)) 13:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:20:02 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-DLbElS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:20:03 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)) 13:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:20:03 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-MFui5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:20:03 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)) 13:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:20:03 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-6qHK_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:20:03 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)) 13:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:20:03 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-FvfbVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:20:03 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)) 13:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:20:03 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-Q3F7BA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:20:03 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)) 13:20:03 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)) 13:20:03 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)) 13:20:03 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)) 13:20:03 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)) 13:20:03 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)) 13:20:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:20:03 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 13:20:03 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 13:20:03 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 13:20:03 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 13:20:03 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 13:20:03 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 13:20:05 INFO - Downloading blessings-1.5.1.tar.gz 13:20:05 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 13:20:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:20:05 INFO - Installing collected packages: blessings 13:20:05 INFO - Running setup.py install for blessings 13:20:05 INFO - Successfully installed blessings 13:20:05 INFO - Cleaning up... 13:20:05 INFO - Return code: 0 13:20:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:20:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:20:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:20:06 INFO - Reading from file tmpfile_stdout 13:20:06 INFO - Current package versions: 13:20:06 INFO - blessings == 1.5.1 13:20:06 INFO - blobuploader == 1.2.4 13:20:06 INFO - docopt == 0.6.1 13:20:06 INFO - manifestparser == 1.1 13:20:06 INFO - mozInstall == 1.12 13:20:06 INFO - mozcrash == 0.16 13:20:06 INFO - mozdebug == 0.1 13:20:06 INFO - mozdevice == 0.47 13:20:06 INFO - mozfile == 1.2 13:20:06 INFO - mozhttpd == 0.7 13:20:06 INFO - mozinfo == 0.9 13:20:06 INFO - mozleak == 0.1 13:20:06 INFO - mozlog == 3.1 13:20:06 INFO - moznetwork == 0.27 13:20:06 INFO - mozprocess == 0.22 13:20:06 INFO - mozprofile == 0.27 13:20:06 INFO - mozrunner == 6.11 13:20:06 INFO - mozscreenshot == 0.1 13:20:06 INFO - mozsystemmonitor == 0.0 13:20:06 INFO - moztest == 0.7 13:20:06 INFO - mozversion == 1.4 13:20:06 INFO - psutil == 3.1.1 13:20:06 INFO - requests == 1.2.3 13:20:06 INFO - wsgiref == 0.1.2 13:20:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:20:06 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')]} 13:20:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:20:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:06 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')]} 13:20:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:20:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:06 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 0x10e061490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e03e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6e3626a40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df859f0>, '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 0x10dce4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df788c8>, '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.hLCjwmXX3D/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.W3CAEKRSBN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 13:20:06 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 13:20:06 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 13:20:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hLCjwmXX3D/Render', 13:20:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:20:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:20:06 INFO - 'HOME': '/Users/cltbld', 13:20:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:20:06 INFO - 'LOGNAME': 'cltbld', 13:20:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:20:06 INFO - 'MOZ_NO_REMOTE': '1', 13:20:06 INFO - 'NO_EM_RESTART': '1', 13:20:06 INFO - 'PAGER': '/bin/cat', 13:20:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:20:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:20:06 INFO - 'PWD': '/builds/slave/test', 13:20:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:20:06 INFO - 'SHELL': '/bin/bash', 13:20:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W3CAEKRSBN/Listeners', 13:20:06 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 13:20:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:20:06 INFO - 'USER': 'cltbld', 13:20:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:20:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:20:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:20:06 INFO - 'XPC_FLAGS': '0x0', 13:20:06 INFO - 'XPC_SERVICE_NAME': '0', 13:20:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:20:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:20:06 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)) 13:20:06 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)) 13:20:06 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)) 13:20:06 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)) 13:20:06 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)) 13:20:06 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)) 13:20:06 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)) 13:20:06 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)) 13:20:06 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)) 13:20:06 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)) 13:20:06 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)) 13:20:06 INFO - Cleaning up... 13:20:06 INFO - Return code: 0 13:20:06 INFO - Running post-action listener: _resource_record_post_action 13:20:06 INFO - Running post-action listener: _start_resource_monitoring 13:20:06 INFO - Starting resource monitoring. 13:20:06 INFO - ##### 13:20:06 INFO - ##### Running install step. 13:20:06 INFO - ##### 13:20:06 INFO - Running pre-action listener: _resource_record_pre_action 13:20:06 INFO - Running main action method: install 13:20:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:20:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:20:06 INFO - Reading from file tmpfile_stdout 13:20:06 INFO - Detecting whether we're running mozinstall >=1.0... 13:20:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:20:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:20:06 INFO - Reading from file tmpfile_stdout 13:20:06 INFO - Output received: 13:20:06 INFO - Usage: mozinstall [options] installer 13:20:06 INFO - Options: 13:20:06 INFO - -h, --help show this help message and exit 13:20:06 INFO - -d DEST, --destination=DEST 13:20:06 INFO - Directory to install application into. [default: 13:20:06 INFO - "/builds/slave/test"] 13:20:06 INFO - --app=APP Application being installed. [default: firefox] 13:20:06 INFO - mkdir: /builds/slave/test/build/application 13:20:06 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'] 13:20:06 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 13:20:37 INFO - Reading from file tmpfile_stdout 13:20:37 INFO - Output received: 13:20:37 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:20:37 INFO - Running post-action listener: _resource_record_post_action 13:20:37 INFO - ##### 13:20:37 INFO - ##### Running run-tests step. 13:20:37 INFO - ##### 13:20:37 INFO - Running pre-action listener: _resource_record_pre_action 13:20:37 INFO - Running main action method: run_tests 13:20:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:20:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:20:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:20:37 INFO - 2015-11-23 13:20:37.232 screenresolution[3734:59603] starting screenresolution argv=screenresolution get 13:20:37 INFO - 2015-11-23 13:20:37.235 screenresolution[3734:59603] Display 0: 1600x1200x32@60 13:20:37 INFO - 2015-11-23 13:20:37.241 screenresolution[3735:59605] starting screenresolution argv=screenresolution list 13:20:37 INFO - Available Modes on Display 0 13:20:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:20:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:20:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:20:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:20:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:20:37 INFO - Intel Iris: 13:20:37 INFO - Chipset Model: Intel Iris 13:20:37 INFO - Type: GPU 13:20:37 INFO - Bus: Built-In 13:20:37 INFO - VRAM (Dynamic, Max): 1536 MB 13:20:37 INFO - Vendor: Intel (0x8086) 13:20:37 INFO - Device ID: 0x0a2e 13:20:37 INFO - Revision ID: 0x0009 13:20:37 INFO - Displays: 13:20:37 INFO - Display: 13:20:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:20:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:20:37 INFO - Display Serial Number: 1600x1200 60 13:20:37 INFO - Main Display: Yes 13:20:37 INFO - Mirror: Off 13:20:37 INFO - Online: Yes 13:20:37 INFO - Rotation: Supported 13:20:37 INFO - Return code: 0 13:20:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:20:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:20:37 INFO - Python 2.7.3 13:20:37 INFO - Return code: 0 13:20:37 INFO - grabbing minidump binary from tooltool 13:20:37 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')]} 13:20:37 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 0x10df859f0>, '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 0x10dce4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df788c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:20:37 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 13:20:37 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 13:20:37 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:20:37 INFO - Return code: 0 13:20:37 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:20:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:20:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:20:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:20:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:20:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/qu-D8N0BTSiWI5kAqH51Pw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0015', '--webServer', 'localhost'] in /builds/slave/test/build 13:20:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/qu-D8N0BTSiWI5kAqH51Pw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0015 --webServer localhost 13:20:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hLCjwmXX3D/Render', 13:20:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:20:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:20:37 INFO - 'HOME': '/Users/cltbld', 13:20:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:20:37 INFO - 'LOGNAME': 'cltbld', 13:20:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:20:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:20:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:20:37 INFO - 'MOZ_NO_REMOTE': '1', 13:20:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:20:37 INFO - 'NO_EM_RESTART': '1', 13:20:37 INFO - 'PAGER': '/bin/cat', 13:20:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:20:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:20:37 INFO - 'PWD': '/builds/slave/test', 13:20:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:20:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:20:37 INFO - 'SHELL': '/bin/bash', 13:20:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W3CAEKRSBN/Listeners', 13:20:37 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 13:20:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:20:37 INFO - 'USER': 'cltbld', 13:20:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:20:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:20:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:20:37 INFO - 'XPC_FLAGS': '0x0', 13:20:37 INFO - 'XPC_SERVICE_NAME': '0', 13:20:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:20:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/qu-D8N0BTSiWI5kAqH51Pw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0015', '--webServer', 'localhost'] with output_timeout 3600 13:20:37 INFO - mozversion INFO | application_buildid: 20151123103724 13:20:37 INFO - mozversion INFO | application_changeset: a5cf6e488f2d4266e5437a18dc1e3930570558c4 13:20:37 INFO - mozversion INFO | application_display_name: Nightly 13:20:37 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:20:37 INFO - mozversion INFO | application_name: Firefox 13:20:37 INFO - mozversion INFO | application_remotingname: firefox 13:20:37 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 13:20:37 INFO - mozversion INFO | application_vendor: Mozilla 13:20:37 INFO - mozversion INFO | application_version: 45.0a1 13:20:37 INFO - mozversion INFO | platform_buildid: 20151123103724 13:20:37 INFO - mozversion INFO | platform_changeset: a5cf6e488f2d4266e5437a18dc1e3930570558c4 13:20:37 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 13:20:37 INFO - mozversion INFO | platform_version: 45.0a1 13:20:37 INFO - 2015-11-23 13:20:37,779 DEBUG : using testdate: 1448313637 13:20:37 INFO - 2015-11-23 13:20:37,779 DEBUG : actual date: 1448313637 13:20:38 INFO - 2015-11-23 13:20:38,233 INFO : starting webserver on 'localhost:58417' 13:20:38 INFO - 2015-11-23 13:20:38,234 INFO : Starting test suite t-yosemite-r7-0015 13:20:38 INFO - 2015-11-23 13:20:38,234 INFO : Starting test dromaeo_css 13:20:38 INFO - 2015-11-23 13:20:38,234 DEBUG : operating with platform_type : mac_ 13:20:38 INFO - 2015-11-23 13:20:38,235 INFO : Initialising browser for dromaeo_css test... 13:20:38 INFO - 2015-11-23 13:20:38,247 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/tmpX_ctiX/profile http://localhost:58417/getInfo.html 13:20:40 INFO - 2015-11-23 13:20:40,116 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:20:40 INFO - 2015-11-23 13:20:40,116 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:20:40 INFO - 2015-11-23 13:20:40,116 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 13:20:40 INFO - 2015-11-23 13:20:40,116 DEBUG : BROWSER_OUTPUT: __metrics 13:20:40 INFO - 2015-11-23 13:20:40,133 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:20:40 INFO - 2015-11-23 13:20:40,739 INFO : Browser initialized. 13:20:40 INFO - 2015-11-23 13:20:40,740 INFO : Running cycle 1/1 for dromaeo_css test... 13:20:40 INFO - 2015-11-23 13:20:40,740 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/tmpX_ctiX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:20:52 INFO - 2015-11-23 13:20:52,722 DEBUG : BROWSER_OUTPUT: RSS: Main: 226086912 13:20:52 INFO - 2015-11-23 13:20:52,723 DEBUG : BROWSER_OUTPUT: 13:21:49 INFO - 2015-11-23 13:21:49,867 DEBUG : BROWSER_OUTPUT: 1448313709867 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] 13:23:55 INFO - 2015-11-23 13:23:55,112 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58417/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58417/tests/dromaeo/cssquery-ext.html) 13:23:56 INFO - 2015-11-23 13:23:56,602 DEBUG : BROWSER_OUTPUT: RSS: Main: 333041664 13:23:56 INFO - 2015-11-23 13:23:56,603 DEBUG : BROWSER_OUTPUT: 13:26:59 INFO - 2015-11-23 13:26:59,200 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58417/tests/dromaeo/cssquery-ext.html (next: http://localhost:58417/tests/dromaeo/cssquery-jquery.html) 13:26:59 INFO - 2015-11-23 13:26:59,797 DEBUG : BROWSER_OUTPUT: RSS: Main: 364036096 13:26:59 INFO - 2015-11-23 13:26:59,798 DEBUG : BROWSER_OUTPUT: 13:30:01 INFO - 2015-11-23 13:30:01,924 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58417/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58417/tests/dromaeo/cssquery-mootools.html) 13:30:02 INFO - 2015-11-23 13:30:02,509 DEBUG : BROWSER_OUTPUT: RSS: Main: 333897728 13:30:02 INFO - 2015-11-23 13:30:02,509 DEBUG : BROWSER_OUTPUT: 13:33:04 INFO - 2015-11-23 13:33:04,570 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58417/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58417/tests/dromaeo/cssquery-prototype.html) 13:33:05 INFO - 2015-11-23 13:33:05,160 DEBUG : BROWSER_OUTPUT: RSS: Main: 321851392 13:33:05 INFO - 2015-11-23 13:33:05,160 DEBUG : BROWSER_OUTPUT: 13:36:08 INFO - 2015-11-23 13:36:08,215 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58417/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58417/tests/dromaeo/cssquery-yui.html) 13:36:08 INFO - 2015-11-23 13:36:08,808 DEBUG : BROWSER_OUTPUT: RSS: Main: 323100672 13:36:08 INFO - 2015-11-23 13:36:08,808 DEBUG : BROWSER_OUTPUT: 13:39:11 INFO - 2015-11-23 13:39:11,531 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58417/tests/dromaeo/cssquery-yui.html (next: http://localhost:58417/tests/dromaeo/cssquery-dojo.html) 13:39:11 INFO - 2015-11-23 13:39:11,789 DEBUG : BROWSER_OUTPUT: RSS: Main: 371998720 13:39:11 INFO - 2015-11-23 13:39:11,789 DEBUG : BROWSER_OUTPUT: 13:39:11 INFO - 2015-11-23 13:39:11,789 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:39:11 INFO - 2015-11-23 13:39:11,789 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:39:11 INFO - 2015-11-23 13:39:11,789 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:39:11 INFO - 2015-11-23 13:39:11,789 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:39:11 INFO - 2015-11-23 13:39:11,789 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3034.3021105145817;3406.1314364836962;3422.760406771527;3459.066052165914;3482.686558209761;5582.27430434043;5712.171735098408;5716.22830917826;5727.112297593874;5765.077587585987;5704.201411802351;5724.62789918655;5741.655500669963;5758.798442054518;5782.161586569945;5142.408623008365;5169.844904652848;5214.348206474191;5228.503292187236;5282.471752824706;5272.209168624699;5274.156135018397;5280.075986702331;5286.471352864722;5294.52349288564;5244.029854476915;5252.238425428311;5264.236685680574;5270.525652691257;5281.102212623863;5210.1403268460845;5235.188545775411;5235.764390602432;5245.213218017289;5251.894962100756;5054.1660625996665;5067.366579177603;5178.792848286064;5184.611154163453;5202.973985130088;5622.409646987048;5663.037283661746;5679.318481782171;5697.344805347397;5723.170140329629;5347.716548028484;6284.622922624657;6289.496840252815;6298;6300.621962682254;6063.104361084514;6176.783812566584;6194.535409844235;6199.473044791198;6285.308616052231;5867.6772777497645;5871.735771890275;5903.055511118243;5926.733297001645;5939.5248380129915;6235.937640623626;6296.401841825019;6301.590396624205;6304.338044505353;6311.053341998645;5960.552958528127;6039.607425517327;6109.755609775648;6123.112148738408;6132.7345309381235;6267.71795269214;6283.5287353448675;6283.748650053946;6290.119383286344;6316.652584107918;6133.478654314344;6196.969015154986;6199.442050215503;6215.9378406216265;6221.346758590374;6049.818505444844;6094.725737341831;6159.784407545714;6168.414000669929;6168.691565421801;4955.578775804097;4962.503749625081;4966.453690094087;4983.401991761012;4986.426560945465;4431.578999995059;4436.822527098944;4459.799309031101;4465.508794032654;4467.754273514923;5481.068218402881;5569.498745112959;5606.439356064442;5620.803271885465;5621.4659607337235;6155.984262596711;6276.623402595859;6279.560430769893;6282.403171698681;6287.46556542699;4385.3641222022625;5546.140348245947;5646.153077038395;5673.461021202979;5703.287089113861;5322.121849894724;5419.864503387447;5421.891562168735;5431.755570999315;5447.992121457543;6309.33751956038;6317.368263173646;6322.525810564226;6331.556791024584;6334.429901308997;5199.688018718889;6117.632942023492;6202.069689546604;6339.366063393623;6350.7459701611415;6219.533534984985;6330.272018717907;6348.873022539616;6350.269718982191;6360.522960777867;6151.72317245716;6186.1648677427975;6192.287886893065;6200.968995154995;6216.658083805434;6082.330943596289;6181.196444462371;6188.907166392598;6303.432691057827;6350.523710721622;6000.609960352563;6088.208532890873;6105.929529384197;6121.644743077476;6127.078295984317;6010.669413182317;6101.792799924424;6104.982978023337;6109.877802443837;6137.140800287874;5694.4590263924865;5963.970180149072;5977.222961015214;5986.4013598639785;5993.31076926159;6032.638041717511;6050.576459647782;6063.848403789941;6116.571839971337;6150.10823430609;6000.549958753199;6009.699515024318;6017.969910150421;6039.667818270037;6041.546883983631 13:39:11 INFO - 2015-11-23 13:39:11,789 DEBUG : BROWSER_OUTPUT: |1;ext.html;562.8817948230871;575.9020966435705;615.8583525789065;627.4165026525333;630.9936900630994;30211.99999999997;32529.51205731916;32574.348513029727;32712.67287327126;40682.98292542688;43697.78151109248;43968.56031439685;44030;44096.55903440973;44170.7791461043;9620.951895240532;9811.65659201928;9812.067853553901;9818.165455936254;9828.852567211497;8863;8924.46453212806;8938.955305223497;8939.284857211407;9650.131488166064;8739.95630021849;11765;11818.940905295462;11853.70365740859;11863.110266729987;11606.303621782678;11676.007539359165;11689;11689.064874809996;11695.47370368327;8737.213650771397;8880.911190888073;11515.712107197387;11677.357745324003;11685.065194784396;32013.519797203062;42846.357304640456;43169.92075198114;43181.35227971583;43204.13591728179;2734.4804487147576;3115.8130512169114;3139.3250451152885;3189.2186414328407;3768.1898391845884;24485.510289794103;25329.49341013188;28007;28317.479191438844;28485.57271640927;2713.1513302391973;2795.217339145043;2855.1862719125156;2870.3828676834582;2977.598024266718;448439;450727;452191;453515.4648453506;454249;63533;63935.68032159809;63945.68027159834;63964;63970.68014659897;67255.66372168108;67314;67319.3268067313;67370.66314668494;67408;15835.524934251991;16177.919110404608;16192.352305907867;16192.838071619133;16195.757063644054;12219.327936963375;12276.508939642494;12278.877211227951;12290.262584244974;12297.200681955645;17368.784185107175;17563.473095807145;19836.900815495832;20172.899135504227;20299.391018269474;6322.747090116344;6789.080695301068;6792.08306878575;6813.0121132435515;7977.3618110551015;868.900076491199;909.5588639509832;992.5632721602472;1036.7719101797593;1091.6233899304727;25700;28219.43561128766;28523.429531409256;28528;29110.563341549892;925.7687275923006;980.9509524523745;1048.3814549415881;1074.8656417947757;1213.648042067808;13552.322383880766;14093.802026827629;14170.85829141716;14770;14983.550493485212;467475;520527;520654;523969;524813;49486;51085;56685.433145668016;58357.708211458674;58613;1421.9360128794021;1428.9642758930902;1439.165284135199;1451;1453.5857280674957;24464.6330305042;27540.89836406521;28797.424051519272;33186.004419867444;33852.32295354128;55740;58923.41076589351;59046;59107.81784364203;59223.703881480316;459149;477832;477862;478705;479108;44387.112257754015;46502.767486163706;46740.6248281452;46858.531414685414;46925.76537117293;47503;47786.76106619445;47840.80397990078;49268.50731492639;49342.519724408325;39161.02097447587;39248;39835.80082099571;39939.60060399475;40538.59461405466;38366;38672.41991370075;39080.919480468496;39219.41170882496;39418.40872386974;38846.4173037399;38868.80565597154;38908;39074.60925390823;39281.607183927794;33824.57808414571;34242.82878585591;34819.47770783491;35176.648233517335;35182;19506.219751209792;22475.21336753206;22630;26323;26393.472130557664 13:39:11 INFO - 2015-11-23 13:39:11,793 DEBUG : BROWSER_OUTPUT: |2;jquery.html;355.74564186606574;357.3282229408711;362.7279540344741;362.8095249993753;368.3682484539015;16173.83826161738;16904.323827046905;19512.512187195327;20721.896390518046;21495.462613434673;9562.760930976729;11213.775724485506;11227.60703375382;19624.803751962478;20050;5083.26292687561;5224.294720212761;5225.399079105894;5225.712585807779;5227.660202086871;3939.5666476687543;4036.031352475399;4050.291199040171;4051.149258655671;5166.018456493273;4042.2117687051036;4074.8166332515107;5646.265985421889;5829.8251052468495;5841.123831425299;5153.2270159476;5803.274590676145;6318.620882747027;6322.134970183807;6332.841678958017;5531.032069387841;5531.534143451948;5533.253010843525;5533.667979921218;5538.778448862041;25146.371340716447;25147.24558263255;25180.24459266225;25655.615165772342;25853.74146258532;2005.2981456490259;2113.619548481273;2135.2206444647745;2177.880216588087;2252.842301038928;9646.083622055894;9827.262955278382;13645.38595763193;14339;14603;1758.9824101758948;1772.8758986870923;1804.9187786549637;1842.7880793708762;1897.468708761549;79520;82159;83282.75075873866;83408;84407.57796210979;9001.594928228114;10880.455977201109;11090.390028548507;11097.667069987914;11171.497282622302;11078.279911805706;13093.036044593196;13120.671983200496;13159.53941612039;13159.802602960963;8185.3451723861945;8243.05204901432;8258.628361723737;8315.210055044761;8333.374996875258;8290.212429819157;8324.916750832414;8330.416870818985;8379.664813407395;8394.286485648789;4268.807903644343;4275.722078064916;4285.400043993781;4290.528041915387;4305.590968858016;1504.7893294938717;1716.313474610166;1763.9118044097743;1768.9734653980202;1790.3196785221533;756.670848181043;884.3544212724747;893.3478560650761;928.8420968435382;964.8215080210183;19458.027098645012;19963.900180499004;20078.89960550217;20757;20957.26649567258;786.732510946281;839.1664213692978;901.8511945528915;950.2967803825258;1051.295631926611;5990.251218597676;6158.661273629993;6163.476104531165;6177.351378105234;10206.693799186036;803542;803578.9821050857;805881;809208;817255;100040;118954;124410.9999999982;124823;125943;486.13468026912153;495.8710735208872;499.4431209201714;499.62528103922784;499.73763774018204;10886.67339979802;16984.915075424542;18148;18760;19300.420987370402;52774;53133.20300195423;53180.46819531755;53841;55100.25545018683;53904;71548;72136;72222;72510.63744681243;8232.382571307297;9950.601975920883;10153.39079655223;10167.898321016695;10170.440625765654;16199.595010124842;20034.499137521678;20180.29368972079;20311.9844007802;20715.58568828585;15198;15928.884978051425;16117.758233626739;16519.587010324838;16525.752113718063;15045.946783725472;15437.305321260346;15601.375944962529;15661.765073523678;15738.763918541461;15896.602584935006;16190.67618647644;16398.426055088014;16441.17794110266;16459.012459252484;9515.381500202464;9638.469884156439;9770.120689138012;9809.950950245204;9835.311528192959;10038;10125.189984801345;14179.00746947745;15700.842991569938;16233.269502872636 13:39:11 INFO - 2015-11-23 13:39:11,794 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1387.1676993803712;1436.0737324425752;1559.2203898050968;1908.8260719657405;1925.7303977443155;7613.657385417656;7867.2132786721295;8287.502749835006;8468.237858592725;8477.279431248337;8159.102498725136;8285.130061343563;8310.667573297076;8325.08424073353;8334.70828521002;2112.1234687604624;2161.254367243306;2349.566764273796;2368.490774483486;2371.288613415977;2172.2831465616387;2172.8370372222066;2182.0289970962926;2329.033451117784;2381.1903952656094;2332.8483648562874;2335.8131349492087;2336.4392545788974;2339.7192336919593;2341.1454818991115;2285.611446054175;2341.274204996448;2347.823913206499;2348.16640092768;2354.399628094842;2131.690904818808;2167.707359506462;2172;2282.7717228277206;2367.9408014799596;7967.800804979922;8349.95825020877;8350.290225330855;8361.456505327134;8361.540115293656;5034.194528875362;5079.568236699885;5090.160123579605;5096.464871188546;5125.410577783566;3183.5065564837487;3390.9152271193416;3471.7916924984584;3562.340966921128;3580.8925732228076;1031.6079889641962;1052.552665117322;1053.3311347294523;1057.2229411382705;1077.94610269487;10980.066694330992;10980.560777568888;10989;10993.395363255018;11015.284006539629;4554.63562914966;4617.168909596237;4654.790534425959;4660.277656963176;4676.95323046772;9598.42409455435;9600.903990960001;9604;9628.085331893459;9647.903520964841;5168.069747445421;5168.58651307902;5169.276301317818;5173.663711858717;5176.767045482962;4701.989072349461;4704.694194877322;4719.551642593948;4720.315554244684;4721.386219791405;3747.4004159334377;3822.6559609635265;3823.2162406706557;3827.2919509890203;3858.151206734514;1257.9308138052495;1257.9308138052495;1264.5194825966073;1265.544404014554;1282.6857419932176;1368.2201145347058;1382.9585112446644;1402.1166665000985;1402.5161319344809;1405.1147776900486;7671.041119860018;7808.843823123506;7817.8827317590285;7821;7832.569208693577;494.51290478878275;500.9974950125299;507.1024287011968;508.72274610337456;509.95410413063;5866.765329386777;6028.457438830526;6158.507319414436;6217.222847144107;6235.033569796688;8965.327600429864;9643.27675424346;9652;9749.512524373753;9750.26872984529;9553.283503737108;9575.521223938915;9610.087041731025;9935.403875767333;9980.700578982642;7730.226977302337;7811.140774514685;7811.687532498637;7883.487573307717;7892.802679933047;7657.34912532441;7782.688692452465;7793.103793063643;7793.649285782267;7807.063152421746;8770.12298770118;8942.642294308414;9038.683646072619;9043.366964312436;9045.547722613712;9132.634694612141;9364.765880853032;9374.062593740571;9434.81130377375;9450.574724137568;7273.272672732684;7290.234525374972;7321.963390183015;7368.1526624438875;7382.926170738224;7899.723509677134;7914.525128492309;7963.323117535075;7964.761057168294;7986.201379861967;7326;7407;7437.367823734827;7550.131734850563;7574.5076570022775;6916.377526022481;6998.125234345707;7300.598467084149;7360.96319518399;7465.6267186641535;7392.852142957003;7450.552966822008;7459.627018648937;7468.290512401313;7477.289657482531;6765.86468270622;6788.083608712958;6805.353491418307;6807.251202367636;6826.385625293748;6773.390394864289;6897.55165914214;6909.032735416945;6909.550879192836;6914.585124892523 13:39:11 INFO - 2015-11-23 13:39:11,795 DEBUG : BROWSER_OUTPUT: |4;prototype.html;318.4411358066593;325.3184578308443;328.09936723693465;332.8136243703526;333.73301358912863;6825.522213445055;6827.2148702899185;6882.690278937441;6927.896081558781;6939.930600694004;6802.115724955749;6807.897881531781;6829.248782633918;6841.5552989055805;6882.346177113166;3586.9016625274244;4032.4354590357375;4869.902601947959;4982.17794063979;4989.800407983686;4958.181899986516;4988.351514303154;5006.374203224597;5050.84847454577;5093.236014597803;4927;4939.061578300111;4955.653104282702;4967.850964471072;4969.726665033421;4707.693999889996;4803.471618122004;4813.494583068762;4950.306957026001;4955.876103097416;3453.4819777033395;4191.643710284599;4231.978840105779;4246.426732391118;4262.87211383659;6528.77149299777;6544.738210471575;6549.443297319734;6552.508561857832;6579.572327798678;5637.323521177444;5684.8294551163535;5817;5825.883482330372;5951.809638072403;7184.856302873965;7249.202587715347;7326.780196594111;7354;7365.815854603624;3987.9202415951518;4796;4797.7601119943865;4797.784099715521;4818.975905120487;7472.364848987788;7810.882836757453;7817.491863028885;7817.570033648147;7825.256600622932;4893.877653058702;4901.436334821541;4909.852704418873;4911.582515486224;4915.26271059344;4972.041635227034;4993.375828021497;5013.24801279811;5016;5018.84943451697;5911.852203694942;5913.438223368773;5916.26046744157;5916.408359164049;5932.555058370639;7191.228164262225;7282.271772822675;7369.336759691653;7372.189059203483;7395.963020184865;1713.7172366559628;1734.7051001329805;1736.600581866178;1736.6092629158338;1741.5384922995415;1113.8997490225918;1123.1744667669257;1138.584416687903;1143.7426579019655;1144.753877916252;6851.554648947902;6855;6861.877845580249;6870.7595234166565;6881.8967715484305;6210.875782484415;7645.847083058419;7657.0811502620045;7669.156392796788;7700.537967721954;5574;6677.632730199885;6826;6853.588784672836;6946.79159625212;3942.8619998300496;4019.1760689058674;4032.1330913853662;4056.756594604274;4113.506379234511;6489.669617728355;7756.573388463576;7810.101838288556;7855.332296754726;7890.8816367754525;8042.03495580534;8049.678012879536;8053;8060.274575288252;8070.596470176468;7008.369246767816;7564.697412103455;7784.766457006185;8018;8026.277635012877;7754.88367674474;7755.689772409266;7755.922440775746;7759.262870027338;7769;7375.557466552024;7577.848443030998;7579.848403032019;7596.240375962359;7618.847623047619;7995.720149794729;8004.319632831274;8013.2387423194705;8014.8397032057865;8023.277904988579;4713.175194340908;4761.785719642694;4769.737664428351;4771.976140119277;4777.402824646919;7452.776416707507;7682.692692292246;7684.731034413769;7701.807454813675;7727.574983375968;5967.8209653710455;6009.278886533644;7378;7389.630518474162;7389.8522029558035;7121.216666166821;7389.298016688406;7391.519551229153;7397.334239918433;7406.888896666446;6063.090536419572;7193.712251509881;7207.387372073433;7218.458615603956;7228.060352154186;7387.519811212254;7393.963030184815;7399.223081576357;7399.8150046249275;7407.851842963219;6999.650017499002;7215.314545118205;7227;7242.891356629761;7264.455165862687 13:39:11 INFO - 2015-11-23 13:39:11,799 DEBUG : BROWSER_OUTPUT: |5;yui.html;683.8392977650251;716.6524235745666;739.3272122368644;766.0539234045956;776.3323541754089;14937.701245975088;15055.171965541904;15490.302936367862;15498.225088745547;15559.766603500928;14243.85756142441;14372.209528475929;14372.49696260631;14374.856251437483;14383.280835958212;778.0740918307224;781.0783275734631;784.4038530716639;952.1668540027458;984.5963155106408;961.942283462991;969.9854502182473;975.5268694683073;977.1010670183413;979.118793086221;934.8784657994452;1009.9545520451597;1015.8019186258682;1021.9744506387325;1024.0015984415172;803.4777394693438;803.7468197517793;807.7738233294657;992.151710287708;1001.8497225416173;749.3667850666233;750.8798592225272;751.5415596486139;751.8796992481177;751.8834580640009;14969.476068337664;15063.849361506464;15086.39654413822;15118.941674082818;15127.319270632737;12013;12401.25592464455;12633.620991370273;12829.61511154667;13087;10158.339707918962;11141.944290278578;11301.717457063556;11335.263207891461;11760.000399965927;3493.7205023598303;3523.5067090607336;3526.2066035142143;3540.4689296605457;3561.465780133001;73467.63266183635;73536.26463735348;73887.63056184685;74701;83694;9362.531873406302;9382;9397.624095036259;9403.670871519464;9439.433633981984;20578.691319630216;20783.58432831335;20815.895920520605;20827.479313017295;20871.852048137498;6122.326544080148;7072.292770722886;7141.89287160693;7187.209406965229;7382.667779949915;3807.124361396839;3896.5129358830145;3942.586028467027;3977.0455090778005;3988.3818008208773;3474.062003259106;3508.1405055760993;3515.8945231643092;3519.6128425873135;3520.841562129659;621.3568956130383;630.5775130662468;632.3676323676324;652.3085529338916;653.9280679125293;511.6597462687346;513.2634669249638;524.6878107526015;540.4676393752151;543.6873797566415;8534.274716288728;8656.956715216384;8711.607977640895;8814.294856411472;8899.377043607015;504.92678561608363;552.9060059789765;554.203704623327;564.4553006348893;638.6806596701649;3819.1788765415013;4140.399642051885;4340.197063543254;4434.778261086933;4492.685512014127;83916.58041709752;86094;88454.55772721225;89141.55429222812;89391;70885.64557177284;71057;71074;71088;72118.19704507325;69806.9528957066;70442;70551.64724176346;70935.2906470939;71288;8762.561871906506;8943.418677785923;8946.418482798597;8972.68595599177;9049;34633.480497793054;51074.74462627663;51223.97552049013;53779.731101344245;53803;75499.62250188933;75557;76521.46957060939;76665.23334766804;78167.60916195382;11496.080313575061;11779.293242405483;11942.880571194524;11945.223560468541;12157.635270941886;11715;12084.516619335129;12482.126251162696;12935;12948.741025179255;11584.710382240512;11612.477438515456;12014.819777703167;12053.457594408097;12454.937725311678;12008.039356851606;12029.639110826689;12038.277703337828;12105.455254513392;12410;6912.896306555305;10937.398443085707;11377.488013039267;11499.425028748696;12166.270023798601;9573.090556397132;9768.36505627132;9846.704598862045;10044.799104017733;10539.209559282932;9603.90396096058;9787.608495660093;9789.259007477918;9823.705288841345;10011.949940250252 13:39:11 INFO - 2015-11-23 13:39:11,799 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:39:11 INFO - 2015-11-23 13:39:11,799 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:39:11 INFO - 2015-11-23 13:39:11,799 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1263 13:39:11 INFO - 2015-11-23 13:39:11,799 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:39:11 INFO - 2015-11-23 13:39:11,799 DEBUG : BROWSER_OUTPUT: __startTimestamp1448314751784__endTimestamp 13:39:11 INFO - 2015-11-23 13:39:11,799 DEBUG : BROWSER_OUTPUT: 13:39:11 INFO - 2015-11-23 13:39:11,800 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:39:11 INFO - 2015-11-23 13:39:11,800 DEBUG : BROWSER_OUTPUT: Number of tests: 6 13:39:11 INFO - 2015-11-23 13:39:11,800 DEBUG : BROWSER_OUTPUT: 13:39:11 INFO - 2015-11-23 13:39:11,800 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5731.34 Median:5993.31 stddev:642.95 (10.7%) stddev-sans-first:609.11 13:39:11 INFO - 2015-11-23 13:39:11,800 DEBUG : BROWSER_OUTPUT: Values: 3034.3 3406.1 3422.8 3459.1 3482.7 5582.3 5712.2 5716.2 5727.1 5765.1 5704.2 5724.6 5741.7 5758.8 5782.2 5142.4 5169.8 5214.3 5228.5 5282.5 5272.2 5274.2 5280.1 5286.5 5294.5 5244.0 5252.2 5264.2 5270.5 5281.1 5210.1 5235.2 5235.8 5245.2 5251.9 5054.2 5067.4 5178.8 5184.6 5203.0 5622.4 5663.0 5679.3 5697.3 5723.2 5347.7 6284.6 6289.5 6298.0 6300.6 6063.1 6176.8 6194.5 6199.5 6285.3 5867.7 5871.7 5903.1 5926.7 5939.5 6235.9 6296.4 6301.6 6304.3 6311.1 5960.6 6039.6 6109.8 6123.1 6132.7 6267.7 6283.5 6283.7 6290.1 6316.7 6133.5 6197.0 6199.4 6215.9 6221.3 6049.8 6094.7 6159.8 6168.4 6168.7 4955.6 4962.5 4966.5 4983.4 4986.4 4431.6 4436.8 4459.8 4465.5 4467.8 5481.1 5569.5 5606.4 5620.8 5621.5 6156.0 6276.6 6279.6 6282.4 6287.5 4385.4 5546.1 5646.2 5673.5 5703.3 5322.1 5419.9 5421.9 5431.8 5448.0 6309.3 6317.4 6322.5 6331.6 6334.4 5199.7 6117.6 6202.1 6339.4 6350.7 6219.5 6330.3 6348.9 6350.3 6360.5 6151.7 6186.2 6192.3 6201.0 6216.7 6082.3 6181.2 6188.9 6303.4 6350.5 6000.6 6088.2 6105.9 6121.6 6127.1 6010.7 6101.8 6105.0 6109.9 6137.1 5694.5 5964.0 5977.2 5986.4 5993.3 6032.6 6050.6 6063.8 6116.6 6150.1 6000.5 6009.7 6018.0 6039.7 6041.5 13:39:11 INFO - 2015-11-23 13:39:11,800 DEBUG : BROWSER_OUTPUT: 13:39:11 INFO - 2015-11-23 13:39:11,800 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:63524.45 Median:39233.71 stddev:127383.74 (324.7%) stddev-sans-first:127653.37 13:39:11 INFO - 2015-11-23 13:39:11,802 DEBUG : BROWSER_OUTPUT: Values: 562.9 575.9 615.9 627.4 631.0 30212.0 32529.5 32574.3 32712.7 40683.0 43697.8 43968.6 44030.0 44096.6 44170.8 9621.0 9811.7 9812.1 9818.2 9828.9 8863.0 8924.5 8939.0 8939.3 9650.1 8740.0 11765.0 11818.9 11853.7 11863.1 11606.3 11676.0 11689.0 11689.1 11695.5 8737.2 8880.9 11515.7 11677.4 11685.1 32013.5 42846.4 43169.9 43181.4 43204.1 2734.5 3115.8 3139.3 3189.2 3768.2 24485.5 25329.5 28007.0 28317.5 28485.6 2713.2 2795.2 2855.2 2870.4 2977.6 448439.0 450727.0 452191.0 453515.5 454249.0 63533.0 63935.7 63945.7 63964.0 63970.7 67255.7 67314.0 67319.3 67370.7 67408.0 15835.5 16177.9 16192.4 16192.8 16195.8 12219.3 12276.5 12278.9 12290.3 12297.2 17368.8 17563.5 19836.9 20172.9 20299.4 6322.7 6789.1 6792.1 6813.0 7977.4 868.9 909.6 992.6 1036.8 1091.6 25700.0 28219.4 28523.4 28528.0 29110.6 925.8 981.0 1048.4 1074.9 1213.6 13552.3 14093.8 14170.9 14770.0 14983.6 467475.0 520527.0 520654.0 523969.0 524813.0 49486.0 51085.0 56685.4 58357.7 58613.0 1421.9 1429.0 1439.2 1451.0 1453.6 24464.6 27540.9 28797.4 33186.0 33852.3 55740.0 58923.4 59046.0 59107.8 59223.7 459149.0 477832.0 477862.0 478705.0 479108.0 44387.1 46502.8 46740.6 46858.5 46925.8 47503.0 47786.8 47840.8 49268.5 49342.5 39161.0 39248.0 39835.8 39939.6 40538.6 38366.0 38672.4 39080.9 39219.4 39418.4 38846.4 38868.8 38908.0 39074.6 39281.6 33824.6 34242.8 34819.5 35176.6 35182.0 19506.2 22475.2 22630.0 26323.0 26393.5 13:39:11 INFO - 2015-11-23 13:39:11,802 DEBUG : BROWSER_OUTPUT: 13:39:11 INFO - 2015-11-23 13:39:11,802 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:39586.42 Median:2153.97 stddev:132572.38 (6154.8%) stddev-sans-first:132911.55 13:39:11 INFO - 2015-11-23 13:39:11,802 DEBUG : BROWSER_OUTPUT: Values: 355.7 357.3 362.7 362.8 368.4 16173.8 16904.3 19512.5 20721.9 21495.5 9562.8 11213.8 11227.6 19624.8 20050.0 5083.3 5224.3 5225.4 5225.7 5227.7 3939.6 4036.0 4050.3 4051.1 5166.0 4042.2 4074.8 5646.3 5829.8 5841.1 5153.2 5803.3 6318.6 6322.1 6332.8 5531.0 5531.5 5533.3 5533.7 5538.8 25146.4 25147.2 25180.2 25655.6 25853.7 2005.3 2113.6 2135.2 2177.9 2252.8 9646.1 9827.3 13645.4 14339.0 14603.0 1759.0 1772.9 1804.9 1842.8 1897.5 79520.0 82159.0 83282.8 83408.0 84407.6 9001.6 10880.5 11090.4 11097.7 11171.5 11078.3 13093.0 13120.7 13159.5 13159.8 8185.3 8243.1 8258.6 8315.2 8333.4 8290.2 8324.9 8330.4 8379.7 8394.3 4268.8 4275.7 4285.4 4290.5 4305.6 1504.8 1716.3 1763.9 1769.0 1790.3 756.7 884.4 893.3 928.8 964.8 19458.0 19963.9 20078.9 20757.0 20957.3 786.7 839.2 901.9 950.3 1051.3 5990.3 6158.7 6163.5 6177.4 10206.7 803542.0 803579.0 805881.0 809208.0 817255.0 100040.0 118954.0 124411.0 124823.0 125943.0 486.1 495.9 499.4 499.6 499.7 10886.7 16984.9 18148.0 18760.0 19300.4 52774.0 53133.2 53180.5 53841.0 55100.3 53904.0 71548.0 72136.0 72222.0 72510.6 8232.4 9950.6 10153.4 10167.9 10170.4 16199.6 20034.5 20180.3 20312.0 20715.6 15198.0 15928.9 16117.8 16519.6 16525.8 15045.9 15437.3 15601.4 15661.8 15738.8 15896.6 16190.7 16398.4 16441.2 16459.0 9515.4 9638.5 9770.1 9810.0 9835.3 10038.0 10125.2 14179.0 15700.8 16233.3 13:39:11 INFO - 2015-11-23 13:39:11,802 DEBUG : BROWSER_OUTPUT: 13:39:11 INFO - 2015-11-23 13:39:11,802 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5766.70 Median:6769.63 stddev:3004.48 (44.4%) stddev-sans-first:2994.88 13:39:11 INFO - 2015-11-23 13:39:11,804 DEBUG : BROWSER_OUTPUT: Values: 1387.2 1436.1 1559.2 1908.8 1925.7 7613.7 7867.2 8287.5 8468.2 8477.3 8159.1 8285.1 8310.7 8325.1 8334.7 2112.1 2161.3 2349.6 2368.5 2371.3 2172.3 2172.8 2182.0 2329.0 2381.2 2332.8 2335.8 2336.4 2339.7 2341.1 2285.6 2341.3 2347.8 2348.2 2354.4 2131.7 2167.7 2172.0 2282.8 2367.9 7967.8 8350.0 8350.3 8361.5 8361.5 5034.2 5079.6 5090.2 5096.5 5125.4 3183.5 3390.9 3471.8 3562.3 3580.9 1031.6 1052.6 1053.3 1057.2 1077.9 10980.1 10980.6 10989.0 10993.4 11015.3 4554.6 4617.2 4654.8 4660.3 4677.0 9598.4 9600.9 9604.0 9628.1 9647.9 5168.1 5168.6 5169.3 5173.7 5176.8 4702.0 4704.7 4719.6 4720.3 4721.4 3747.4 3822.7 3823.2 3827.3 3858.2 1257.9 1257.9 1264.5 1265.5 1282.7 1368.2 1383.0 1402.1 1402.5 1405.1 7671.0 7808.8 7817.9 7821.0 7832.6 494.5 501.0 507.1 508.7 510.0 5866.8 6028.5 6158.5 6217.2 6235.0 8965.3 9643.3 9652.0 9749.5 9750.3 9553.3 9575.5 9610.1 9935.4 9980.7 7730.2 7811.1 7811.7 7883.5 7892.8 7657.3 7782.7 7793.1 7793.6 7807.1 8770.1 8942.6 9038.7 9043.4 9045.5 9132.6 9364.8 9374.1 9434.8 9450.6 7273.3 7290.2 7322.0 7368.2 7382.9 7899.7 7914.5 7963.3 7964.8 7986.2 7326.0 7407.0 7437.4 7550.1 7574.5 6916.4 6998.1 7300.6 7361.0 7465.6 7392.9 7450.6 7459.6 7468.3 7477.3 6765.9 6788.1 6805.4 6807.3 6826.4 6773.4 6897.6 6909.0 6909.6 6914.6 13:39:11 INFO - 2015-11-23 13:39:11,804 DEBUG : BROWSER_OUTPUT: 13:39:11 INFO - 2015-11-23 13:39:11,804 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5974.24 Median:6826.61 stddev:1942.28 (28.5%) stddev-sans-first:1900.77 13:39:11 INFO - 2015-11-23 13:39:11,805 DEBUG : BROWSER_OUTPUT: Values: 318.4 325.3 328.1 332.8 333.7 6825.5 6827.2 6882.7 6927.9 6939.9 6802.1 6807.9 6829.2 6841.6 6882.3 3586.9 4032.4 4869.9 4982.2 4989.8 4958.2 4988.4 5006.4 5050.8 5093.2 4927.0 4939.1 4955.7 4967.9 4969.7 4707.7 4803.5 4813.5 4950.3 4955.9 3453.5 4191.6 4232.0 4246.4 4262.9 6528.8 6544.7 6549.4 6552.5 6579.6 5637.3 5684.8 5817.0 5825.9 5951.8 7184.9 7249.2 7326.8 7354.0 7365.8 3987.9 4796.0 4797.8 4797.8 4819.0 7472.4 7810.9 7817.5 7817.6 7825.3 4893.9 4901.4 4909.9 4911.6 4915.3 4972.0 4993.4 5013.2 5016.0 5018.8 5911.9 5913.4 5916.3 5916.4 5932.6 7191.2 7282.3 7369.3 7372.2 7396.0 1713.7 1734.7 1736.6 1736.6 1741.5 1113.9 1123.2 1138.6 1143.7 1144.8 6851.6 6855.0 6861.9 6870.8 6881.9 6210.9 7645.8 7657.1 7669.2 7700.5 5574.0 6677.6 6826.0 6853.6 6946.8 3942.9 4019.2 4032.1 4056.8 4113.5 6489.7 7756.6 7810.1 7855.3 7890.9 8042.0 8049.7 8053.0 8060.3 8070.6 7008.4 7564.7 7784.8 8018.0 8026.3 7754.9 7755.7 7755.9 7759.3 7769.0 7375.6 7577.8 7579.8 7596.2 7618.8 7995.7 8004.3 8013.2 8014.8 8023.3 4713.2 4761.8 4769.7 4772.0 4777.4 7452.8 7682.7 7684.7 7701.8 7727.6 5967.8 6009.3 7378.0 7389.6 7389.9 7121.2 7389.3 7391.5 7397.3 7406.9 6063.1 7193.7 7207.4 7218.5 7228.1 7387.5 7394.0 7399.2 7399.8 7407.9 6999.7 7215.3 7227.0 7242.9 7264.5 13:39:11 INFO - 2015-11-23 13:39:11,805 DEBUG : BROWSER_OUTPUT: 13:39:11 INFO - 2015-11-23 13:39:11,805 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:18183.18 Median:27171.73 stddev:25070.36 (92.3%) stddev-sans-first:25106.26 13:39:11 INFO - 2015-11-23 13:39:11,807 DEBUG : BROWSER_OUTPUT: Values: 683.8 716.7 739.3 766.1 776.3 14937.7 15055.2 15490.3 15498.2 15559.8 14243.9 14372.2 14372.5 14374.9 14383.3 778.1 781.1 784.4 952.2 984.6 961.9 970.0 975.5 977.1 979.1 934.9 1010.0 1015.8 1022.0 1024.0 803.5 803.7 807.8 992.2 1001.8 749.4 750.9 751.5 751.9 751.9 14969.5 15063.8 15086.4 15118.9 15127.3 12013.0 12401.3 12633.6 12829.6 13087.0 10158.3 11141.9 11301.7 11335.3 11760.0 3493.7 3523.5 3526.2 3540.5 3561.5 73467.6 73536.3 73887.6 74701.0 83694.0 9362.5 9382.0 9397.6 9403.7 9439.4 20578.7 20783.6 20815.9 20827.5 20871.9 6122.3 7072.3 7141.9 7187.2 7382.7 3807.1 3896.5 3942.6 3977.0 3988.4 3474.1 3508.1 3515.9 3519.6 3520.8 621.4 630.6 632.4 652.3 653.9 511.7 513.3 524.7 540.5 543.7 8534.3 8657.0 8711.6 8814.3 8899.4 504.9 552.9 554.2 564.5 638.7 3819.2 4140.4 4340.2 4434.8 4492.7 83916.6 86094.0 88454.6 89141.6 89391.0 70885.6 71057.0 71074.0 71088.0 72118.2 69807.0 70442.0 70551.6 70935.3 71288.0 8762.6 8943.4 8946.4 8972.7 9049.0 34633.5 51074.7 51224.0 53779.7 53803.0 75499.6 75557.0 76521.5 76665.2 78167.6 11496.1 11779.3 11942.9 11945.2 12157.6 11715.0 12084.5 12482.1 12935.0 12948.7 11584.7 11612.5 12014.8 12053.5 12454.9 12008.0 12029.6 12038.3 12105.5 12410.0 6912.9 10937.4 11377.5 11499.4 12166.3 9573.1 9768.4 9846.7 10044.8 10539.2 9603.9 9787.6 9789.3 9823.7 10011.9 13:39:11 INFO - 2015-11-23 13:39:11,807 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:39:11 INFO - 2015-11-23 13:39:11,807 DEBUG : BROWSER_OUTPUT: 13:39:12 INFO - 2015-11-23 13:39:12,314 INFO : Browser exited with error code: 0 13:39:12 INFO - 2015-11-23 13:39:12,340 INFO : Completed test dromaeo_css (00:18:34) 13:39:12 INFO - 2015-11-23 13:39:12,340 INFO : Starting test kraken 13:39:12 INFO - 2015-11-23 13:39:12,340 DEBUG : operating with platform_type : mac_ 13:39:12 INFO - 2015-11-23 13:39:12,340 INFO : Initialising browser for kraken test... 13:39:12 INFO - 2015-11-23 13:39:12,353 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/tmp7c32gs/profile http://localhost:58417/getInfo.html 13:39:14 INFO - 2015-11-23 13:39:14,366 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:39:14 INFO - 2015-11-23 13:39:14,366 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:39:14 INFO - 2015-11-23 13:39:14,366 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 13:39:14 INFO - 2015-11-23 13:39:14,366 DEBUG : BROWSER_OUTPUT: __metrics 13:39:14 INFO - 2015-11-23 13:39:14,383 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:39:14 INFO - 2015-11-23 13:39:14,990 INFO : Browser initialized. 13:39:14 INFO - 2015-11-23 13:39:14,991 INFO : Running cycle 1/1 for kraken test... 13:39:14 INFO - 2015-11-23 13:39:14,991 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/tmp7c32gs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:39:26 INFO - 2015-11-23 13:39:26,787 DEBUG : BROWSER_OUTPUT: RSS: Main: 225112064 13:39:26 INFO - 2015-11-23 13:39:26,787 DEBUG : BROWSER_OUTPUT: 13:39:29 INFO - 2015-11-23 13:39:29,455 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58417/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58417/tests/kraken/driver.html?testName=audio-beat-detection) 13:39:30 INFO - 2015-11-23 13:39:30,041 DEBUG : BROWSER_OUTPUT: RSS: Main: 276860928 13:39:30 INFO - 2015-11-23 13:39:30,042 DEBUG : BROWSER_OUTPUT: 13:39:32 INFO - 2015-11-23 13:39:32,782 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58417/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58417/tests/kraken/driver.html?testName=audio-dft) 13:39:33 INFO - 2015-11-23 13:39:33,367 DEBUG : BROWSER_OUTPUT: RSS: Main: 289685504 13:39:33 INFO - 2015-11-23 13:39:33,367 DEBUG : BROWSER_OUTPUT: 13:39:36 INFO - 2015-11-23 13:39:36,585 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58417/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58417/tests/kraken/driver.html?testName=audio-fft) 13:39:37 INFO - 2015-11-23 13:39:37,167 DEBUG : BROWSER_OUTPUT: RSS: Main: 275148800 13:39:37 INFO - 2015-11-23 13:39:37,168 DEBUG : BROWSER_OUTPUT: 13:39:39 INFO - 2015-11-23 13:39:39,068 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58417/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58417/tests/kraken/driver.html?testName=audio-oscillator) 13:39:39 INFO - 2015-11-23 13:39:39,671 DEBUG : BROWSER_OUTPUT: RSS: Main: 277520384 13:39:39 INFO - 2015-11-23 13:39:39,671 DEBUG : BROWSER_OUTPUT: 13:39:41 INFO - 2015-11-23 13:39:41,678 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58417/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58417/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:39:42 INFO - 2015-11-23 13:39:42,257 DEBUG : BROWSER_OUTPUT: RSS: Main: 278138880 13:39:42 INFO - 2015-11-23 13:39:42,257 DEBUG : BROWSER_OUTPUT: 13:39:45 INFO - 2015-11-23 13:39:45,075 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58417/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58417/tests/kraken/driver.html?testName=imaging-darkroom) 13:39:45 INFO - 2015-11-23 13:39:45,668 DEBUG : BROWSER_OUTPUT: RSS: Main: 279105536 13:39:45 INFO - 2015-11-23 13:39:45,668 DEBUG : BROWSER_OUTPUT: 13:39:48 INFO - 2015-11-23 13:39:48,508 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58417/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58417/tests/kraken/driver.html?testName=imaging-desaturate) 13:39:49 INFO - 2015-11-23 13:39:49,110 DEBUG : BROWSER_OUTPUT: RSS: Main: 279953408 13:39:49 INFO - 2015-11-23 13:39:49,110 DEBUG : BROWSER_OUTPUT: 13:39:51 INFO - 2015-11-23 13:39:51,791 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58417/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58417/tests/kraken/driver.html?testName=json-parse-financial) 13:39:52 INFO - 2015-11-23 13:39:52,382 DEBUG : BROWSER_OUTPUT: RSS: Main: 280596480 13:39:52 INFO - 2015-11-23 13:39:52,382 DEBUG : BROWSER_OUTPUT: 13:39:53 INFO - 2015-11-23 13:39:53,893 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58417/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58417/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:39:54 INFO - 2015-11-23 13:39:54,465 DEBUG : BROWSER_OUTPUT: RSS: Main: 317382656 13:39:54 INFO - 2015-11-23 13:39:54,466 DEBUG : BROWSER_OUTPUT: 13:39:56 INFO - 2015-11-23 13:39:56,247 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58417/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58417/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:39:56 INFO - 2015-11-23 13:39:56,861 DEBUG : BROWSER_OUTPUT: RSS: Main: 317415424 13:39:56 INFO - 2015-11-23 13:39:56,861 DEBUG : BROWSER_OUTPUT: 13:39:58 INFO - 2015-11-23 13:39:58,923 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58417/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58417/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:39:59 INFO - 2015-11-23 13:39:59,546 DEBUG : BROWSER_OUTPUT: RSS: Main: 324509696 13:39:59 INFO - 2015-11-23 13:39:59,546 DEBUG : BROWSER_OUTPUT: 13:40:02 INFO - 2015-11-23 13:40:02,026 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58417/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58417/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:40:02 INFO - 2015-11-23 13:40:02,627 DEBUG : BROWSER_OUTPUT: RSS: Main: 325234688 13:40:02 INFO - 2015-11-23 13:40:02,627 DEBUG : BROWSER_OUTPUT: 13:40:05 INFO - 2015-11-23 13:40:05,123 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58417/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58417/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:40:05 INFO - 2015-11-23 13:40:05,713 DEBUG : BROWSER_OUTPUT: RSS: Main: 324542464 13:40:05 INFO - 2015-11-23 13:40:05,714 DEBUG : BROWSER_OUTPUT: 13:40:07 INFO - 2015-11-23 13:40:07,434 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58417/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58417/tests/kraken/driver.html?testName=ai-astar) 13:40:07 INFO - 2015-11-23 13:40:07,683 DEBUG : BROWSER_OUTPUT: RSS: Main: 383533056 13:40:07 INFO - 2015-11-23 13:40:07,683 DEBUG : BROWSER_OUTPUT: 13:40:07 INFO - 2015-11-23 13:40:07,684 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:40:07 INFO - 2015-11-23 13:40:07,684 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:40:07 INFO - 2015-11-23 13:40:07,684 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:40:07 INFO - 2015-11-23 13:40:07,684 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:40:07 INFO - 2015-11-23 13:40:07,685 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;109;104;109;109;110;113;155;148;109 13:40:07 INFO - 2015-11-23 13:40:07,685 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;126;177;169;141;168;140;118;158;146 13:40:07 INFO - 2015-11-23 13:40:07,685 DEBUG : BROWSER_OUTPUT: |2;audio-dft;184;186;180;183;184;182;185;186;182;180 13:40:07 INFO - 2015-11-23 13:40:07,685 DEBUG : BROWSER_OUTPUT: |3;audio-fft;66;65;77;73;55;56;56;74;73;71 13:40:07 INFO - 2015-11-23 13:40:07,685 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;85;86;116;74;75;75;114;78;75;110 13:40:07 INFO - 2015-11-23 13:40:07,685 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;86;86;87;85;85;84;90;131;131;85 13:40:07 INFO - 2015-11-23 13:40:07,685 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;96;94;93;93;93;93;102;131;93;93 13:40:07 INFO - 2015-11-23 13:40:07,685 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;85;85;86;86;87;86;84;88;85;88 13:40:07 INFO - 2015-11-23 13:40:07,685 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;56;55;56;54;52;53;54;54;56;52 13:40:07 INFO - 2015-11-23 13:40:07,685 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;63;64;62;65;68;68;67;68;67 13:40:07 INFO - 2015-11-23 13:40:07,685 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;79;81;82;82;82;82;90;109;83;70 13:40:07 INFO - 2015-11-23 13:40:07,685 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;119;118;120;117;129;130;120;120;128;129 13:40:07 INFO - 2015-11-23 13:40:07,686 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;122;146;135;133;164;125;119;169;163;123 13:40:07 INFO - 2015-11-23 13:40:07,686 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;64;66;65;64;65;65;64;74;76;88 13:40:07 INFO - 2015-11-23 13:40:07,686 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:40:07 INFO - 2015-11-23 13:40:07,686 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:40:07 INFO - 2015-11-23 13:40:07,686 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1067 13:40:07 INFO - 2015-11-23 13:40:07,686 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:40:07 INFO - 2015-11-23 13:40:07,686 DEBUG : BROWSER_OUTPUT: __startTimestamp1448314807683__endTimestamp 13:40:07 INFO - 2015-11-23 13:40:07,686 DEBUG : BROWSER_OUTPUT: 13:40:07 INFO - 2015-11-23 13:40:07,693 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:40:07 INFO - 2015-11-23 13:40:07,694 DEBUG : BROWSER_OUTPUT: Number of tests: 14 13:40:07 INFO - 2015-11-23 13:40:07,694 DEBUG : BROWSER_OUTPUT: 13:40:07 INFO - 2015-11-23 13:40:07,694 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:117.50 Median:109.50 stddev:18.12 (16.6%) stddev-sans-first:18.96 13:40:07 INFO - 2015-11-23 13:40:07,694 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 104.0 109.0 109.0 110.0 113.0 155.0 148.0 109.0 13:40:07 INFO - 2015-11-23 13:40:07,694 DEBUG : BROWSER_OUTPUT: 13:40:07 INFO - 2015-11-23 13:40:07,694 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.60 Median:155.50 stddev:19.10 (12.3%) stddev-sans-first:20.22 13:40:07 INFO - 2015-11-23 13:40:07,694 DEBUG : BROWSER_OUTPUT: Values: 153.0 126.0 177.0 169.0 141.0 168.0 140.0 118.0 158.0 146.0 13:40:07 INFO - 2015-11-23 13:40:07,694 DEBUG : BROWSER_OUTPUT: 13:40:07 INFO - 2015-11-23 13:40:07,694 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:183.20 Median:184.00 stddev:2.20 (1.2%) stddev-sans-first:2.32 13:40:07 INFO - 2015-11-23 13:40:07,694 DEBUG : BROWSER_OUTPUT: Values: 184.0 186.0 180.0 183.0 184.0 182.0 185.0 186.0 182.0 180.0 13:40:07 INFO - 2015-11-23 13:40:07,694 DEBUG : BROWSER_OUTPUT: 13:40:07 INFO - 2015-11-23 13:40:07,694 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:66.60 Median:72.00 stddev:8.34 (11.6%) stddev-sans-first:8.85 13:40:07 INFO - 2015-11-23 13:40:07,694 DEBUG : BROWSER_OUTPUT: Values: 66.0 65.0 77.0 73.0 55.0 56.0 56.0 74.0 73.0 71.0 13:40:07 INFO - 2015-11-23 13:40:07,695 DEBUG : BROWSER_OUTPUT: 13:40:07 INFO - 2015-11-23 13:40:07,695 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:88.80 Median:75.00 stddev:17.49 (23.3%) stddev-sans-first:18.50 13:40:07 INFO - 2015-11-23 13:40:07,695 DEBUG : BROWSER_OUTPUT: Values: 85.0 86.0 116.0 74.0 75.0 75.0 114.0 78.0 75.0 110.0 13:40:07 INFO - 2015-11-23 13:40:07,695 DEBUG : BROWSER_OUTPUT: 13:40:07 INFO - 2015-11-23 13:40:07,695 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:95.00 Median:85.50 stddev:19.04 (22.3%) stddev-sans-first:19.92 13:40:07 INFO - 2015-11-23 13:40:07,695 DEBUG : BROWSER_OUTPUT: Values: 86.0 86.0 87.0 85.0 85.0 84.0 90.0 131.0 131.0 85.0 13:40:07 INFO - 2015-11-23 13:40:07,695 DEBUG : BROWSER_OUTPUT: 13:40:07 INFO - 2015-11-23 13:40:07,695 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:98.10 Median:93.00 stddev:11.90 (12.8%) stddev-sans-first:12.60 13:40:07 INFO - 2015-11-23 13:40:07,695 DEBUG : BROWSER_OUTPUT: Values: 96.0 94.0 93.0 93.0 93.0 93.0 102.0 131.0 93.0 93.0 13:40:07 INFO - 2015-11-23 13:40:07,695 DEBUG : BROWSER_OUTPUT: 13:40:07 INFO - 2015-11-23 13:40:07,695 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:86.00 Median:86.00 stddev:1.33 (1.6%) stddev-sans-first:1.36 13:40:07 INFO - 2015-11-23 13:40:07,695 DEBUG : BROWSER_OUTPUT: Values: 85.0 85.0 86.0 86.0 87.0 86.0 84.0 88.0 85.0 88.0 13:40:07 INFO - 2015-11-23 13:40:07,695 DEBUG : BROWSER_OUTPUT: 13:40:07 INFO - 2015-11-23 13:40:07,695 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.50 stddev:1.55 (2.8%) stddev-sans-first:1.50 13:40:07 INFO - 2015-11-23 13:40:07,695 DEBUG : BROWSER_OUTPUT: Values: 56.0 55.0 56.0 54.0 52.0 53.0 54.0 54.0 56.0 52.0 13:40:07 INFO - 2015-11-23 13:40:07,696 DEBUG : BROWSER_OUTPUT: 13:40:07 INFO - 2015-11-23 13:40:07,696 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:67.00 stddev:2.37 (3.5%) stddev-sans-first:2.33 13:40:07 INFO - 2015-11-23 13:40:07,696 DEBUG : BROWSER_OUTPUT: Values: 63.0 63.0 64.0 62.0 65.0 68.0 68.0 67.0 68.0 67.0 13:40:07 INFO - 2015-11-23 13:40:07,696 DEBUG : BROWSER_OUTPUT: 13:40:07 INFO - 2015-11-23 13:40:07,696 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:82.00 stddev:10.04 (12.2%) stddev-sans-first:10.49 13:40:07 INFO - 2015-11-23 13:40:07,696 DEBUG : BROWSER_OUTPUT: Values: 79.0 81.0 82.0 82.0 82.0 82.0 90.0 109.0 83.0 70.0 13:40:07 INFO - 2015-11-23 13:40:07,696 DEBUG : BROWSER_OUTPUT: 13:40:07 INFO - 2015-11-23 13:40:07,696 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.00 Median:124.00 stddev:5.27 (4.3%) stddev-sans-first:5.39 13:40:07 INFO - 2015-11-23 13:40:07,696 DEBUG : BROWSER_OUTPUT: Values: 119.0 118.0 120.0 117.0 129.0 130.0 120.0 120.0 128.0 129.0 13:40:07 INFO - 2015-11-23 13:40:07,696 DEBUG : BROWSER_OUTPUT: 13:40:07 INFO - 2015-11-23 13:40:07,696 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.90 Median:140.50 stddev:19.25 (13.7%) stddev-sans-first:19.30 13:40:07 INFO - 2015-11-23 13:40:07,696 DEBUG : BROWSER_OUTPUT: Values: 122.0 146.0 135.0 133.0 164.0 125.0 119.0 169.0 163.0 123.0 13:40:07 INFO - 2015-11-23 13:40:07,696 DEBUG : BROWSER_OUTPUT: 13:40:07 INFO - 2015-11-23 13:40:07,696 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:65.50 stddev:7.94 (12.1%) stddev-sans-first:8.20 13:40:07 INFO - 2015-11-23 13:40:07,697 DEBUG : BROWSER_OUTPUT: Values: 64.0 66.0 65.0 64.0 65.0 65.0 64.0 74.0 76.0 88.0 13:40:07 INFO - 2015-11-23 13:40:07,697 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:40:07 INFO - 2015-11-23 13:40:07,697 DEBUG : BROWSER_OUTPUT: 13:40:08 INFO - 2015-11-23 13:40:08,341 INFO : Browser exited with error code: 0 13:40:08 INFO - 2015-11-23 13:40:08,389 INFO : Completed test kraken (00:00:56) 13:40:08 INFO - 2015-11-23 13:40:08,389 INFO : Starting test v8_7 13:40:08 INFO - 2015-11-23 13:40:08,389 DEBUG : operating with platform_type : mac_ 13:40:08 INFO - 2015-11-23 13:40:08,390 INFO : Initialising browser for v8_7 test... 13:40:08 INFO - 2015-11-23 13:40:08,403 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/tmpA25JVD/profile http://localhost:58417/getInfo.html 13:40:10 INFO - 2015-11-23 13:40:10,276 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:40:10 INFO - 2015-11-23 13:40:10,276 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:40:10 INFO - 2015-11-23 13:40:10,277 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 13:40:10 INFO - 2015-11-23 13:40:10,277 DEBUG : BROWSER_OUTPUT: __metrics 13:40:10 INFO - 2015-11-23 13:40:10,295 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:40:10 INFO - 2015-11-23 13:40:10,940 INFO : Browser initialized. 13:40:10 INFO - 2015-11-23 13:40:10,941 INFO : Running cycle 1/1 for v8_7 test... 13:40:10 INFO - 2015-11-23 13:40:10,941 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/tmpA25JVD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:40:22 INFO - 2015-11-23 13:40:22,726 DEBUG : BROWSER_OUTPUT: RSS: Main: 225521664 13:40:22 INFO - 2015-11-23 13:40:22,726 DEBUG : BROWSER_OUTPUT: 13:40:44 INFO - 2015-11-23 13:40:44,270 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58417/tests/v8_7/run.html (next: http://localhost:58417/tests/v8_7/run.html) 13:40:44 INFO - 2015-11-23 13:40:44,526 DEBUG : BROWSER_OUTPUT: RSS: Main: 750321664 13:40:44 INFO - 2015-11-23 13:40:44,526 DEBUG : BROWSER_OUTPUT: 13:40:44 INFO - 2015-11-23 13:40:44,526 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:40:44 INFO - 2015-11-23 13:40:44,526 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:40:44 INFO - 2015-11-23 13:40:44,527 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:40:44 INFO - 2015-11-23 13:40:44,527 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:40:44 INFO - 2015-11-23 13:40:44,527 DEBUG : BROWSER_OUTPUT: |0;Richards;173.13019390581718 13:40:44 INFO - 2015-11-23 13:40:44,527 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;160.77170418006432 13:40:44 INFO - 2015-11-23 13:40:44,527 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.2516056967328 13:40:44 INFO - 2015-11-23 13:40:44,527 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4596.3302752293575 13:40:44 INFO - 2015-11-23 13:40:44,527 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1721.170395869191 13:40:44 INFO - 2015-11-23 13:40:44,527 DEBUG : BROWSER_OUTPUT: |5;Earley;791.7656373713381 13:40:44 INFO - 2015-11-23 13:40:44,527 DEBUG : BROWSER_OUTPUT: |6;Boyer;12987.012987012988 13:40:44 INFO - 2015-11-23 13:40:44,527 DEBUG : BROWSER_OUTPUT: |7;RegExp;28250 13:40:44 INFO - 2015-11-23 13:40:44,527 DEBUG : BROWSER_OUTPUT: |8;Splay;718.2620502376103 13:40:44 INFO - 2015-11-23 13:40:44,527 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4882.926829268293 13:40:44 INFO - 2015-11-23 13:40:44,527 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:40:44 INFO - 2015-11-23 13:40:44,527 DEBUG : BROWSER_OUTPUT: __startTimestamp1448314844521__endTimestamp 13:40:44 INFO - 2015-11-23 13:40:44,527 DEBUG : BROWSER_OUTPUT: 13:40:44 INFO - 2015-11-23 13:40:44,528 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:40:44 INFO - 2015-11-23 13:40:44,528 DEBUG : BROWSER_OUTPUT: Number of tests: 10 13:40:44 INFO - 2015-11-23 13:40:44,528 DEBUG : BROWSER_OUTPUT: 13:40:44 INFO - 2015-11-23 13:40:44,528 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:173.13 Median:173.13 stddev:0.00 (0.0%) 13:40:44 INFO - 2015-11-23 13:40:44,528 DEBUG : BROWSER_OUTPUT: Values: 173.1 13:40:44 INFO - 2015-11-23 13:40:44,528 DEBUG : BROWSER_OUTPUT: 13:40:44 INFO - 2015-11-23 13:40:44,528 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:160.77 Median:160.77 stddev:0.00 (0.0%) 13:40:44 INFO - 2015-11-23 13:40:44,528 DEBUG : BROWSER_OUTPUT: Values: 160.8 13:40:44 INFO - 2015-11-23 13:40:44,528 DEBUG : BROWSER_OUTPUT: 13:40:44 INFO - 2015-11-23 13:40:44,528 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.25 Median:279.25 stddev:0.00 (0.0%) 13:40:44 INFO - 2015-11-23 13:40:44,528 DEBUG : BROWSER_OUTPUT: Values: 279.3 13:40:44 INFO - 2015-11-23 13:40:44,528 DEBUG : BROWSER_OUTPUT: 13:40:44 INFO - 2015-11-23 13:40:44,528 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4596.33 Median:4596.33 stddev:0.00 (0.0%) 13:40:44 INFO - 2015-11-23 13:40:44,528 DEBUG : BROWSER_OUTPUT: Values: 4596.3 13:40:44 INFO - 2015-11-23 13:40:44,529 DEBUG : BROWSER_OUTPUT: 13:40:44 INFO - 2015-11-23 13:40:44,529 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1721.17 Median:1721.17 stddev:0.00 (0.0%) 13:40:44 INFO - 2015-11-23 13:40:44,529 DEBUG : BROWSER_OUTPUT: Values: 1721.2 13:40:44 INFO - 2015-11-23 13:40:44,529 DEBUG : BROWSER_OUTPUT: 13:40:44 INFO - 2015-11-23 13:40:44,529 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:791.77 Median:791.77 stddev:0.00 (0.0%) 13:40:44 INFO - 2015-11-23 13:40:44,529 DEBUG : BROWSER_OUTPUT: Values: 791.8 13:40:44 INFO - 2015-11-23 13:40:44,529 DEBUG : BROWSER_OUTPUT: 13:40:44 INFO - 2015-11-23 13:40:44,529 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12987.01 Median:12987.01 stddev:0.00 (0.0%) 13:40:44 INFO - 2015-11-23 13:40:44,529 DEBUG : BROWSER_OUTPUT: Values: 12987.0 13:40:44 INFO - 2015-11-23 13:40:44,529 DEBUG : BROWSER_OUTPUT: 13:40:44 INFO - 2015-11-23 13:40:44,529 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:28250.00 Median:28250.00 stddev:0.00 (0.0%) 13:40:44 INFO - 2015-11-23 13:40:44,529 DEBUG : BROWSER_OUTPUT: Values: 28250.0 13:40:44 INFO - 2015-11-23 13:40:44,529 DEBUG : BROWSER_OUTPUT: 13:40:44 INFO - 2015-11-23 13:40:44,529 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:718.26 Median:718.26 stddev:0.00 (0.0%) 13:40:44 INFO - 2015-11-23 13:40:44,529 DEBUG : BROWSER_OUTPUT: Values: 718.3 13:40:44 INFO - 2015-11-23 13:40:44,530 DEBUG : BROWSER_OUTPUT: 13:40:44 INFO - 2015-11-23 13:40:44,530 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4882.93 Median:4882.93 stddev:0.00 (0.0%) 13:40:44 INFO - 2015-11-23 13:40:44,530 DEBUG : BROWSER_OUTPUT: Values: 4882.9 13:40:44 INFO - 2015-11-23 13:40:44,530 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:40:44 INFO - 2015-11-23 13:40:44,530 DEBUG : BROWSER_OUTPUT: 13:40:45 INFO - 2015-11-23 13:40:45,145 INFO : Browser exited with error code: 0 13:40:45 INFO - 2015-11-23 13:40:45,163 INFO : Completed test v8_7 (00:00:36) 13:40:45 INFO - 2015-11-23 13:40:45,530 INFO : Completed test suite (00:20:07) 13:40:45 INFO - 2015-11-23 13:40:45,530 DEBUG : Working with test: dromaeo_css 13:40:45 INFO - 2015-11-23 13:40:45,530 DEBUG : Generating results file: dromaeo_css 13:40:45 INFO - 2015-11-23 13:40:45,531 DEBUG : Working with test: kraken 13:40:45 INFO - 2015-11-23 13:40:45,531 DEBUG : Generating results file: kraken 13:40:45 INFO - 2015-11-23 13:40:45,532 INFO : javascript benchmark 13:40:45 INFO - 2015-11-23 13:40:45,532 DEBUG : Working with test: v8_7 13:40:45 INFO - 2015-11-23 13:40:45,532 DEBUG : Generating results file: v8_7 13:40:45 INFO - 2015-11-23 13:40:45,532 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:40:45 INFO - 2015-11-23 13:40:45,990 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 13:40:45 INFO - 2015-11-23 13:40:45,990 DEBUG : process_Request line: dromaeo_css 7541.80 graph.html#tests=[[72,64,59]] 13:40:45 INFO - 2015-11-23 13:40:45,991 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:40:46 INFO - 2015-11-23 13:40:46,091 DEBUG : process_Request line: kraken 1420.50 graph.html#tests=[[232,64,59]] 13:40:46 INFO - 2015-11-23 13:40:46,092 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:40:46 INFO - 2015-11-23 13:40:46,191 DEBUG : process_Request line: v8_7 19944.17 graph.html#tests=[[230,64,59]] 13:40:46 INFO - 2015-11-23 13:40:46,192 INFO : javascript benchmark 13:40:46 INFO - 2015-11-23 13:40:46,194 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3034.3021105145817, 3406.1314364836962, 3422.760406771527, 3459.066052165914, 3482.686558209761, 5582.27430434043, 5712.171735098408, 5716.22830917826, 5727.112297593874, 5765.077587585987, 5704.201411802351, 5724.62789918655, 5741.655500669963, 5758.798442054518, 5782.161586569945, 5142.408623008365, 5169.844904652848, 5214.348206474191, 5228.503292187236, 5282.471752824706, 5272.209168624699, 5274.156135018397, 5280.075986702331, 5286.471352864722, 5294.52349288564, 5244.029854476915, 5252.238425428311, 5264.236685680574, 5270.525652691257, 5281.102212623863, 5210.1403268460845, 5235.188545775411, 5235.764390602432, 5245.213218017289, 5251.894962100756, 5054.1660625996665, 5067.366579177603, 5178.792848286064, 5184.611154163453, 5202.973985130088, 5622.409646987048, 5663.037283661746, 5679.318481782171, 5697.344805347397, 5723.170140329629, 5347.716548028484, 6284.622922624657, 6289.496840252815, 6298.0, 6300.621962682254, 6063.104361084514, 6176.783812566584, 6194.535409844235, 6199.473044791198, 6285.308616052231, 5867.6772777497645, 5871.735771890275, 5903.055511118243, 5926.733297001645, 5939.5248380129915, 6235.937640623626, 6296.401841825019, 6301.590396624205, 6304.338044505353, 6311.053341998645, 5960.552958528127, 6039.607425517327, 6109.755609775648, 6123.112148738408, 6132.7345309381235, 6267.71795269214, 6283.5287353448675, 6283.748650053946, 6290.119383286344, 6316.652584107918, 6133.478654314344, 6196.969015154986, 6199.442050215503, 6215.9378406216265, 6221.346758590374, 6049.818505444844, 6094.725737341831, 6159.784407545714, 6168.414000669929, 6168.691565421801, 4955.578775804097, 4962.503749625081, 4966.453690094087, 4983.401991761012, 4986.426560945465, 4431.578999995059, 4436.822527098944, 4459.799309031101, 4465.508794032654, 4467.754273514923, 5481.068218402881, 5569.498745112959, 5606.439356064442, 5620.803271885465, 5621.4659607337235, 6155.984262596711, 6276.623402595859, 6279.560430769893, 6282.403171698681, 6287.46556542699, 4385.3641222022625, 5546.140348245947, 5646.153077038395, 5673.461021202979, 5703.287089113861, 5322.121849894724, 5419.864503387447, 5421.891562168735, 5431.755570999315, 5447.992121457543, 6309.33751956038, 6317.368263173646, 6322.525810564226, 6331.556791024584, 6334.429901308997, 5199.688018718889, 6117.632942023492, 6202.069689546604, 6339.366063393623, 6350.7459701611415, 6219.533534984985, 6330.272018717907, 6348.873022539616, 6350.269718982191, 6360.522960777867, 6151.72317245716, 6186.1648677427975, 6192.287886893065, 6200.968995154995, 6216.658083805434, 6082.330943596289, 6181.196444462371, 6188.907166392598, 6303.432691057827, 6350.523710721622, 6000.609960352563, 6088.208532890873, 6105.929529384197, 6121.644743077476, 6127.078295984317, 6010.669413182317, 6101.792799924424, 6104.982978023337, 6109.877802443837, 6137.140800287874, 5694.4590263924865, 5963.970180149072, 5977.222961015214, 5986.4013598639785, 5993.31076926159, 6032.638041717511, 6050.576459647782, 6063.848403789941, 6116.571839971337, 6150.10823430609, 6000.549958753199, 6009.699515024318, 6017.969910150421, 6039.667818270037, 6041.546883983631], "unit": "ms", "name": "dojo.html", "value": 5690.74169408337}, {"lowerIsBetter": false, "replicates": [562.8817948230871, 575.9020966435705, 615.8583525789065, 627.4165026525333, 630.9936900630994, 30211.99999999997, 32529.51205731916, 32574.348513029727, 32712.67287327126, 40682.98292542688, 43697.78151109248, 43968.56031439685, 44030.0, 44096.55903440973, 44170.7791461043, 9620.951895240532, 9811.65659201928, 9812.067853553901, 9818.165455936254, 9828.852567211497, 8863.0, 8924.46453212806, 8938.955305223497, 8939.284857211407, 9650.131488166064, 8739.95630021849, 11765.0, 11818.940905295462, 11853.70365740859, 11863.110266729987, 11606.303621782678, 11676.007539359165, 11689.0, 11689.064874809996, 11695.47370368327, 8737.213650771397, 8880.911190888073, 11515.712107197387, 11677.357745324003, 11685.065194784396, 32013.519797203062, 42846.357304640456, 43169.92075198114, 43181.35227971583, 43204.13591728179, 2734.4804487147576, 3115.8130512169114, 3139.3250451152885, 3189.2186414328407, 3768.1898391845884, 24485.510289794103, 25329.49341013188, 28007.0, 28317.479191438844, 28485.57271640927, 2713.1513302391973, 2795.217339145043, 2855.1862719125156, 2870.3828676834582, 2977.598024266718, 448439.0, 450727.0, 452191.0, 453515.4648453506, 454249.0, 63533.0, 63935.68032159809, 63945.68027159834, 63964.0, 63970.68014659897, 67255.66372168108, 67314.0, 67319.3268067313, 67370.66314668494, 67408.0, 15835.524934251991, 16177.919110404608, 16192.352305907867, 16192.838071619133, 16195.757063644054, 12219.327936963375, 12276.508939642494, 12278.877211227951, 12290.262584244974, 12297.200681955645, 17368.784185107175, 17563.473095807145, 19836.900815495832, 20172.899135504227, 20299.391018269474, 6322.747090116344, 6789.080695301068, 6792.08306878575, 6813.0121132435515, 7977.3618110551015, 868.900076491199, 909.5588639509832, 992.5632721602472, 1036.7719101797593, 1091.6233899304727, 25700.0, 28219.43561128766, 28523.429531409256, 28528.0, 29110.563341549892, 925.7687275923006, 980.9509524523745, 1048.3814549415881, 1074.8656417947757, 1213.648042067808, 13552.322383880766, 14093.802026827629, 14170.85829141716, 14770.0, 14983.550493485212, 467475.0, 520527.0, 520654.0, 523969.0, 524813.0, 49486.0, 51085.0, 56685.433145668016, 58357.708211458674, 58613.0, 1421.9360128794021, 1428.9642758930902, 1439.165284135199, 1451.0, 1453.5857280674957, 24464.6330305042, 27540.89836406521, 28797.424051519272, 33186.004419867444, 33852.32295354128, 55740.0, 58923.41076589351, 59046.0, 59107.81784364203, 59223.703881480316, 459149.0, 477832.0, 477862.0, 478705.0, 479108.0, 44387.112257754015, 46502.767486163706, 46740.6248281452, 46858.531414685414, 46925.76537117293, 47503.0, 47786.76106619445, 47840.80397990078, 49268.50731492639, 49342.519724408325, 39161.02097447587, 39248.0, 39835.80082099571, 39939.60060399475, 40538.59461405466, 38366.0, 38672.41991370075, 39080.919480468496, 39219.41170882496, 39418.40872386974, 38846.4173037399, 38868.80565597154, 38908.0, 39074.60925390823, 39281.607183927794, 33824.57808414571, 34242.82878585591, 34819.47770783491, 35176.648233517335, 35182.0, 19506.219751209792, 22475.21336753206, 22630.0, 26323.0, 26393.472130557664], "unit": "ms", "name": "ext.html", "value": 20105.373251988836}, {"lowerIsBetter": false, "replicates": [355.74564186606574, 357.3282229408711, 362.7279540344741, 362.8095249993753, 368.3682484539015, 16173.83826161738, 16904.323827046905, 19512.512187195327, 20721.896390518046, 21495.462613434673, 9562.760930976729, 11213.775724485506, 11227.60703375382, 19624.803751962478, 20050.0, 5083.26292687561, 5224.294720212761, 5225.399079105894, 5225.712585807779, 5227.660202086871, 3939.5666476687543, 4036.031352475399, 4050.291199040171, 4051.149258655671, 5166.018456493273, 4042.2117687051036, 4074.8166332515107, 5646.265985421889, 5829.8251052468495, 5841.123831425299, 5153.2270159476, 5803.274590676145, 6318.620882747027, 6322.134970183807, 6332.841678958017, 5531.032069387841, 5531.534143451948, 5533.253010843525, 5533.667979921218, 5538.778448862041, 25146.371340716447, 25147.24558263255, 25180.24459266225, 25655.615165772342, 25853.74146258532, 2005.2981456490259, 2113.619548481273, 2135.2206444647745, 2177.880216588087, 2252.842301038928, 9646.083622055894, 9827.262955278382, 13645.38595763193, 14339.0, 14603.0, 1758.9824101758948, 1772.8758986870923, 1804.9187786549637, 1842.7880793708762, 1897.468708761549, 79520.0, 82159.0, 83282.75075873866, 83408.0, 84407.57796210979, 9001.594928228114, 10880.455977201109, 11090.390028548507, 11097.667069987914, 11171.497282622302, 11078.279911805706, 13093.036044593196, 13120.671983200496, 13159.53941612039, 13159.802602960963, 8185.3451723861945, 8243.05204901432, 8258.628361723737, 8315.210055044761, 8333.374996875258, 8290.212429819157, 8324.916750832414, 8330.416870818985, 8379.664813407395, 8394.286485648789, 4268.807903644343, 4275.722078064916, 4285.400043993781, 4290.528041915387, 4305.590968858016, 1504.7893294938717, 1716.313474610166, 1763.9118044097743, 1768.9734653980202, 1790.3196785221533, 756.670848181043, 884.3544212724747, 893.3478560650761, 928.8420968435382, 964.8215080210183, 19458.027098645012, 19963.900180499004, 20078.89960550217, 20757.0, 20957.26649567258, 786.732510946281, 839.1664213692978, 901.8511945528915, 950.2967803825258, 1051.295631926611, 5990.251218597676, 6158.661273629993, 6163.476104531165, 6177.351378105234, 10206.693799186036, 803542.0, 803578.9821050857, 805881.0, 809208.0, 817255.0, 100040.0, 118954.0, 124410.9999999982, 124823.0, 125943.0, 486.13468026912153, 495.8710735208872, 499.4431209201714, 499.62528103922784, 499.73763774018204, 10886.67339979802, 16984.915075424542, 18148.0, 18760.0, 19300.420987370402, 52774.0, 53133.20300195423, 53180.46819531755, 53841.0, 55100.25545018683, 53904.0, 71548.0, 72136.0, 72222.0, 72510.63744681243, 8232.382571307297, 9950.601975920883, 10153.39079655223, 10167.898321016695, 10170.440625765654, 16199.595010124842, 20034.499137521678, 20180.29368972079, 20311.9844007802, 20715.58568828585, 15198.0, 15928.884978051425, 16117.758233626739, 16519.587010324838, 16525.752113718063, 15045.946783725472, 15437.305321260346, 15601.375944962529, 15661.765073523678, 15738.763918541461, 15896.602584935006, 16190.67618647644, 16398.426055088014, 16441.17794110266, 16459.012459252484, 9515.381500202464, 9638.469884156439, 9770.120689138012, 9809.950950245204, 9835.311528192959, 10038.0, 10125.189984801345, 14179.00746947745, 15700.842991569938, 16233.269502872636], "unit": "ms", "name": "jquery.html", "value": 9333.226498212865}, {"lowerIsBetter": false, "replicates": [1387.1676993803712, 1436.0737324425752, 1559.2203898050968, 1908.8260719657405, 1925.7303977443155, 7613.657385417656, 7867.2132786721295, 8287.502749835006, 8468.237858592725, 8477.279431248337, 8159.102498725136, 8285.130061343563, 8310.667573297076, 8325.08424073353, 8334.70828521002, 2112.1234687604624, 2161.254367243306, 2349.566764273796, 2368.490774483486, 2371.288613415977, 2172.2831465616387, 2172.8370372222066, 2182.0289970962926, 2329.033451117784, 2381.1903952656094, 2332.8483648562874, 2335.8131349492087, 2336.4392545788974, 2339.7192336919593, 2341.1454818991115, 2285.611446054175, 2341.274204996448, 2347.823913206499, 2348.16640092768, 2354.399628094842, 2131.690904818808, 2167.707359506462, 2172.0, 2282.7717228277206, 2367.9408014799596, 7967.800804979922, 8349.95825020877, 8350.290225330855, 8361.456505327134, 8361.540115293656, 5034.194528875362, 5079.568236699885, 5090.160123579605, 5096.464871188546, 5125.410577783566, 3183.5065564837487, 3390.9152271193416, 3471.7916924984584, 3562.340966921128, 3580.8925732228076, 1031.6079889641962, 1052.552665117322, 1053.3311347294523, 1057.2229411382705, 1077.94610269487, 10980.066694330992, 10980.560777568888, 10989.0, 10993.395363255018, 11015.284006539629, 4554.63562914966, 4617.168909596237, 4654.790534425959, 4660.277656963176, 4676.95323046772, 9598.42409455435, 9600.903990960001, 9604.0, 9628.085331893459, 9647.903520964841, 5168.069747445421, 5168.58651307902, 5169.276301317818, 5173.663711858717, 5176.767045482962, 4701.989072349461, 4704.694194877322, 4719.551642593948, 4720.315554244684, 4721.386219791405, 3747.4004159334377, 3822.6559609635265, 3823.2162406706557, 3827.2919509890203, 3858.151206734514, 1257.9308138052495, 1257.9308138052495, 1264.5194825966073, 1265.544404014554, 1282.6857419932176, 1368.2201145347058, 1382.9585112446644, 1402.1166665000985, 1402.5161319344809, 1405.1147776900486, 7671.041119860018, 7808.843823123506, 7817.8827317590285, 7821.0, 7832.569208693577, 494.51290478878275, 500.9974950125299, 507.1024287011968, 508.72274610337456, 509.95410413063, 5866.765329386777, 6028.457438830526, 6158.507319414436, 6217.222847144107, 6235.033569796688, 8965.327600429864, 9643.27675424346, 9652.0, 9749.512524373753, 9750.26872984529, 9553.283503737108, 9575.521223938915, 9610.087041731025, 9935.403875767333, 9980.700578982642, 7730.226977302337, 7811.140774514685, 7811.687532498637, 7883.487573307717, 7892.802679933047, 7657.34912532441, 7782.688692452465, 7793.103793063643, 7793.649285782267, 7807.063152421746, 8770.12298770118, 8942.642294308414, 9038.683646072619, 9043.366964312436, 9045.547722613712, 9132.634694612141, 9364.765880853032, 9374.062593740571, 9434.81130377375, 9450.574724137568, 7273.272672732684, 7290.234525374972, 7321.963390183015, 7368.1526624438875, 7382.926170738224, 7899.723509677134, 7914.525128492309, 7963.323117535075, 7964.761057168294, 7986.201379861967, 7326.0, 7407.0, 7437.367823734827, 7550.131734850563, 7574.5076570022775, 6916.377526022481, 6998.125234345707, 7300.598467084149, 7360.96319518399, 7465.6267186641535, 7392.852142957003, 7450.552966822008, 7459.627018648937, 7468.290512401313, 7477.289657482531, 6765.86468270622, 6788.083608712958, 6805.353491418307, 6807.251202367636, 6826.385625293748, 6773.390394864289, 6897.55165914214, 6909.032735416945, 6909.550879192836, 6914.585124892523], "unit": "ms", "name": "mootools.html", "value": 4647.444792765836}, {"lowerIsBetter": false, "replicates": [318.4411358066593, 325.3184578308443, 328.09936723693465, 332.8136243703526, 333.73301358912863, 6825.522213445055, 6827.2148702899185, 6882.690278937441, 6927.896081558781, 6939.930600694004, 6802.115724955749, 6807.897881531781, 6829.248782633918, 6841.5552989055805, 6882.346177113166, 3586.9016625274244, 4032.4354590357375, 4869.902601947959, 4982.17794063979, 4989.800407983686, 4958.181899986516, 4988.351514303154, 5006.374203224597, 5050.84847454577, 5093.236014597803, 4927.0, 4939.061578300111, 4955.653104282702, 4967.850964471072, 4969.726665033421, 4707.693999889996, 4803.471618122004, 4813.494583068762, 4950.306957026001, 4955.876103097416, 3453.4819777033395, 4191.643710284599, 4231.978840105779, 4246.426732391118, 4262.87211383659, 6528.77149299777, 6544.738210471575, 6549.443297319734, 6552.508561857832, 6579.572327798678, 5637.323521177444, 5684.8294551163535, 5817.0, 5825.883482330372, 5951.809638072403, 7184.856302873965, 7249.202587715347, 7326.780196594111, 7354.0, 7365.815854603624, 3987.9202415951518, 4796.0, 4797.7601119943865, 4797.784099715521, 4818.975905120487, 7472.364848987788, 7810.882836757453, 7817.491863028885, 7817.570033648147, 7825.256600622932, 4893.877653058702, 4901.436334821541, 4909.852704418873, 4911.582515486224, 4915.26271059344, 4972.041635227034, 4993.375828021497, 5013.24801279811, 5016.0, 5018.84943451697, 5911.852203694942, 5913.438223368773, 5916.26046744157, 5916.408359164049, 5932.555058370639, 7191.228164262225, 7282.271772822675, 7369.336759691653, 7372.189059203483, 7395.963020184865, 1713.7172366559628, 1734.7051001329805, 1736.600581866178, 1736.6092629158338, 1741.5384922995415, 1113.8997490225918, 1123.1744667669257, 1138.584416687903, 1143.7426579019655, 1144.753877916252, 6851.554648947902, 6855.0, 6861.877845580249, 6870.7595234166565, 6881.8967715484305, 6210.875782484415, 7645.847083058419, 7657.0811502620045, 7669.156392796788, 7700.537967721954, 5574.0, 6677.632730199885, 6826.0, 6853.588784672836, 6946.79159625212, 3942.8619998300496, 4019.1760689058674, 4032.1330913853662, 4056.756594604274, 4113.506379234511, 6489.669617728355, 7756.573388463576, 7810.101838288556, 7855.332296754726, 7890.8816367754525, 8042.03495580534, 8049.678012879536, 8053.0, 8060.274575288252, 8070.596470176468, 7008.369246767816, 7564.697412103455, 7784.766457006185, 8018.0, 8026.277635012877, 7754.88367674474, 7755.689772409266, 7755.922440775746, 7759.262870027338, 7769.0, 7375.557466552024, 7577.848443030998, 7579.848403032019, 7596.240375962359, 7618.847623047619, 7995.720149794729, 8004.319632831274, 8013.2387423194705, 8014.8397032057865, 8023.277904988579, 4713.175194340908, 4761.785719642694, 4769.737664428351, 4771.976140119277, 4777.402824646919, 7452.776416707507, 7682.692692292246, 7684.731034413769, 7701.807454813675, 7727.574983375968, 5967.8209653710455, 6009.278886533644, 7378.0, 7389.630518474162, 7389.8522029558035, 7121.216666166821, 7389.298016688406, 7391.519551229153, 7397.334239918433, 7406.888896666446, 6063.090536419572, 7193.712251509881, 7207.387372073433, 7218.458615603956, 7228.060352154186, 7387.519811212254, 7393.963030184815, 7399.223081576357, 7399.8150046249275, 7407.851842963219, 6999.650017499002, 7215.314545118205, 7227.0, 7242.891356629761, 7264.455165862687], "unit": "ms", "name": "prototype.html", "value": 5325.845685747002}, {"lowerIsBetter": false, "replicates": [683.8392977650251, 716.6524235745666, 739.3272122368644, 766.0539234045956, 776.3323541754089, 14937.701245975088, 15055.171965541904, 15490.302936367862, 15498.225088745547, 15559.766603500928, 14243.85756142441, 14372.209528475929, 14372.49696260631, 14374.856251437483, 14383.280835958212, 778.0740918307224, 781.0783275734631, 784.4038530716639, 952.1668540027458, 984.5963155106408, 961.942283462991, 969.9854502182473, 975.5268694683073, 977.1010670183413, 979.118793086221, 934.8784657994452, 1009.9545520451597, 1015.8019186258682, 1021.9744506387325, 1024.0015984415172, 803.4777394693438, 803.7468197517793, 807.7738233294657, 992.151710287708, 1001.8497225416173, 749.3667850666233, 750.8798592225272, 751.5415596486139, 751.8796992481177, 751.8834580640009, 14969.476068337664, 15063.849361506464, 15086.39654413822, 15118.941674082818, 15127.319270632737, 12013.0, 12401.25592464455, 12633.620991370273, 12829.61511154667, 13087.0, 10158.339707918962, 11141.944290278578, 11301.717457063556, 11335.263207891461, 11760.000399965927, 3493.7205023598303, 3523.5067090607336, 3526.2066035142143, 3540.4689296605457, 3561.465780133001, 73467.63266183635, 73536.26463735348, 73887.63056184685, 74701.0, 83694.0, 9362.531873406302, 9382.0, 9397.624095036259, 9403.670871519464, 9439.433633981984, 20578.691319630216, 20783.58432831335, 20815.895920520605, 20827.479313017295, 20871.852048137498, 6122.326544080148, 7072.292770722886, 7141.89287160693, 7187.209406965229, 7382.667779949915, 3807.124361396839, 3896.5129358830145, 3942.586028467027, 3977.0455090778005, 3988.3818008208773, 3474.062003259106, 3508.1405055760993, 3515.8945231643092, 3519.6128425873135, 3520.841562129659, 621.3568956130383, 630.5775130662468, 632.3676323676324, 652.3085529338916, 653.9280679125293, 511.6597462687346, 513.2634669249638, 524.6878107526015, 540.4676393752151, 543.6873797566415, 8534.274716288728, 8656.956715216384, 8711.607977640895, 8814.294856411472, 8899.377043607015, 504.92678561608363, 552.9060059789765, 554.203704623327, 564.4553006348893, 638.6806596701649, 3819.1788765415013, 4140.399642051885, 4340.197063543254, 4434.778261086933, 4492.685512014127, 83916.58041709752, 86094.0, 88454.55772721225, 89141.55429222812, 89391.0, 70885.64557177284, 71057.0, 71074.0, 71088.0, 72118.19704507325, 69806.9528957066, 70442.0, 70551.64724176346, 70935.2906470939, 71288.0, 8762.561871906506, 8943.418677785923, 8946.418482798597, 8972.68595599177, 9049.0, 34633.480497793054, 51074.74462627663, 51223.97552049013, 53779.731101344245, 53803.0, 75499.62250188933, 75557.0, 76521.46957060939, 76665.23334766804, 78167.60916195382, 11496.080313575061, 11779.293242405483, 11942.880571194524, 11945.223560468541, 12157.635270941886, 11715.0, 12084.516619335129, 12482.126251162696, 12935.0, 12948.741025179255, 11584.710382240512, 11612.477438515456, 12014.819777703167, 12053.457594408097, 12454.937725311678, 12008.039356851606, 12029.639110826689, 12038.277703337828, 12105.455254513392, 12410.0, 6912.896306555305, 10937.398443085707, 11377.488013039267, 11499.425028748696, 12166.270023798601, 9573.090556397132, 9768.36505627132, 9846.704598862045, 10044.799104017733, 10539.209559282932, 9603.90396096058, 9787.608495660093, 9789.259007477918, 9823.705288841345, 10011.949940250252], "unit": "ms", "name": "yui.html", "value": 6961.421166289264}], "name": "dromaeo_css", "value": 7541.799385130708}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 109.0, 104.0, 109.0, 109.0, 110.0, 113.0, 155.0, 148.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 117.5}, {"lowerIsBetter": true, "replicates": [153.0, 126.0, 177.0, 169.0, 141.0, 168.0, 140.0, 118.0, 158.0, 146.0], "unit": "ms", "name": "audio-beat-detection", "value": 149.6}, {"lowerIsBetter": true, "replicates": [184.0, 186.0, 180.0, 183.0, 184.0, 182.0, 185.0, 186.0, 182.0, 180.0], "unit": "ms", "name": "audio-dft", "value": 183.2}, {"lowerIsBetter": true, "replicates": [66.0, 65.0, 77.0, 73.0, 55.0, 56.0, 56.0, 74.0, 73.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 66.6}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 116.0, 74.0, 75.0, 75.0, 114.0, 78.0, 75.0, 110.0], "unit": "ms", "name": "audio-oscillator", "value": 88.8}, {"lowerIsBetter": true, "replicates": [86.0, 86.0, 87.0, 85.0, 85.0, 84.0, 90.0, 131.0, 131.0, 85.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 95.0}, {"lowerIsBetter": true, "replicates": [96.0, 94.0, 93.0, 93.0, 93.0, 93.0, 102.0, 131.0, 93.0, 93.0], "unit": "ms", "name": "imaging-darkroom", "value": 98.1}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 86.0, 86.0, 87.0, 86.0, 84.0, 88.0, 85.0, 88.0], "unit": "ms", "name": "imaging-desaturate", "value": 86.0}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 56.0, 54.0, 52.0, 53.0, 54.0, 54.0, 56.0, 52.0], "unit": "ms", "name": "json-parse-financial", "value": 54.2}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 64.0, 62.0, 65.0, 68.0, 68.0, 67.0, 68.0, 67.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 65.5}, {"lowerIsBetter": true, "replicates": [79.0, 81.0, 82.0, 82.0, 82.0, 82.0, 90.0, 109.0, 83.0, 70.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.0}, {"lowerIsBetter": true, "replicates": [119.0, 118.0, 120.0, 117.0, 129.0, 130.0, 120.0, 120.0, 128.0, 129.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 123.0}, {"lowerIsBetter": true, "replicates": [122.0, 146.0, 135.0, 133.0, 164.0, 125.0, 119.0, 169.0, 163.0, 123.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 139.9}, {"lowerIsBetter": true, "replicates": [64.0, 66.0, 65.0, 64.0, 65.0, 65.0, 64.0, 74.0, 76.0, 88.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.1}], "name": "kraken", "value": 1420.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [173.13019390581718], "unit": "score", "name": "Richards", "value": 203.90435199999996}, {"lowerIsBetter": false, "replicates": [160.77170418006432], "unit": "score", "name": "DeltaBlue", "value": 411.25395999999995}, {"lowerIsBetter": false, "replicates": [279.2516056967328], "unit": "score", "name": "Encrypt", "value": 953.1941609999996}, {"lowerIsBetter": false, "replicates": [4596.3302752293575], "unit": "score", "name": "Decrypt", "value": 57.9116347305389}, {"lowerIsBetter": false, "replicates": [1721.170395869191], "unit": "score", "name": "RayTrace", "value": 429.9336090000001}, {"lowerIsBetter": false, "replicates": [791.7656373713381], "unit": "score", "name": "Earley", "value": 841.7427690000002}, {"lowerIsBetter": false, "replicates": [12987.012987012988], "unit": "score", "name": "Boyer", "value": 51.31765100000003}, {"lowerIsBetter": false, "replicates": [28250.0], "unit": "score", "name": "RegExp", "value": 32.24725663716814}, {"lowerIsBetter": false, "replicates": [718.2620502376103], "unit": "score", "name": "Splay", "value": 113.45580623818523}, {"lowerIsBetter": false, "replicates": [4882.926829268293], "unit": "score", "name": "NavierStokes", "value": 303.91608391608383}], "name": "v8_7", "value": 19944.173178644305}]} 13:40:46 INFO - RETURN: dromaeo_css: 7541.80 13:40:46 INFO - RETURN: kraken: 1420.50 13:40:46 INFO - RETURN: v8_7: 19944.17 13:40:46 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,59]]", "result": "19944.17"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1420.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7541.80"}}} 13:40:46 INFO - Return code: 0 13:40:46 INFO - # TBPL SUCCESS # 13:40:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:40:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:40:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:40:46 INFO - 2015-11-23 13:40:46.280 screenresolution[3761:62011] starting screenresolution argv=screenresolution get 13:40:46 INFO - 2015-11-23 13:40:46.283 screenresolution[3761:62011] Display 0: 1600x1200x32@60 13:40:46 INFO - 2015-11-23 13:40:46.289 screenresolution[3762:62014] starting screenresolution argv=screenresolution list 13:40:46 INFO - Available Modes on Display 0 13:40:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:40:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:40:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:40:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:40:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:40:46 INFO - Intel Iris: 13:40:46 INFO - Chipset Model: Intel Iris 13:40:46 INFO - Type: GPU 13:40:46 INFO - Bus: Built-In 13:40:46 INFO - VRAM (Dynamic, Max): 1536 MB 13:40:46 INFO - Vendor: Intel (0x8086) 13:40:46 INFO - Device ID: 0x0a2e 13:40:46 INFO - Revision ID: 0x0009 13:40:46 INFO - Displays: 13:40:46 INFO - Display: 13:40:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:40:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:40:46 INFO - Display Serial Number: 1600x1200 60 13:40:46 INFO - Main Display: Yes 13:40:46 INFO - Mirror: Off 13:40:46 INFO - Online: Yes 13:40:46 INFO - Rotation: Supported 13:40:46 INFO - Return code: 0 13:40:46 INFO - Running post-action listener: _resource_record_post_action 13:40:46 INFO - Running post-run listener: _resource_record_post_run 13:40:47 INFO - Total resource usage - Wall time: 1239s; CPU: 53.0%; Read bytes: 737280; Write bytes: 691643904; Read time: 13; Write time: 2502 13:40:47 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 336914944; Write bytes: 338143232; Read time: 25931; Write time: 669 13:40:47 INFO - run-tests - Wall time: 1209s; CPU: 53.0%; Read bytes: 737280; Write bytes: 343068160; Read time: 13; Write time: 1798 13:40:47 INFO - Running post-run listener: _upload_blobber_files 13:40:47 INFO - Blob upload gear active. 13:40:47 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 13:40:47 INFO - Copying logs to upload dir... 13:40:47 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1281.987311 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2015-11-23 13:40:47.678228) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 13:40:47.681487) ========= 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.hLCjwmXX3D/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.W3CAEKRSBN/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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/qu-D8N0BTSiWI5kAqH51Pw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009652 build_url: 'https://queue.taskcluster.net/v1/task/qu-D8N0BTSiWI5kAqH51Pw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 13:40:47.707915) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 13:40:47.708301) ========= 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.hLCjwmXX3D/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.W3CAEKRSBN/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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.005295 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 13:40:47.760873) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 13:40:47.761544) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 13:40:47.761922) ========= ========= Total master_lag: 0.21 =========