builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0053 starttime: 1447985983.71 results: success (0) buildid: 20151119151436 builduid: 2a97a7e5a25741fda4b38bd805072f7b revision: c43d530f61c2672dd059a64c1ad04279f9650dd5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 18:19:43.709076) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 18:19:43.709567) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 18:19:43.709915) ========= 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.PmqZNiNNRo/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.kVuIaOPwdE/Listeners TMPDIR=/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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.005639 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 18:19:43.730405) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 18:19:43.730745) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 18:19:43.745119) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 18:19:43.745426) ========= 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.PmqZNiNNRo/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.kVuIaOPwdE/Listeners TMPDIR=/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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.005212 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 18:19:43.793722) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 18:19:43.794040) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 18:19:43.794420) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 18:19:43.794690) ========= 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.PmqZNiNNRo/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.kVuIaOPwdE/Listeners TMPDIR=/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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-19 18:19:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 6.49M=0.002s 2015-11-19 18:19:43 (6.49 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.161767 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 18:19:43.969771) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 18:19:43.970145) ========= 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.PmqZNiNNRo/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.kVuIaOPwdE/Listeners TMPDIR=/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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.019773 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 18:19:44.019010) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-19 18:19:44.019441) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c43d530f61c2672dd059a64c1ad04279f9650dd5 --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 c43d530f61c2672dd059a64c1ad04279f9650dd5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.PmqZNiNNRo/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.kVuIaOPwdE/Listeners TMPDIR=/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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-19 18:19:44,100 truncating revision to first 12 chars 2015-11-19 18:19:44,101 Setting DEBUG logging. 2015-11-19 18:19:44,101 attempt 1/10 2015-11-19 18:19:44,101 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c43d530f61c2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-19 18:19:45,068 unpacking tar archive at: fx-team-c43d530f61c2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.208246 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-19 18:19:45.242143) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 18:19:45.242484) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 18:19:45.254371) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 18:19:45.254719) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 18:19:45.255218) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2015-11-19 18:19:45.255533) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.PmqZNiNNRo/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.kVuIaOPwdE/Listeners TMPDIR=/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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 18:19:45 INFO - MultiFileLogger online at 20151119 18:19:45 in /builds/slave/test 18:19:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 18:19:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:19:45 INFO - {'append_to_log': False, 18:19:45 INFO - 'base_work_dir': '/builds/slave/test', 18:19:45 INFO - 'blob_upload_branch': 'Fx-Team', 18:19:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:19:45 INFO - 'branch': 'Fx-Team', 18:19:45 INFO - 'buildbot_json_path': 'buildprops.json', 18:19:45 INFO - 'config_files': ('talos/mac_config.py',), 18:19:45 INFO - 'default_actions': ('clobber', 18:19:45 INFO - 'read-buildbot-config', 18:19:45 INFO - 'download-and-extract', 18:19:45 INFO - 'populate-webroot', 18:19:45 INFO - 'create-virtualenv', 18:19:45 INFO - 'install', 18:19:45 INFO - 'run-tests'), 18:19:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:19:45 INFO - 'download_minidump_stackwalk': True, 18:19:45 INFO - 'download_symbols': 'ondemand', 18:19:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:19:45 INFO - 'tooltool.py': '/tools/tooltool.py', 18:19:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:19:45 INFO - '/tools/misc-python/virtualenv.py')}, 18:19:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:19:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:19:45 INFO - 'installer_path': 'installer.exe', 18:19:45 INFO - 'log_level': 'info', 18:19:45 INFO - 'log_name': 'talos', 18:19:45 INFO - 'log_to_console': True, 18:19:45 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:19:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:19:45 INFO - 'opt_config_files': (), 18:19:45 INFO - 'pip_index': False, 18:19:45 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:19:45 INFO - 'cmd': ('bash', 18:19:45 INFO - '-c', 18:19:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:19:45 INFO - 'enabled': True, 18:19:45 INFO - 'halt_on_failure': False, 18:19:45 INFO - 'name': 'check_screen_resolution'},), 18:19:45 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:19:45 INFO - 'cmd': ('bash', 18:19:45 INFO - '-c', 18:19:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:19:45 INFO - 'enabled': True, 18:19:45 INFO - 'halt_on_failure': False, 18:19:45 INFO - 'name': 'check_screen_resolution'},), 18:19:45 INFO - 'run_cmd_checks_enabled': True, 18:19:45 INFO - 'sps_profile': False, 18:19:45 INFO - 'sps_profile_interval': 0, 18:19:45 INFO - 'suite': 'dromaeojs-e10s', 18:19:45 INFO - 'system_bits': '64', 18:19:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:19:45 INFO - 'title': 't-yosemite-r7-0053', 18:19:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:19:45 INFO - 'use_talos_json': True, 18:19:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:19:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:19:45 INFO - 'work_dir': 'build'} 18:19:45 INFO - ##### 18:19:45 INFO - ##### Running clobber step. 18:19:45 INFO - ##### 18:19:45 INFO - Running pre-action listener: _resource_record_pre_action 18:19:45 INFO - Running main action method: clobber 18:19:45 INFO - rmtree: /builds/slave/test/build 18:19:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:19:46 INFO - Running post-action listener: _resource_record_post_action 18:19:46 INFO - ##### 18:19:46 INFO - ##### Running read-buildbot-config step. 18:19:46 INFO - ##### 18:19:46 INFO - Running pre-action listener: _resource_record_pre_action 18:19:46 INFO - Running main action method: read_buildbot_config 18:19:46 INFO - Using buildbot properties: 18:19:46 INFO - { 18:19:46 INFO - "properties": { 18:19:46 INFO - "buildnumber": 7, 18:19:46 INFO - "product": "firefox", 18:19:46 INFO - "script_repo_revision": "production", 18:19:46 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 18:19:46 INFO - "repository": "", 18:19:46 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 18:19:46 INFO - "buildid": "20151119151436", 18:19:46 INFO - "slavename": "t-yosemite-r7-0053", 18:19:46 INFO - "pgo_build": "False", 18:19:46 INFO - "basedir": "/builds/slave/test", 18:19:46 INFO - "project": "", 18:19:46 INFO - "platform": "yosemite_r7", 18:19:46 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 18:19:46 INFO - "slavebuilddir": "test", 18:19:46 INFO - "scheduler": "tests-fx-team-macosx64-talos", 18:19:46 INFO - "branch": "fx-team", 18:19:46 INFO - "repo_path": "integration/fx-team", 18:19:46 INFO - "stage_platform": "macosx64", 18:19:46 INFO - "builduid": "2a97a7e5a25741fda4b38bd805072f7b", 18:19:46 INFO - "revision": "c43d530f61c2672dd059a64c1ad04279f9650dd5" 18:19:46 INFO - }, 18:19:46 INFO - "sourcestamp": { 18:19:46 INFO - "repository": "", 18:19:46 INFO - "hasPatch": false, 18:19:46 INFO - "project": "", 18:19:46 INFO - "branch": "fx-team-macosx64-talos", 18:19:46 INFO - "changes": [ 18:19:46 INFO - { 18:19:46 INFO - "category": null, 18:19:46 INFO - "files": [ 18:19:46 INFO - { 18:19:46 INFO - "url": null, 18:19:46 INFO - "name": "https://queue.taskcluster.net/v1/task/Lgx9hOx6RGqYCwFaLn5K_w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 18:19:46 INFO - } 18:19:46 INFO - ], 18:19:46 INFO - "repository": "", 18:19:46 INFO - "rev": "c43d530f61c2672dd059a64c1ad04279f9650dd5", 18:19:46 INFO - "who": "jdolske@mozilla.com", 18:19:46 INFO - "when": 1447982391, 18:19:46 INFO - "number": 6686275, 18:19:46 INFO - "comments": "Bug 1215948 - \"Hey Cortana\" searches in Windows 10 default to Bing. r=jaws", 18:19:46 INFO - "project": "", 18:19:46 INFO - "at": "Thu 19 Nov 2015 17:19:51", 18:19:46 INFO - "branch": "fx-team-macosx64-talos", 18:19:46 INFO - "revlink": "", 18:19:46 INFO - "properties": [ 18:19:46 INFO - [ 18:19:46 INFO - "buildid", 18:19:46 INFO - "20151119151436", 18:19:46 INFO - "Change" 18:19:46 INFO - ], 18:19:46 INFO - [ 18:19:46 INFO - "builduid", 18:19:46 INFO - "2a97a7e5a25741fda4b38bd805072f7b", 18:19:46 INFO - "Change" 18:19:46 INFO - ], 18:19:46 INFO - [ 18:19:46 INFO - "pgo_build", 18:19:46 INFO - "False", 18:19:46 INFO - "Change" 18:19:46 INFO - ] 18:19:46 INFO - ], 18:19:46 INFO - "revision": "c43d530f61c2672dd059a64c1ad04279f9650dd5" 18:19:46 INFO - } 18:19:46 INFO - ], 18:19:46 INFO - "revision": "c43d530f61c2672dd059a64c1ad04279f9650dd5" 18:19:46 INFO - } 18:19:46 INFO - } 18:19:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/Lgx9hOx6RGqYCwFaLn5K_w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 18:19:46 INFO - Running post-action listener: _resource_record_post_action 18:19:46 INFO - ##### 18:19:46 INFO - ##### Running download-and-extract step. 18:19:46 INFO - ##### 18:19:46 INFO - Running pre-action listener: _resource_record_pre_action 18:19:46 INFO - Running main action method: download_and_extract 18:19:46 INFO - mkdir: /builds/slave/test/build/tests 18:19:46 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')]} 18:19:46 INFO - https://queue.taskcluster.net/v1/task/Lgx9hOx6RGqYCwFaLn5K_w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:19:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lgx9hOx6RGqYCwFaLn5K_w/artifacts/public/build/test_packages.json 18:19:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lgx9hOx6RGqYCwFaLn5K_w/artifacts/public/build/test_packages.json 18:19:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lgx9hOx6RGqYCwFaLn5K_w/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 18:19:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lgx9hOx6RGqYCwFaLn5K_w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 18:19:47 INFO - Downloaded 1149 bytes. 18:19:47 INFO - Reading from file /builds/slave/test/build/test_packages.json 18:19:47 INFO - Using the following test package requirements: 18:19:47 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 18:19:47 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:19:47 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 18:19:47 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:19:47 INFO - u'jsshell-mac.zip'], 18:19:47 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:19:47 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 18:19:47 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 18:19:47 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:19:47 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 18:19:47 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:19:47 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 18:19:47 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:19:47 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 18:19:47 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 18:19:47 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:19:47 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 18:19:47 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:19:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:19:47 INFO - https://queue.taskcluster.net/v1/task/Lgx9hOx6RGqYCwFaLn5K_w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:19:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lgx9hOx6RGqYCwFaLn5K_w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:19:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lgx9hOx6RGqYCwFaLn5K_w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:19:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lgx9hOx6RGqYCwFaLn5K_w/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 18:19:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lgx9hOx6RGqYCwFaLn5K_w/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 18:19:48 INFO - Downloaded 17525132 bytes. 18:19:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 18:19:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:19:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 18:19:51 INFO - Return code: 0 18:19:51 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip', u'firefox-45.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 18:19:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:19:51 INFO - https://queue.taskcluster.net/v1/task/Lgx9hOx6RGqYCwFaLn5K_w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:19:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lgx9hOx6RGqYCwFaLn5K_w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:19:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lgx9hOx6RGqYCwFaLn5K_w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:19:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lgx9hOx6RGqYCwFaLn5K_w/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 18:19:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lgx9hOx6RGqYCwFaLn5K_w/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 18:19:52 INFO - Downloaded 17525132 bytes. 18:19:52 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 18:19:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:19:52 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 18:19:56 INFO - Return code: 0 18: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')]} 18:19:56 INFO - https://queue.taskcluster.net/v1/task/Lgx9hOx6RGqYCwFaLn5K_w/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 18:19:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lgx9hOx6RGqYCwFaLn5K_w/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 18:19:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lgx9hOx6RGqYCwFaLn5K_w/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 18:19:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lgx9hOx6RGqYCwFaLn5K_w/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 18:19:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lgx9hOx6RGqYCwFaLn5K_w/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 18:19:57 INFO - Downloaded 11130997 bytes. 18:19:57 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 18:19:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 18:19:57 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 18:19:57 INFO - Return code: 0 18:19:57 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')]} 18:19:57 INFO - https://queue.taskcluster.net/v1/task/Lgx9hOx6RGqYCwFaLn5K_w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 18:19:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lgx9hOx6RGqYCwFaLn5K_w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 18:19:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lgx9hOx6RGqYCwFaLn5K_w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 18:19:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lgx9hOx6RGqYCwFaLn5K_w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 18:19:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lgx9hOx6RGqYCwFaLn5K_w/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 18:20:06 INFO - Downloaded 109416846 bytes. 18:20:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Lgx9hOx6RGqYCwFaLn5K_w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 18:20:06 INFO - mkdir: /builds/slave/test/properties 18:20:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:20:06 INFO - Writing to file /builds/slave/test/properties/build_url 18:20:06 INFO - Contents: 18:20:06 INFO - build_url:https://queue.taskcluster.net/v1/task/Lgx9hOx6RGqYCwFaLn5K_w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 18:20:06 INFO - Running post-action listener: _resource_record_post_action 18:20:06 INFO - Running post-action listener: set_extra_try_arguments 18:20:06 INFO - ##### 18:20:06 INFO - ##### Running populate-webroot step. 18:20:06 INFO - ##### 18:20:06 INFO - Running pre-action listener: _resource_record_pre_action 18:20:06 INFO - Running main action method: populate_webroot 18:20:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:20:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:20:06 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 18:20:06 INFO - '../fennec_ids.txt'], 18:20:06 INFO - 'tests': ['tcheck2']}, 18:20:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:20:06 INFO - '--tppagecycles', 18:20:06 INFO - '7'], 18:20:06 INFO - 'tests': ['tsvgm']}}, 18:20:06 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:20:06 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:20:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:20:06 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:20:06 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:20:06 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:20:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:20:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:20:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:20:06 INFO - 'talos_options': ['--e10s'], 18:20:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:20:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:20:06 INFO - 'tests': ['damp', 'tps']}, 18:20:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:20:06 INFO - 'talos_options': ['--e10s'], 18:20:06 INFO - 'tests': ['damp', 'tps']}, 18:20:06 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:20:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:20:06 INFO - 'other': {'tests': ['a11yr', 18:20:06 INFO - 'ts_paint', 18:20:06 INFO - 'tpaint', 18:20:06 INFO - 'sessionrestore', 18:20:06 INFO - 'sessionrestore_no_auto_restore']}, 18:20:06 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:20:06 INFO - 'tests': ['a11yr', 18:20:06 INFO - 'ts_paint', 18:20:06 INFO - 'tpaint', 18:20:06 INFO - 'sessionrestore', 18:20:06 INFO - 'sessionrestore_no_auto_restore']}, 18:20:06 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:20:06 INFO - 'tests': ['a11yr', 18:20:06 INFO - 'ts_paint', 18:20:06 INFO - 'tpaint', 18:20:06 INFO - 'sessionrestore', 18:20:06 INFO - 'sessionrestore_no_auto_restore']}, 18:20:06 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:20:06 INFO - 'tests': ['a11yr', 18:20:06 INFO - 'ts_paint', 18:20:06 INFO - 'tpaint', 18:20:06 INFO - 'sessionrestore', 18:20:06 INFO - 'sessionrestore_no_auto_restore']}, 18:20:06 INFO - 'other_l64': {'tests': ['a11yr', 18:20:06 INFO - 'ts_paint', 18:20:06 INFO - 'tpaint', 18:20:06 INFO - 'sessionrestore', 18:20:06 INFO - 'sessionrestore_no_auto_restore']}, 18:20:06 INFO - 'other_nol64': {'tests': ['a11yr', 18:20:06 INFO - 'ts_paint', 18:20:06 INFO - 'tpaint', 18:20:06 INFO - 'sessionrestore', 18:20:06 INFO - 'sessionrestore_no_auto_restore']}, 18:20:06 INFO - 'svgr': {'tests': ['tsvgx', 18:20:06 INFO - 'tsvgr_opacity', 18:20:06 INFO - 'tart', 18:20:06 INFO - 'tscrollx', 18:20:06 INFO - 'cart']}, 18:20:06 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:20:06 INFO - 'tests': ['tsvgx', 18:20:06 INFO - 'tsvgr_opacity', 18:20:06 INFO - 'tart', 18:20:06 INFO - 'tscrollx', 18:20:06 INFO - 'cart']}, 18:20:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:20:06 INFO - 'tests': ['tp5o']}, 18:20:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:20:06 INFO - 'talos_options': ['--e10s'], 18:20:06 INFO - 'tests': ['tp5o']}, 18:20:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:20:06 INFO - 'talos_options': ['--xperf_path', 18:20:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:20:06 INFO - 'tests': ['tp5n']}, 18:20:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:20:06 INFO - 'talos_options': ['--e10s', 18:20:06 INFO - '--xperf_path', 18:20:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:20:06 INFO - 'tests': ['tp5n']}}, 18:20:06 INFO - 'talos.zip': {'path': '', 18:20:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:20:06 INFO - Running post-action listener: _resource_record_post_action 18:20:06 INFO - ##### 18:20:06 INFO - ##### Running create-virtualenv step. 18:20:06 INFO - ##### 18:20:06 INFO - Running pre-action listener: _resource_record_pre_action 18:20:06 INFO - Running main action method: create_virtualenv 18:20:06 INFO - Creating virtualenv /builds/slave/test/build/venv 18:20:06 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:20:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:20:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:20:06 INFO - Using real prefix '/tools/python27' 18:20:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:20:07 INFO - Installing distribute.............................................................................................................................................................................................done. 18:20:10 INFO - Installing pip.................done. 18:20:10 INFO - Return code: 0 18:20:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:20:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:20:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:20:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x103c87490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c64228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a38c87170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103bab9f0>, '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 0x10390adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b9e8c8>, '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.PmqZNiNNRo/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.kVuIaOPwdE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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 18:20:10 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 18:20:10 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 18:20:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PmqZNiNNRo/Render', 18:20:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:20:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:20:10 INFO - 'HOME': '/Users/cltbld', 18:20:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:20:10 INFO - 'LOGNAME': 'cltbld', 18:20:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:10 INFO - 'MOZ_NO_REMOTE': '1', 18:20:10 INFO - 'NO_EM_RESTART': '1', 18:20:10 INFO - 'PAGER': '/bin/cat', 18:20:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:20:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:10 INFO - 'PWD': '/builds/slave/test', 18:20:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:20:10 INFO - 'SHELL': '/bin/bash', 18:20:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kVuIaOPwdE/Listeners', 18:20:10 INFO - 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', 18:20:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:20:10 INFO - 'USER': 'cltbld', 18:20:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:20:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:20:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:10 INFO - 'XPC_FLAGS': '0x0', 18:20:10 INFO - 'XPC_SERVICE_NAME': '0', 18:20:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:20:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:10 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 18:20:10 INFO - Cleaning up... 18:20:10 INFO - Return code: 0 18:20:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:20:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:20:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:20:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x103c87490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c64228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a38c87170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103bab9f0>, '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 0x10390adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b9e8c8>, '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.PmqZNiNNRo/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.kVuIaOPwdE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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 18:20:10 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 18:20:10 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 18:20:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PmqZNiNNRo/Render', 18:20:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:20:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:20:10 INFO - 'HOME': '/Users/cltbld', 18:20:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:20:10 INFO - 'LOGNAME': 'cltbld', 18:20:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:10 INFO - 'MOZ_NO_REMOTE': '1', 18:20:10 INFO - 'NO_EM_RESTART': '1', 18:20:10 INFO - 'PAGER': '/bin/cat', 18:20:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:20:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:10 INFO - 'PWD': '/builds/slave/test', 18:20:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:20:10 INFO - 'SHELL': '/bin/bash', 18:20:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kVuIaOPwdE/Listeners', 18:20:10 INFO - 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', 18:20:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:20:10 INFO - 'USER': 'cltbld', 18:20:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:20:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:20:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:10 INFO - 'XPC_FLAGS': '0x0', 18:20:10 INFO - 'XPC_SERVICE_NAME': '0', 18:20:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:20:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:10 INFO - Downloading/unpacking psutil>=0.7.1 18:20:10 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 18:20:10 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 18:20:10 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 18:20:10 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 18:20:10 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 18:20:10 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 18:20:13 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 18:20:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:20:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:20:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:20:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:20:13 INFO - Installing collected packages: psutil 18:20:13 INFO - Running setup.py install for psutil 18:20:13 INFO - building 'psutil._psutil_osx' extension 18:20:13 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 18:20:13 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 18:20:13 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 18:20:13 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 18:20:13 INFO - building 'psutil._psutil_posix' extension 18:20:13 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 18:20:13 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:20:13 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:20:13 INFO - ^ 18:20:13 INFO - 1 warning generated. 18:20:13 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 18:20:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:20:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:20:14 INFO - Successfully installed psutil 18:20:14 INFO - Cleaning up... 18:20:14 INFO - Return code: 0 18:20:14 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:20:14 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')]} 18:20:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:14 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')]} 18:20:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:14 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 0x103c87490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c64228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a38c87170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103bab9f0>, '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 0x10390adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b9e8c8>, '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.PmqZNiNNRo/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.kVuIaOPwdE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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 18:20:14 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 18:20:14 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 18:20:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PmqZNiNNRo/Render', 18:20:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:20:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:20:14 INFO - 'HOME': '/Users/cltbld', 18:20:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:20:14 INFO - 'LOGNAME': 'cltbld', 18:20:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:14 INFO - 'MOZ_NO_REMOTE': '1', 18:20:14 INFO - 'NO_EM_RESTART': '1', 18:20:14 INFO - 'PAGER': '/bin/cat', 18:20:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:20:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:14 INFO - 'PWD': '/builds/slave/test', 18:20:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:20:14 INFO - 'SHELL': '/bin/bash', 18:20:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kVuIaOPwdE/Listeners', 18:20:14 INFO - 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', 18:20:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:20:14 INFO - 'USER': 'cltbld', 18:20:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:20:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:20:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:14 INFO - 'XPC_FLAGS': '0x0', 18:20:14 INFO - 'XPC_SERVICE_NAME': '0', 18:20:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:20:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:14 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:20:14 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 18:20:14 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 18:20:14 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 18:20:14 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 18:20:14 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 18:20:14 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 18:20:16 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:20:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:20:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:20:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:20:16 INFO - Installing collected packages: mozsystemmonitor 18:20:16 INFO - Running setup.py install for mozsystemmonitor 18:20:16 INFO - Successfully installed mozsystemmonitor 18:20:16 INFO - Cleaning up... 18:20:16 INFO - Return code: 0 18:20:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:20:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:20:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:20:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:16 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 0x103c87490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c64228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a38c87170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103bab9f0>, '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 0x10390adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b9e8c8>, '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.PmqZNiNNRo/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.kVuIaOPwdE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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 18:20:16 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 18:20:16 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 18:20:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PmqZNiNNRo/Render', 18:20:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:20:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:20:16 INFO - 'HOME': '/Users/cltbld', 18:20:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:20:16 INFO - 'LOGNAME': 'cltbld', 18:20:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:16 INFO - 'MOZ_NO_REMOTE': '1', 18:20:16 INFO - 'NO_EM_RESTART': '1', 18:20:16 INFO - 'PAGER': '/bin/cat', 18:20:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:20:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:16 INFO - 'PWD': '/builds/slave/test', 18:20:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:20:16 INFO - 'SHELL': '/bin/bash', 18:20:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kVuIaOPwdE/Listeners', 18:20:16 INFO - 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', 18:20:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:20:16 INFO - 'USER': 'cltbld', 18:20:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:20:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:20:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:16 INFO - 'XPC_FLAGS': '0x0', 18:20:16 INFO - 'XPC_SERVICE_NAME': '0', 18:20:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:20:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:16 INFO - Downloading/unpacking blobuploader==1.2.4 18:20:16 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 18:20:16 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 18:20:16 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 18:20:16 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 18:20:16 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 18:20:16 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 18:20:19 INFO - Downloading blobuploader-1.2.4.tar.gz 18:20:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:20:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:20:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:20:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:20:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:20:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:20:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:20:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:20:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:20:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:20:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:20 INFO - Downloading docopt-0.6.1.tar.gz 18:20:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:20:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:20:20 INFO - Installing collected packages: blobuploader, requests, docopt 18:20:20 INFO - Running setup.py install for blobuploader 18:20:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:20:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:20:20 INFO - Running setup.py install for requests 18:20:20 INFO - Running setup.py install for docopt 18:20:21 INFO - Successfully installed blobuploader requests docopt 18:20:21 INFO - Cleaning up... 18:20:21 INFO - Return code: 0 18:20:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:20:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:20:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:21 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 0x103c87490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c64228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a38c87170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103bab9f0>, '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 0x10390adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b9e8c8>, '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.PmqZNiNNRo/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.kVuIaOPwdE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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 18:20:21 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 18:20:21 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 18:20:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PmqZNiNNRo/Render', 18:20:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:20:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:20:21 INFO - 'HOME': '/Users/cltbld', 18:20:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:20:21 INFO - 'LOGNAME': 'cltbld', 18:20:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:21 INFO - 'MOZ_NO_REMOTE': '1', 18:20:21 INFO - 'NO_EM_RESTART': '1', 18:20:21 INFO - 'PAGER': '/bin/cat', 18:20:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:20:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:21 INFO - 'PWD': '/builds/slave/test', 18:20:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:20:21 INFO - 'SHELL': '/bin/bash', 18:20:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kVuIaOPwdE/Listeners', 18:20:21 INFO - 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', 18:20:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:20:21 INFO - 'USER': 'cltbld', 18:20:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:20:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:20:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:21 INFO - 'XPC_FLAGS': '0x0', 18:20:21 INFO - 'XPC_SERVICE_NAME': '0', 18:20:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:20:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:20:21 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-4YtL53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:20:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:20:21 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-0fDWFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:20:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:20:21 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-ROjArI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:20:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:20:21 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-Wk5lbi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:20:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:20:21 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-5cOAwt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:20:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:20:21 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-Awo2A6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:20:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:20:21 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-eT7G3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:20:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:20:22 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-iPN8yO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:20:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:20:22 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-4pj3Gq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:20:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:20:22 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-7p6Al_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:20:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:20:22 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-TXN0WS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:20:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:20:22 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-Yac97L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:20:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:20:22 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-ReoREn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:20:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:20:22 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-Fcv3x6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:20:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:20:22 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-OzWQrb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:20:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:20:22 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-ZywibN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:20:23 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-9Up6mZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:20:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:20:23 INFO - Running setup.py install for manifestparser 18:20:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:20:23 INFO - Running setup.py install for mozcrash 18:20:23 INFO - Running setup.py install for mozdebug 18:20:23 INFO - Running setup.py install for mozdevice 18:20:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:20:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:20:23 INFO - Running setup.py install for mozfile 18:20:23 INFO - Running setup.py install for mozhttpd 18:20:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:20:24 INFO - Running setup.py install for mozinfo 18:20:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:20:24 INFO - Running setup.py install for mozInstall 18:20:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:20:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:20:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:20:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:20:24 INFO - Running setup.py install for mozleak 18:20:24 INFO - Running setup.py install for mozlog 18:20:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:20:24 INFO - Running setup.py install for moznetwork 18:20:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:20:24 INFO - Running setup.py install for mozprocess 18:20:24 INFO - Running setup.py install for mozprofile 18:20:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:20:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:20:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:20:25 INFO - Running setup.py install for mozrunner 18:20:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:20:25 INFO - Running setup.py install for mozscreenshot 18:20:25 INFO - Running setup.py install for moztest 18:20:25 INFO - Running setup.py install for mozversion 18:20:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:20:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:20:25 INFO - Cleaning up... 18:20:25 INFO - Return code: 0 18:20:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:20:25 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')]} 18:20:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:25 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')]} 18:20:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:25 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 0x103c87490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c64228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a38c87170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103bab9f0>, '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 0x10390adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b9e8c8>, '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.PmqZNiNNRo/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.kVuIaOPwdE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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 18:20:25 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 18:20:25 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 18:20:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PmqZNiNNRo/Render', 18:20:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:20:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:20:25 INFO - 'HOME': '/Users/cltbld', 18:20:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:20:25 INFO - 'LOGNAME': 'cltbld', 18:20:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:25 INFO - 'MOZ_NO_REMOTE': '1', 18:20:25 INFO - 'NO_EM_RESTART': '1', 18:20:25 INFO - 'PAGER': '/bin/cat', 18:20:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:20:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:25 INFO - 'PWD': '/builds/slave/test', 18:20:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:20:25 INFO - 'SHELL': '/bin/bash', 18:20:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kVuIaOPwdE/Listeners', 18:20:25 INFO - 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', 18:20:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:20:25 INFO - 'USER': 'cltbld', 18:20:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:20:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:20:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:25 INFO - 'XPC_FLAGS': '0x0', 18:20:25 INFO - 'XPC_SERVICE_NAME': '0', 18:20:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:20:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:20:26 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-GJWxbo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:20:26 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)) 18:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:20:26 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-U3q17I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:20:26 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)) 18:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:20:26 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-wDPbZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:20:26 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)) 18:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:20:26 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-cy0iUY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:20:26 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)) 18:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:20:26 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-f4E0b7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:20:26 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)) 18:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:20:26 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-uvH0Oi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:20:26 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)) 18:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:20:26 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-3e460_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:20:26 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)) 18:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:20:26 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-2wpCpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:20:26 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)) 18:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:20:26 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-bAtc8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:20:26 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)) 18:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:20:26 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-ghsBGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:20:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:20:27 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-YJyivl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:20:27 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)) 18:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:20:27 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-PrbFtS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:20:27 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)) 18:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:20:27 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-MCsJk0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:20:27 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)) 18:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:20:27 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-0_YOqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:20:27 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)) 18:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:20:27 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-WXIE7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:20:27 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)) 18:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:20:27 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-dDSeOC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:20:27 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)) 18:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:20:27 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-l9BCqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:20:27 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)) 18:20:27 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)) 18:20:27 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)) 18:20:27 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)) 18:20:27 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)) 18:20:27 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)) 18:20:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:20:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:20:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:20:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:29 INFO - Downloading blessings-1.5.1.tar.gz 18:20:29 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 18:20:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:20:30 INFO - Installing collected packages: blessings 18:20:30 INFO - Running setup.py install for blessings 18:20:30 INFO - Successfully installed blessings 18:20:30 INFO - Cleaning up... 18:20:30 INFO - Return code: 0 18:20:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:20:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:20:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:20:30 INFO - Reading from file tmpfile_stdout 18:20:30 INFO - Current package versions: 18:20:30 INFO - blessings == 1.5.1 18:20:30 INFO - blobuploader == 1.2.4 18:20:30 INFO - docopt == 0.6.1 18:20:30 INFO - manifestparser == 1.1 18:20:30 INFO - mozInstall == 1.12 18:20:30 INFO - mozcrash == 0.16 18:20:30 INFO - mozdebug == 0.1 18:20:30 INFO - mozdevice == 0.47 18:20:30 INFO - mozfile == 1.2 18:20:30 INFO - mozhttpd == 0.7 18:20:30 INFO - mozinfo == 0.9 18:20:30 INFO - mozleak == 0.1 18:20:30 INFO - mozlog == 3.0 18:20:30 INFO - moznetwork == 0.27 18:20:30 INFO - mozprocess == 0.22 18:20:30 INFO - mozprofile == 0.27 18:20:30 INFO - mozrunner == 6.11 18:20:30 INFO - mozscreenshot == 0.1 18:20:30 INFO - mozsystemmonitor == 0.0 18:20:30 INFO - moztest == 0.7 18:20:30 INFO - mozversion == 1.4 18:20:30 INFO - psutil == 3.1.1 18:20:30 INFO - requests == 1.2.3 18:20:30 INFO - wsgiref == 0.1.2 18:20:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:20:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:20:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:20:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:30 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 0x103c87490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c64228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a38c87170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103bab9f0>, '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 0x10390adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b9e8c8>, '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.PmqZNiNNRo/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.kVuIaOPwdE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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 18:20:30 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 18:20:30 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 18:20:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PmqZNiNNRo/Render', 18:20:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:20:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:20:30 INFO - 'HOME': '/Users/cltbld', 18:20:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:20:30 INFO - 'LOGNAME': 'cltbld', 18:20:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:30 INFO - 'MOZ_NO_REMOTE': '1', 18:20:30 INFO - 'NO_EM_RESTART': '1', 18:20:30 INFO - 'PAGER': '/bin/cat', 18:20:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:20:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:30 INFO - 'PWD': '/builds/slave/test', 18:20:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:20:30 INFO - 'SHELL': '/bin/bash', 18:20:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kVuIaOPwdE/Listeners', 18:20:30 INFO - 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', 18:20:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:20:30 INFO - 'USER': 'cltbld', 18:20:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:20:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:20:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:30 INFO - 'XPC_FLAGS': '0x0', 18:20:30 INFO - 'XPC_SERVICE_NAME': '0', 18:20:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:20:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:30 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)) 18:20:30 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)) 18:20:30 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)) 18:20:30 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)) 18:20:30 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)) 18:20:30 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)) 18:20:30 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)) 18:20:30 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)) 18:20:30 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)) 18:20:30 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)) 18:20:30 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)) 18:20:30 INFO - Cleaning up... 18:20:30 INFO - Return code: 0 18:20:30 INFO - Running post-action listener: _resource_record_post_action 18:20:30 INFO - Running post-action listener: _start_resource_monitoring 18:20:30 INFO - Starting resource monitoring. 18:20:30 INFO - ##### 18:20:30 INFO - ##### Running install step. 18:20:30 INFO - ##### 18:20:30 INFO - Running pre-action listener: _resource_record_pre_action 18:20:30 INFO - Running main action method: install 18:20:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:20:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:20:31 INFO - Reading from file tmpfile_stdout 18:20:31 INFO - Detecting whether we're running mozinstall >=1.0... 18:20:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:20:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:20:31 INFO - Reading from file tmpfile_stdout 18:20:31 INFO - Output received: 18:20:31 INFO - Usage: mozinstall [options] installer 18:20:31 INFO - Options: 18:20:31 INFO - -h, --help show this help message and exit 18:20:31 INFO - -d DEST, --destination=DEST 18:20:31 INFO - Directory to install application into. [default: 18:20:31 INFO - "/builds/slave/test"] 18:20:31 INFO - --app=APP Application being installed. [default: firefox] 18:20:31 INFO - mkdir: /builds/slave/test/build/application 18:20:31 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'] 18:20:31 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 18:21:01 INFO - Reading from file tmpfile_stdout 18:21:01 INFO - Output received: 18:21:01 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:21:01 INFO - Running post-action listener: _resource_record_post_action 18:21:01 INFO - ##### 18:21:01 INFO - ##### Running run-tests step. 18:21:01 INFO - ##### 18:21:01 INFO - Running pre-action listener: _resource_record_pre_action 18:21:01 INFO - Running main action method: run_tests 18:21:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:21:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:21:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:21:01 INFO - 2015-11-19 18:21:01.602 screenresolution[1952:11779] starting screenresolution argv=screenresolution get 18:21:01 INFO - 2015-11-19 18:21:01.604 screenresolution[1952:11779] Display 0: 1600x1200x32@60 18:21:01 INFO - 2015-11-19 18:21:01.611 screenresolution[1953:11781] starting screenresolution argv=screenresolution list 18:21:01 INFO - Available Modes on Display 0 18:21:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:21:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:21:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:21:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:21:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:21:01 INFO - Intel Iris: 18:21:01 INFO - Chipset Model: Intel Iris 18:21:01 INFO - Type: GPU 18:21:01 INFO - Bus: Built-In 18:21:01 INFO - VRAM (Dynamic, Max): 1536 MB 18:21:01 INFO - Vendor: Intel (0x8086) 18:21:01 INFO - Device ID: 0x0a2e 18:21:01 INFO - Revision ID: 0x0009 18:21:01 INFO - Displays: 18:21:01 INFO - Display: 18:21:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:21:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:21:01 INFO - Display Serial Number: 1600x1200 60 18:21:01 INFO - Main Display: Yes 18:21:01 INFO - Mirror: Off 18:21:01 INFO - Online: Yes 18:21:01 INFO - Rotation: Supported 18:21:01 INFO - Return code: 0 18:21:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:21:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:21:01 INFO - Python 2.7.3 18:21:01 INFO - Return code: 0 18:21:01 INFO - grabbing minidump binary from tooltool 18:21: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')]} 18:21:01 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 0x103bab9f0>, '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 0x10390adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b9e8c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:21:01 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 18:21:01 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 18:21:01 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:21:01 INFO - Return code: 0 18:21:01 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:21:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:21:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:21:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:21:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:21:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Lgx9hOx6RGqYCwFaLn5K_w/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0053', '--webServer', 'localhost'] in /builds/slave/test/build 18:21:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Lgx9hOx6RGqYCwFaLn5K_w/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0053 --webServer localhost 18:21:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PmqZNiNNRo/Render', 18:21:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:21:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:21:01 INFO - 'HOME': '/Users/cltbld', 18:21:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:21:01 INFO - 'LOGNAME': 'cltbld', 18:21:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:21:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:21:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:01 INFO - 'MOZ_NO_REMOTE': '1', 18:21:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:21:01 INFO - 'NO_EM_RESTART': '1', 18:21:01 INFO - 'PAGER': '/bin/cat', 18:21:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:21:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:01 INFO - 'PWD': '/builds/slave/test', 18:21:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:21:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:21:01 INFO - 'SHELL': '/bin/bash', 18:21:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kVuIaOPwdE/Listeners', 18:21:01 INFO - 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', 18:21:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:21:01 INFO - 'USER': 'cltbld', 18:21:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:21:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:21:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:01 INFO - 'XPC_FLAGS': '0x0', 18:21:01 INFO - 'XPC_SERVICE_NAME': '0', 18:21:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:21:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Lgx9hOx6RGqYCwFaLn5K_w/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0053', '--webServer', 'localhost'] with output_timeout 3600 18:21:02 INFO - mozversion INFO | application_buildid: 20151119151436 18:21:02 INFO - mozversion INFO | application_changeset: c43d530f61c2672dd059a64c1ad04279f9650dd5 18:21:02 INFO - mozversion INFO | application_display_name: Nightly 18:21:02 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:21:02 INFO - mozversion INFO | application_name: Firefox 18:21:02 INFO - mozversion INFO | application_remotingname: firefox 18:21:02 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 18:21:02 INFO - mozversion INFO | application_vendor: Mozilla 18:21:02 INFO - mozversion INFO | application_version: 45.0a1 18:21:02 INFO - mozversion INFO | platform_buildid: 20151119151436 18:21:02 INFO - mozversion INFO | platform_changeset: c43d530f61c2672dd059a64c1ad04279f9650dd5 18:21:02 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 18:21:02 INFO - mozversion INFO | platform_version: 45.0a1 18:21:02 INFO - 2015-11-19 18:21:02,147 DEBUG : using testdate: 1447986062 18:21:02 INFO - 2015-11-19 18:21:02,147 DEBUG : actual date: 1447986062 18:21:02 INFO - 2015-11-19 18:21:02,226 INFO : starting webserver on 'localhost:49712' 18:21:02 INFO - 2015-11-19 18:21:02,227 INFO : Starting test suite t-yosemite-r7-0053.e 18:21:02 INFO - 2015-11-19 18:21:02,227 INFO : Starting test dromaeo_css 18:21:02 INFO - 2015-11-19 18:21:02,227 DEBUG : operating with platform_type : mac_ 18:21:02 INFO - 2015-11-19 18:21:02,228 INFO : Initialising browser for dromaeo_css test... 18:21:02 INFO - 2015-11-19 18:21:02,240 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/tmpajK67g/profile http://localhost:49712/getInfo.html 18:21:04 INFO - 2015-11-19 18:21:04,697 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:21:04 INFO - 2015-11-19 18:21:04,697 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:21:04 INFO - 2015-11-19 18:21:04,698 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 18:21:04 INFO - 2015-11-19 18:21:04,698 DEBUG : BROWSER_OUTPUT: __metrics 18:21:05 INFO - 2015-11-19 18:21:05,297 INFO : Browser initialized. 18:21:05 INFO - 2015-11-19 18:21:05,298 INFO : Running cycle 1/1 for dromaeo_css test... 18:21:05 INFO - 2015-11-19 18:21:05,298 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/tmpajK67g/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:21:17 INFO - 2015-11-19 18:21:17,285 DEBUG : BROWSER_OUTPUT: RSS: Main: 237154304 18:21:17 INFO - 2015-11-19 18:21:17,285 DEBUG : BROWSER_OUTPUT: 18:22:06 INFO - 2015-11-19 18:22:06,950 DEBUG : BROWSER_OUTPUT: 1447986126949 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] 18:24:18 INFO - 2015-11-19 18:24:18,036 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49712/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49712/tests/dromaeo/cssquery-ext.html) 18:24:19 INFO - 2015-11-19 18:24:19,322 DEBUG : BROWSER_OUTPUT: RSS: Main: 253624320 18:24:19 INFO - 2015-11-19 18:24:19,322 DEBUG : BROWSER_OUTPUT: 18:27:21 INFO - 2015-11-19 18:27:21,454 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49712/tests/dromaeo/cssquery-ext.html (next: http://localhost:49712/tests/dromaeo/cssquery-jquery.html) 18:27:22 INFO - 2015-11-19 18:27:22,055 DEBUG : BROWSER_OUTPUT: RSS: Main: 262938624 18:27:22 INFO - 2015-11-19 18:27:22,056 DEBUG : BROWSER_OUTPUT: 18:30:23 INFO - 2015-11-19 18:30:23,704 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49712/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49712/tests/dromaeo/cssquery-mootools.html) 18:30:24 INFO - 2015-11-19 18:30:24,298 DEBUG : BROWSER_OUTPUT: RSS: Main: 262942720 18:30:24 INFO - 2015-11-19 18:30:24,298 DEBUG : BROWSER_OUTPUT: 18:33:25 INFO - 2015-11-19 18:33:25,916 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49712/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49712/tests/dromaeo/cssquery-prototype.html) 18:33:26 INFO - 2015-11-19 18:33:26,505 DEBUG : BROWSER_OUTPUT: RSS: Main: 266166272 18:33:26 INFO - 2015-11-19 18:33:26,505 DEBUG : BROWSER_OUTPUT: 18:36:28 INFO - 2015-11-19 18:36:28,943 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49712/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49712/tests/dromaeo/cssquery-yui.html) 18:36:29 INFO - 2015-11-19 18:36:29,543 DEBUG : BROWSER_OUTPUT: RSS: Main: 268722176 18:36:29 INFO - 2015-11-19 18:36:29,543 DEBUG : BROWSER_OUTPUT: 18:39:31 INFO - 2015-11-19 18:39:31,393 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49712/tests/dromaeo/cssquery-yui.html (next: http://localhost:49712/tests/dromaeo/cssquery-dojo.html) 18:39:31 INFO - 2015-11-19 18:39:31,650 DEBUG : BROWSER_OUTPUT: RSS: Main: 271626240 18:39:31 INFO - 2015-11-19 18:39:31,650 DEBUG : BROWSER_OUTPUT: 18:39:31 INFO - 2015-11-19 18:39:31,650 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:39:31 INFO - 2015-11-19 18:39:31,650 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:39:31 INFO - 2015-11-19 18:39:31,650 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:39:31 INFO - 2015-11-19 18:39:31,651 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:39:31 INFO - 2015-11-19 18:39:31,652 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3454.3264063507618;3512.069301635067;3550.8579656813727;3576.2668652926154;3579.7315201359906;5834.212381328524;5901.05583106703;5932.614380065298;5958.285005799299;5982.132590774335;5716.485516303532;5804.564657650672;5846.976779063668;5861;5861.267341582302;5304.49607287308;5313.654612450197;5330.147176451768;5390.78436862527;5420.403755586883;4456.754878481682;5327.706976116312;5386.326709161355;5507.449255074501;5510.779568817243;5429.538489228401;5460.31746031746;5473.808416705416;5486.780528778844;5527.613067085305;4797.18447863864;5192.662476938987;5392.460753924615;5414.972925135349;5445.264889239961;5300.257963885059;5321.600879934021;5365.678059316453;5372.57019438444;5397.946020539784;5413.53984911283;5746.396628354046;5807.82576522705;5855.209546711182;5936.406359364029;5265.7893684252585;6127.342242870425;6209.87580248397;6325.936740632581;6347.047942808569;6322.178116844827;6348.365163483661;6372.044193370985;6374.298827129012;6392.232932048138;5992.49063829575;6045.153678485016;6061.121137435047;6064.181335519736;6067.696615169268;5875.941240587625;6262.749490020348;6319.115323854664;6346.492280617539;6482.708278127496;6288.591241569284;6301.905471417932;6315.778947736807;6321.336259692758;6325.114483972247;6337.936620633827;6362.331955144736;6378.617282963037;6389.7763578274535;6405.519586031066;6079.240094988127;6197.4732147767045;6255.280642726054;6265.906011409833;6266.467350275187;6254.74981000764;6270.090836828635;6283.905741413882;6327.272363678236;6335.746570137235;4922.33548470959;5065.164247899055;5070.569001634829;5073.213651883964;5113.079645663742;4467.7319360838455;4528.818847246139;4561.110583436198;4583.106294272585;4596.908061838812;6000.249968753906;6026.668533230627;6064.545159113084;6065.787697430657;6076.572005578685;6172.290186628506;6327.905081423783;6378.74485020594;6383.329750376237;6404.551681382259;5981.162637230791;6020.879582408327;6051.394860513913;6056.727447264883;6065.423784740443;5571.721413929287;5577.107662774018;5602;5603.8599035023635;5623.240862483594;6238.064290356483;6361.109444677842;6364.268109167505;6612.933870661328;6653.767118150841;6241.344658810759;6317.5893566918;6328.683565821782;6336.3030066693545;6355.3644635536075;5273.709945953009;5759.424057594207;6493.480521558358;6529.281779004401;6550.181227346582;6143.877122457615;6216.316205217513;6230.376962303733;6302.558820882494;6338.207724034496;6290.559660823881;6379.298277189413;6395.16862807832;6400.583962042452;6438.452731517874;5113.463086376026;6302.71637776292;6304.148939893055;6317.368263173646;6324.620522768649;6084.056971169476;6151.630902145886;6199.318075011655;6316.652584107918;6319.842003949938;6049.546284028627;6179.104029915727;6229.314775374796;6230.127782110418;6235.127082208585;5834.095715164156;6257.4994000480765;6266.843328916813;6295.898217811773;6345.2702939160745;6011.458968692838;6106.551676171979;6119.685352982247;6204.255489341127;6210.534209934182 18:39:31 INFO - 2015-11-19 18:39:31,656 DEBUG : BROWSER_OUTPUT: |1;ext.html;551.0907003444319;566.3289002532;572.5047833623915;584.010102875626;598.6378241164095;33959.49060764087;40565;41533;41610.79194604026;41659.16681666365;44510.554894451045;44725.552744472545;44895;44955.550444495544;45049.09901801962;9647.469389183592;9814.263930205227;9843.163331116864;9843.60625574976;9870.802583948316;9658.903410965871;9732.854007189897;9741.902580974205;9749.512524373753;9763.267754918374;9679.564419601134;9726.610935562605;9735.610575576968;9737.221022318234;9747.805043899118;9680.419174849496;9750.26872984529;9761.07269809367;9773.413595184276;9787.119159275699;9555.18780903624;9682.273829462749;9694.757631059209;9696.030396960317;9719.125278724949;41347;41383.58616413858;41593;41654.37518437226;41722.37416438756;3195.265089029513;3202.6637203093806;3247.561579186803;3386.271951530408;3678.098865777875;28686.713132868612;29056.564151537743;29673.554896676567;30051.849740751375;30213.827548107573;2821.1818572613915;2827.3073097091346;2845.8434786086755;2895.4064416794718;2955.275957390453;465045;465227;471552;472320.6383968092;473358;57727.134092988636;58444.12333814996;66063.33936660668;66110.33889661042;71325.28674713291;67595.32404675988;67889.3211067883;67964;68180.97728534076;68487.97268040983;15441.919065665521;15503.457378991681;15519.301631426613;15669;15718.764218536731;11673.474693638807;11724.531018759324;11745.17783755146;11773.941130294465;11845.289282643069;20587.38237852867;20902.26842060551;21076.894615526824;21113.894430527747;21313.89343053275;8572.91427085721;8776.824463510695;8784.165504277084;8784.429012114193;8828.77928051791;964.8600952861796;994.4480813148772;1025.3284098915221;1116.553378648531;1159.8492196014465;29514.87933179109;29704.811807527458;29926.102216933527;30279;30368.088957331314;885.7209978856639;1020.7958408318366;1067.514281002142;1074.693712291993;1162.436218434059;15000.249987500581;15116.54650360491;15379.769303460456;15396.615084622974;15480;542983;549986;556861;558322.4167758352;562291;59070.40929590735;59402.40597594055;59465;59662;59753.40246597478;1387.4796951143321;1393.5749596373;1410.4499245294344;1432.7349440353569;1436.2818590704649;29545.852270739368;30271.545926811556;30417.23956901095;30516.694833051384;30603.2349191272;53132.46867531275;53394;53461.19808202802;53560;53613;316909;319222;320727;320938;322319;30752.384952301276;33140.84007059741;34123.829380852934;34144.31711365709;34160.31679366349;42880.14239715251;43392;43473;43539.56460435355;43742;36474.8176259117;36566;36599.63400365962;36901.815490922374;38034.0491487704;35338;36095;36125.45811812877;36157.638423615426;36303.636963631085;36599.45100823436;37356.62643373531;37970.43044354281;37986;37990.81004594959;30278.394432111676;32499.675003249664;33536.99389018333;33816.49275260824;34610;21761.455963601038;25150.874245628656;25201.24396268115;25396.984120634967;25560.849761760393 18:39:31 INFO - 2015-11-19 18:39:31,656 DEBUG : BROWSER_OUTPUT: |2;jquery.html;280.72909642195276;352.42554635943407;353.2757846414849;356.9072041269269;368.03574634457715;16336.428225012127;18222.81777182228;19704.40886773397;19883.30408435703;20359.898200508997;11593.942030289858;11645.941770291158;11870.881291187086;11872.525098996051;19604.117814698337;4591.242444996588;5278.3665960084845;5328.333958255218;5353.732313384316;5374.462553744614;3944.605539446047;4057.127717540728;5281.049411106019;5747.453991870787;5913.14259432382;5779.884402311972;5844.941550584504;5869.9706501467435;5913.349531551526;5934.050551911695;5742.822721342115;5782.335031471372;5949.988501954678;5951.821445356646;5973.761049558012;4947.2579113133315;5552.5280351169795;5673.489385955242;5692.288463942007;5746.310442746855;24281.150159744502;24286;24885.880135393953;24947.87526062376;25173.24480265595;1933.8549608779397;2019.7475315585552;2053.9589208215752;2087.499000239947;2251.617225071742;9614.75963100921;9828.262880284008;13515.256660883648;13826.771024678535;14684.559463216121;1704.940327088546;1722.190570431895;1722.8621710263149;1733.0468242466593;1755.4645833020923;90941;92935.53532232296;94998;98216.0178398214;102791.48604257006;10677;10935.234533582732;10970.232083754061;10993.065589424989;11129.666110016713;11640.60312762474;12569.371531423392;13107.606771796862;13112.344382781013;13116.0818742689;8126.228008339198;8169.0605580359015;8184.713535026245;8190.590470476572;8244.051934027544;7998.64006119726;8209.179082091863;8226.958865205756;8245.546494942835;8313.875291870627;3571.8571257149943;3706.8331925063435;4289.613934745826;4324.71889327199;4353.281708518122;1740.1125426032816;1780.0654656305285;1798.3975368251781;1835.229203734408;1842.797292297846;380.5433479824222;388.9027743064234;891.5898686604105;909.7634615000147;1000.2748007694508;11305.812889646633;11668.533258669728;11742.647720568397;11779.52881884715;21147.894260528905;714.8034290570031;763.6868883757744;812.2811311988814;823.360745504858;1027.7379268286538;10803.891961080446;10995.725106872393;11050.51550495605;11162.386068766133;11168.329900206014;665514;745004;752529.2373538207;758166;761064;100822;116485;117302.41348793202;119102;120378;1190.7023244188954;1193.9256414731926;1196.0730433913786;1201.1711918776016;1214.4049415786378;18039.188236529124;18610.720839187692;18972.335968241045;19189.32837350742;19221.231150753814;48421.88413984851;48547.27179092387;48991.02017959692;51269.48730512647;52550;68156.61451849161;68569.65715171392;71054;71755;71957;9733;9904.950475247577;9985.051420115078;10025.849612255675;10058.49707514636;11694.2983420995;11729.47217375203;15069.397224110913;18682.25270989145;19149.35982955313;15717.056976581442;16135.112568808829;16181;16257.430989915769;16334.509964701077;14926.328315225624;15261.694766104394;15443.691126177639;15636.921815391306;16266.918665406598;16283;16487.587810304838;16617.75073373876;16691.24889380005;16744.24650890737;9908.108270255712;9924.900750992398;9951.950240248752;9957.651482198089;10077.748056298651;12763.48946042185;15317.310721017804;16086.150092739485;16306.510804675878;16544.338226470805 18:39:31 INFO - 2015-11-19 18:39:31,660 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1506.2393491286898;1542.5912133284683;1829.7621309229798;1831.386485527348;1864.0400193900143;6891.7243310267595;7019;7051.823704407386;7397.963010184942;7516.173220945705;7653.4259930505295;7950.920490795091;8404.62179201936;8483.533405662685;8514.020887597928;2347.5539647467012;2382.9872304270702;2383.797377222938;2386.2364043506086;2389.6057150570136;2115.576884623074;2381.7380088190284;2404.627282771173;2409.8915548800346;2436.8537887726793;2340.918067867625;2368.52629474105;2381.7499162587937;2392.8564286142887;2400.6399040143942;2341.8360714749974;2367.9052837886466;2391.103336248898;2402.4834660547976;2402.6756387887585;2046.9795302046937;2384.225126833786;2398.9160379386813;2418.891149898259;2421.4914867877765;8382.87425688615;8457.238848503664;8467.788305292417;8490.448120872123;8510;4504.774761261924;5111.948880511184;5205.193195054735;5219.138842091051;5233.084210263227;3160.7787454878166;3476.200473891019;3478.930421391558;3552.964470355289;3571.624979377154;967.8596603492524;998.241336584194;1019.94390308533;1056.1128651932413;1063.0273299930554;11102.389368584643;11151.442427878574;11163.776724465466;11164.888351116466;11228.55085796567;4333.678228140385;4361.694681372337;4728.976355118202;4776.689515181502;4784.138855006063;9661.32370734056;9702.90297097034;9708.563114659857;9723.902760972442;9727.270454715925;5183.611229157828;5192;5207.140821764442;5219.217117432416;5245.921311180336;4716.646251531149;4723;4729.95270047302;4742.596879265301;4756.096341695067;3815.3323168445413;3871.6709079727975;3888.358420860583;3908.335582950905;3910.100676844285;1273.8980881529455;1287.8776516230944;1290.2129700882454;1291.5544137272625;1308.587794844621;1349.3514841371577;1371.9176849389069;1379.6137081617164;1389.7706878364957;1402.4740722229164;7737.767866964;7802.843943121105;7818.960905195438;7884.093329267208;7884.448088633741;488.4870885570137;489.76491284183794;490.0395225358266;490.4604934571942;513.912634852076;5710.771569137188;6039.909401358983;6051.9697401513595;6072.330109219912;6091.086337049478;9170.220531254785;9982.450965196984;10089.697309080739;10179.745506362253;10210.4384258865;8355.248027677417;8396.664133434717;9890.80218395628;10071.295009349422;10077.445740484198;7842.686292548348;7888.802779930433;7915.604219788987;7928.365730741642;7952.840943181104;6692.196936367667;7678.308952194329;7757.7672669819995;7791.948087008182;7844.137144914169;8982.461052336881;9085.409448385833;9099.090090990849;9100.635974560944;9151.222146117654;9271.536423178948;9350.719478415658;9427.57575909072;9484.810303793747;9544;7245.203027666847;7284.162321333115;7290.3438690518105;7322;7324.377427918686;7840.764777056697;8030.196980301923;8031.397645176752;8053.033635963722;8057.194280571896;7515.9853419789815;7527.698892044257;7529.58587277705;7662.616869156632;7672.578008209602;7435.256474352522;7450.925490745023;7472.40220782347;7534.660940257592;7568.697252110074;7446.4042876568665;7612.543247405173;7621.237876212334;7659.4255430841795;7665.501742386727;5751.827445176651;6915.204751453647;6933.2026816916705;6942.51402401827;6949.583025018515;6033.276006879202;6918.411934985583;6986.091808065123;7003.29967003316;7016.22821489646 18:39:31 INFO - 2015-11-19 18:39:31,661 DEBUG : BROWSER_OUTPUT: |4;prototype.html;322.3938994689983;326.221960623912;329.2460265990881;331.86725309876056;334.6101791413004;6642.966785166067;6890.310968903107;6901.309869013103;6902.378785909274;6930.549514281568;6651.268360480343;6810.761623343184;6829.248782633918;6842;6849.383555480006;5039.72281524516;5044.243363495469;5071.746412679369;5096.031753966744;5100.285959965608;4898.657094003421;5062.822801201959;5065.290859279704;5070.569001634865;5087.56755675768;4922.483139270379;4960.206366981283;5005.624578156635;5018.949810501903;5025.321581586476;5010.048090862742;5010.574101201402;5015.824446144386;5018.447970723218;5025.447200807908;3574.2315402188656;4215.093754842693;4301.72038817479;4309.439772829513;4320.697551171419;6543.1821022372205;6564.606123632598;6577.736890524373;6582.407583317525;6585.6707164641575;5947.6431414115295;5965.433283838029;5982.670953097578;5983.1025346197985;5991.370906054845;5605.635633683838;5788.073908174714;5847.912281315784;5900;7071.045408869788;4810.845397104705;4818.927716084261;4825.9758701206265;4834.58905992991;4850.975745121287;7721.575313357763;7749.108852481924;7756.534607923542;7802.336801371834;7808.252039021245;4758.452777930513;4907.631927605444;4915.803367865316;4921.606271498272;4932.67937584063;5009.273655319958;5020.974895125501;5021.548060674557;5028.094942910238;5046.167382381939;5930.229070220844;5930.7924222652;5936.673482958392;5950.9107363389585;5954.345022047572;7343.77968660941;7348.742794002291;7351.117865856025;7354.521956072838;7406.370458510979;1663.2432243329497;1715.3138744502298;1730.3078768492453;1730.411660035594;1738.1309345327336;936.4849332866896;1045.6772183188273;1067.2849191042021;1135.8807325230896;1139.732162941708;6958.860822783516;6969.47728920333;6974.58152510851;6989.5107342485535;7020.894686579705;6202.4417802398;7621.161672216052;7645.655945482466;7654.4259180561685;7672.117706463717;6224.533160013018;6818.897716534256;6935.826604334932;6952.617606031616;6971.128608923885;3930.9017274568364;4022.1151346703678;4025.5370632377653;4039.939400908989;4060.2894493463527;7826.373890088779;7991.081025682005;7997.400194985283;8004.839903201903;8045.517268963881;6453.548251622436;7957.124716281204;7957.323627491613;7965.56189409588;7965.960170199228;7770.106437759617;7940.722074727357;7978.202179781975;7990.720324788605;7993.640286187136;6178.907316390348;7691.923080769121;7714.228577142241;7719.266669666373;7749.302562769378;7354.899857830458;7516.812079698051;7527.2849079337375;7574.621268936421;7605.961970190114;6954.269801670752;7517.736879209201;8010.158933311918;8032.759017229492;8041.8391632168195;4954.430240522386;4964.021587047742;4969.82605608802;4972.950270497394;4977.228529577921;7458.701651934079;7594.962025189839;7666.693332266647;7685;7709.267619576131;7327.047483827068;7398.926010739824;7401.777946661608;7405.741024026036;7407.851842963219;7361.337479626859;7366.337029667356;7368.047467421031;7368.410527157707;7384.446166537424;5939.524838012862;6977.33715297046;7143.856982882714;7228.746993855189;7253.601051942193;7382.3724983377015;7385.778426647209;7391.556506609621;7411.66647500853;7424.517406368569;7044.013838062573;7205;7225.277472252943;7229.891551626835;7286.599237042014 18:39:31 INFO - 2015-11-19 18:39:31,664 DEBUG : BROWSER_OUTPUT: |5;yui.html;730.3390431659349;781.9061712594482;793.9364850811936;811.6185392865351;840.701550949413;15032.248387580617;15203.239838008083;15407.922960385196;15420.151891645955;15438.61403464914;12277.140600157993;12450.252984820894;12919.160254583468;12925.289109098996;12940.22358658481;779.6218833865571;928.5310917986408;943.3019565521499;951.5955718819508;957.1816097236866;949.8812648418948;955.044955044955;961.0149596663441;961.4231461123305;962.2254085461201;981.7594689301131;1000.0649392817738;1002.3735165521549;1002.5538635307291;1005.4369553050278;978.7944531648362;985.7387792234991;989.114742305636;993.3195760903805;1001.0390025575492;730.8903664450374;739.2164305835778;741.8961345411593;742.8365759532894;755.4636208292119;11223.943880280547;13110.213387196703;13195.736085278337;13203.339833008311;13206.801897971538;11022.559097636085;11024.50389732464;11064.336139831636;11513.963743263146;11702.941485292518;9564.760880977961;9588.472634005197;9633.277504187214;9646.276529260334;10275.79448411035;3427.6572342765526;3465.5148279240925;3467.6705712957228;3489.668481494254;3490.5287786148797;68696.3130368695;72767.63616181938;74062.62968685175;74177.25822741758;80754.19245807525;9338.673146439978;9369.672061477815;9373.48445835472;9388.342816002814;9582.041795820362;20890;21327.46681332948;21595.460113497287;21741.13035478563;21939.67090493644;7445.181030086686;7544.4341674373545;7598.0502437195355;7730.497517661334;7861.213878612093;4100.466939297872;4163.937540936889;4167.1457351242925;4174.20690068886;4196.853110141131;3115.922101947424;3610.837512311952;3629.165291982859;3630.3102410541915;3637.4543818427446;629.9716512756937;644.0693198328464;645.4287955159717;667.2993356975254;673.0375562944938;445.32310887450893;452.0800171650741;484.1189035954599;498.4890487250597;515.3763945625835;7822.687092516236;9462.621495140118;9511.809763804686;9556.187724043395;9639.831038016531;503;506.1092477240084;574.3768011707261;609.1289456077762;634.4385219081054;4054.270231358325;4208.473940757405;4249.362595610622;4260.957390426056;4291.29193683045;98270.50864745774;99610;99961.50019249857;101374;101814;74825;82379.5881020591;83493.74759378615;84087.5795621018;85018;71874;73808.63095684488;75763;77623.28318508939;78811.60594197107;8966.462012279284;9093.499857507635;9169.449833010041;9192.356535042483;9232.030636783042;49495;50400.49599503958;50786.730331740524;53014.204786928996;54110.64723381947;60491.69754151201;66651;70499.9425008615;73476.26523734695;76643;9111.31665125105;11003.724906877393;11108.277961932448;11395.487203075716;12047.397630118283;11956.521739130338;12013.978811800745;12024.398780061138;12370.876291236973;12808;11132.499037543492;11249.71875703114;11288.665167468534;11530.135239857213;11999.280043197086;11326.490307935997;11427.828582571101;11653.47559359814;11824.52701891949;12306.015518758299;10999.560017599206;11039.558417663204;11107.278026928223;11642.359670218219;12321.93839030799;8146.5519396433765;9336.579853906454;9595.664151754656;10083.294169408071;10424.530896109542;8716.520591367282;8831.205191532792;8932.86600701003;9618.807623847624;9939.950300248453 18:39:31 INFO - 2015-11-19 18:39:31,664 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:39:31 INFO - 2015-11-19 18:39:31,665 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:39:31 INFO - 2015-11-19 18:39:31,665 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,327 18:39:31 INFO - 2015-11-19 18:39:31,665 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:39:31 INFO - 2015-11-19 18:39:31,665 DEBUG : BROWSER_OUTPUT: __startTimestamp1447987171649__endTimestamp 18:39:31 INFO - 2015-11-19 18:39:31,665 DEBUG : BROWSER_OUTPUT: 18:39:31 INFO - 2015-11-19 18:39:31,665 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:39:31 INFO - 2015-11-19 18:39:31,665 DEBUG : BROWSER_OUTPUT: Number of tests: 6 18:39:31 INFO - 2015-11-19 18:39:31,665 DEBUG : BROWSER_OUTPUT: 18:39:31 INFO - 2015-11-19 18:39:31,665 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5864.37 Median:6076.57 stddev:639.92 (10.5%) stddev-sans-first:613.32 18:39:31 INFO - 2015-11-19 18:39:31,666 DEBUG : BROWSER_OUTPUT: Values: 3454.3 3512.1 3550.9 3576.3 3579.7 5834.2 5901.1 5932.6 5958.3 5982.1 5716.5 5804.6 5847.0 5861.0 5861.3 5304.5 5313.7 5330.1 5390.8 5420.4 4456.8 5327.7 5386.3 5507.4 5510.8 5429.5 5460.3 5473.8 5486.8 5527.6 4797.2 5192.7 5392.5 5415.0 5445.3 5300.3 5321.6 5365.7 5372.6 5397.9 5413.5 5746.4 5807.8 5855.2 5936.4 5265.8 6127.3 6209.9 6325.9 6347.0 6322.2 6348.4 6372.0 6374.3 6392.2 5992.5 6045.2 6061.1 6064.2 6067.7 5875.9 6262.7 6319.1 6346.5 6482.7 6288.6 6301.9 6315.8 6321.3 6325.1 6337.9 6362.3 6378.6 6389.8 6405.5 6079.2 6197.5 6255.3 6265.9 6266.5 6254.7 6270.1 6283.9 6327.3 6335.7 4922.3 5065.2 5070.6 5073.2 5113.1 4467.7 4528.8 4561.1 4583.1 4596.9 6000.2 6026.7 6064.5 6065.8 6076.6 6172.3 6327.9 6378.7 6383.3 6404.6 5981.2 6020.9 6051.4 6056.7 6065.4 5571.7 5577.1 5602.0 5603.9 5623.2 6238.1 6361.1 6364.3 6612.9 6653.8 6241.3 6317.6 6328.7 6336.3 6355.4 5273.7 5759.4 6493.5 6529.3 6550.2 6143.9 6216.3 6230.4 6302.6 6338.2 6290.6 6379.3 6395.2 6400.6 6438.5 5113.5 6302.7 6304.1 6317.4 6324.6 6084.1 6151.6 6199.3 6316.7 6319.8 6049.5 6179.1 6229.3 6230.1 6235.1 5834.1 6257.5 6266.8 6295.9 6345.3 6011.5 6106.6 6119.7 6204.3 6210.5 18:39:31 INFO - 2015-11-19 18:39:31,666 DEBUG : BROWSER_OUTPUT: 18:39:31 INFO - 2015-11-19 18:39:31,666 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:60569.99 Median:37988.41 stddev:121833.25 (320.7%) stddev-sans-first:122091.68 18:39:31 INFO - 2015-11-19 18:39:31,666 DEBUG : BROWSER_OUTPUT: Values: 551.1 566.3 572.5 584.0 598.6 33959.5 40565.0 41533.0 41610.8 41659.2 44510.6 44725.6 44895.0 44955.6 45049.1 9647.5 9814.3 9843.2 9843.6 9870.8 9658.9 9732.9 9741.9 9749.5 9763.3 9679.6 9726.6 9735.6 9737.2 9747.8 9680.4 9750.3 9761.1 9773.4 9787.1 9555.2 9682.3 9694.8 9696.0 9719.1 41347.0 41383.6 41593.0 41654.4 41722.4 3195.3 3202.7 3247.6 3386.3 3678.1 28686.7 29056.6 29673.6 30051.8 30213.8 2821.2 2827.3 2845.8 2895.4 2955.3 465045.0 465227.0 471552.0 472320.6 473358.0 57727.1 58444.1 66063.3 66110.3 71325.3 67595.3 67889.3 67964.0 68181.0 68488.0 15441.9 15503.5 15519.3 15669.0 15718.8 11673.5 11724.5 11745.2 11773.9 11845.3 20587.4 20902.3 21076.9 21113.9 21313.9 8572.9 8776.8 8784.2 8784.4 8828.8 964.9 994.4 1025.3 1116.6 1159.8 29514.9 29704.8 29926.1 30279.0 30368.1 885.7 1020.8 1067.5 1074.7 1162.4 15000.2 15116.5 15379.8 15396.6 15480.0 542983.0 549986.0 556861.0 558322.4 562291.0 59070.4 59402.4 59465.0 59662.0 59753.4 1387.5 1393.6 1410.4 1432.7 1436.3 29545.9 30271.5 30417.2 30516.7 30603.2 53132.5 53394.0 53461.2 53560.0 53613.0 316909.0 319222.0 320727.0 320938.0 322319.0 30752.4 33140.8 34123.8 34144.3 34160.3 42880.1 43392.0 43473.0 43539.6 43742.0 36474.8 36566.0 36599.6 36901.8 38034.0 35338.0 36095.0 36125.5 36157.6 36303.6 36599.5 37356.6 37970.4 37986.0 37990.8 30278.4 32499.7 33537.0 33816.5 34610.0 21761.5 25150.9 25201.2 25397.0 25560.8 18:39:31 INFO - 2015-11-19 18:39:31,666 DEBUG : BROWSER_OUTPUT: 18:39:31 INFO - 2015-11-19 18:39:31,666 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:37752.25 Median:2070.73 stddev:121247.29 (5855.3%) stddev-sans-first:121554.77 18:39:31 INFO - 2015-11-19 18:39:31,667 DEBUG : BROWSER_OUTPUT: Values: 280.7 352.4 353.3 356.9 368.0 16336.4 18222.8 19704.4 19883.3 20359.9 11593.9 11645.9 11870.9 11872.5 19604.1 4591.2 5278.4 5328.3 5353.7 5374.5 3944.6 4057.1 5281.0 5747.5 5913.1 5779.9 5844.9 5870.0 5913.3 5934.1 5742.8 5782.3 5950.0 5951.8 5973.8 4947.3 5552.5 5673.5 5692.3 5746.3 24281.2 24286.0 24885.9 24947.9 25173.2 1933.9 2019.7 2054.0 2087.5 2251.6 9614.8 9828.3 13515.3 13826.8 14684.6 1704.9 1722.2 1722.9 1733.0 1755.5 90941.0 92935.5 94998.0 98216.0 102791.5 10677.0 10935.2 10970.2 10993.1 11129.7 11640.6 12569.4 13107.6 13112.3 13116.1 8126.2 8169.1 8184.7 8190.6 8244.1 7998.6 8209.2 8227.0 8245.5 8313.9 3571.9 3706.8 4289.6 4324.7 4353.3 1740.1 1780.1 1798.4 1835.2 1842.8 380.5 388.9 891.6 909.8 1000.3 11305.8 11668.5 11742.6 11779.5 21147.9 714.8 763.7 812.3 823.4 1027.7 10803.9 10995.7 11050.5 11162.4 11168.3 665514.0 745004.0 752529.2 758166.0 761064.0 100822.0 116485.0 117302.4 119102.0 120378.0 1190.7 1193.9 1196.1 1201.2 1214.4 18039.2 18610.7 18972.3 19189.3 19221.2 48421.9 48547.3 48991.0 51269.5 52550.0 68156.6 68569.7 71054.0 71755.0 71957.0 9733.0 9905.0 9985.1 10025.8 10058.5 11694.3 11729.5 15069.4 18682.3 19149.4 15717.1 16135.1 16181.0 16257.4 16334.5 14926.3 15261.7 15443.7 15636.9 16266.9 16283.0 16487.6 16617.8 16691.2 16744.2 9908.1 9924.9 9952.0 9957.7 10077.7 12763.5 15317.3 16086.2 16306.5 16544.3 18:39:31 INFO - 2015-11-19 18:39:31,667 DEBUG : BROWSER_OUTPUT: 18:39:31 INFO - 2015-11-19 18:39:31,667 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5774.14 Median:6036.59 stddev:3004.49 (49.8%) stddev-sans-first:2995.79 18:39:31 INFO - 2015-11-19 18:39:31,669 DEBUG : BROWSER_OUTPUT: Values: 1506.2 1542.6 1829.8 1831.4 1864.0 6891.7 7019.0 7051.8 7398.0 7516.2 7653.4 7950.9 8404.6 8483.5 8514.0 2347.6 2383.0 2383.8 2386.2 2389.6 2115.6 2381.7 2404.6 2409.9 2436.9 2340.9 2368.5 2381.7 2392.9 2400.6 2341.8 2367.9 2391.1 2402.5 2402.7 2047.0 2384.2 2398.9 2418.9 2421.5 8382.9 8457.2 8467.8 8490.4 8510.0 4504.8 5111.9 5205.2 5219.1 5233.1 3160.8 3476.2 3478.9 3553.0 3571.6 967.9 998.2 1019.9 1056.1 1063.0 11102.4 11151.4 11163.8 11164.9 11228.6 4333.7 4361.7 4729.0 4776.7 4784.1 9661.3 9702.9 9708.6 9723.9 9727.3 5183.6 5192.0 5207.1 5219.2 5245.9 4716.6 4723.0 4730.0 4742.6 4756.1 3815.3 3871.7 3888.4 3908.3 3910.1 1273.9 1287.9 1290.2 1291.6 1308.6 1349.4 1371.9 1379.6 1389.8 1402.5 7737.8 7802.8 7819.0 7884.1 7884.4 488.5 489.8 490.0 490.5 513.9 5710.8 6039.9 6052.0 6072.3 6091.1 9170.2 9982.5 10089.7 10179.7 10210.4 8355.2 8396.7 9890.8 10071.3 10077.4 7842.7 7888.8 7915.6 7928.4 7952.8 6692.2 7678.3 7757.8 7791.9 7844.1 8982.5 9085.4 9099.1 9100.6 9151.2 9271.5 9350.7 9427.6 9484.8 9544.0 7245.2 7284.2 7290.3 7322.0 7324.4 7840.8 8030.2 8031.4 8053.0 8057.2 7516.0 7527.7 7529.6 7662.6 7672.6 7435.3 7450.9 7472.4 7534.7 7568.7 7446.4 7612.5 7621.2 7659.4 7665.5 5751.8 6915.2 6933.2 6942.5 6949.6 6033.3 6918.4 6986.1 7003.3 7016.2 18:39:31 INFO - 2015-11-19 18:39:31,669 DEBUG : BROWSER_OUTPUT: 18:39:31 INFO - 2015-11-19 18:39:31,669 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5989.14 Median:6814.83 stddev:1913.19 (28.1%) stddev-sans-first:1870.68 18:39:31 INFO - 2015-11-19 18:39:31,671 DEBUG : BROWSER_OUTPUT: Values: 322.4 326.2 329.2 331.9 334.6 6643.0 6890.3 6901.3 6902.4 6930.5 6651.3 6810.8 6829.2 6842.0 6849.4 5039.7 5044.2 5071.7 5096.0 5100.3 4898.7 5062.8 5065.3 5070.6 5087.6 4922.5 4960.2 5005.6 5018.9 5025.3 5010.0 5010.6 5015.8 5018.4 5025.4 3574.2 4215.1 4301.7 4309.4 4320.7 6543.2 6564.6 6577.7 6582.4 6585.7 5947.6 5965.4 5982.7 5983.1 5991.4 5605.6 5788.1 5847.9 5900.0 7071.0 4810.8 4818.9 4826.0 4834.6 4851.0 7721.6 7749.1 7756.5 7802.3 7808.3 4758.5 4907.6 4915.8 4921.6 4932.7 5009.3 5021.0 5021.5 5028.1 5046.2 5930.2 5930.8 5936.7 5950.9 5954.3 7343.8 7348.7 7351.1 7354.5 7406.4 1663.2 1715.3 1730.3 1730.4 1738.1 936.5 1045.7 1067.3 1135.9 1139.7 6958.9 6969.5 6974.6 6989.5 7020.9 6202.4 7621.2 7645.7 7654.4 7672.1 6224.5 6818.9 6935.8 6952.6 6971.1 3930.9 4022.1 4025.5 4039.9 4060.3 7826.4 7991.1 7997.4 8004.8 8045.5 6453.5 7957.1 7957.3 7965.6 7966.0 7770.1 7940.7 7978.2 7990.7 7993.6 6178.9 7691.9 7714.2 7719.3 7749.3 7354.9 7516.8 7527.3 7574.6 7606.0 6954.3 7517.7 8010.2 8032.8 8041.8 4954.4 4964.0 4969.8 4973.0 4977.2 7458.7 7595.0 7666.7 7685.0 7709.3 7327.0 7398.9 7401.8 7405.7 7407.9 7361.3 7366.3 7368.0 7368.4 7384.4 5939.5 6977.3 7143.9 7228.7 7253.6 7382.4 7385.8 7391.6 7411.7 7424.5 7044.0 7205.0 7225.3 7229.9 7286.6 18:39:31 INFO - 2015-11-19 18:39:31,671 DEBUG : BROWSER_OUTPUT: 18:39:31 INFO - 2015-11-19 18:39:31,671 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:18626.07 Median:27342.51 stddev:26692.83 (97.6%) stddev-sans-first:26733.89 18:39:31 INFO - 2015-11-19 18:39:31,672 DEBUG : BROWSER_OUTPUT: Values: 730.3 781.9 793.9 811.6 840.7 15032.2 15203.2 15407.9 15420.2 15438.6 12277.1 12450.3 12919.2 12925.3 12940.2 779.6 928.5 943.3 951.6 957.2 949.9 955.0 961.0 961.4 962.2 981.8 1000.1 1002.4 1002.6 1005.4 978.8 985.7 989.1 993.3 1001.0 730.9 739.2 741.9 742.8 755.5 11223.9 13110.2 13195.7 13203.3 13206.8 11022.6 11024.5 11064.3 11514.0 11702.9 9564.8 9588.5 9633.3 9646.3 10275.8 3427.7 3465.5 3467.7 3489.7 3490.5 68696.3 72767.6 74062.6 74177.3 80754.2 9338.7 9369.7 9373.5 9388.3 9582.0 20890.0 21327.5 21595.5 21741.1 21939.7 7445.2 7544.4 7598.1 7730.5 7861.2 4100.5 4163.9 4167.1 4174.2 4196.9 3115.9 3610.8 3629.2 3630.3 3637.5 630.0 644.1 645.4 667.3 673.0 445.3 452.1 484.1 498.5 515.4 7822.7 9462.6 9511.8 9556.2 9639.8 503.0 506.1 574.4 609.1 634.4 4054.3 4208.5 4249.4 4261.0 4291.3 98270.5 99610.0 99961.5 101374.0 101814.0 74825.0 82379.6 83493.7 84087.6 85018.0 71874.0 73808.6 75763.0 77623.3 78811.6 8966.5 9093.5 9169.4 9192.4 9232.0 49495.0 50400.5 50786.7 53014.2 54110.6 60491.7 66651.0 70499.9 73476.3 76643.0 9111.3 11003.7 11108.3 11395.5 12047.4 11956.5 12014.0 12024.4 12370.9 12808.0 11132.5 11249.7 11288.7 11530.1 11999.3 11326.5 11427.8 11653.5 11824.5 12306.0 10999.6 11039.6 11107.3 11642.4 12321.9 8146.6 9336.6 9595.7 10083.3 10424.5 8716.5 8831.2 8932.9 9618.8 9940.0 18:39:31 INFO - 2015-11-19 18:39:31,672 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:39:31 INFO - 2015-11-19 18:39:31,672 DEBUG : BROWSER_OUTPUT: 18:39:32 INFO - 2015-11-19 18:39:32,084 INFO : Browser exited with error code: 0 18:39:32 INFO - 2015-11-19 18:39:32,113 INFO : Completed test dromaeo_css (00:18:29) 18:39:32 INFO - 2015-11-19 18:39:32,113 INFO : Starting test kraken 18:39:32 INFO - 2015-11-19 18:39:32,113 DEBUG : operating with platform_type : mac_ 18:39:32 INFO - 2015-11-19 18:39:32,113 INFO : Initialising browser for kraken test... 18:39:32 INFO - 2015-11-19 18:39:32,128 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/tmpgXa8KN/profile http://localhost:49712/getInfo.html 18:39:34 INFO - 2015-11-19 18:39:34,930 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:39:34 INFO - 2015-11-19 18:39:34,930 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:39:34 INFO - 2015-11-19 18:39:34,930 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 18:39:34 INFO - 2015-11-19 18:39:34,930 DEBUG : BROWSER_OUTPUT: __metrics 18:39:35 INFO - 2015-11-19 18:39:35,540 INFO : Browser initialized. 18:39:35 INFO - 2015-11-19 18:39:35,540 INFO : Running cycle 1/1 for kraken test... 18:39:35 INFO - 2015-11-19 18:39:35,540 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/tmpgXa8KN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:39:47 INFO - 2015-11-19 18:39:47,500 DEBUG : BROWSER_OUTPUT: RSS: Main: 236830720 18:39:47 INFO - 2015-11-19 18:39:47,500 DEBUG : BROWSER_OUTPUT: 18:39:50 INFO - 2015-11-19 18:39:50,039 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49712/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49712/tests/kraken/driver.html?testName=audio-beat-detection) 18:39:50 INFO - 2015-11-19 18:39:50,658 DEBUG : BROWSER_OUTPUT: RSS: Main: 248061952 18:39:50 INFO - 2015-11-19 18:39:50,658 DEBUG : BROWSER_OUTPUT: 18:39:53 INFO - 2015-11-19 18:39:53,288 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49712/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49712/tests/kraken/driver.html?testName=audio-dft) 18:39:53 INFO - 2015-11-19 18:39:53,900 DEBUG : BROWSER_OUTPUT: RSS: Main: 258768896 18:39:53 INFO - 2015-11-19 18:39:53,900 DEBUG : BROWSER_OUTPUT: 18:39:57 INFO - 2015-11-19 18:39:57,417 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49712/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49712/tests/kraken/driver.html?testName=audio-fft) 18:39:58 INFO - 2015-11-19 18:39:58,002 DEBUG : BROWSER_OUTPUT: RSS: Main: 261619712 18:39:58 INFO - 2015-11-19 18:39:58,003 DEBUG : BROWSER_OUTPUT: 18:39:59 INFO - 2015-11-19 18:39:59,833 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49712/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49712/tests/kraken/driver.html?testName=audio-oscillator) 18:40:00 INFO - 2015-11-19 18:40:00,433 DEBUG : BROWSER_OUTPUT: RSS: Main: 262209536 18:40:00 INFO - 2015-11-19 18:40:00,433 DEBUG : BROWSER_OUTPUT: 18:40:02 INFO - 2015-11-19 18:40:02,378 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49712/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49712/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:40:02 INFO - 2015-11-19 18:40:02,966 DEBUG : BROWSER_OUTPUT: RSS: Main: 264437760 18:40:02 INFO - 2015-11-19 18:40:02,966 DEBUG : BROWSER_OUTPUT: 18:40:05 INFO - 2015-11-19 18:40:05,614 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49712/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49712/tests/kraken/driver.html?testName=imaging-darkroom) 18:40:06 INFO - 2015-11-19 18:40:06,213 DEBUG : BROWSER_OUTPUT: RSS: Main: 265138176 18:40:06 INFO - 2015-11-19 18:40:06,213 DEBUG : BROWSER_OUTPUT: 18:40:09 INFO - 2015-11-19 18:40:09,066 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49712/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49712/tests/kraken/driver.html?testName=imaging-desaturate) 18:40:09 INFO - 2015-11-19 18:40:09,656 DEBUG : BROWSER_OUTPUT: RSS: Main: 265052160 18:40:09 INFO - 2015-11-19 18:40:09,656 DEBUG : BROWSER_OUTPUT: 18:40:12 INFO - 2015-11-19 18:40:12,616 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49712/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49712/tests/kraken/driver.html?testName=json-parse-financial) 18:40:13 INFO - 2015-11-19 18:40:13,216 DEBUG : BROWSER_OUTPUT: RSS: Main: 265388032 18:40:13 INFO - 2015-11-19 18:40:13,216 DEBUG : BROWSER_OUTPUT: 18:40:14 INFO - 2015-11-19 18:40:14,721 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49712/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49712/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:40:15 INFO - 2015-11-19 18:40:15,308 DEBUG : BROWSER_OUTPUT: RSS: Main: 263749632 18:40:15 INFO - 2015-11-19 18:40:15,308 DEBUG : BROWSER_OUTPUT: 18:40:17 INFO - 2015-11-19 18:40:17,095 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49712/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49712/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:40:17 INFO - 2015-11-19 18:40:17,746 DEBUG : BROWSER_OUTPUT: RSS: Main: 263962624 18:40:17 INFO - 2015-11-19 18:40:17,747 DEBUG : BROWSER_OUTPUT: 18:40:19 INFO - 2015-11-19 18:40:19,914 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49712/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49712/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:40:20 INFO - 2015-11-19 18:40:20,509 DEBUG : BROWSER_OUTPUT: RSS: Main: 264601600 18:40:20 INFO - 2015-11-19 18:40:20,509 DEBUG : BROWSER_OUTPUT: 18:40:23 INFO - 2015-11-19 18:40:23,029 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49712/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49712/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:40:23 INFO - 2015-11-19 18:40:23,632 DEBUG : BROWSER_OUTPUT: RSS: Main: 264245248 18:40:23 INFO - 2015-11-19 18:40:23,632 DEBUG : BROWSER_OUTPUT: 18:40:26 INFO - 2015-11-19 18:40:26,095 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49712/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49712/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:40:26 INFO - 2015-11-19 18:40:26,687 DEBUG : BROWSER_OUTPUT: RSS: Main: 263868416 18:40:26 INFO - 2015-11-19 18:40:26,688 DEBUG : BROWSER_OUTPUT: 18:40:28 INFO - 2015-11-19 18:40:28,434 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49712/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49712/tests/kraken/driver.html?testName=ai-astar) 18:40:28 INFO - 2015-11-19 18:40:28,697 DEBUG : BROWSER_OUTPUT: RSS: Main: 263610368 18:40:28 INFO - 2015-11-19 18:40:28,697 DEBUG : BROWSER_OUTPUT: 18:40:28 INFO - 2015-11-19 18:40:28,697 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:40:28 INFO - 2015-11-19 18:40:28,697 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:40:28 INFO - 2015-11-19 18:40:28,697 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:40:28 INFO - 2015-11-19 18:40:28,698 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:40:28 INFO - 2015-11-19 18:40:28,698 DEBUG : BROWSER_OUTPUT: |0;ai-astar;116;108;114;114;114;125;113;114;113;112 18:40:28 INFO - 2015-11-19 18:40:28,698 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;149;126;146;154;121;150;162;150;186;126 18:40:28 INFO - 2015-11-19 18:40:28,698 DEBUG : BROWSER_OUTPUT: |2;audio-dft;197;202;198;273;252;228;274;256;198;206 18:40:28 INFO - 2015-11-19 18:40:28,698 DEBUG : BROWSER_OUTPUT: |3;audio-fft;64;61;72;111;59;55;58;61;112;59 18:40:28 INFO - 2015-11-19 18:40:28,698 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;77;76;108;75;79;75;105;77;105;92 18:40:28 INFO - 2015-11-19 18:40:28,698 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;86;87;86;87;86;87;87;86;89;87 18:40:28 INFO - 2015-11-19 18:40:28,698 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;95;94;95;104;94;98;150;125;95;95 18:40:28 INFO - 2015-11-19 18:40:28,698 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;111;141;119;93;91;91;78;149;140;94 18:40:28 INFO - 2015-11-19 18:40:28,698 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;61;59;61;59;60;60;66;57;58 18:40:28 INFO - 2015-11-19 18:40:28,698 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;67;66;66;67;67;70;69;73;63 18:40:28 INFO - 2015-11-19 18:40:28,698 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;73;93;74;85;74;91;106;109;108;99 18:40:28 INFO - 2015-11-19 18:40:28,698 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;124;131;134;135;113;130;125;121;127;128 18:40:28 INFO - 2015-11-19 18:40:28,698 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;143;141;139;142;139;128;139;142;145;170 18:40:28 INFO - 2015-11-19 18:40:28,699 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;69;84;87;95;78;68;67;66;84 18:40:28 INFO - 2015-11-19 18:40:28,699 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:40:28 INFO - 2015-11-19 18:40:28,699 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:40:28 INFO - 2015-11-19 18:40:28,699 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,816 18:40:28 INFO - 2015-11-19 18:40:28,699 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:40:28 INFO - 2015-11-19 18:40:28,699 DEBUG : BROWSER_OUTPUT: __startTimestamp1447987228694__endTimestamp 18:40:28 INFO - 2015-11-19 18:40:28,699 DEBUG : BROWSER_OUTPUT: 18:40:28 INFO - 2015-11-19 18:40:28,699 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:40:28 INFO - 2015-11-19 18:40:28,699 DEBUG : BROWSER_OUTPUT: Number of tests: 14 18:40:28 INFO - 2015-11-19 18:40:28,699 DEBUG : BROWSER_OUTPUT: 18:40:28 INFO - 2015-11-19 18:40:28,700 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:114.30 Median:114.00 stddev:4.30 (3.8%) stddev-sans-first:4.51 18:40:28 INFO - 2015-11-19 18:40:28,700 DEBUG : BROWSER_OUTPUT: Values: 116.0 108.0 114.0 114.0 114.0 125.0 113.0 114.0 113.0 112.0 18:40:28 INFO - 2015-11-19 18:40:28,700 DEBUG : BROWSER_OUTPUT: 18:40:28 INFO - 2015-11-19 18:40:28,700 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:147.00 Median:150.00 stddev:19.37 (12.9%) stddev-sans-first:20.53 18:40:28 INFO - 2015-11-19 18:40:28,701 DEBUG : BROWSER_OUTPUT: Values: 149.0 126.0 146.0 154.0 121.0 150.0 162.0 150.0 186.0 126.0 18:40:28 INFO - 2015-11-19 18:40:28,701 DEBUG : BROWSER_OUTPUT: 18:40:28 INFO - 2015-11-19 18:40:28,701 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:228.40 Median:240.00 stddev:32.35 (13.5%) stddev-sans-first:32.26 18:40:28 INFO - 2015-11-19 18:40:28,702 DEBUG : BROWSER_OUTPUT: Values: 197.0 202.0 198.0 273.0 252.0 228.0 274.0 256.0 198.0 206.0 18:40:28 INFO - 2015-11-19 18:40:28,702 DEBUG : BROWSER_OUTPUT: 18:40:28 INFO - 2015-11-19 18:40:28,702 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:71.20 Median:60.00 stddev:21.71 (36.2%) stddev-sans-first:22.87 18:40:28 INFO - 2015-11-19 18:40:28,702 DEBUG : BROWSER_OUTPUT: Values: 64.0 61.0 72.0 111.0 59.0 55.0 58.0 61.0 112.0 59.0 18:40:28 INFO - 2015-11-19 18:40:28,702 DEBUG : BROWSER_OUTPUT: 18:40:28 INFO - 2015-11-19 18:40:28,702 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:86.90 Median:76.50 stddev:14.09 (18.4%) stddev-sans-first:14.48 18:40:28 INFO - 2015-11-19 18:40:28,702 DEBUG : BROWSER_OUTPUT: Values: 77.0 76.0 108.0 75.0 79.0 75.0 105.0 77.0 105.0 92.0 18:40:28 INFO - 2015-11-19 18:40:28,702 DEBUG : BROWSER_OUTPUT: 18:40:28 INFO - 2015-11-19 18:40:28,702 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:86.80 Median:87.00 stddev:0.92 (1.1%) stddev-sans-first:0.93 18:40:28 INFO - 2015-11-19 18:40:28,702 DEBUG : BROWSER_OUTPUT: Values: 86.0 87.0 86.0 87.0 86.0 87.0 87.0 86.0 89.0 87.0 18:40:28 INFO - 2015-11-19 18:40:28,703 DEBUG : BROWSER_OUTPUT: 18:40:28 INFO - 2015-11-19 18:40:28,703 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:104.50 Median:95.00 stddev:18.60 (19.6%) stddev-sans-first:19.41 18:40:28 INFO - 2015-11-19 18:40:28,703 DEBUG : BROWSER_OUTPUT: Values: 95.0 94.0 95.0 104.0 94.0 98.0 150.0 125.0 95.0 95.0 18:40:28 INFO - 2015-11-19 18:40:28,703 DEBUG : BROWSER_OUTPUT: 18:40:28 INFO - 2015-11-19 18:40:28,703 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:110.70 Median:84.50 stddev:25.28 (29.9%) stddev-sans-first:26.81 18:40:28 INFO - 2015-11-19 18:40:28,703 DEBUG : BROWSER_OUTPUT: Values: 111.0 141.0 119.0 93.0 91.0 91.0 78.0 149.0 140.0 94.0 18:40:28 INFO - 2015-11-19 18:40:28,703 DEBUG : BROWSER_OUTPUT: 18:40:28 INFO - 2015-11-19 18:40:28,703 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:60.00 Median:60.00 stddev:2.45 (4.1%) stddev-sans-first:2.57 18:40:28 INFO - 2015-11-19 18:40:28,703 DEBUG : BROWSER_OUTPUT: Values: 59.0 61.0 59.0 61.0 59.0 60.0 60.0 66.0 57.0 58.0 18:40:28 INFO - 2015-11-19 18:40:28,704 DEBUG : BROWSER_OUTPUT: 18:40:28 INFO - 2015-11-19 18:40:28,704 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:67.50 stddev:2.67 (4.0%) stddev-sans-first:2.83 18:40:28 INFO - 2015-11-19 18:40:28,704 DEBUG : BROWSER_OUTPUT: Values: 68.0 67.0 66.0 66.0 67.0 67.0 70.0 69.0 73.0 63.0 18:40:28 INFO - 2015-11-19 18:40:28,704 DEBUG : BROWSER_OUTPUT: 18:40:28 INFO - 2015-11-19 18:40:28,704 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:91.20 Median:79.50 stddev:14.31 (18.0%) stddev-sans-first:13.58 18:40:28 INFO - 2015-11-19 18:40:28,705 DEBUG : BROWSER_OUTPUT: Values: 73.0 93.0 74.0 85.0 74.0 91.0 106.0 109.0 108.0 99.0 18:40:28 INFO - 2015-11-19 18:40:28,705 DEBUG : BROWSER_OUTPUT: 18:40:28 INFO - 2015-11-19 18:40:28,705 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.80 Median:129.00 stddev:6.53 (5.1%) stddev-sans-first:6.85 18:40:28 INFO - 2015-11-19 18:40:28,705 DEBUG : BROWSER_OUTPUT: Values: 124.0 131.0 134.0 135.0 113.0 130.0 125.0 121.0 127.0 128.0 18:40:28 INFO - 2015-11-19 18:40:28,706 DEBUG : BROWSER_OUTPUT: 18:40:28 INFO - 2015-11-19 18:40:28,706 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.80 Median:142.00 stddev:10.60 (7.5%) stddev-sans-first:11.24 18:40:28 INFO - 2015-11-19 18:40:28,706 DEBUG : BROWSER_OUTPUT: Values: 143.0 141.0 139.0 142.0 139.0 128.0 139.0 142.0 145.0 170.0 18:40:28 INFO - 2015-11-19 18:40:28,706 DEBUG : BROWSER_OUTPUT: 18:40:28 INFO - 2015-11-19 18:40:28,706 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.40 Median:81.00 stddev:10.57 (13.1%) stddev-sans-first:10.53 18:40:28 INFO - 2015-11-19 18:40:28,706 DEBUG : BROWSER_OUTPUT: Values: 66.0 69.0 84.0 87.0 95.0 78.0 68.0 67.0 66.0 84.0 18:40:28 INFO - 2015-11-19 18:40:28,706 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:40:28 INFO - 2015-11-19 18:40:28,706 DEBUG : BROWSER_OUTPUT: 18:40:29 INFO - 2015-11-19 18:40:29,317 INFO : Browser exited with error code: 0 18:40:29 INFO - 2015-11-19 18:40:29,365 INFO : Completed test kraken (00:00:57) 18:40:29 INFO - 2015-11-19 18:40:29,365 INFO : Starting test v8_7 18:40:29 INFO - 2015-11-19 18:40:29,365 DEBUG : operating with platform_type : mac_ 18:40:29 INFO - 2015-11-19 18:40:29,365 INFO : Initialising browser for v8_7 test... 18:40:29 INFO - 2015-11-19 18:40:29,378 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/tmp0Axp1e/profile http://localhost:49712/getInfo.html 18:40:31 INFO - 2015-11-19 18:40:31,897 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:40:31 INFO - 2015-11-19 18:40:31,897 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:40:31 INFO - 2015-11-19 18:40:31,897 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 18:40:31 INFO - 2015-11-19 18:40:31,897 DEBUG : BROWSER_OUTPUT: __metrics 18:40:32 INFO - 2015-11-19 18:40:32,517 INFO : Browser initialized. 18:40:32 INFO - 2015-11-19 18:40:32,517 INFO : Running cycle 1/1 for v8_7 test... 18:40:32 INFO - 2015-11-19 18:40:32,517 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/tmp0Axp1e/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:40:44 INFO - 2015-11-19 18:40:44,633 DEBUG : BROWSER_OUTPUT: RSS: Main: 235851776 18:40:44 INFO - 2015-11-19 18:40:44,633 DEBUG : BROWSER_OUTPUT: 18:41:06 INFO - 2015-11-19 18:41:06,039 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49712/tests/v8_7/run.html (next: http://localhost:49712/tests/v8_7/run.html) 18:41:06 INFO - 2015-11-19 18:41:06,301 DEBUG : BROWSER_OUTPUT: RSS: Main: 245985280 18:41:06 INFO - 2015-11-19 18:41:06,301 DEBUG : BROWSER_OUTPUT: 18:41:06 INFO - 2015-11-19 18:41:06,301 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:41:06 INFO - 2015-11-19 18:41:06,301 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:41:06 INFO - 2015-11-19 18:41:06,301 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:41:06 INFO - 2015-11-19 18:41:06,301 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:41:06 INFO - 2015-11-19 18:41:06,301 DEBUG : BROWSER_OUTPUT: |0;Richards;146.82131845543972 18:41:06 INFO - 2015-11-19 18:41:06,301 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;165.28925619834712 18:41:06 INFO - 2015-11-19 18:41:06,302 DEBUG : BROWSER_OUTPUT: |2;Encrypt;282.08744710860367 18:41:06 INFO - 2015-11-19 18:41:06,302 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4935.9605911330045 18:41:06 INFO - 2015-11-19 18:41:06,302 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1142.857142857143 18:41:06 INFO - 2015-11-19 18:41:06,302 DEBUG : BROWSER_OUTPUT: |5;Earley;739.6449704142012 18:41:06 INFO - 2015-11-19 18:41:06,302 DEBUG : BROWSER_OUTPUT: |6;Boyer;13621.621621621622 18:41:06 INFO - 2015-11-19 18:41:06,302 DEBUG : BROWSER_OUTPUT: |7;RegExp;26394.736842105263 18:41:06 INFO - 2015-11-19 18:41:06,302 DEBUG : BROWSER_OUTPUT: |8;Splay;700.2801120448179 18:41:06 INFO - 2015-11-19 18:41:06,302 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4559.090909090909 18:41:06 INFO - 2015-11-19 18:41:06,302 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:41:06 INFO - 2015-11-19 18:41:06,302 DEBUG : BROWSER_OUTPUT: __startTimestamp1447987266299__endTimestamp 18:41:06 INFO - 2015-11-19 18:41:06,302 DEBUG : BROWSER_OUTPUT: 18:41:06 INFO - 2015-11-19 18:41:06,302 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:41:06 INFO - 2015-11-19 18:41:06,302 DEBUG : BROWSER_OUTPUT: Number of tests: 10 18:41:06 INFO - 2015-11-19 18:41:06,303 DEBUG : BROWSER_OUTPUT: 18:41:06 INFO - 2015-11-19 18:41:06,303 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:146.82 Median:146.82 stddev:0.00 (0.0%) 18:41:06 INFO - 2015-11-19 18:41:06,303 DEBUG : BROWSER_OUTPUT: Values: 146.8 18:41:06 INFO - 2015-11-19 18:41:06,303 DEBUG : BROWSER_OUTPUT: 18:41:06 INFO - 2015-11-19 18:41:06,303 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:165.29 Median:165.29 stddev:0.00 (0.0%) 18:41:06 INFO - 2015-11-19 18:41:06,303 DEBUG : BROWSER_OUTPUT: Values: 165.3 18:41:06 INFO - 2015-11-19 18:41:06,303 DEBUG : BROWSER_OUTPUT: 18:41:06 INFO - 2015-11-19 18:41:06,303 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:282.09 Median:282.09 stddev:0.00 (0.0%) 18:41:06 INFO - 2015-11-19 18:41:06,303 DEBUG : BROWSER_OUTPUT: Values: 282.1 18:41:06 INFO - 2015-11-19 18:41:06,303 DEBUG : BROWSER_OUTPUT: 18:41:06 INFO - 2015-11-19 18:41:06,303 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4935.96 Median:4935.96 stddev:0.00 (0.0%) 18:41:06 INFO - 2015-11-19 18:41:06,303 DEBUG : BROWSER_OUTPUT: Values: 4936.0 18:41:06 INFO - 2015-11-19 18:41:06,303 DEBUG : BROWSER_OUTPUT: 18:41:06 INFO - 2015-11-19 18:41:06,303 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1142.86 Median:1142.86 stddev:0.00 (0.0%) 18:41:06 INFO - 2015-11-19 18:41:06,304 DEBUG : BROWSER_OUTPUT: Values: 1142.9 18:41:06 INFO - 2015-11-19 18:41:06,304 DEBUG : BROWSER_OUTPUT: 18:41:06 INFO - 2015-11-19 18:41:06,304 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:739.64 Median:739.64 stddev:0.00 (0.0%) 18:41:06 INFO - 2015-11-19 18:41:06,304 DEBUG : BROWSER_OUTPUT: Values: 739.6 18:41:06 INFO - 2015-11-19 18:41:06,304 DEBUG : BROWSER_OUTPUT: 18:41:06 INFO - 2015-11-19 18:41:06,304 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:13621.62 Median:13621.62 stddev:0.00 (0.0%) 18:41:06 INFO - 2015-11-19 18:41:06,304 DEBUG : BROWSER_OUTPUT: Values: 13621.6 18:41:06 INFO - 2015-11-19 18:41:06,304 DEBUG : BROWSER_OUTPUT: 18:41:06 INFO - 2015-11-19 18:41:06,304 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26394.74 Median:26394.74 stddev:0.00 (0.0%) 18:41:06 INFO - 2015-11-19 18:41:06,304 DEBUG : BROWSER_OUTPUT: Values: 26394.7 18:41:06 INFO - 2015-11-19 18:41:06,304 DEBUG : BROWSER_OUTPUT: 18:41:06 INFO - 2015-11-19 18:41:06,304 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:700.28 Median:700.28 stddev:0.00 (0.0%) 18:41:06 INFO - 2015-11-19 18:41:06,304 DEBUG : BROWSER_OUTPUT: Values: 700.3 18:41:06 INFO - 2015-11-19 18:41:06,304 DEBUG : BROWSER_OUTPUT: 18:41:06 INFO - 2015-11-19 18:41:06,305 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4559.09 Median:4559.09 stddev:0.00 (0.0%) 18:41:06 INFO - 2015-11-19 18:41:06,305 DEBUG : BROWSER_OUTPUT: Values: 4559.1 18:41:06 INFO - 2015-11-19 18:41:06,305 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:41:06 INFO - 2015-11-19 18:41:06,305 DEBUG : BROWSER_OUTPUT: 18:41:06 INFO - 2015-11-19 18:41:06,881 INFO : Browser exited with error code: 0 18:41:06 INFO - 2015-11-19 18:41:06,898 INFO : Completed test v8_7 (00:00:37) 18:41:06 INFO - 2015-11-19 18:41:06,899 INFO : Completed test suite (00:20:04) 18:41:06 INFO - 2015-11-19 18:41:06,899 DEBUG : Working with test: dromaeo_css 18:41:06 INFO - 2015-11-19 18:41:06,899 DEBUG : Generating results file: dromaeo_css 18:41:06 INFO - 2015-11-19 18:41:06,900 DEBUG : Working with test: kraken 18:41:06 INFO - 2015-11-19 18:41:06,900 DEBUG : Generating results file: kraken 18:41:06 INFO - 2015-11-19 18:41:06,900 INFO : javascript benchmark 18:41:06 INFO - 2015-11-19 18:41:06,900 DEBUG : Working with test: v8_7 18:41:06 INFO - 2015-11-19 18:41:06,900 DEBUG : Generating results file: v8_7 18:41:06 INFO - 2015-11-19 18:41:06,901 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:41:06 INFO - 2015-11-19 18:41:06,950 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 18:41:06 INFO - 2015-11-19 18:41:06,950 DEBUG : process_Request line: dromaeo_css 7586.45 graph.html#tests=[[72,64,61]] 18:41:06 INFO - 2015-11-19 18:41:06,950 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:41:06 INFO - 2015-11-19 18:41:06,974 DEBUG : process_Request line: kraken 1514.60 graph.html#tests=[[232,64,61]] 18:41:06 INFO - 2015-11-19 18:41:06,974 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:41:07 INFO - 2015-11-19 18:41:07,082 DEBUG : process_Request line: v8_7 21281.21 graph.html#tests=[[230,64,61]] 18:41:07 INFO - 2015-11-19 18:41:07,083 INFO : javascript benchmark 18:41:07 INFO - 2015-11-19 18:41:07,085 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3454.3264063507618, 3512.069301635067, 3550.8579656813727, 3576.2668652926154, 3579.7315201359906, 5834.212381328524, 5901.05583106703, 5932.614380065298, 5958.285005799299, 5982.132590774335, 5716.485516303532, 5804.564657650672, 5846.976779063668, 5861.0, 5861.267341582302, 5304.49607287308, 5313.654612450197, 5330.147176451768, 5390.78436862527, 5420.403755586883, 4456.754878481682, 5327.706976116312, 5386.326709161355, 5507.449255074501, 5510.779568817243, 5429.538489228401, 5460.31746031746, 5473.808416705416, 5486.780528778844, 5527.613067085305, 4797.18447863864, 5192.662476938987, 5392.460753924615, 5414.972925135349, 5445.264889239961, 5300.257963885059, 5321.600879934021, 5365.678059316453, 5372.57019438444, 5397.946020539784, 5413.53984911283, 5746.396628354046, 5807.82576522705, 5855.209546711182, 5936.406359364029, 5265.7893684252585, 6127.342242870425, 6209.87580248397, 6325.936740632581, 6347.047942808569, 6322.178116844827, 6348.365163483661, 6372.044193370985, 6374.298827129012, 6392.232932048138, 5992.49063829575, 6045.153678485016, 6061.121137435047, 6064.181335519736, 6067.696615169268, 5875.941240587625, 6262.749490020348, 6319.115323854664, 6346.492280617539, 6482.708278127496, 6288.591241569284, 6301.905471417932, 6315.778947736807, 6321.336259692758, 6325.114483972247, 6337.936620633827, 6362.331955144736, 6378.617282963037, 6389.7763578274535, 6405.519586031066, 6079.240094988127, 6197.4732147767045, 6255.280642726054, 6265.906011409833, 6266.467350275187, 6254.74981000764, 6270.090836828635, 6283.905741413882, 6327.272363678236, 6335.746570137235, 4922.33548470959, 5065.164247899055, 5070.569001634829, 5073.213651883964, 5113.079645663742, 4467.7319360838455, 4528.818847246139, 4561.110583436198, 4583.106294272585, 4596.908061838812, 6000.249968753906, 6026.668533230627, 6064.545159113084, 6065.787697430657, 6076.572005578685, 6172.290186628506, 6327.905081423783, 6378.74485020594, 6383.329750376237, 6404.551681382259, 5981.162637230791, 6020.879582408327, 6051.394860513913, 6056.727447264883, 6065.423784740443, 5571.721413929287, 5577.107662774018, 5602.0, 5603.8599035023635, 5623.240862483594, 6238.064290356483, 6361.109444677842, 6364.268109167505, 6612.933870661328, 6653.767118150841, 6241.344658810759, 6317.5893566918, 6328.683565821782, 6336.3030066693545, 6355.3644635536075, 5273.709945953009, 5759.424057594207, 6493.480521558358, 6529.281779004401, 6550.181227346582, 6143.877122457615, 6216.316205217513, 6230.376962303733, 6302.558820882494, 6338.207724034496, 6290.559660823881, 6379.298277189413, 6395.16862807832, 6400.583962042452, 6438.452731517874, 5113.463086376026, 6302.71637776292, 6304.148939893055, 6317.368263173646, 6324.620522768649, 6084.056971169476, 6151.630902145886, 6199.318075011655, 6316.652584107918, 6319.842003949938, 6049.546284028627, 6179.104029915727, 6229.314775374796, 6230.127782110418, 6235.127082208585, 5834.095715164156, 6257.4994000480765, 6266.843328916813, 6295.898217811773, 6345.2702939160745, 6011.458968692838, 6106.551676171979, 6119.685352982247, 6204.255489341127, 6210.534209934182], "unit": "ms", "name": "dojo.html", "value": 5826.330921191775}, {"lowerIsBetter": false, "replicates": [551.0907003444319, 566.3289002532, 572.5047833623915, 584.010102875626, 598.6378241164095, 33959.49060764087, 40565.0, 41533.0, 41610.79194604026, 41659.16681666365, 44510.554894451045, 44725.552744472545, 44895.0, 44955.550444495544, 45049.09901801962, 9647.469389183592, 9814.263930205227, 9843.163331116864, 9843.60625574976, 9870.802583948316, 9658.903410965871, 9732.854007189897, 9741.902580974205, 9749.512524373753, 9763.267754918374, 9679.564419601134, 9726.610935562605, 9735.610575576968, 9737.221022318234, 9747.805043899118, 9680.419174849496, 9750.26872984529, 9761.07269809367, 9773.413595184276, 9787.119159275699, 9555.18780903624, 9682.273829462749, 9694.757631059209, 9696.030396960317, 9719.125278724949, 41347.0, 41383.58616413858, 41593.0, 41654.37518437226, 41722.37416438756, 3195.265089029513, 3202.6637203093806, 3247.561579186803, 3386.271951530408, 3678.098865777875, 28686.713132868612, 29056.564151537743, 29673.554896676567, 30051.849740751375, 30213.827548107573, 2821.1818572613915, 2827.3073097091346, 2845.8434786086755, 2895.4064416794718, 2955.275957390453, 465045.0, 465227.0, 471552.0, 472320.6383968092, 473358.0, 57727.134092988636, 58444.12333814996, 66063.33936660668, 66110.33889661042, 71325.28674713291, 67595.32404675988, 67889.3211067883, 67964.0, 68180.97728534076, 68487.97268040983, 15441.919065665521, 15503.457378991681, 15519.301631426613, 15669.0, 15718.764218536731, 11673.474693638807, 11724.531018759324, 11745.17783755146, 11773.941130294465, 11845.289282643069, 20587.38237852867, 20902.26842060551, 21076.894615526824, 21113.894430527747, 21313.89343053275, 8572.91427085721, 8776.824463510695, 8784.165504277084, 8784.429012114193, 8828.77928051791, 964.8600952861796, 994.4480813148772, 1025.3284098915221, 1116.553378648531, 1159.8492196014465, 29514.87933179109, 29704.811807527458, 29926.102216933527, 30279.0, 30368.088957331314, 885.7209978856639, 1020.7958408318366, 1067.514281002142, 1074.693712291993, 1162.436218434059, 15000.249987500581, 15116.54650360491, 15379.769303460456, 15396.615084622974, 15480.0, 542983.0, 549986.0, 556861.0, 558322.4167758352, 562291.0, 59070.40929590735, 59402.40597594055, 59465.0, 59662.0, 59753.40246597478, 1387.4796951143321, 1393.5749596373, 1410.4499245294344, 1432.7349440353569, 1436.2818590704649, 29545.852270739368, 30271.545926811556, 30417.23956901095, 30516.694833051384, 30603.2349191272, 53132.46867531275, 53394.0, 53461.19808202802, 53560.0, 53613.0, 316909.0, 319222.0, 320727.0, 320938.0, 322319.0, 30752.384952301276, 33140.84007059741, 34123.829380852934, 34144.31711365709, 34160.31679366349, 42880.14239715251, 43392.0, 43473.0, 43539.56460435355, 43742.0, 36474.8176259117, 36566.0, 36599.63400365962, 36901.815490922374, 38034.0491487704, 35338.0, 36095.0, 36125.45811812877, 36157.638423615426, 36303.636963631085, 36599.45100823436, 37356.62643373531, 37970.43044354281, 37986.0, 37990.81004594959, 30278.394432111676, 32499.675003249664, 33536.99389018333, 33816.49275260824, 34610.0, 21761.455963601038, 25150.874245628656, 25201.24396268115, 25396.984120634967, 25560.849761760393], "unit": "ms", "name": "ext.html", "value": 19840.37025268749}, {"lowerIsBetter": false, "replicates": [280.72909642195276, 352.42554635943407, 353.2757846414849, 356.9072041269269, 368.03574634457715, 16336.428225012127, 18222.81777182228, 19704.40886773397, 19883.30408435703, 20359.898200508997, 11593.942030289858, 11645.941770291158, 11870.881291187086, 11872.525098996051, 19604.117814698337, 4591.242444996588, 5278.3665960084845, 5328.333958255218, 5353.732313384316, 5374.462553744614, 3944.605539446047, 4057.127717540728, 5281.049411106019, 5747.453991870787, 5913.14259432382, 5779.884402311972, 5844.941550584504, 5869.9706501467435, 5913.349531551526, 5934.050551911695, 5742.822721342115, 5782.335031471372, 5949.988501954678, 5951.821445356646, 5973.761049558012, 4947.2579113133315, 5552.5280351169795, 5673.489385955242, 5692.288463942007, 5746.310442746855, 24281.150159744502, 24286.0, 24885.880135393953, 24947.87526062376, 25173.24480265595, 1933.8549608779397, 2019.7475315585552, 2053.9589208215752, 2087.499000239947, 2251.617225071742, 9614.75963100921, 9828.262880284008, 13515.256660883648, 13826.771024678535, 14684.559463216121, 1704.940327088546, 1722.190570431895, 1722.8621710263149, 1733.0468242466593, 1755.4645833020923, 90941.0, 92935.53532232296, 94998.0, 98216.0178398214, 102791.48604257006, 10677.0, 10935.234533582732, 10970.232083754061, 10993.065589424989, 11129.666110016713, 11640.60312762474, 12569.371531423392, 13107.606771796862, 13112.344382781013, 13116.0818742689, 8126.228008339198, 8169.0605580359015, 8184.713535026245, 8190.590470476572, 8244.051934027544, 7998.64006119726, 8209.179082091863, 8226.958865205756, 8245.546494942835, 8313.875291870627, 3571.8571257149943, 3706.8331925063435, 4289.613934745826, 4324.71889327199, 4353.281708518122, 1740.1125426032816, 1780.0654656305285, 1798.3975368251781, 1835.229203734408, 1842.797292297846, 380.5433479824222, 388.9027743064234, 891.5898686604105, 909.7634615000147, 1000.2748007694508, 11305.812889646633, 11668.533258669728, 11742.647720568397, 11779.52881884715, 21147.894260528905, 714.8034290570031, 763.6868883757744, 812.2811311988814, 823.360745504858, 1027.7379268286538, 10803.891961080446, 10995.725106872393, 11050.51550495605, 11162.386068766133, 11168.329900206014, 665514.0, 745004.0, 752529.2373538207, 758166.0, 761064.0, 100822.0, 116485.0, 117302.41348793202, 119102.0, 120378.0, 1190.7023244188954, 1193.9256414731926, 1196.0730433913786, 1201.1711918776016, 1214.4049415786378, 18039.188236529124, 18610.720839187692, 18972.335968241045, 19189.32837350742, 19221.231150753814, 48421.88413984851, 48547.27179092387, 48991.02017959692, 51269.48730512647, 52550.0, 68156.61451849161, 68569.65715171392, 71054.0, 71755.0, 71957.0, 9733.0, 9904.950475247577, 9985.051420115078, 10025.849612255675, 10058.49707514636, 11694.2983420995, 11729.47217375203, 15069.397224110913, 18682.25270989145, 19149.35982955313, 15717.056976581442, 16135.112568808829, 16181.0, 16257.430989915769, 16334.509964701077, 14926.328315225624, 15261.694766104394, 15443.691126177639, 15636.921815391306, 16266.918665406598, 16283.0, 16487.587810304838, 16617.75073373876, 16691.24889380005, 16744.24650890737, 9908.108270255712, 9924.900750992398, 9951.950240248752, 9957.651482198089, 10077.748056298651, 12763.48946042185, 15317.310721017804, 16086.150092739485, 16306.510804675878, 16544.338226470805], "unit": "ms", "name": "jquery.html", "value": 9524.268275622251}, {"lowerIsBetter": false, "replicates": [1506.2393491286898, 1542.5912133284683, 1829.7621309229798, 1831.386485527348, 1864.0400193900143, 6891.7243310267595, 7019.0, 7051.823704407386, 7397.963010184942, 7516.173220945705, 7653.4259930505295, 7950.920490795091, 8404.62179201936, 8483.533405662685, 8514.020887597928, 2347.5539647467012, 2382.9872304270702, 2383.797377222938, 2386.2364043506086, 2389.6057150570136, 2115.576884623074, 2381.7380088190284, 2404.627282771173, 2409.8915548800346, 2436.8537887726793, 2340.918067867625, 2368.52629474105, 2381.7499162587937, 2392.8564286142887, 2400.6399040143942, 2341.8360714749974, 2367.9052837886466, 2391.103336248898, 2402.4834660547976, 2402.6756387887585, 2046.9795302046937, 2384.225126833786, 2398.9160379386813, 2418.891149898259, 2421.4914867877765, 8382.87425688615, 8457.238848503664, 8467.788305292417, 8490.448120872123, 8510.0, 4504.774761261924, 5111.948880511184, 5205.193195054735, 5219.138842091051, 5233.084210263227, 3160.7787454878166, 3476.200473891019, 3478.930421391558, 3552.964470355289, 3571.624979377154, 967.8596603492524, 998.241336584194, 1019.94390308533, 1056.1128651932413, 1063.0273299930554, 11102.389368584643, 11151.442427878574, 11163.776724465466, 11164.888351116466, 11228.55085796567, 4333.678228140385, 4361.694681372337, 4728.976355118202, 4776.689515181502, 4784.138855006063, 9661.32370734056, 9702.90297097034, 9708.563114659857, 9723.902760972442, 9727.270454715925, 5183.611229157828, 5192.0, 5207.140821764442, 5219.217117432416, 5245.921311180336, 4716.646251531149, 4723.0, 4729.95270047302, 4742.596879265301, 4756.096341695067, 3815.3323168445413, 3871.6709079727975, 3888.358420860583, 3908.335582950905, 3910.100676844285, 1273.8980881529455, 1287.8776516230944, 1290.2129700882454, 1291.5544137272625, 1308.587794844621, 1349.3514841371577, 1371.9176849389069, 1379.6137081617164, 1389.7706878364957, 1402.4740722229164, 7737.767866964, 7802.843943121105, 7818.960905195438, 7884.093329267208, 7884.448088633741, 488.4870885570137, 489.76491284183794, 490.0395225358266, 490.4604934571942, 513.912634852076, 5710.771569137188, 6039.909401358983, 6051.9697401513595, 6072.330109219912, 6091.086337049478, 9170.220531254785, 9982.450965196984, 10089.697309080739, 10179.745506362253, 10210.4384258865, 8355.248027677417, 8396.664133434717, 9890.80218395628, 10071.295009349422, 10077.445740484198, 7842.686292548348, 7888.802779930433, 7915.604219788987, 7928.365730741642, 7952.840943181104, 6692.196936367667, 7678.308952194329, 7757.7672669819995, 7791.948087008182, 7844.137144914169, 8982.461052336881, 9085.409448385833, 9099.090090990849, 9100.635974560944, 9151.222146117654, 9271.536423178948, 9350.719478415658, 9427.57575909072, 9484.810303793747, 9544.0, 7245.203027666847, 7284.162321333115, 7290.3438690518105, 7322.0, 7324.377427918686, 7840.764777056697, 8030.196980301923, 8031.397645176752, 8053.033635963722, 8057.194280571896, 7515.9853419789815, 7527.698892044257, 7529.58587277705, 7662.616869156632, 7672.578008209602, 7435.256474352522, 7450.925490745023, 7472.40220782347, 7534.660940257592, 7568.697252110074, 7446.4042876568665, 7612.543247405173, 7621.237876212334, 7659.4255430841795, 7665.501742386727, 5751.827445176651, 6915.204751453647, 6933.2026816916705, 6942.51402401827, 6949.583025018515, 6033.276006879202, 6918.411934985583, 6986.091808065123, 7003.29967003316, 7016.22821489646], "unit": "ms", "name": "mootools.html", "value": 4665.494517797583}, {"lowerIsBetter": false, "replicates": [322.3938994689983, 326.221960623912, 329.2460265990881, 331.86725309876056, 334.6101791413004, 6642.966785166067, 6890.310968903107, 6901.309869013103, 6902.378785909274, 6930.549514281568, 6651.268360480343, 6810.761623343184, 6829.248782633918, 6842.0, 6849.383555480006, 5039.72281524516, 5044.243363495469, 5071.746412679369, 5096.031753966744, 5100.285959965608, 4898.657094003421, 5062.822801201959, 5065.290859279704, 5070.569001634865, 5087.56755675768, 4922.483139270379, 4960.206366981283, 5005.624578156635, 5018.949810501903, 5025.321581586476, 5010.048090862742, 5010.574101201402, 5015.824446144386, 5018.447970723218, 5025.447200807908, 3574.2315402188656, 4215.093754842693, 4301.72038817479, 4309.439772829513, 4320.697551171419, 6543.1821022372205, 6564.606123632598, 6577.736890524373, 6582.407583317525, 6585.6707164641575, 5947.6431414115295, 5965.433283838029, 5982.670953097578, 5983.1025346197985, 5991.370906054845, 5605.635633683838, 5788.073908174714, 5847.912281315784, 5900.0, 7071.045408869788, 4810.845397104705, 4818.927716084261, 4825.9758701206265, 4834.58905992991, 4850.975745121287, 7721.575313357763, 7749.108852481924, 7756.534607923542, 7802.336801371834, 7808.252039021245, 4758.452777930513, 4907.631927605444, 4915.803367865316, 4921.606271498272, 4932.67937584063, 5009.273655319958, 5020.974895125501, 5021.548060674557, 5028.094942910238, 5046.167382381939, 5930.229070220844, 5930.7924222652, 5936.673482958392, 5950.9107363389585, 5954.345022047572, 7343.77968660941, 7348.742794002291, 7351.117865856025, 7354.521956072838, 7406.370458510979, 1663.2432243329497, 1715.3138744502298, 1730.3078768492453, 1730.411660035594, 1738.1309345327336, 936.4849332866896, 1045.6772183188273, 1067.2849191042021, 1135.8807325230896, 1139.732162941708, 6958.860822783516, 6969.47728920333, 6974.58152510851, 6989.5107342485535, 7020.894686579705, 6202.4417802398, 7621.161672216052, 7645.655945482466, 7654.4259180561685, 7672.117706463717, 6224.533160013018, 6818.897716534256, 6935.826604334932, 6952.617606031616, 6971.128608923885, 3930.9017274568364, 4022.1151346703678, 4025.5370632377653, 4039.939400908989, 4060.2894493463527, 7826.373890088779, 7991.081025682005, 7997.400194985283, 8004.839903201903, 8045.517268963881, 6453.548251622436, 7957.124716281204, 7957.323627491613, 7965.56189409588, 7965.960170199228, 7770.106437759617, 7940.722074727357, 7978.202179781975, 7990.720324788605, 7993.640286187136, 6178.907316390348, 7691.923080769121, 7714.228577142241, 7719.266669666373, 7749.302562769378, 7354.899857830458, 7516.812079698051, 7527.2849079337375, 7574.621268936421, 7605.961970190114, 6954.269801670752, 7517.736879209201, 8010.158933311918, 8032.759017229492, 8041.8391632168195, 4954.430240522386, 4964.021587047742, 4969.82605608802, 4972.950270497394, 4977.228529577921, 7458.701651934079, 7594.962025189839, 7666.693332266647, 7685.0, 7709.267619576131, 7327.047483827068, 7398.926010739824, 7401.777946661608, 7405.741024026036, 7407.851842963219, 7361.337479626859, 7366.337029667356, 7368.047467421031, 7368.410527157707, 7384.446166537424, 5939.524838012862, 6977.33715297046, 7143.856982882714, 7228.746993855189, 7253.601051942193, 7382.3724983377015, 7385.778426647209, 7391.556506609621, 7411.66647500853, 7424.517406368569, 7044.013838062573, 7205.0, 7225.277472252943, 7229.891551626835, 7286.599237042014], "unit": "ms", "name": "prototype.html", "value": 5341.4073092309745}, {"lowerIsBetter": false, "replicates": [730.3390431659349, 781.9061712594482, 793.9364850811936, 811.6185392865351, 840.701550949413, 15032.248387580617, 15203.239838008083, 15407.922960385196, 15420.151891645955, 15438.61403464914, 12277.140600157993, 12450.252984820894, 12919.160254583468, 12925.289109098996, 12940.22358658481, 779.6218833865571, 928.5310917986408, 943.3019565521499, 951.5955718819508, 957.1816097236866, 949.8812648418948, 955.044955044955, 961.0149596663441, 961.4231461123305, 962.2254085461201, 981.7594689301131, 1000.0649392817738, 1002.3735165521549, 1002.5538635307291, 1005.4369553050278, 978.7944531648362, 985.7387792234991, 989.114742305636, 993.3195760903805, 1001.0390025575492, 730.8903664450374, 739.2164305835778, 741.8961345411593, 742.8365759532894, 755.4636208292119, 11223.943880280547, 13110.213387196703, 13195.736085278337, 13203.339833008311, 13206.801897971538, 11022.559097636085, 11024.50389732464, 11064.336139831636, 11513.963743263146, 11702.941485292518, 9564.760880977961, 9588.472634005197, 9633.277504187214, 9646.276529260334, 10275.79448411035, 3427.6572342765526, 3465.5148279240925, 3467.6705712957228, 3489.668481494254, 3490.5287786148797, 68696.3130368695, 72767.63616181938, 74062.62968685175, 74177.25822741758, 80754.19245807525, 9338.673146439978, 9369.672061477815, 9373.48445835472, 9388.342816002814, 9582.041795820362, 20890.0, 21327.46681332948, 21595.460113497287, 21741.13035478563, 21939.67090493644, 7445.181030086686, 7544.4341674373545, 7598.0502437195355, 7730.497517661334, 7861.213878612093, 4100.466939297872, 4163.937540936889, 4167.1457351242925, 4174.20690068886, 4196.853110141131, 3115.922101947424, 3610.837512311952, 3629.165291982859, 3630.3102410541915, 3637.4543818427446, 629.9716512756937, 644.0693198328464, 645.4287955159717, 667.2993356975254, 673.0375562944938, 445.32310887450893, 452.0800171650741, 484.1189035954599, 498.4890487250597, 515.3763945625835, 7822.687092516236, 9462.621495140118, 9511.809763804686, 9556.187724043395, 9639.831038016531, 503.0, 506.1092477240084, 574.3768011707261, 609.1289456077762, 634.4385219081054, 4054.270231358325, 4208.473940757405, 4249.362595610622, 4260.957390426056, 4291.29193683045, 98270.50864745774, 99610.0, 99961.50019249857, 101374.0, 101814.0, 74825.0, 82379.5881020591, 83493.74759378615, 84087.5795621018, 85018.0, 71874.0, 73808.63095684488, 75763.0, 77623.28318508939, 78811.60594197107, 8966.462012279284, 9093.499857507635, 9169.449833010041, 9192.356535042483, 9232.030636783042, 49495.0, 50400.49599503958, 50786.730331740524, 53014.204786928996, 54110.64723381947, 60491.69754151201, 66651.0, 70499.9425008615, 73476.26523734695, 76643.0, 9111.31665125105, 11003.724906877393, 11108.277961932448, 11395.487203075716, 12047.397630118283, 11956.521739130338, 12013.978811800745, 12024.398780061138, 12370.876291236973, 12808.0, 11132.499037543492, 11249.71875703114, 11288.665167468534, 11530.135239857213, 11999.280043197086, 11326.490307935997, 11427.828582571101, 11653.47559359814, 11824.52701891949, 12306.015518758299, 10999.560017599206, 11039.558417663204, 11107.278026928223, 11642.359670218219, 12321.93839030799, 8146.5519396433765, 9336.579853906454, 9595.664151754656, 10083.294169408071, 10424.530896109542, 8716.520591367282, 8831.205191532792, 8932.86600701003, 9618.807623847624, 9939.950300248453], "unit": "ms", "name": "yui.html", "value": 6948.075242518174}], "name": "dromaeo_css", "value": 7586.444980178789}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 108.0, 114.0, 114.0, 114.0, 125.0, 113.0, 114.0, 113.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 114.3}, {"lowerIsBetter": true, "replicates": [149.0, 126.0, 146.0, 154.0, 121.0, 150.0, 162.0, 150.0, 186.0, 126.0], "unit": "ms", "name": "audio-beat-detection", "value": 147.0}, {"lowerIsBetter": true, "replicates": [197.0, 202.0, 198.0, 273.0, 252.0, 228.0, 274.0, 256.0, 198.0, 206.0], "unit": "ms", "name": "audio-dft", "value": 228.4}, {"lowerIsBetter": true, "replicates": [64.0, 61.0, 72.0, 111.0, 59.0, 55.0, 58.0, 61.0, 112.0, 59.0], "unit": "ms", "name": "audio-fft", "value": 71.2}, {"lowerIsBetter": true, "replicates": [77.0, 76.0, 108.0, 75.0, 79.0, 75.0, 105.0, 77.0, 105.0, 92.0], "unit": "ms", "name": "audio-oscillator", "value": 86.9}, {"lowerIsBetter": true, "replicates": [86.0, 87.0, 86.0, 87.0, 86.0, 87.0, 87.0, 86.0, 89.0, 87.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 86.8}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 95.0, 104.0, 94.0, 98.0, 150.0, 125.0, 95.0, 95.0], "unit": "ms", "name": "imaging-darkroom", "value": 104.5}, {"lowerIsBetter": true, "replicates": [111.0, 141.0, 119.0, 93.0, 91.0, 91.0, 78.0, 149.0, 140.0, 94.0], "unit": "ms", "name": "imaging-desaturate", "value": 110.7}, {"lowerIsBetter": true, "replicates": [59.0, 61.0, 59.0, 61.0, 59.0, 60.0, 60.0, 66.0, 57.0, 58.0], "unit": "ms", "name": "json-parse-financial", "value": 60.0}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 66.0, 66.0, 67.0, 67.0, 70.0, 69.0, 73.0, 63.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 67.6}, {"lowerIsBetter": true, "replicates": [73.0, 93.0, 74.0, 85.0, 74.0, 91.0, 106.0, 109.0, 108.0, 99.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 91.2}, {"lowerIsBetter": true, "replicates": [124.0, 131.0, 134.0, 135.0, 113.0, 130.0, 125.0, 121.0, 127.0, 128.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 126.8}, {"lowerIsBetter": true, "replicates": [143.0, 141.0, 139.0, 142.0, 139.0, 128.0, 139.0, 142.0, 145.0, 170.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 142.8}, {"lowerIsBetter": true, "replicates": [66.0, 69.0, 84.0, 87.0, 95.0, 78.0, 68.0, 67.0, 66.0, 84.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 76.4}], "name": "kraken", "value": 1514.6000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [146.82131845543972], "unit": "score", "name": "Richards", "value": 240.441922}, {"lowerIsBetter": false, "replicates": [165.28925619834712], "unit": "score", "name": "DeltaBlue", "value": 400.0139000000002}, {"lowerIsBetter": false, "replicates": [282.08744710860367], "unit": "score", "name": "Encrypt", "value": 943.6116450000002}, {"lowerIsBetter": false, "replicates": [4935.9605911330045], "unit": "score", "name": "Decrypt", "value": 53.92688922155686}, {"lowerIsBetter": false, "replicates": [1142.857142857143], "unit": "score", "name": "RayTrace", "value": 647.4903750000001}, {"lowerIsBetter": false, "replicates": [739.6449704142012], "unit": "score", "name": "Earley", "value": 901.0579759999997}, {"lowerIsBetter": false, "replicates": [13621.621621621622], "unit": "score", "name": "Boyer", "value": 48.92684722222226}, {"lowerIsBetter": false, "replicates": [26394.736842105263], "unit": "score", "name": "RegExp", "value": 34.51388833499503}, {"lowerIsBetter": false, "replicates": [700.2801120448179], "unit": "score", "name": "Splay", "value": 116.36914800000002}, {"lowerIsBetter": false, "replicates": [4559.090909090909], "unit": "score", "name": "NavierStokes", "value": 325.5034895314059}], "name": "v8_7", "value": 21281.208748928773}]} 18:41:07 INFO - RETURN: dromaeo_css: 7586.45 18:41:07 INFO - RETURN: kraken: 1514.60 18:41:07 INFO - RETURN: v8_7: 21281.21 18:41:07 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,61]]", "result": "21281.21"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1514.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7586.45"}}} 18:41:07 INFO - Return code: 0 18:41:07 INFO - # TBPL SUCCESS # 18:41:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:41:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:41:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:41:07 INFO - 2015-11-19 18:41:07.175 screenresolution[1986:15156] starting screenresolution argv=screenresolution get 18:41:07 INFO - 2015-11-19 18:41:07.178 screenresolution[1986:15156] Display 0: 1600x1200x32@60 18:41:07 INFO - 2015-11-19 18:41:07.184 screenresolution[1987:15159] starting screenresolution argv=screenresolution list 18:41:07 INFO - Available Modes on Display 0 18:41:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:41:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:41:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:41:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:41:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:41:07 INFO - Intel Iris: 18:41:07 INFO - Chipset Model: Intel Iris 18:41:07 INFO - Type: GPU 18:41:07 INFO - Bus: Built-In 18:41:07 INFO - VRAM (Dynamic, Max): 1536 MB 18:41:07 INFO - Vendor: Intel (0x8086) 18:41:07 INFO - Device ID: 0x0a2e 18:41:07 INFO - Revision ID: 0x0009 18:41:07 INFO - Displays: 18:41:07 INFO - Display: 18:41:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:41:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:41:07 INFO - Display Serial Number: 1600x1200 60 18:41:07 INFO - Main Display: Yes 18:41:07 INFO - Mirror: Off 18:41:07 INFO - Online: Yes 18:41:07 INFO - Rotation: Supported 18:41:07 INFO - Return code: 0 18:41:07 INFO - Running post-action listener: _resource_record_post_action 18:41:07 INFO - Running post-run listener: _resource_record_post_run 18:41:08 INFO - Total resource usage - Wall time: 1236s; CPU: 54.0%; Read bytes: 503808; Write bytes: 692917248; Read time: 8; Write time: 2214 18:41:08 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 336286208; Write bytes: 336590848; Read time: 25720; Write time: 626 18:41:08 INFO - run-tests - Wall time: 1206s; CPU: 54.0%; Read bytes: 503808; Write bytes: 345951232; Read time: 8; Write time: 1559 18:41:08 INFO - Running post-run listener: _upload_blobber_files 18:41:08 INFO - Blob upload gear active. 18:41:08 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 18:41:08 INFO - Copying logs to upload dir... 18:41:08 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1283.262409 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2015-11-19 18:41:08.549662) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 18:41:08.553247) ========= 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.PmqZNiNNRo/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.kVuIaOPwdE/Listeners TMPDIR=/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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/Lgx9hOx6RGqYCwFaLn5K_w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009468 build_url: 'https://queue.taskcluster.net/v1/task/Lgx9hOx6RGqYCwFaLn5K_w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 18:41:08.576004) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 18:41:08.576322) ========= 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.PmqZNiNNRo/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.kVuIaOPwdE/Listeners TMPDIR=/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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.005082 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 18:41:08.624886) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 18:41:08.625198) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 18:41:08.625610) ========= ========= Total master_lag: 0.20 =========