builder: fx-team_yosemite_test-dromaeojs-e10s slave: t-yosemite-r5-0057 starttime: 1447615516.37 results: success (0) buildid: 20151115092632 builduid: 743ffbfad5cf440597a3b71c3118312f revision: 3f0651985bf0e3403b5fd4984a907813689ee3a9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-15 11:25:16.369002) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-15 11:25:16.369491) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-15 11:25:16.369818) ========= 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.gF3LuyrGwH/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.l5mTGs2n5e/Listeners TMPDIR=/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/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:0x0:0x0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.007314 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-15 11:25:16.396576) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-15 11:25:16.396924) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-15 11:25:16.414055) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 11:25:16.414394) ========= 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.gF3LuyrGwH/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.l5mTGs2n5e/Listeners TMPDIR=/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/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:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.006158 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 11:25:16.464446) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-15 11:25:16.464789) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-15 11:25:16.465192) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 11:25:16.465521) ========= 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.gF3LuyrGwH/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.l5mTGs2n5e/Listeners TMPDIR=/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/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:0x0:0x0 using PTY: False --2015-11-15 11:25:16-- 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% 7.38M=0.002s 2015-11-15 11:25:16 (7.38 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.229926 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 11:25:16.712746) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 11:25:16.713109) ========= 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.gF3LuyrGwH/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.l5mTGs2n5e/Listeners TMPDIR=/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/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:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.022075 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 11:25:16.763570) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-15 11:25:16.764020) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3f0651985bf0e3403b5fd4984a907813689ee3a9 --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 3f0651985bf0e3403b5fd4984a907813689ee3a9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.gF3LuyrGwH/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.l5mTGs2n5e/Listeners TMPDIR=/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/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:0x0:0x0 using PTY: False 2015-11-15 11:25:16,843 truncating revision to first 12 chars 2015-11-15 11:25:16,843 Setting DEBUG logging. 2015-11-15 11:25:16,843 attempt 1/10 2015-11-15 11:25:16,843 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3f0651985bf0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-15 11:25:17,866 unpacking tar archive at: fx-team-3f0651985bf0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.293092 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-15 11:25:18.075576) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-15 11:25:18.075955) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-15 11:25:18.090426) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-15 11:25:18.090866) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-15 11:25:18.091364) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 56 secs) (at 2015-11-15 11:25:18.091707) ========= /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.gF3LuyrGwH/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.l5mTGs2n5e/Listeners TMPDIR=/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/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:0x0:0x0 using PTY: False 11:25:18 INFO - MultiFileLogger online at 20151115 11:25:18 in /builds/slave/test 11:25:18 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 11:25:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:25:18 INFO - {'append_to_log': False, 11:25:18 INFO - 'base_work_dir': '/builds/slave/test', 11:25:18 INFO - 'blob_upload_branch': 'Fx-Team', 11:25:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:25:18 INFO - 'branch': 'Fx-Team', 11:25:18 INFO - 'buildbot_json_path': 'buildprops.json', 11:25:18 INFO - 'config_files': ('talos/mac_config.py',), 11:25:18 INFO - 'default_actions': ('clobber', 11:25:18 INFO - 'read-buildbot-config', 11:25:18 INFO - 'download-and-extract', 11:25:18 INFO - 'populate-webroot', 11:25:18 INFO - 'create-virtualenv', 11:25:18 INFO - 'install', 11:25:18 INFO - 'run-tests'), 11:25:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:25:18 INFO - 'download_minidump_stackwalk': True, 11:25:18 INFO - 'download_symbols': 'ondemand', 11:25:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:25:18 INFO - 'tooltool.py': '/tools/tooltool.py', 11:25:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:25:18 INFO - '/tools/misc-python/virtualenv.py')}, 11:25:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:25:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:25:18 INFO - 'installer_path': 'installer.exe', 11:25:18 INFO - 'log_level': 'info', 11:25:18 INFO - 'log_name': 'talos', 11:25:18 INFO - 'log_to_console': True, 11:25:18 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:25:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:25:18 INFO - 'opt_config_files': (), 11:25:18 INFO - 'pip_index': False, 11:25:18 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:25:18 INFO - 'cmd': ('bash', 11:25:18 INFO - '-c', 11:25:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:25:18 INFO - 'enabled': True, 11:25:18 INFO - 'halt_on_failure': False, 11:25:18 INFO - 'name': 'check_screen_resolution'},), 11:25:18 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:25:18 INFO - 'cmd': ('bash', 11:25:18 INFO - '-c', 11:25:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:25:18 INFO - 'enabled': True, 11:25:18 INFO - 'halt_on_failure': False, 11:25:18 INFO - 'name': 'check_screen_resolution'},), 11:25:18 INFO - 'run_cmd_checks_enabled': True, 11:25:18 INFO - 'sps_profile': False, 11:25:18 INFO - 'sps_profile_interval': 0, 11:25:18 INFO - 'suite': 'dromaeojs-e10s', 11:25:18 INFO - 'system_bits': '64', 11:25:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:25:18 INFO - 'title': 't-yosemite-r5-0057', 11:25:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:25:18 INFO - 'use_talos_json': True, 11:25:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:25:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:25:18 INFO - 'work_dir': 'build'} 11:25:18 INFO - ##### 11:25:18 INFO - ##### Running clobber step. 11:25:18 INFO - ##### 11:25:18 INFO - Running pre-action listener: _resource_record_pre_action 11:25:18 INFO - Running main action method: clobber 11:25:18 INFO - rmtree: /builds/slave/test/build 11:25:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:25:21 INFO - Running post-action listener: _resource_record_post_action 11:25:21 INFO - ##### 11:25:21 INFO - ##### Running read-buildbot-config step. 11:25:21 INFO - ##### 11:25:21 INFO - Running pre-action listener: _resource_record_pre_action 11:25:21 INFO - Running main action method: read_buildbot_config 11:25:21 INFO - Using buildbot properties: 11:25:21 INFO - { 11:25:21 INFO - "properties": { 11:25:21 INFO - "buildnumber": 44, 11:25:21 INFO - "product": "firefox", 11:25:21 INFO - "script_repo_revision": "production", 11:25:21 INFO - "builddir": "fx-team_yosemite_test-dromaeojs-e10s", 11:25:21 INFO - "repository": "", 11:25:21 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 fx-team talos dromaeojs-e10s", 11:25:21 INFO - "buildid": "20151115092632", 11:25:21 INFO - "slavename": "t-yosemite-r5-0057", 11:25:21 INFO - "pgo_build": "False", 11:25:21 INFO - "basedir": "/builds/slave/test", 11:25:21 INFO - "project": "", 11:25:21 INFO - "platform": "yosemite", 11:25:21 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 11:25:21 INFO - "slavebuilddir": "test", 11:25:21 INFO - "scheduler": "tests-fx-team-macosx64-talos", 11:25:21 INFO - "branch": "fx-team", 11:25:21 INFO - "repo_path": "integration/fx-team", 11:25:21 INFO - "stage_platform": "macosx64", 11:25:21 INFO - "builduid": "743ffbfad5cf440597a3b71c3118312f", 11:25:21 INFO - "revision": "3f0651985bf0e3403b5fd4984a907813689ee3a9" 11:25:21 INFO - }, 11:25:21 INFO - "sourcestamp": { 11:25:21 INFO - "repository": "", 11:25:21 INFO - "hasPatch": false, 11:25:21 INFO - "project": "", 11:25:21 INFO - "branch": "fx-team-macosx64-talos", 11:25:21 INFO - "changes": [ 11:25:21 INFO - { 11:25:21 INFO - "category": null, 11:25:21 INFO - "files": [ 11:25:21 INFO - { 11:25:21 INFO - "url": null, 11:25:21 INFO - "name": "https://queue.taskcluster.net/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 11:25:21 INFO - } 11:25:21 INFO - ], 11:25:21 INFO - "repository": "", 11:25:21 INFO - "rev": "3f0651985bf0e3403b5fd4984a907813689ee3a9", 11:25:21 INFO - "who": "philringnalda@gmail.com", 11:25:21 INFO - "when": 1447614904, 11:25:21 INFO - "number": 6663849, 11:25:21 INFO - "comments": "Merge m-c to f-t", 11:25:21 INFO - "project": "", 11:25:21 INFO - "at": "Sun 15 Nov 2015 11:15:04", 11:25:21 INFO - "branch": "fx-team-macosx64-talos", 11:25:21 INFO - "revlink": "", 11:25:21 INFO - "properties": [ 11:25:21 INFO - [ 11:25:21 INFO - "buildid", 11:25:21 INFO - "20151115092632", 11:25:21 INFO - "Change" 11:25:21 INFO - ], 11:25:21 INFO - [ 11:25:21 INFO - "builduid", 11:25:21 INFO - "743ffbfad5cf440597a3b71c3118312f", 11:25:21 INFO - "Change" 11:25:21 INFO - ], 11:25:21 INFO - [ 11:25:21 INFO - "pgo_build", 11:25:21 INFO - "False", 11:25:21 INFO - "Change" 11:25:21 INFO - ] 11:25:21 INFO - ], 11:25:21 INFO - "revision": "3f0651985bf0e3403b5fd4984a907813689ee3a9" 11:25:21 INFO - } 11:25:21 INFO - ], 11:25:21 INFO - "revision": "3f0651985bf0e3403b5fd4984a907813689ee3a9" 11:25:21 INFO - } 11:25:21 INFO - } 11:25:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 11:25:21 INFO - Running post-action listener: _resource_record_post_action 11:25:21 INFO - ##### 11:25:21 INFO - ##### Running download-and-extract step. 11:25:21 INFO - ##### 11:25:21 INFO - Running pre-action listener: _resource_record_pre_action 11:25:21 INFO - Running main action method: download_and_extract 11:25:21 INFO - mkdir: /builds/slave/test/build/tests 11:25: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')]} 11:25:21 INFO - https://queue.taskcluster.net/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:25:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/test_packages.json 11:25:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/test_packages.json 11:25:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 11:25:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 11:25:21 INFO - Downloaded 1149 bytes. 11:25:21 INFO - Reading from file /builds/slave/test/build/test_packages.json 11:25:21 INFO - Using the following test package requirements: 11:25:21 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 11:25:21 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:25:21 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 11:25:21 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:25:21 INFO - u'jsshell-mac.zip'], 11:25:21 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:25:21 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 11:25:21 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 11:25:21 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:25:21 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 11:25:21 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:25:21 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 11:25:21 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:25:21 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 11:25:21 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 11:25:21 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:25:21 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 11:25:21 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:25: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')]} 11:25:21 INFO - https://queue.taskcluster.net/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:25:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:25:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:25:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:25:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:25:22 INFO - Downloaded 17464154 bytes. 11:25:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 11:25:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:25:22 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 11:25:29 INFO - Return code: 0 11:25:29 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip', u'firefox-45.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 11:25:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:29 INFO - https://queue.taskcluster.net/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:25:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:25:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:25:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:25:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:25:30 INFO - Downloaded 17464154 bytes. 11:25:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 11:25:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:25:30 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 11:25:37 INFO - Return code: 0 11:25:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:37 INFO - https://queue.taskcluster.net/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 11:25:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 11:25:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 11:25:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 11:25:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'}, attempt #1 11:25:38 INFO - Downloaded 11131693 bytes. 11:25:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 11:25:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 11:25:38 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 11:25:38 INFO - Return code: 0 11:25:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:38 INFO - https://queue.taskcluster.net/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 11:25:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 11:25:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 11:25:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 11:25:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg'}, attempt #1 11:25:42 INFO - Downloaded 108681180 bytes. 11:25:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 11:25:42 INFO - mkdir: /builds/slave/test/properties 11:25:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:25:42 INFO - Writing to file /builds/slave/test/properties/build_url 11:25:42 INFO - Contents: 11:25:42 INFO - build_url:https://queue.taskcluster.net/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 11:25:42 INFO - Running post-action listener: _resource_record_post_action 11:25:42 INFO - Running post-action listener: set_extra_try_arguments 11:25:42 INFO - ##### 11:25:42 INFO - ##### Running populate-webroot step. 11:25:42 INFO - ##### 11:25:42 INFO - Running pre-action listener: _resource_record_pre_action 11:25:42 INFO - Running main action method: populate_webroot 11:25:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:25:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:25:42 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 11:25:42 INFO - '../fennec_ids.txt'], 11:25:42 INFO - 'tests': ['tcheck2']}, 11:25:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:25:42 INFO - '--tppagecycles', 11:25:42 INFO - '7'], 11:25:42 INFO - 'tests': ['tsvgm']}}, 11:25:42 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:25:42 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:25:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:25:42 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:25:42 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:25:42 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:25:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:25:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:42 INFO - 'talos_options': ['--e10s'], 11:25:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:25:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:42 INFO - 'tests': ['damp', 'tps']}, 11:25:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:42 INFO - 'talos_options': ['--e10s'], 11:25:42 INFO - 'tests': ['damp', 'tps']}, 11:25:42 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:25:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:25:42 INFO - 'other': {'tests': ['a11yr', 11:25:42 INFO - 'ts_paint', 11:25:42 INFO - 'tpaint', 11:25:42 INFO - 'sessionrestore', 11:25:42 INFO - 'sessionrestore_no_auto_restore']}, 11:25:42 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:25:42 INFO - 'tests': ['a11yr', 11:25:42 INFO - 'ts_paint', 11:25:42 INFO - 'tpaint', 11:25:42 INFO - 'sessionrestore', 11:25:42 INFO - 'sessionrestore_no_auto_restore']}, 11:25:42 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:25:42 INFO - 'tests': ['a11yr', 11:25:42 INFO - 'ts_paint', 11:25:42 INFO - 'tpaint', 11:25:42 INFO - 'sessionrestore', 11:25:42 INFO - 'sessionrestore_no_auto_restore']}, 11:25:42 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:25:42 INFO - 'tests': ['a11yr', 11:25:42 INFO - 'ts_paint', 11:25:42 INFO - 'tpaint', 11:25:42 INFO - 'sessionrestore', 11:25:42 INFO - 'sessionrestore_no_auto_restore']}, 11:25:42 INFO - 'other_l64': {'tests': ['a11yr', 11:25:42 INFO - 'ts_paint', 11:25:42 INFO - 'tpaint', 11:25:42 INFO - 'sessionrestore', 11:25:42 INFO - 'sessionrestore_no_auto_restore']}, 11:25:42 INFO - 'other_nol64': {'tests': ['a11yr', 11:25:42 INFO - 'ts_paint', 11:25:42 INFO - 'tpaint', 11:25:42 INFO - 'sessionrestore', 11:25:42 INFO - 'sessionrestore_no_auto_restore']}, 11:25:42 INFO - 'svgr': {'tests': ['tsvgx', 11:25:42 INFO - 'tsvgr_opacity', 11:25:42 INFO - 'tart', 11:25:42 INFO - 'tscrollx', 11:25:42 INFO - 'cart']}, 11:25:42 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:25:42 INFO - 'tests': ['tsvgx', 11:25:42 INFO - 'tsvgr_opacity', 11:25:42 INFO - 'tart', 11:25:42 INFO - 'tscrollx', 11:25:42 INFO - 'cart']}, 11:25:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:42 INFO - 'tests': ['tp5o']}, 11:25:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:42 INFO - 'talos_options': ['--e10s'], 11:25:42 INFO - 'tests': ['tp5o']}, 11:25:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:42 INFO - 'talos_options': ['--xperf_path', 11:25:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:25:42 INFO - 'tests': ['tp5n']}, 11:25:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:42 INFO - 'talos_options': ['--e10s', 11:25:42 INFO - '--xperf_path', 11:25:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:25:42 INFO - 'tests': ['tp5n']}}, 11:25:42 INFO - 'talos.zip': {'path': '', 11:25:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:25:42 INFO - Running post-action listener: _resource_record_post_action 11:25:42 INFO - ##### 11:25:42 INFO - ##### Running create-virtualenv step. 11:25:42 INFO - ##### 11:25:42 INFO - Running pre-action listener: _resource_record_pre_action 11:25:42 INFO - Running main action method: create_virtualenv 11:25:42 INFO - Creating virtualenv /builds/slave/test/build/venv 11:25:42 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:25:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:25:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:25:42 INFO - Using real prefix '/tools/python27' 11:25:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:25:43 INFO - Installing distribute.............................................................................................................................................................................................done. 11:25:46 INFO - Installing pip.................done. 11:25:47 INFO - Return code: 0 11:25:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:25: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')]} 11:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25: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')]} 11:25:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:47 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 0x1024fe490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024db228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf32d04f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024219f0>, '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 0x102181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024158c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gF3LuyrGwH/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.l5mTGs2n5e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:25:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:25:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:25:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gF3LuyrGwH/Render', 11:25:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:25:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:25:47 INFO - 'HOME': '/Users/cltbld', 11:25:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:25:47 INFO - 'LOGNAME': 'cltbld', 11:25:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:47 INFO - 'MOZ_NO_REMOTE': '1', 11:25:47 INFO - 'NO_EM_RESTART': '1', 11:25:47 INFO - 'PAGER': '/bin/cat', 11:25:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:25:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:47 INFO - 'PWD': '/builds/slave/test', 11:25:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:25:47 INFO - 'SHELL': '/bin/bash', 11:25:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l5mTGs2n5e/Listeners', 11:25:47 INFO - 'TMPDIR': '/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/', 11:25:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:25:47 INFO - 'USER': 'cltbld', 11:25:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:25:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:25:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:47 INFO - 'XPC_FLAGS': '0x0', 11:25:47 INFO - 'XPC_SERVICE_NAME': '0', 11:25:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 11:25:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:47 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:25:47 INFO - Cleaning up... 11:25:47 INFO - Return code: 0 11:25:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:25: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')]} 11:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25: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')]} 11:25:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:47 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 0x1024fe490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024db228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf32d04f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024219f0>, '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 0x102181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024158c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gF3LuyrGwH/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.l5mTGs2n5e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:25:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 11:25:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 11:25:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gF3LuyrGwH/Render', 11:25:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:25:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:25:47 INFO - 'HOME': '/Users/cltbld', 11:25:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:25:47 INFO - 'LOGNAME': 'cltbld', 11:25:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:47 INFO - 'MOZ_NO_REMOTE': '1', 11:25:47 INFO - 'NO_EM_RESTART': '1', 11:25:47 INFO - 'PAGER': '/bin/cat', 11:25:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:25:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:47 INFO - 'PWD': '/builds/slave/test', 11:25:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:25:47 INFO - 'SHELL': '/bin/bash', 11:25:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l5mTGs2n5e/Listeners', 11:25:47 INFO - 'TMPDIR': '/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/', 11:25:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:25:47 INFO - 'USER': 'cltbld', 11:25:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:25:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:25:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:47 INFO - 'XPC_FLAGS': '0x0', 11:25:47 INFO - 'XPC_SERVICE_NAME': '0', 11:25:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 11:25:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:47 INFO - Downloading/unpacking psutil>=0.7.1 11:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:50 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 11:25:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 11:25:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:25:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:25:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:25:50 INFO - Installing collected packages: psutil 11:25:50 INFO - Running setup.py install for psutil 11:25:50 INFO - building 'psutil._psutil_osx' extension 11:25:50 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 11:25:51 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 11:25:51 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 11:25:51 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 11:25:51 INFO - building 'psutil._psutil_posix' extension 11:25:51 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 11:25:51 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:25:51 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:25:51 INFO - ^ 11:25:51 INFO - 1 warning generated. 11:25:51 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 11:25:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:25:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:25:51 INFO - Successfully installed psutil 11:25:51 INFO - Cleaning up... 11:25:51 INFO - Return code: 0 11:25:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:25: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')]} 11:25:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25: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')]} 11:25:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:51 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 0x1024fe490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024db228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf32d04f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024219f0>, '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 0x102181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024158c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gF3LuyrGwH/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.l5mTGs2n5e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:25:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 11:25:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 11:25:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gF3LuyrGwH/Render', 11:25:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:25:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:25:51 INFO - 'HOME': '/Users/cltbld', 11:25:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:25:51 INFO - 'LOGNAME': 'cltbld', 11:25:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:51 INFO - 'MOZ_NO_REMOTE': '1', 11:25:51 INFO - 'NO_EM_RESTART': '1', 11:25:51 INFO - 'PAGER': '/bin/cat', 11:25:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:25:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:51 INFO - 'PWD': '/builds/slave/test', 11:25:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:25:51 INFO - 'SHELL': '/bin/bash', 11:25:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l5mTGs2n5e/Listeners', 11:25:51 INFO - 'TMPDIR': '/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/', 11:25:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:25:51 INFO - 'USER': 'cltbld', 11:25:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:25:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:25:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:51 INFO - 'XPC_FLAGS': '0x0', 11:25:51 INFO - 'XPC_SERVICE_NAME': '0', 11:25:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 11:25:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:25:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 11:25:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:25:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:25:55 INFO - Installing collected packages: mozsystemmonitor 11:25:55 INFO - Running setup.py install for mozsystemmonitor 11:25:55 INFO - Successfully installed mozsystemmonitor 11:25:55 INFO - Cleaning up... 11:25:55 INFO - Return code: 0 11:25:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:25:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:55 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 0x1024fe490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024db228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf32d04f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024219f0>, '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 0x102181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024158c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gF3LuyrGwH/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.l5mTGs2n5e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:25:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:25:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:25:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gF3LuyrGwH/Render', 11:25:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:25:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:25:55 INFO - 'HOME': '/Users/cltbld', 11:25:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:25:55 INFO - 'LOGNAME': 'cltbld', 11:25:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:55 INFO - 'MOZ_NO_REMOTE': '1', 11:25:55 INFO - 'NO_EM_RESTART': '1', 11:25:55 INFO - 'PAGER': '/bin/cat', 11:25:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:25:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:55 INFO - 'PWD': '/builds/slave/test', 11:25:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:25:55 INFO - 'SHELL': '/bin/bash', 11:25:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l5mTGs2n5e/Listeners', 11:25:55 INFO - 'TMPDIR': '/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/', 11:25:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:25:55 INFO - 'USER': 'cltbld', 11:25:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:25:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:25:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:55 INFO - 'XPC_FLAGS': '0x0', 11:25:55 INFO - 'XPC_SERVICE_NAME': '0', 11:25:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 11:25:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:56 INFO - Downloading/unpacking blobuploader==1.2.4 11:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:58 INFO - Downloading blobuploader-1.2.4.tar.gz 11:25:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 11:25:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:25:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:25:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 11:25:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:25:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:25:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:00 INFO - Downloading docopt-0.6.1.tar.gz 11:26:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 11:26:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:26:00 INFO - Installing collected packages: blobuploader, requests, docopt 11:26:00 INFO - Running setup.py install for blobuploader 11:26:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:26:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:26:00 INFO - Running setup.py install for requests 11:26:01 INFO - Running setup.py install for docopt 11:26:01 INFO - Successfully installed blobuploader requests docopt 11:26:01 INFO - Cleaning up... 11:26:01 INFO - Return code: 0 11:26:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:26: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')]} 11:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26: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')]} 11:26:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:01 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 0x1024fe490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024db228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf32d04f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024219f0>, '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 0x102181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024158c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gF3LuyrGwH/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.l5mTGs2n5e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:26:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:26:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:26:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gF3LuyrGwH/Render', 11:26:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:26:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:26:01 INFO - 'HOME': '/Users/cltbld', 11:26:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:26:01 INFO - 'LOGNAME': 'cltbld', 11:26:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:01 INFO - 'MOZ_NO_REMOTE': '1', 11:26:01 INFO - 'NO_EM_RESTART': '1', 11:26:01 INFO - 'PAGER': '/bin/cat', 11:26:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:26:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:01 INFO - 'PWD': '/builds/slave/test', 11:26:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:26:01 INFO - 'SHELL': '/bin/bash', 11:26:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l5mTGs2n5e/Listeners', 11:26:01 INFO - 'TMPDIR': '/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/', 11:26:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:26:01 INFO - 'USER': 'cltbld', 11:26:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:26:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:26:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:01 INFO - 'XPC_FLAGS': '0x0', 11:26:01 INFO - 'XPC_SERVICE_NAME': '0', 11:26:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 11:26:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:26:01 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-ISctL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:26:01 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-IEKPfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:26:02 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-EY4KdQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:26:02 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-spdVZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:26:02 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-vYuo8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:26:02 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-DWdSKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:26:02 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-vzlV2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:26:02 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-ZabNpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:26:02 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-yFXkck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:26:03 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-TZFiPY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:26:03 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-vcO5Uy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:26:03 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-TzKtGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:26:03 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-IyuTWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:26:03 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-XymodP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:26:03 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-fzPARM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:26:03 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-0DxJQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:26:04 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-mIWj0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:26:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:26:04 INFO - Running setup.py install for manifestparser 11:26:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:26:04 INFO - Running setup.py install for mozcrash 11:26:04 INFO - Running setup.py install for mozdebug 11:26:04 INFO - Running setup.py install for mozdevice 11:26:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:26:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:26:04 INFO - Running setup.py install for mozfile 11:26:05 INFO - Running setup.py install for mozhttpd 11:26:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:26:05 INFO - Running setup.py install for mozinfo 11:26:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:26:05 INFO - Running setup.py install for mozInstall 11:26:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:26:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:26:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:26:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:26:05 INFO - Running setup.py install for mozleak 11:26:05 INFO - Running setup.py install for mozlog 11:26:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:26:06 INFO - Running setup.py install for moznetwork 11:26:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:26:06 INFO - Running setup.py install for mozprocess 11:26:06 INFO - Running setup.py install for mozprofile 11:26:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:26:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:26:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:26:06 INFO - Running setup.py install for mozrunner 11:26:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:26:06 INFO - Running setup.py install for mozscreenshot 11:26:07 INFO - Running setup.py install for moztest 11:26:07 INFO - Running setup.py install for mozversion 11:26:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:26:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:26:07 INFO - Cleaning up... 11:26:07 INFO - Return code: 0 11:26:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:26:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:26:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:26:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:07 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 0x1024fe490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024db228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf32d04f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024219f0>, '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 0x102181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024158c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gF3LuyrGwH/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.l5mTGs2n5e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:26:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:26:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:26:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gF3LuyrGwH/Render', 11:26:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:26:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:26:07 INFO - 'HOME': '/Users/cltbld', 11:26:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:26:07 INFO - 'LOGNAME': 'cltbld', 11:26:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:07 INFO - 'MOZ_NO_REMOTE': '1', 11:26:07 INFO - 'NO_EM_RESTART': '1', 11:26:07 INFO - 'PAGER': '/bin/cat', 11:26:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:26:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:07 INFO - 'PWD': '/builds/slave/test', 11:26:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:26:07 INFO - 'SHELL': '/bin/bash', 11:26:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l5mTGs2n5e/Listeners', 11:26:07 INFO - 'TMPDIR': '/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/', 11:26:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:26:07 INFO - 'USER': 'cltbld', 11:26:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:26:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:26:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:07 INFO - 'XPC_FLAGS': '0x0', 11:26:07 INFO - 'XPC_SERVICE_NAME': '0', 11:26:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 11:26:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:26:07 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-a_8_jI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:26:08 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:26:08 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-rc4D7e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:26:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:26:08 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-QYGgCf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:26:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:26:08 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-RxRH5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:26:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:26:08 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-BwkDrc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:26:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:26:08 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-RavtZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:26:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:26:08 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-9WGhZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:26:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:26:08 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-jWEno3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:26:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:26:09 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-LBhKKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:26:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:26:09 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-lY0Tp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:26:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:26:09 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-DKAPau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:26:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:26:09 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-qGz8g_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:26:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:26:09 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-HUnyyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:26:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:26:09 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-3_QUuj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:26:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:26:09 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-Fb7Hgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:26:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:26:10 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-hM1Cma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:26:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:26:10 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-H7g_xk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:26:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:26:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:26:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:26:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:26:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:26:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:26:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:26: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 11:26: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 11:26: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 11:26: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 11:26: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 11:26: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 11:26:13 INFO - Downloading blessings-1.5.1.tar.gz 11:26:13 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 11:26:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:26:13 INFO - Installing collected packages: blessings 11:26:13 INFO - Running setup.py install for blessings 11:26:13 INFO - Successfully installed blessings 11:26:13 INFO - Cleaning up... 11:26:13 INFO - Return code: 0 11:26:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:26:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:26:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:26:13 INFO - Reading from file tmpfile_stdout 11:26:13 INFO - Current package versions: 11:26:13 INFO - blessings == 1.5.1 11:26:13 INFO - blobuploader == 1.2.4 11:26:13 INFO - docopt == 0.6.1 11:26:13 INFO - manifestparser == 1.1 11:26:13 INFO - mozInstall == 1.12 11:26:13 INFO - mozcrash == 0.16 11:26:13 INFO - mozdebug == 0.1 11:26:13 INFO - mozdevice == 0.47 11:26:13 INFO - mozfile == 1.2 11:26:13 INFO - mozhttpd == 0.7 11:26:13 INFO - mozinfo == 0.9 11:26:13 INFO - mozleak == 0.1 11:26:13 INFO - mozlog == 3.0 11:26:13 INFO - moznetwork == 0.27 11:26:13 INFO - mozprocess == 0.22 11:26:13 INFO - mozprofile == 0.27 11:26:13 INFO - mozrunner == 6.11 11:26:13 INFO - mozscreenshot == 0.1 11:26:13 INFO - mozsystemmonitor == 0.0 11:26:13 INFO - moztest == 0.7 11:26:13 INFO - mozversion == 1.4 11:26:13 INFO - psutil == 3.1.1 11:26:13 INFO - requests == 1.2.3 11:26:13 INFO - wsgiref == 0.1.2 11:26:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:26:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:26:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:26:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:13 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 0x1024fe490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024db228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf32d04f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024219f0>, '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 0x102181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024158c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gF3LuyrGwH/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.l5mTGs2n5e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:26:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:26:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:26:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gF3LuyrGwH/Render', 11:26:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:26:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:26:13 INFO - 'HOME': '/Users/cltbld', 11:26:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:26:13 INFO - 'LOGNAME': 'cltbld', 11:26:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:13 INFO - 'MOZ_NO_REMOTE': '1', 11:26:13 INFO - 'NO_EM_RESTART': '1', 11:26:13 INFO - 'PAGER': '/bin/cat', 11:26:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:26:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:13 INFO - 'PWD': '/builds/slave/test', 11:26:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:26:13 INFO - 'SHELL': '/bin/bash', 11:26:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l5mTGs2n5e/Listeners', 11:26:13 INFO - 'TMPDIR': '/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/', 11:26:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:26:13 INFO - 'USER': 'cltbld', 11:26:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:26:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:26:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:13 INFO - 'XPC_FLAGS': '0x0', 11:26:13 INFO - 'XPC_SERVICE_NAME': '0', 11:26:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 11:26:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:26:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:26:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:26:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:26:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:26:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:26:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:26:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:26:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:26:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:26:14 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:26:14 INFO - Cleaning up... 11:26:14 INFO - Return code: 0 11:26:14 INFO - Running post-action listener: _resource_record_post_action 11:26:14 INFO - Running post-action listener: _start_resource_monitoring 11:26:14 INFO - Starting resource monitoring. 11:26:14 INFO - ##### 11:26:14 INFO - ##### Running install step. 11:26:14 INFO - ##### 11:26:14 INFO - Running pre-action listener: _resource_record_pre_action 11:26:14 INFO - Running main action method: install 11:26:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:26:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:26:14 INFO - Reading from file tmpfile_stdout 11:26:14 INFO - Detecting whether we're running mozinstall >=1.0... 11:26:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:26:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:26:14 INFO - Reading from file tmpfile_stdout 11:26:14 INFO - Output received: 11:26:14 INFO - Usage: mozinstall [options] installer 11:26:14 INFO - Options: 11:26:14 INFO - -h, --help show this help message and exit 11:26:14 INFO - -d DEST, --destination=DEST 11:26:14 INFO - Directory to install application into. [default: 11:26:14 INFO - "/builds/slave/test"] 11:26:14 INFO - --app=APP Application being installed. [default: firefox] 11:26:14 INFO - mkdir: /builds/slave/test/build/application 11:26:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:26:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 11:26:56 INFO - Reading from file tmpfile_stdout 11:26:56 INFO - Output received: 11:26:56 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:26:56 INFO - Running post-action listener: _resource_record_post_action 11:26:56 INFO - ##### 11:26:56 INFO - ##### Running run-tests step. 11:26:56 INFO - ##### 11:26:56 INFO - Running pre-action listener: _resource_record_pre_action 11:26:56 INFO - Running main action method: run_tests 11:26:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:26:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:26:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:26:56 INFO - 2015-11-15 11:26:56.819 screenresolution[1962:11095] starting screenresolution argv=screenresolution get 11:26:56 INFO - 2015-11-15 11:26:56.823 screenresolution[1962:11095] Display 0: 1600x1200x32@60 11:26:56 INFO - 2015-11-15 11:26:56.830 screenresolution[1963:11097] starting screenresolution argv=screenresolution list 11:26:56 INFO - Available Modes on Display 0 11:26:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:26:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:26:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:26:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:26:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:26:57 INFO - Intel HD Graphics 3000: 11:26:57 INFO - Chipset Model: Intel HD Graphics 3000 11:26:57 INFO - Type: GPU 11:26:57 INFO - Bus: Built-In 11:26:57 INFO - VRAM (Total): 512 MB 11:26:57 INFO - VRAM (Dynamic, Max): 10 11:26:57 INFO - Vendor: Intel (0x8086) 11:26:57 INFO - Device ID: 0x0116 11:26:57 INFO - Revision ID: 0x0009 11:26:57 INFO - Displays: 11:26:57 INFO - Display: 11:26:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:26:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:26:57 INFO - Display Serial Number: 1600x1200 60 11:26:57 INFO - Main Display: Yes 11:26:57 INFO - Mirror: Off 11:26:57 INFO - Online: Yes 11:26:57 INFO - Rotation: Supported 11:26:57 INFO - Return code: 0 11:26:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:26:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:26:57 INFO - Python 2.7.3 11:26:57 INFO - Return code: 0 11:26:57 INFO - grabbing minidump binary from tooltool 11:26: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')]} 11:26:57 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 0x1024219f0>, '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 0x102181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024158c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:26:57 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:26:57 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 11:26:57 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:26:57 INFO - Return code: 0 11:26:57 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:26:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:26:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:26:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:26:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:26:57 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/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0057', '--webServer', 'localhost'] in /builds/slave/test/build 11:26:57 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/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0057 --webServer localhost 11:26:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gF3LuyrGwH/Render', 11:26:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:26:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:26:57 INFO - 'HOME': '/Users/cltbld', 11:26:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:26:57 INFO - 'LOGNAME': 'cltbld', 11:26:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:26:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:26:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:57 INFO - 'MOZ_NO_REMOTE': '1', 11:26:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:26:57 INFO - 'NO_EM_RESTART': '1', 11:26:57 INFO - 'PAGER': '/bin/cat', 11:26:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:26:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:57 INFO - 'PWD': '/builds/slave/test', 11:26:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:26:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:26:57 INFO - 'SHELL': '/bin/bash', 11:26:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l5mTGs2n5e/Listeners', 11:26:57 INFO - 'TMPDIR': '/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/', 11:26:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:26:57 INFO - 'USER': 'cltbld', 11:26:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:26:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:26:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:57 INFO - 'XPC_FLAGS': '0x0', 11:26:57 INFO - 'XPC_SERVICE_NAME': '0', 11:26:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 11:26:57 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/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0057', '--webServer', 'localhost'] with output_timeout 3600 11:26:57 INFO - mozversion INFO | application_buildid: 20151115092632 11:26:57 INFO - mozversion INFO | application_changeset: 3f0651985bf0e3403b5fd4984a907813689ee3a9 11:26:57 INFO - mozversion INFO | application_display_name: Nightly 11:26:57 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:26:57 INFO - mozversion INFO | application_name: Firefox 11:26:57 INFO - mozversion INFO | application_remotingname: firefox 11:26:57 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 11:26:57 INFO - mozversion INFO | application_vendor: Mozilla 11:26:57 INFO - mozversion INFO | application_version: 45.0a1 11:26:57 INFO - mozversion INFO | platform_buildid: 20151115092632 11:26:57 INFO - mozversion INFO | platform_changeset: 3f0651985bf0e3403b5fd4984a907813689ee3a9 11:26:57 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 11:26:57 INFO - mozversion INFO | platform_version: 45.0a1 11:26:57 INFO - 2015-11-15 11:26:57,507 DEBUG : using testdate: 1447615617 11:26:57 INFO - 2015-11-15 11:26:57,507 DEBUG : actual date: 1447615617 11:26:57 INFO - 2015-11-15 11:26:57,518 INFO : starting webserver on 'localhost:49347' 11:26:57 INFO - 2015-11-15 11:26:57,519 INFO : Starting test suite t-yosemite-r5-0057.e 11:26:57 INFO - 2015-11-15 11:26:57,519 INFO : Starting test dromaeo_css 11:26:57 INFO - 2015-11-15 11:26:57,520 DEBUG : operating with platform_type : mac_ 11:26:57 INFO - 2015-11-15 11:26:57,520 INFO : Initialising browser for dromaeo_css test... 11:26:57 INFO - 2015-11-15 11:26:57,536 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/tmpKVjxbp/profile http://localhost:49347/getInfo.html 11:27:00 INFO - 2015-11-15 11:27:00,947 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:27:00 INFO - 2015-11-15 11:27:00,947 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:27:00 INFO - 2015-11-15 11:27:00,947 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 11:27:00 INFO - 2015-11-15 11:27:00,947 DEBUG : BROWSER_OUTPUT: __metrics 11:27:01 INFO - 2015-11-15 11:27:01,715 INFO : Browser initialized. 11:27:01 INFO - 2015-11-15 11:27:01,715 INFO : Running cycle 1/1 for dromaeo_css test... 11:27:01 INFO - 2015-11-15 11:27:01,715 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/tmpKVjxbp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:27:13 INFO - 2015-11-15 11:27:13,978 DEBUG : BROWSER_OUTPUT: RSS: Main: 241197056 11:27:13 INFO - 2015-11-15 11:27:13,979 DEBUG : BROWSER_OUTPUT: 11:28:03 INFO - 2015-11-15 11:28:03,720 DEBUG : BROWSER_OUTPUT: 1447615683713 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:30:13 INFO - 2015-11-15 11:30:13,490 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49347/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49347/tests/dromaeo/cssquery-ext.html) 11:30:14 INFO - 2015-11-15 11:30:14,597 DEBUG : BROWSER_OUTPUT: RSS: Main: 268685312 11:30:14 INFO - 2015-11-15 11:30:14,597 DEBUG : BROWSER_OUTPUT: 11:33:16 INFO - 2015-11-15 11:33:16,703 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49347/tests/dromaeo/cssquery-ext.html (next: http://localhost:49347/tests/dromaeo/cssquery-jquery.html) 11:33:17 INFO - 2015-11-15 11:33:17,286 DEBUG : BROWSER_OUTPUT: RSS: Main: 274644992 11:33:17 INFO - 2015-11-15 11:33:17,286 DEBUG : BROWSER_OUTPUT: 11:36:19 INFO - 2015-11-15 11:36:19,218 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49347/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49347/tests/dromaeo/cssquery-mootools.html) 11:36:19 INFO - 2015-11-15 11:36:19,794 DEBUG : BROWSER_OUTPUT: RSS: Main: 276795392 11:36:19 INFO - 2015-11-15 11:36:19,794 DEBUG : BROWSER_OUTPUT: 11:39:21 INFO - 2015-11-15 11:39:21,497 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49347/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49347/tests/dromaeo/cssquery-prototype.html) 11:39:22 INFO - 2015-11-15 11:39:22,074 DEBUG : BROWSER_OUTPUT: RSS: Main: 282189824 11:39:22 INFO - 2015-11-15 11:39:22,074 DEBUG : BROWSER_OUTPUT: 11:42:24 INFO - 2015-11-15 11:42:24,778 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49347/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49347/tests/dromaeo/cssquery-yui.html) 11:42:25 INFO - 2015-11-15 11:42:25,390 DEBUG : BROWSER_OUTPUT: RSS: Main: 287059968 11:42:25 INFO - 2015-11-15 11:42:25,391 DEBUG : BROWSER_OUTPUT: 11:45:27 INFO - 2015-11-15 11:45:27,878 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49347/tests/dromaeo/cssquery-yui.html (next: http://localhost:49347/tests/dromaeo/cssquery-dojo.html) 11:45:28 INFO - 2015-11-15 11:45:28,137 DEBUG : BROWSER_OUTPUT: RSS: Main: 292134912 11:45:28 INFO - 2015-11-15 11:45:28,137 DEBUG : BROWSER_OUTPUT: 11:45:28 INFO - 2015-11-15 11:45:28,137 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:45:28 INFO - 2015-11-15 11:45:28,137 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:45:28 INFO - 2015-11-15 11:45:28,138 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:45:28 INFO - 2015-11-15 11:45:28,138 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:45:28 INFO - 2015-11-15 11:45:28,138 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2652.2441104285276;2656.203139058282;2708.63433436486;2722.877470513826;2734.5898115282716;4430.6012458878695;4482.462104547455;4497.640188784898;4512.503624601291;4638.00282939168;4363.869083927487;4394.450693663292;4479.664025198115;4487.12501062293;4560.33875088112;4115.36211887158;4211.157768446307;4216.599423054805;4228.471441069866;4274.5939135782055;235.94241445137544;4182.498100227962;4229.851955181569;4285.400043993828;4304.289792184286;3974.721769476138;4057.8173982170724;4085.3667681509414;4112.465379500676;4228.260054490467;4144.668426525871;4147.875563733093;4155.501339839238;4188.099558594886;4203.390508376268;3966.920661586781;4125.443065186191;4159.771212583307;4173.64524015459;4201.915961680749;4198.286291330481;4310.288802347609;4377.6935614507;4407.757573333465;4451.488078870907;4798.5441383068555;4803.2554953981835;4829.203181475053;4837.105135549935;4876.878078048042;4669.34629151919;4683.320918466838;4774.140654682155;4917.631177661689;4926.9014619707405;4445.222086134913;4473.373727678128;4474.8881277967985;4543.636509079266;4569.29175977724;4837.903241935212;4902.558769710743;4918.754062296871;4954.752262386866;4961.231009193581;4484.708493947948;4586.724796512153;4625.236835922103;4641.512641172696;4711.387519622427;4788.856334309976;4827.903441931212;4865.56209941107;4878.926816097762;4902.4362198346935;4746.1931471649905;4756.120117778222;4768.237082066853;4802.84731664405;4824.8793780155775;4531.524189960072;4653.883652908637;4683.15703173432;4804.807807687724;4826.372571565674;3698.7041036716996;3719.702423806089;3746.7751934883995;3759.8496060157286;3766.0020094674933;3305.4545999909747;3386.847591858323;3408.880689175867;3425.1608355952453;3442.7762195457217;4501.752403617833;4514.68397212192;4521.1409832131785;4557.430321209848;4577.954220457819;4835.854924352275;4877.731724755102;4887.0714564232685;4887.95112048882;4900.779464924087;4358.716683415568;4564.2012647786505;4572.7942242599165;4581.198290299184;4590.334401511829;4130.979345103256;4166.66666666672;4200.327947528381;4206.137741762931;4256.936145957813;4967.925481117786;5012.273220383024;5029.245613157982;5066.544011039025;5129.358830146231;4768.713877167381;4772.7136371817805;4875.68308059975;4889.413270407432;4938.7530623467965;5016.072026675077;5036.244563315532;5046.949530504648;5054.873628159326;5135.7432128394175;4752.42970843501;4769.856904292877;4770.117528257283;4770.7853146607795;4826.565609095198;4686.62506999446;4753.47711751714;4826.3243145958895;4839.540243676845;4935.506449355035;4735.052989402202;4752.453467851241;4805.038992201504;4815.422149342101;4845.055214233191;4754.690945088558;4761.904761904673;4783.115123702126;4794.952050479451;4804.8318308859025;4478.619317358061;4510.075434535846;4512.729236245836;4521.367008618862;4548.090381923563;4715.174844402284;4724.244120940771;4744.312074749073;4787.736674482937;4852.636052296162;4685.835995740133;4698.389209402756;4705.882352941204;4737.502562230916;4750.9287360690305 11:45:28 INFO - 2015-11-15 11:45:28,138 DEBUG : BROWSER_OUTPUT: |1;ext.html;447.1035573674782;465.4856383696016;467.7146940366377;477.35556998052624;493.66924160812255;31474.213144671394;31558.99999999994;31573.842130789344;31762.364752704932;31976.520352194737;35465.46801797975;36304.45543316852;36664.08339791506;36756.26487470256;37380;7601.733939312126;7732.884006739875;7846.450748447611;7867.881981770278;7926;7598.658060387296;7699.576523291216;7770.184130666284;7788.454808163431;7792.844143117134;7737.613119344011;7789.883151752728;7823.0612326520895;7868.567228802413;7896.960515197416;7608.315251627352;7672.884906726404;7705.499142555716;7747.38020958322;7809.921900780976;7478.2895624915545;7584.5070070445245;7648.196939321347;7676.501027433199;7715.614219289013;33267.833660831544;33770.83114584412;33817.83091084529;34031.489527657104;34076.14809629754;2435;2573.8841752121198;2606.9348266293496;2644.0217119665654;3075.984620076885;22657.660135097987;22681.2061577844;22946.77053229463;22981.77018229813;23052.308430747104;2025.3923822853233;2037.724907137547;2065.0707181768266;2083.468715477559;2085.2597327948665;233634;237917;239090.99999999825;239290;239736;52170.73914630478;52452.213216801014;52493.21260181101;52613.47386526162;52780.20829687558;46635.76682116568;47263.29105063427;59052;60851;61145.69427152836;12275.754484910252;12341.568045118378;12497;12536.686582835502;12723;9096.135867092615;9278.536073196314;9284.814303713887;9341;9405.482698451651;17134.742978855327;17483.475495735147;17545;17611.38360157414;17649.294028238728;7207.711691532385;7491.400687944952;7554.244575542401;7592.772216833504;7625.809354766065;787.1144961917843;882.280941033056;921.9950254222929;926.545992463688;929;23691.644625330635;23694.289171324886;23952.28143155708;24041.27876163718;24121.86415765939;871.4596949891109;875.671623141322;895.0959530873864;946.7443790176613;951.4053716427233;12565.246085234916;12690.365481725878;13409.396577154052;14306.642333941734;14378.784318235235;335810;342177;345255;345501;346621;48388.27417588739;48802.51197488051;49083.50916490861;49802.50197497979;49847.75076124596;998.9111868063845;1144.7080994346388;1150.0167356909722;1165.9825102623468;1169.029705344562;24997.250082497554;25302;25626.359341016625;25678.358041049123;25840.741592583832;40294;40674.38988415117;40765.592344076176;41238.79380603078;41578.79210603928;244515;244558;248776;249191;249401;27171.320716982234;36848.63151368452;38893.80553097217;38910;39844.80077599709;36218;36871;37118.62881371152;37125.257494849415;37754.8112259437;32818;34217.486737698455;34762.82618586891;34930.825345873105;35165.82417087898;30070.24824379408;30484.542731858597;30568.235794105327;30592.388152237276;30615.387692246477;30907.0727878164;31149.532757008208;31151.065468035995;31439;31739.841300794273;25959.480810384066;29518.55722164212;29728.554071689374;30127;30268.84865575658;20539.589208215453;20578;20613.278535251193;20846;20911 11:45:28 INFO - 2015-11-15 11:45:28,139 DEBUG : BROWSER_OUTPUT: |2;jquery.html;279.6490404542299;281.3149979799189;282.7102220224271;282.87270728172325;283.8084293102156;12595.244285342886;14514.63713407164;14864.182469964162;15051.096934183957;15560.68878622427;14777.187254700988;14813.037152585075;15126.621834454145;15174.696506069871;15254.237288135577;4487.730736155841;4578.404807375036;4603.49361570227;4626.884327891796;4666;4577.33628623851;4580.954190458103;4617.976910115444;4654.953450465486;4664.230401983668;3284.687954644305;4399.472063352402;4577.519360467153;4597.908041839178;5130.56390206831;4992.425871024842;5044.419891712463;5075.619328550355;5113.821016264432;5132.153194722866;4233.788310584489;4331.740095594243;4350.6736994725525;4351.325544540601;4395.758233297167;16973.236204370834;16977.49067527976;16986.40547580841;17247.482575522754;17602.11989400525;1728.956776080608;1773.0779994402967;1779.2693279584594;1826.3881599664128;1832.3861506395374;11100.611478598292;11186.608468703556;11454;11613.30320180792;11799.469023893946;1407.247122789303;1417.5109587192505;1459.7007613439218;1488.918109503977;1514.3488300030983;46011.769941150415;47406;47747.76126119382;47957.76021119907;49290.7535462324;7894.763157105296;8044.6379912902885;8201.343892488587;8263.462874913112;8299.875501867476;10028.398296102258;10028.498575071364;10066.396016239049;10079.042490963348;10195.184385249162;6267.561270711007;6359.332270111571;6381.744730210739;6394.721055788861;6416.230052393649;6189.907151392733;6204.5967012144065;6246.875062498724;6318.494520438354;6407.167068281186;4882.414110306715;4947.134251506044;4950.975245123751;5027.748612569357;5041.697498150123;1392.5752645443035;1437.4896911596443;1445.6891768269873;1450.4923276853017;1463.4219483304248;340.11739535904286;340.144536490726;348.67050637148157;776.7436745873848;952.8189643967625;8392.916070839214;8503.428560004813;8585.098564650621;8698.91301086981;8942.284617230605;324.8668046101087;338.67994744965773;344.8189700407256;350.6563567703665;352.70020482590104;4653.930191047137;4779.808807647724;4903.092927808367;4953.90092198154;4981.950180498221;482320;487149;498710;504772;510255;60413.395866041654;62385.68807155935;62604;62896.371036289966;64729.35270647328;373.824302577788;377.9697624190058;378.89390970528297;379.86135060703197;383.2297082863409;8382.538960357238;8452.704155354779;8566.314694824274;8612.526311052952;8688.91311086881;27686;27969;28497.145085647462;29197.85401072981;29308.267293317836;40400.39399408952;40465.59534404618;40847.591524084375;41113;41656;6206.06908963641;6437.710303036468;6503.804885853432;6517.543771935919;6552;9408.76478088026;9656.855147172657;9788.804223915624;9832.950835245778;9907.207423406255;7221.891671625035;8147.837043258983;8335.49987000782;8420.536870472182;8546.2308392245;7490.5131166474;8073.273405393308;8216.876746848682;8316.584170791557;8489.4481858679;8018.679252830055;8499.617517211864;8543.444676096035;8722.215000649972;8726.825463490568;6160.9383906160365;6502.349765023459;6502.479801615954;6504.934950650433;6638.800835974928;8260.463069900437;8305.501669899826;8348.415610907177;8573.699920502753;8622.353323500887 11:45:28 INFO - 2015-11-15 11:45:28,143 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1184.792661284275;1204.614523352527;1204.8734882837302;1482.9999999999993;1530.5867415797727;5942.138389933457;5991.460768530831;6777.728890844366;6912.343327383896;6945;6553.868922621545;6647.368499992493;6720.731170753164;6727.091842601248;6769.4584433245345;1916.492129585661;1919.3857965451061;1925.3357591630865;1932.391296741529;1941.7184508246296;1954.198778500815;1957.8727382720149;1969.9704504432445;2010.5074256807102;2026.3616960657419;1900.1734245603138;1929.5851391950728;1932.5361913140885;1934.94195174145;1951.6877299632063;1903.3338331583973;1934.1006432009183;1936.1093896807345;1937.7287179794769;1965.931192408266;1958.3243780895712;1971.842252619787;1981.1184023109722;1991.0442987366146;2027.0776796557532;6736.360045795642;6804.55770374924;6822.488313376517;6827.726890924407;6848;4209.7474151551005;4282.229198744225;4295.763732994684;4300.956990430118;4322.222000039991;2457.6436416719475;2534.721180670125;2564.474282772046;2587.0815860369485;2616.515944550264;789.471054393552;800.4476910931497;802.9156938521429;812.715549557656;829.0714399872181;8862.778430539223;8876.378653494257;8884.555772211364;8964.238039766627;9003;3856.787876666754;3869.1294458746556;3954.7033972451604;3958.3072962232072;3973.1060511385285;7756.844863102707;7771.184025677222;7773.650185741655;7830.33442157423;7899.921000790034;4296.076343586082;4297.505786834491;4326.113146804897;4336.934945975813;4389.561043895649;3440.3119376124873;3548.716102711777;3896.5324161100284;3915.9021024474614;3924.7448915820382;3127.890523831655;3206.679332066821;3216.823074730912;3253.398121347558;3265.8367081645824;1048.365738728074;1059.7350662334416;1063.409807556798;1064.7284942339809;1072.5977758340623;955.1594596754811;1015.720676813882;1123.3316176874746;1134.1323887226279;1138.0610995928228;6384.553081284358;6390.7443702251385;6425.903611445832;6457.063725759833;6480.027995800668;940.7177846645978;970.8203982263304;977.5258999385293;981.2003217377815;988.2094324540338;4843.128236917389;4848.636352273594;4965.875853103629;5005.099082165245;5013.24801279811;7788.493747906368;8108.270255677017;8108.554029528433;8114.675412983414;8115.8782618260775;7983.600819958979;7988.320992715684;8005.319547838382;8033.477823941542;8092.635831387602;6121.785737499166;6272.592281501779;6420.807375778734;6450.5484616077365;6452.741890324428;6341.207349081365;6417.294097649162;6417.647029413427;6466.030095485715;6514.153160089348;7057.7176912922905;7147.356737893615;7262.600556969417;7276.1996180419055;7332.120145582564;7295.744648937261;7470.589117598584;7516;7533.284337987882;7567.772966811004;5433.972830135824;5571.693556854412;5601.80393686219;5646.7458964347525;5688.829335119953;6169.784057557964;6349.936500634934;6431.389018043278;6473.061406095995;6525.445337146396;5620.606557541097;5656.6888821115235;5864.882702346014;5910.143029260819;6181.227346581677;5879.853003674772;5947.226860508106;5995.700214989321;6068.393160683896;6102.908456373247;5951.7619295227705;5994.340622531431;6000.939990600038;6009.669468179117;6152.292486363946;5503.504684578407;5540;5540.667559946416;5576.7211639417055;5605.691686957257;5585.748641311069;5587.776488940397;5637.408072152365;5662.915056274242;5699.857503562278 11:45:28 INFO - 2015-11-15 11:45:28,145 DEBUG : BROWSER_OUTPUT: |4;prototype.html;266.63737317248547;270.56979402749636;274.3484224965707;279.054006916553;279.2961736424211;5256.211568264762;5375.623706340552;5431.809886653958;5520.9171862422045;5584.162375643656;5219.765110570024;5310.176922576997;5340.786368545254;5390.407055223922;5453.509184173424;4079.77561234132;4085.2238074765846;4140.648044916178;4161.646260067898;4164.75011499311;4086.734362266443;4088.080181959065;4113.136241389297;4143.647789937859;4158.958410415902;3823.770573765583;4026.7986600669997;4049.9797501012454;4116.423700681907;4127.62851343379;3963.98018009911;3969.98015009926;4012.378081397359;4016.819243134066;4078.1843631273864;3398.065531978701;3401.6188667932297;3419.9658003419895;3426.1777173478436;3463.9653603463894;5211.42674305826;5261.394939581959;5263.578913686896;5271.314729085233;5329.973350133263;4385;4536.523665015159;4551.203539380595;4564.2012647786505;4601.079784043205;5419.485148910847;5599.804006859781;5606.327240731098;5622.803201887955;5665.507176842218;3692.058525076115;3709.2581483703366;3727.701783857312;3736.962630373716;3754.7747135171976;5840.591158618899;5941.584089113764;5955.880882382328;5982.521398288127;6015.939840601582;3653.908652283714;3746.9063273418383;3779.962200378016;3780.281746468162;3784.280986612535;3772.43413487979;3840.519935008124;3845.134844659929;3848.9615103849164;3879.4180872869297;4481.641468682563;4502.257127573979;4509.1658043262105;4577.427821522309;4585.312203169551;5599.524040456526;5618.381977982419;5633.352164501053;5634.971825140848;5729.942700573024;1322.550332886823;1354.106289848695;1355.4713661671956;1357.5859362894412;1367.8700523450257;814.1614137438448;825.8885050518223;852.9829403411896;856.1310270075878;872.1409411729442;5346.572274218053;5373.919391209135;5391.81128660495;5410.810621628224;5425.430329815392;5839.153322768175;5859.648421094748;5898.203742494708;5903.793367232212;5912.083627037816;5394.595405344615;5401.2168235606405;5427.674339539641;5447.237386765856;5462.044142275086;3046.086174147747;3127.202563346332;3152.7004934531183;3161.573187619688;3190.664980177048;6037.969810150921;6078.118672792509;6080.665563394055;6126.295476020315;6163.3836616338;5965.880682386328;5995.61028533144;5997.910031349533;6009.06859436788;6141.57009009374;5861.706914654335;6074.817755467343;6084.361142080106;6092.512598991982;6098.0852872069545;5776.075827867521;5808.854778630399;5868.3251426086545;5881.441263080001;5920.851978700394;5715.685637289989;5731.971340143273;5743.59794814359;5793.478586927196;5827.446392592697;5852.619579727304;6025.126356678345;6051.33435322123;6071.150038994456;6102.176206212104;3798.525184351956;3805.372113601225;3819.5416550014174;3821.5032045833864;3843.308204523101;5737.655740655574;5804.535637148933;5807.070868661163;5837.532997360286;5844.912326315024;5607;5618.269624948894;5622.634528755618;5690.544756419559;5691.7438715257085;5420.864478388072;5618.550515958796;5660.85847853807;5663.093904975184;5713.628614140068;5467.507924286833;5488.341399032141;5498.615096943336;5606.691631960118;5620.072688006433;5409.594280428905;5534.501894829485;5632.746526406239;5652.773889044557;5686.914696279642;5493.945060549503;5556.444355564411;5578.60949733531;5610.438956104357;5620.04459241938 11:45:28 INFO - 2015-11-15 11:45:28,149 DEBUG : BROWSER_OUTPUT: |5;yui.html;620.8509018650241;634.9587276827003;643.391994565136;647.6535053746245;661.157024793388;11436.771264574714;11721.70695732605;11875.28748275104;12002.339871307075;12040.397980100994;10978;11095.4452277386;11106.389148596823;11136.777264454706;11143.442827858615;587.1779508687829;597.2951916738247;724.5399171526079;734.0457405373021;744.2297222374843;747.9326860582546;751.9962400187991;754.8678981178272;759.8290384663434;761.1627210068907;775.728495026739;785.2853902948318;785.4030936488253;789.0964845252183;795.4948607634136;778.4317448262772;781.1719577248107;781.9374450043982;788.8934993775881;789.1004255149135;583.0903790087477;583.9562032847554;585.096026638844;588.479195911617;589.2251689028956;11450.94274528622;11509.424528773612;11617.419129043514;11732.17874748768;11843.407829608484;9504.762380940532;9560.56977436017;9879.950600247024;10232.693019209435;10284;7716;7804.765857024298;7848.609138669021;8038.914746509205;8211.466254693425;2539.6952365716047;2573.7812285955715;2629.6975847777367;2920.328324485359;2935.339548601569;39507.8024609878;39711.205775884606;39792.20415591701;39942.20115597672;40240;5768.596198266081;5900.6164599301765;5915.497182739516;6031.24609423822;6170.784022559189;9924.900750992541;9971.351862128939;10005.44970026641;10143.289969702199;10146.746331341776;5040.571551418097;5155.639105262596;5155.948440515622;5163.870903227375;5343.145096784574;3042.787004909635;3047.3143542703156;3082.3064810417477;3145.119366577362;3172.08009677191;2216.9889150554145;2638.037116452481;2735.6990731019573;2748.807583469138;2756.131818477173;454.1008802570928;466.1446246138306;475.230127193948;481.47519204067737;485.16067203737026;462.4381376627414;497.67337696269794;499.2735569746011;520.1833121998426;536.000359329847;6641.103451034145;6751.763688270985;6895.896561551581;6960.756373526902;6976.651167441608;497.572088004316;526.2606038515814;530.6815910453697;537.3578573604505;539.4847920236165;3270.640229574745;3390.2541440882965;3393.7624366294617;3494.7378946579106;3548.503209550665;47132.293015604795;47333;48056.759716201894;48238.51761482411;48600;42685.35971960423;43154;43276;43862;44068.3389749154;38713.80643096766;38725.6127438722;38929.026774330305;39488.80255598704;39786;6809.69356378974;6889.414399776075;6927.89608155868;7165.176004759519;7226.855462890608;28090.578641320804;28123;28691.569626455203;28741;29031;35918.8204058978;36361.27277454489;36422.8178859104;38048.23903521859;38681;6424.432341018329;6436.324185960407;6447.290798012309;6577.2436169841085;6682.9331706682315;9152.084791521062;9292;9355.158035776813;9475.620975160917;10161.644342447978;8618;8799.736007919773;8884.955575222082;8970.506622135585;9698.563564639468;8467.323651452301;8482.491050536988;8881.955590222007;8917.28661707075;8922.420042697204;8916.465012099296;8921.598528066383;8960.103989600988;9018.549072546477;9052.592633331647;7594.544327340377;7885.605719713876;7942.722004729807;8076.515409075474;8094.716684915999;7283.308085732059;7412.592307423143;7681.692732290646;7744.148143704076;8105.716299929474 11:45:28 INFO - 2015-11-15 11:45:28,149 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:45:28 INFO - 2015-11-15 11:45:28,149 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:45:28 INFO - 2015-11-15 11:45:28,150 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,300 11:45:28 INFO - 2015-11-15 11:45:28,150 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:45:28 INFO - 2015-11-15 11:45:28,150 DEBUG : BROWSER_OUTPUT: __startTimestamp1447616728132__endTimestamp 11:45:28 INFO - 2015-11-15 11:45:28,150 DEBUG : BROWSER_OUTPUT: 11:45:28 INFO - 2015-11-15 11:45:28,150 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:45:28 INFO - 2015-11-15 11:45:28,151 DEBUG : BROWSER_OUTPUT: Number of tests: 6 11:45:28 INFO - 2015-11-15 11:45:28,151 DEBUG : BROWSER_OUTPUT: 11:45:28 INFO - 2015-11-15 11:45:28,151 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4466.88 Median:4625.24 stddev:589.25 (12.7%) stddev-sans-first:573.61 11:45:28 INFO - 2015-11-15 11:45:28,151 DEBUG : BROWSER_OUTPUT: Values: 2652.2 2656.2 2708.6 2722.9 2734.6 4430.6 4482.5 4497.6 4512.5 4638.0 4363.9 4394.5 4479.7 4487.1 4560.3 4115.4 4211.2 4216.6 4228.5 4274.6 235.9 4182.5 4229.9 4285.4 4304.3 3974.7 4057.8 4085.4 4112.5 4228.3 4144.7 4147.9 4155.5 4188.1 4203.4 3966.9 4125.4 4159.8 4173.6 4201.9 4198.3 4310.3 4377.7 4407.8 4451.5 4798.5 4803.3 4829.2 4837.1 4876.9 4669.3 4683.3 4774.1 4917.6 4926.9 4445.2 4473.4 4474.9 4543.6 4569.3 4837.9 4902.6 4918.8 4954.8 4961.2 4484.7 4586.7 4625.2 4641.5 4711.4 4788.9 4827.9 4865.6 4878.9 4902.4 4746.2 4756.1 4768.2 4802.8 4824.9 4531.5 4653.9 4683.2 4804.8 4826.4 3698.7 3719.7 3746.8 3759.8 3766.0 3305.5 3386.8 3408.9 3425.2 3442.8 4501.8 4514.7 4521.1 4557.4 4578.0 4835.9 4877.7 4887.1 4888.0 4900.8 4358.7 4564.2 4572.8 4581.2 4590.3 4131.0 4166.7 4200.3 4206.1 4256.9 4967.9 5012.3 5029.2 5066.5 5129.4 4768.7 4772.7 4875.7 4889.4 4938.8 5016.1 5036.2 5046.9 5054.9 5135.7 4752.4 4769.9 4770.1 4770.8 4826.6 4686.6 4753.5 4826.3 4839.5 4935.5 4735.1 4752.5 4805.0 4815.4 4845.1 4754.7 4761.9 4783.1 4795.0 4804.8 4478.6 4510.1 4512.7 4521.4 4548.1 4715.2 4724.2 4744.3 4787.7 4852.6 4685.8 4698.4 4705.9 4737.5 4750.9 11:45:28 INFO - 2015-11-15 11:45:28,151 DEBUG : BROWSER_OUTPUT: 11:45:28 INFO - 2015-11-15 11:45:28,151 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42400.14 Median:346061.00 stddev:73630.63 (21.3%) stddev-sans-first:73769.80 11:45:28 INFO - 2015-11-15 11:45:28,152 DEBUG : BROWSER_OUTPUT: Values: 447.1 465.5 467.7 477.4 493.7 31474.2 31559.0 31573.8 31762.4 31976.5 35465.5 36304.5 36664.1 36756.3 37380.0 7601.7 7732.9 7846.5 7867.9 7926.0 7598.7 7699.6 7770.2 7788.5 7792.8 7737.6 7789.9 7823.1 7868.6 7897.0 7608.3 7672.9 7705.5 7747.4 7809.9 7478.3 7584.5 7648.2 7676.5 7715.6 33267.8 33770.8 33817.8 34031.5 34076.1 2435.0 2573.9 2606.9 2644.0 3076.0 22657.7 22681.2 22946.8 22981.8 23052.3 2025.4 2037.7 2065.1 2083.5 2085.3 233634.0 237917.0 239091.0 239290.0 239736.0 52170.7 52452.2 52493.2 52613.5 52780.2 46635.8 47263.3 59052.0 60851.0 61145.7 12275.8 12341.6 12497.0 12536.7 12723.0 9096.1 9278.5 9284.8 9341.0 9405.5 17134.7 17483.5 17545.0 17611.4 17649.3 7207.7 7491.4 7554.2 7592.8 7625.8 787.1 882.3 922.0 926.5 929.0 23691.6 23694.3 23952.3 24041.3 24121.9 871.5 875.7 895.1 946.7 951.4 12565.2 12690.4 13409.4 14306.6 14378.8 335810.0 342177.0 345255.0 345501.0 346621.0 48388.3 48802.5 49083.5 49802.5 49847.8 998.9 1144.7 1150.0 1166.0 1169.0 24997.3 25302.0 25626.4 25678.4 25840.7 40294.0 40674.4 40765.6 41238.8 41578.8 244515.0 244558.0 248776.0 249191.0 249401.0 27171.3 36848.6 38893.8 38910.0 39844.8 36218.0 36871.0 37118.6 37125.3 37754.8 32818.0 34217.5 34762.8 34930.8 35165.8 30070.2 30484.5 30568.2 30592.4 30615.4 30907.1 31149.5 31151.1 31439.0 31739.8 25959.5 29518.6 29728.6 30127.0 30268.8 20539.6 20578.0 20613.3 20846.0 20911.0 11:45:28 INFO - 2015-11-15 11:45:28,152 DEBUG : BROWSER_OUTPUT: 11:45:28 INFO - 2015-11-15 11:45:28,152 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24372.01 Median:26263.79 stddev:81181.35 (309.1%) stddev-sans-first:81388.93 11:45:28 INFO - 2015-11-15 11:45:28,153 DEBUG : BROWSER_OUTPUT: Values: 279.6 281.3 282.7 282.9 283.8 12595.2 14514.6 14864.2 15051.1 15560.7 14777.2 14813.0 15126.6 15174.7 15254.2 4487.7 4578.4 4603.5 4626.9 4666.0 4577.3 4581.0 4618.0 4655.0 4664.2 3284.7 4399.5 4577.5 4597.9 5130.6 4992.4 5044.4 5075.6 5113.8 5132.2 4233.8 4331.7 4350.7 4351.3 4395.8 16973.2 16977.5 16986.4 17247.5 17602.1 1729.0 1773.1 1779.3 1826.4 1832.4 11100.6 11186.6 11454.0 11613.3 11799.5 1407.2 1417.5 1459.7 1488.9 1514.3 46011.8 47406.0 47747.8 47957.8 49290.8 7894.8 8044.6 8201.3 8263.5 8299.9 10028.4 10028.5 10066.4 10079.0 10195.2 6267.6 6359.3 6381.7 6394.7 6416.2 6189.9 6204.6 6246.9 6318.5 6407.2 4882.4 4947.1 4951.0 5027.7 5041.7 1392.6 1437.5 1445.7 1450.5 1463.4 340.1 340.1 348.7 776.7 952.8 8392.9 8503.4 8585.1 8698.9 8942.3 324.9 338.7 344.8 350.7 352.7 4653.9 4779.8 4903.1 4953.9 4982.0 482320.0 487149.0 498710.0 504772.0 510255.0 60413.4 62385.7 62604.0 62896.4 64729.4 373.8 378.0 378.9 379.9 383.2 8382.5 8452.7 8566.3 8612.5 8688.9 27686.0 27969.0 28497.1 29197.9 29308.3 40400.4 40465.6 40847.6 41113.0 41656.0 6206.1 6437.7 6503.8 6517.5 6552.0 9408.8 9656.9 9788.8 9833.0 9907.2 7221.9 8147.8 8335.5 8420.5 8546.2 7490.5 8073.3 8216.9 8316.6 8489.4 8018.7 8499.6 8543.4 8722.2 8726.8 6160.9 6502.3 6502.5 6504.9 6638.8 8260.5 8305.5 8348.4 8573.7 8622.4 11:45:28 INFO - 2015-11-15 11:45:28,154 DEBUG : BROWSER_OUTPUT: 11:45:28 INFO - 2015-11-15 11:45:28,154 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4713.99 Median:5782.37 stddev:2409.29 (41.7%) stddev-sans-first:2401.45 11:45:28 INFO - 2015-11-15 11:45:28,154 DEBUG : BROWSER_OUTPUT: Values: 1184.8 1204.6 1204.9 1483.0 1530.6 5942.1 5991.5 6777.7 6912.3 6945.0 6553.9 6647.4 6720.7 6727.1 6769.5 1916.5 1919.4 1925.3 1932.4 1941.7 1954.2 1957.9 1970.0 2010.5 2026.4 1900.2 1929.6 1932.5 1934.9 1951.7 1903.3 1934.1 1936.1 1937.7 1965.9 1958.3 1971.8 1981.1 1991.0 2027.1 6736.4 6804.6 6822.5 6827.7 6848.0 4209.7 4282.2 4295.8 4301.0 4322.2 2457.6 2534.7 2564.5 2587.1 2616.5 789.5 800.4 802.9 812.7 829.1 8862.8 8876.4 8884.6 8964.2 9003.0 3856.8 3869.1 3954.7 3958.3 3973.1 7756.8 7771.2 7773.7 7830.3 7899.9 4296.1 4297.5 4326.1 4336.9 4389.6 3440.3 3548.7 3896.5 3915.9 3924.7 3127.9 3206.7 3216.8 3253.4 3265.8 1048.4 1059.7 1063.4 1064.7 1072.6 955.2 1015.7 1123.3 1134.1 1138.1 6384.6 6390.7 6425.9 6457.1 6480.0 940.7 970.8 977.5 981.2 988.2 4843.1 4848.6 4965.9 5005.1 5013.2 7788.5 8108.3 8108.6 8114.7 8115.9 7983.6 7988.3 8005.3 8033.5 8092.6 6121.8 6272.6 6420.8 6450.5 6452.7 6341.2 6417.3 6417.6 6466.0 6514.2 7057.7 7147.4 7262.6 7276.2 7332.1 7295.7 7470.6 7516.0 7533.3 7567.8 5434.0 5571.7 5601.8 5646.7 5688.8 6169.8 6349.9 6431.4 6473.1 6525.4 5620.6 5656.7 5864.9 5910.1 6181.2 5879.9 5947.2 5995.7 6068.4 6102.9 5951.8 5994.3 6000.9 6009.7 6152.3 5503.5 5540.0 5540.7 5576.7 5605.7 5585.7 5587.8 5637.4 5662.9 5699.9 11:45:28 INFO - 2015-11-15 11:45:28,154 DEBUG : BROWSER_OUTPUT: 11:45:28 INFO - 2015-11-15 11:45:28,154 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4693.53 Median:5426.55 stddev:1463.72 (27.0%) stddev-sans-first:1429.62 11:45:28 INFO - 2015-11-15 11:45:28,156 DEBUG : BROWSER_OUTPUT: Values: 266.6 270.6 274.3 279.1 279.3 5256.2 5375.6 5431.8 5520.9 5584.2 5219.8 5310.2 5340.8 5390.4 5453.5 4079.8 4085.2 4140.6 4161.6 4164.8 4086.7 4088.1 4113.1 4143.6 4159.0 3823.8 4026.8 4050.0 4116.4 4127.6 3964.0 3970.0 4012.4 4016.8 4078.2 3398.1 3401.6 3420.0 3426.2 3464.0 5211.4 5261.4 5263.6 5271.3 5330.0 4385.0 4536.5 4551.2 4564.2 4601.1 5419.5 5599.8 5606.3 5622.8 5665.5 3692.1 3709.3 3727.7 3737.0 3754.8 5840.6 5941.6 5955.9 5982.5 6015.9 3653.9 3746.9 3780.0 3780.3 3784.3 3772.4 3840.5 3845.1 3849.0 3879.4 4481.6 4502.3 4509.2 4577.4 4585.3 5599.5 5618.4 5633.4 5635.0 5729.9 1322.6 1354.1 1355.5 1357.6 1367.9 814.2 825.9 853.0 856.1 872.1 5346.6 5373.9 5391.8 5410.8 5425.4 5839.2 5859.6 5898.2 5903.8 5912.1 5394.6 5401.2 5427.7 5447.2 5462.0 3046.1 3127.2 3152.7 3161.6 3190.7 6038.0 6078.1 6080.7 6126.3 6163.4 5965.9 5995.6 5997.9 6009.1 6141.6 5861.7 6074.8 6084.4 6092.5 6098.1 5776.1 5808.9 5868.3 5881.4 5920.9 5715.7 5732.0 5743.6 5793.5 5827.4 5852.6 6025.1 6051.3 6071.2 6102.2 3798.5 3805.4 3819.5 3821.5 3843.3 5737.7 5804.5 5807.1 5837.5 5844.9 5607.0 5618.3 5622.6 5690.5 5691.7 5420.9 5618.6 5660.9 5663.1 5713.6 5467.5 5488.3 5498.6 5606.7 5620.1 5409.6 5534.5 5632.7 5652.8 5686.9 5493.9 5556.4 5578.6 5610.4 5620.0 11:45:28 INFO - 2015-11-15 11:45:28,156 DEBUG : BROWSER_OUTPUT: 11:45:28 INFO - 2015-11-15 11:45:28,156 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11086.05 Median:3154.04 stddev:13381.53 (424.3%) stddev-sans-first:13395.99 11:45:28 INFO - 2015-11-15 11:45:28,159 DEBUG : BROWSER_OUTPUT: Values: 620.9 635.0 643.4 647.7 661.2 11436.8 11721.7 11875.3 12002.3 12040.4 10978.0 11095.4 11106.4 11136.8 11143.4 587.2 597.3 724.5 734.0 744.2 747.9 752.0 754.9 759.8 761.2 775.7 785.3 785.4 789.1 795.5 778.4 781.2 781.9 788.9 789.1 583.1 584.0 585.1 588.5 589.2 11450.9 11509.4 11617.4 11732.2 11843.4 9504.8 9560.6 9880.0 10232.7 10284.0 7716.0 7804.8 7848.6 8038.9 8211.5 2539.7 2573.8 2629.7 2920.3 2935.3 39507.8 39711.2 39792.2 39942.2 40240.0 5768.6 5900.6 5915.5 6031.2 6170.8 9924.9 9971.4 10005.4 10143.3 10146.7 5040.6 5155.6 5155.9 5163.9 5343.1 3042.8 3047.3 3082.3 3145.1 3172.1 2217.0 2638.0 2735.7 2748.8 2756.1 454.1 466.1 475.2 481.5 485.2 462.4 497.7 499.3 520.2 536.0 6641.1 6751.8 6895.9 6960.8 6976.7 497.6 526.3 530.7 537.4 539.5 3270.6 3390.3 3393.8 3494.7 3548.5 47132.3 47333.0 48056.8 48238.5 48600.0 42685.4 43154.0 43276.0 43862.0 44068.3 38713.8 38725.6 38929.0 39488.8 39786.0 6809.7 6889.4 6927.9 7165.2 7226.9 28090.6 28123.0 28691.6 28741.0 29031.0 35918.8 36361.3 36422.8 38048.2 38681.0 6424.4 6436.3 6447.3 6577.2 6682.9 9152.1 9292.0 9355.2 9475.6 10161.6 8618.0 8799.7 8885.0 8970.5 9698.6 8467.3 8482.5 8882.0 8917.3 8922.4 8916.5 8921.6 8960.1 9018.5 9052.6 7594.5 7885.6 7942.7 8076.5 8094.7 7283.3 7412.6 7681.7 7744.1 8105.7 11:45:28 INFO - 2015-11-15 11:45:28,160 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:45:28 INFO - 2015-11-15 11:45:28,160 DEBUG : BROWSER_OUTPUT: 11:45:28 INFO - 2015-11-15 11:45:28,789 INFO : Browser exited with error code: 0 11:45:28 INFO - 2015-11-15 11:45:28,821 INFO : Completed test dromaeo_css (00:18:31) 11:45:28 INFO - 2015-11-15 11:45:28,822 INFO : Starting test kraken 11:45:28 INFO - 2015-11-15 11:45:28,822 DEBUG : operating with platform_type : mac_ 11:45:28 INFO - 2015-11-15 11:45:28,822 INFO : Initialising browser for kraken test... 11:45:28 INFO - 2015-11-15 11:45:28,837 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/tmp0Rt8bd/profile http://localhost:49347/getInfo.html 11:45:32 INFO - 2015-11-15 11:45:32,171 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:45:32 INFO - 2015-11-15 11:45:32,171 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:45:32 INFO - 2015-11-15 11:45:32,171 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 11:45:32 INFO - 2015-11-15 11:45:32,171 DEBUG : BROWSER_OUTPUT: __metrics 11:45:32 INFO - 2015-11-15 11:45:32,863 INFO : Browser initialized. 11:45:32 INFO - 2015-11-15 11:45:32,864 INFO : Running cycle 1/1 for kraken test... 11:45:32 INFO - 2015-11-15 11:45:32,864 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/tmp0Rt8bd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:45:45 INFO - 2015-11-15 11:45:45,121 DEBUG : BROWSER_OUTPUT: RSS: Main: 240889856 11:45:45 INFO - 2015-11-15 11:45:45,121 DEBUG : BROWSER_OUTPUT: 11:45:48 INFO - 2015-11-15 11:45:48,003 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49347/tests/kraken/driver.html?testName=audio-beat-detection) 11:45:48 INFO - 2015-11-15 11:45:48,608 DEBUG : BROWSER_OUTPUT: RSS: Main: 259821568 11:45:48 INFO - 2015-11-15 11:45:48,608 DEBUG : BROWSER_OUTPUT: 11:45:51 INFO - 2015-11-15 11:45:51,689 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49347/tests/kraken/driver.html?testName=audio-dft) 11:45:52 INFO - 2015-11-15 11:45:52,292 DEBUG : BROWSER_OUTPUT: RSS: Main: 267939840 11:45:52 INFO - 2015-11-15 11:45:52,292 DEBUG : BROWSER_OUTPUT: 11:45:55 INFO - 2015-11-15 11:45:55,640 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49347/tests/kraken/driver.html?testName=audio-fft) 11:45:56 INFO - 2015-11-15 11:45:56,216 DEBUG : BROWSER_OUTPUT: RSS: Main: 267321344 11:45:56 INFO - 2015-11-15 11:45:56,216 DEBUG : BROWSER_OUTPUT: 11:45:58 INFO - 2015-11-15 11:45:58,416 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49347/tests/kraken/driver.html?testName=audio-oscillator) 11:45:59 INFO - 2015-11-15 11:45:59,021 DEBUG : BROWSER_OUTPUT: RSS: Main: 267132928 11:45:59 INFO - 2015-11-15 11:45:59,022 DEBUG : BROWSER_OUTPUT: 11:46:01 INFO - 2015-11-15 11:46:01,440 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49347/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:46:02 INFO - 2015-11-15 11:46:02,030 DEBUG : BROWSER_OUTPUT: RSS: Main: 268218368 11:46:02 INFO - 2015-11-15 11:46:02,030 DEBUG : BROWSER_OUTPUT: 11:46:05 INFO - 2015-11-15 11:46:05,575 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49347/tests/kraken/driver.html?testName=imaging-darkroom) 11:46:06 INFO - 2015-11-15 11:46:06,149 DEBUG : BROWSER_OUTPUT: RSS: Main: 265842688 11:46:06 INFO - 2015-11-15 11:46:06,149 DEBUG : BROWSER_OUTPUT: 11:46:09 INFO - 2015-11-15 11:46:09,781 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49347/tests/kraken/driver.html?testName=imaging-desaturate) 11:46:10 INFO - 2015-11-15 11:46:10,376 DEBUG : BROWSER_OUTPUT: RSS: Main: 266702848 11:46:10 INFO - 2015-11-15 11:46:10,376 DEBUG : BROWSER_OUTPUT: 11:46:13 INFO - 2015-11-15 11:46:13,651 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49347/tests/kraken/driver.html?testName=json-parse-financial) 11:46:14 INFO - 2015-11-15 11:46:14,243 DEBUG : BROWSER_OUTPUT: RSS: Main: 270503936 11:46:14 INFO - 2015-11-15 11:46:14,243 DEBUG : BROWSER_OUTPUT: 11:46:16 INFO - 2015-11-15 11:46:16,001 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49347/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:46:16 INFO - 2015-11-15 11:46:16,585 DEBUG : BROWSER_OUTPUT: RSS: Main: 270614528 11:46:16 INFO - 2015-11-15 11:46:16,585 DEBUG : BROWSER_OUTPUT: 11:46:18 INFO - 2015-11-15 11:46:18,635 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49347/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:46:19 INFO - 2015-11-15 11:46:19,263 DEBUG : BROWSER_OUTPUT: RSS: Main: 271351808 11:46:19 INFO - 2015-11-15 11:46:19,264 DEBUG : BROWSER_OUTPUT: 11:46:21 INFO - 2015-11-15 11:46:21,626 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49347/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:46:22 INFO - 2015-11-15 11:46:22,226 DEBUG : BROWSER_OUTPUT: RSS: Main: 271335424 11:46:22 INFO - 2015-11-15 11:46:22,226 DEBUG : BROWSER_OUTPUT: 11:46:25 INFO - 2015-11-15 11:46:25,283 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49347/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:46:25 INFO - 2015-11-15 11:46:25,882 DEBUG : BROWSER_OUTPUT: RSS: Main: 270761984 11:46:25 INFO - 2015-11-15 11:46:25,883 DEBUG : BROWSER_OUTPUT: 11:46:28 INFO - 2015-11-15 11:46:28,877 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49347/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:46:29 INFO - 2015-11-15 11:46:29,468 DEBUG : BROWSER_OUTPUT: RSS: Main: 271290368 11:46:29 INFO - 2015-11-15 11:46:29,468 DEBUG : BROWSER_OUTPUT: 11:46:31 INFO - 2015-11-15 11:46:31,385 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49347/tests/kraken/driver.html?testName=ai-astar) 11:46:31 INFO - 2015-11-15 11:46:31,633 DEBUG : BROWSER_OUTPUT: RSS: Main: 272715776 11:46:31 INFO - 2015-11-15 11:46:31,633 DEBUG : BROWSER_OUTPUT: 11:46:31 INFO - 2015-11-15 11:46:31,634 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:46:31 INFO - 2015-11-15 11:46:31,634 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:46:31 INFO - 2015-11-15 11:46:31,634 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:46:31 INFO - 2015-11-15 11:46:31,634 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:46:31 INFO - 2015-11-15 11:46:31,634 DEBUG : BROWSER_OUTPUT: |0;ai-astar;130;123;133;140;141;146;134;132;133;133 11:46:31 INFO - 2015-11-15 11:46:31,634 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;183;167;192;207;165;178;180;164;205;161 11:46:31 INFO - 2015-11-15 11:46:31,634 DEBUG : BROWSER_OUTPUT: |2;audio-dft;197;215;209;205;204;202;205;206;205;205 11:46:31 INFO - 2015-11-15 11:46:31,634 DEBUG : BROWSER_OUTPUT: |3;audio-fft;86;89;101;156;84;89;89;85;119;80 11:46:31 INFO - 2015-11-15 11:46:31,635 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;101;109;153;110;114;113;151;108;110;155 11:46:31 INFO - 2015-11-15 11:46:31,635 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;152;144;142;149;149;157;151;150;149;142 11:46:31 INFO - 2015-11-15 11:46:31,635 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;157;164;158;156;156;158;156;157;156;158 11:46:31 INFO - 2015-11-15 11:46:31,635 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;118;138;124;124;121;125;124;124;117;128 11:46:31 INFO - 2015-11-15 11:46:31,635 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;74;76;75;78;78;78;79;84;78;78 11:46:31 INFO - 2015-11-15 11:46:31,636 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;80;87;85;86;87;87;87;87;87;87 11:46:31 INFO - 2015-11-15 11:46:31,636 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;102;106;108;110;112;111;107;108;108;109 11:46:31 INFO - 2015-11-15 11:46:31,636 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;170;163;166;177;158;164;171;174;174;155 11:46:31 INFO - 2015-11-15 11:46:31,636 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;171;191;192;192;194;178;192;191;193;180 11:46:31 INFO - 2015-11-15 11:46:31,636 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;81;85;88;88;87;88;90;92;92;87 11:46:31 INFO - 2015-11-15 11:46:31,636 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:46:31 INFO - 2015-11-15 11:46:31,636 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:46:31 INFO - 2015-11-15 11:46:31,637 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,762 11:46:31 INFO - 2015-11-15 11:46:31,637 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:46:31 INFO - 2015-11-15 11:46:31,637 DEBUG : BROWSER_OUTPUT: __startTimestamp1447616791631__endTimestamp 11:46:31 INFO - 2015-11-15 11:46:31,637 DEBUG : BROWSER_OUTPUT: 11:46:31 INFO - 2015-11-15 11:46:31,637 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:46:31 INFO - 2015-11-15 11:46:31,637 DEBUG : BROWSER_OUTPUT: Number of tests: 14 11:46:31 INFO - 2015-11-15 11:46:31,638 DEBUG : BROWSER_OUTPUT: 11:46:31 INFO - 2015-11-15 11:46:31,639 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:134.50 Median:133.50 stddev:6.42 (4.8%) stddev-sans-first:6.60 11:46:31 INFO - 2015-11-15 11:46:31,640 DEBUG : BROWSER_OUTPUT: Values: 130.0 123.0 133.0 140.0 141.0 146.0 134.0 132.0 133.0 133.0 11:46:31 INFO - 2015-11-15 11:46:31,640 DEBUG : BROWSER_OUTPUT: 11:46:31 INFO - 2015-11-15 11:46:31,640 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:180.20 Median:181.50 stddev:16.74 (9.2%) stddev-sans-first:17.72 11:46:31 INFO - 2015-11-15 11:46:31,640 DEBUG : BROWSER_OUTPUT: Values: 183.0 167.0 192.0 207.0 165.0 178.0 180.0 164.0 205.0 161.0 11:46:31 INFO - 2015-11-15 11:46:31,640 DEBUG : BROWSER_OUTPUT: 11:46:31 INFO - 2015-11-15 11:46:31,641 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:205.30 Median:205.00 stddev:4.60 (2.2%) stddev-sans-first:3.77 11:46:31 INFO - 2015-11-15 11:46:31,641 DEBUG : BROWSER_OUTPUT: Values: 197.0 215.0 209.0 205.0 204.0 202.0 205.0 206.0 205.0 205.0 11:46:31 INFO - 2015-11-15 11:46:31,641 DEBUG : BROWSER_OUTPUT: 11:46:31 INFO - 2015-11-15 11:46:31,641 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:97.80 Median:85.50 stddev:23.31 (27.3%) stddev-sans-first:24.33 11:46:31 INFO - 2015-11-15 11:46:31,641 DEBUG : BROWSER_OUTPUT: Values: 86.0 89.0 101.0 156.0 84.0 89.0 89.0 85.0 119.0 80.0 11:46:31 INFO - 2015-11-15 11:46:31,642 DEBUG : BROWSER_OUTPUT: 11:46:31 INFO - 2015-11-15 11:46:31,642 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:122.40 Median:113.50 stddev:21.42 (18.9%) stddev-sans-first:21.27 11:46:31 INFO - 2015-11-15 11:46:31,642 DEBUG : BROWSER_OUTPUT: Values: 101.0 109.0 153.0 110.0 114.0 113.0 151.0 108.0 110.0 155.0 11:46:31 INFO - 2015-11-15 11:46:31,642 DEBUG : BROWSER_OUTPUT: 11:46:31 INFO - 2015-11-15 11:46:31,642 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:148.50 Median:149.50 stddev:4.70 (3.1%) stddev-sans-first:4.81 11:46:31 INFO - 2015-11-15 11:46:31,642 DEBUG : BROWSER_OUTPUT: Values: 152.0 144.0 142.0 149.0 149.0 157.0 151.0 150.0 149.0 142.0 11:46:31 INFO - 2015-11-15 11:46:31,642 DEBUG : BROWSER_OUTPUT: 11:46:31 INFO - 2015-11-15 11:46:31,643 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:157.60 Median:157.50 stddev:2.41 (1.5%) stddev-sans-first:2.55 11:46:31 INFO - 2015-11-15 11:46:31,643 DEBUG : BROWSER_OUTPUT: Values: 157.0 164.0 158.0 156.0 156.0 158.0 156.0 157.0 156.0 158.0 11:46:31 INFO - 2015-11-15 11:46:31,643 DEBUG : BROWSER_OUTPUT: 11:46:31 INFO - 2015-11-15 11:46:31,643 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:124.30 Median:124.00 stddev:5.83 (4.7%) stddev-sans-first:5.72 11:46:31 INFO - 2015-11-15 11:46:31,644 DEBUG : BROWSER_OUTPUT: Values: 118.0 138.0 124.0 124.0 121.0 125.0 124.0 124.0 117.0 128.0 11:46:31 INFO - 2015-11-15 11:46:31,644 DEBUG : BROWSER_OUTPUT: 11:46:31 INFO - 2015-11-15 11:46:31,644 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:77.80 Median:78.00 stddev:2.70 (3.5%) stddev-sans-first:2.49 11:46:31 INFO - 2015-11-15 11:46:31,644 DEBUG : BROWSER_OUTPUT: Values: 74.0 76.0 75.0 78.0 78.0 78.0 79.0 84.0 78.0 78.0 11:46:31 INFO - 2015-11-15 11:46:31,644 DEBUG : BROWSER_OUTPUT: 11:46:31 INFO - 2015-11-15 11:46:31,644 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:86.00 Median:87.00 stddev:2.21 (2.5%) stddev-sans-first:0.71 11:46:31 INFO - 2015-11-15 11:46:31,645 DEBUG : BROWSER_OUTPUT: Values: 80.0 87.0 85.0 86.0 87.0 87.0 87.0 87.0 87.0 87.0 11:46:31 INFO - 2015-11-15 11:46:31,645 DEBUG : BROWSER_OUTPUT: 11:46:31 INFO - 2015-11-15 11:46:31,645 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:108.10 Median:108.50 stddev:2.81 (2.6%) stddev-sans-first:1.92 11:46:31 INFO - 2015-11-15 11:46:31,645 DEBUG : BROWSER_OUTPUT: Values: 102.0 106.0 108.0 110.0 112.0 111.0 107.0 108.0 108.0 109.0 11:46:31 INFO - 2015-11-15 11:46:31,645 DEBUG : BROWSER_OUTPUT: 11:46:31 INFO - 2015-11-15 11:46:31,645 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:167.20 Median:170.50 stddev:7.25 (4.3%) stddev-sans-first:7.62 11:46:31 INFO - 2015-11-15 11:46:31,646 DEBUG : BROWSER_OUTPUT: Values: 170.0 163.0 166.0 177.0 158.0 164.0 171.0 174.0 174.0 155.0 11:46:31 INFO - 2015-11-15 11:46:31,646 DEBUG : BROWSER_OUTPUT: 11:46:31 INFO - 2015-11-15 11:46:31,646 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.40 Median:192.00 stddev:8.00 (4.2%) stddev-sans-first:5.89 11:46:31 INFO - 2015-11-15 11:46:31,646 DEBUG : BROWSER_OUTPUT: Values: 171.0 191.0 192.0 192.0 194.0 178.0 192.0 191.0 193.0 180.0 11:46:31 INFO - 2015-11-15 11:46:31,646 DEBUG : BROWSER_OUTPUT: 11:46:31 INFO - 2015-11-15 11:46:31,646 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:87.80 Median:88.00 stddev:3.26 (3.7%) stddev-sans-first:2.35 11:46:31 INFO - 2015-11-15 11:46:31,646 DEBUG : BROWSER_OUTPUT: Values: 81.0 85.0 88.0 88.0 87.0 88.0 90.0 92.0 92.0 87.0 11:46:31 INFO - 2015-11-15 11:46:31,646 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:46:31 INFO - 2015-11-15 11:46:31,646 DEBUG : BROWSER_OUTPUT: 11:46:32 INFO - 2015-11-15 11:46:32,389 INFO : Browser exited with error code: 0 11:46:32 INFO - 2015-11-15 11:46:32,445 INFO : Completed test kraken (00:01:03) 11:46:32 INFO - 2015-11-15 11:46:32,445 INFO : Starting test v8_7 11:46:32 INFO - 2015-11-15 11:46:32,446 DEBUG : operating with platform_type : mac_ 11:46:32 INFO - 2015-11-15 11:46:32,446 INFO : Initialising browser for v8_7 test... 11:46:32 INFO - 2015-11-15 11:46:32,461 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/tmpEkep5r/profile http://localhost:49347/getInfo.html 11:46:35 INFO - 2015-11-15 11:46:35,666 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:46:35 INFO - 2015-11-15 11:46:35,666 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:46:35 INFO - 2015-11-15 11:46:35,666 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 11:46:35 INFO - 2015-11-15 11:46:35,666 DEBUG : BROWSER_OUTPUT: __metrics 11:46:36 INFO - 2015-11-15 11:46:36,414 INFO : Browser initialized. 11:46:36 INFO - 2015-11-15 11:46:36,415 INFO : Running cycle 1/1 for v8_7 test... 11:46:36 INFO - 2015-11-15 11:46:36,415 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/tmpEkep5r/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:46:48 INFO - 2015-11-15 11:46:48,655 DEBUG : BROWSER_OUTPUT: RSS: Main: 241491968 11:46:48 INFO - 2015-11-15 11:46:48,655 DEBUG : BROWSER_OUTPUT: 11:47:11 INFO - 2015-11-15 11:47:11,287 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49347/tests/v8_7/run.html (next: http://localhost:49347/tests/v8_7/run.html) 11:47:11 INFO - 2015-11-15 11:47:11,553 DEBUG : BROWSER_OUTPUT: RSS: Main: 256790528 11:47:11 INFO - 2015-11-15 11:47:11,553 DEBUG : BROWSER_OUTPUT: 11:47:11 INFO - 2015-11-15 11:47:11,553 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:47:11 INFO - 2015-11-15 11:47:11,553 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:47:11 INFO - 2015-11-15 11:47:11,553 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:47:11 INFO - 2015-11-15 11:47:11,553 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:47:11 INFO - 2015-11-15 11:47:11,553 DEBUG : BROWSER_OUTPUT: |0;Richards;877.9631255487269 11:47:11 INFO - 2015-11-15 11:47:11,553 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;236.85457129322597 11:47:11 INFO - 2015-11-15 11:47:11,553 DEBUG : BROWSER_OUTPUT: |2;Encrypt;380.517503805175 11:47:11 INFO - 2015-11-15 11:47:11,553 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6972.222222222223 11:47:11 INFO - 2015-11-15 11:47:11,554 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1358.695652173913 11:47:11 INFO - 2015-11-15 11:47:11,554 DEBUG : BROWSER_OUTPUT: |5;Earley;956.0229445506692 11:47:11 INFO - 2015-11-15 11:47:11,554 DEBUG : BROWSER_OUTPUT: |6;Boyer;16225.806451612903 11:47:11 INFO - 2015-11-15 11:47:11,554 DEBUG : BROWSER_OUTPUT: |7;RegExp;34913.793103448275 11:47:11 INFO - 2015-11-15 11:47:11,554 DEBUG : BROWSER_OUTPUT: |8;Splay;716.8458781362007 11:47:11 INFO - 2015-11-15 11:47:11,554 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6777.027027027027 11:47:11 INFO - 2015-11-15 11:47:11,554 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:47:11 INFO - 2015-11-15 11:47:11,554 DEBUG : BROWSER_OUTPUT: __startTimestamp1447616831543__endTimestamp 11:47:11 INFO - 2015-11-15 11:47:11,554 DEBUG : BROWSER_OUTPUT: 11:47:11 INFO - 2015-11-15 11:47:11,554 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:47:11 INFO - 2015-11-15 11:47:11,554 DEBUG : BROWSER_OUTPUT: Number of tests: 10 11:47:11 INFO - 2015-11-15 11:47:11,554 DEBUG : BROWSER_OUTPUT: 11:47:11 INFO - 2015-11-15 11:47:11,554 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:877.96 Median:877.96 stddev:0.00 (0.0%) 11:47:11 INFO - 2015-11-15 11:47:11,555 DEBUG : BROWSER_OUTPUT: Values: 878.0 11:47:11 INFO - 2015-11-15 11:47:11,555 DEBUG : BROWSER_OUTPUT: 11:47:11 INFO - 2015-11-15 11:47:11,555 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:236.85 Median:236.85 stddev:0.00 (0.0%) 11:47:11 INFO - 2015-11-15 11:47:11,555 DEBUG : BROWSER_OUTPUT: Values: 236.9 11:47:11 INFO - 2015-11-15 11:47:11,555 DEBUG : BROWSER_OUTPUT: 11:47:11 INFO - 2015-11-15 11:47:11,555 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:380.52 Median:380.52 stddev:0.00 (0.0%) 11:47:11 INFO - 2015-11-15 11:47:11,555 DEBUG : BROWSER_OUTPUT: Values: 380.5 11:47:11 INFO - 2015-11-15 11:47:11,555 DEBUG : BROWSER_OUTPUT: 11:47:11 INFO - 2015-11-15 11:47:11,555 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6972.22 Median:6972.22 stddev:0.00 (0.0%) 11:47:11 INFO - 2015-11-15 11:47:11,555 DEBUG : BROWSER_OUTPUT: Values: 6972.2 11:47:11 INFO - 2015-11-15 11:47:11,555 DEBUG : BROWSER_OUTPUT: 11:47:11 INFO - 2015-11-15 11:47:11,555 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1358.70 Median:1358.70 stddev:0.00 (0.0%) 11:47:11 INFO - 2015-11-15 11:47:11,555 DEBUG : BROWSER_OUTPUT: Values: 1358.7 11:47:11 INFO - 2015-11-15 11:47:11,556 DEBUG : BROWSER_OUTPUT: 11:47:11 INFO - 2015-11-15 11:47:11,556 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:956.02 Median:956.02 stddev:0.00 (0.0%) 11:47:11 INFO - 2015-11-15 11:47:11,556 DEBUG : BROWSER_OUTPUT: Values: 956.0 11:47:11 INFO - 2015-11-15 11:47:11,556 DEBUG : BROWSER_OUTPUT: 11:47:11 INFO - 2015-11-15 11:47:11,556 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:16225.81 Median:16225.81 stddev:0.00 (0.0%) 11:47:11 INFO - 2015-11-15 11:47:11,556 DEBUG : BROWSER_OUTPUT: Values: 16225.8 11:47:11 INFO - 2015-11-15 11:47:11,556 DEBUG : BROWSER_OUTPUT: 11:47:11 INFO - 2015-11-15 11:47:11,556 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:34913.79 Median:34913.79 stddev:0.00 (0.0%) 11:47:11 INFO - 2015-11-15 11:47:11,556 DEBUG : BROWSER_OUTPUT: Values: 34913.8 11:47:11 INFO - 2015-11-15 11:47:11,556 DEBUG : BROWSER_OUTPUT: 11:47:11 INFO - 2015-11-15 11:47:11,556 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:716.85 Median:716.85 stddev:0.00 (0.0%) 11:47:11 INFO - 2015-11-15 11:47:11,556 DEBUG : BROWSER_OUTPUT: Values: 716.8 11:47:11 INFO - 2015-11-15 11:47:11,556 DEBUG : BROWSER_OUTPUT: 11:47:11 INFO - 2015-11-15 11:47:11,557 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6777.03 Median:6777.03 stddev:0.00 (0.0%) 11:47:11 INFO - 2015-11-15 11:47:11,557 DEBUG : BROWSER_OUTPUT: Values: 6777.0 11:47:11 INFO - 2015-11-15 11:47:11,557 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:47:11 INFO - 2015-11-15 11:47:11,557 DEBUG : BROWSER_OUTPUT: 11:47:12 INFO - 2015-11-15 11:47:12,317 INFO : Browser exited with error code: 0 11:47:12 INFO - 2015-11-15 11:47:12,340 INFO : Completed test v8_7 (00:00:39) 11:47:12 INFO - 2015-11-15 11:47:12,468 INFO : Completed test suite (00:20:14) 11:47:12 INFO - 2015-11-15 11:47:12,468 DEBUG : Working with test: dromaeo_css 11:47:12 INFO - 2015-11-15 11:47:12,468 DEBUG : Generating results file: dromaeo_css 11:47:12 INFO - 2015-11-15 11:47:12,469 DEBUG : Working with test: kraken 11:47:12 INFO - 2015-11-15 11:47:12,469 DEBUG : Generating results file: kraken 11:47:12 INFO - 2015-11-15 11:47:12,469 INFO : javascript benchmark 11:47:12 INFO - 2015-11-15 11:47:12,470 DEBUG : Working with test: v8_7 11:47:12 INFO - 2015-11-15 11:47:12,470 DEBUG : Generating results file: v8_7 11:47:12 INFO - 2015-11-15 11:47:12,470 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:47:12 INFO - 2015-11-15 11:47:12,514 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,57]] 11:47:12 INFO - 2015-11-15 11:47:12,515 DEBUG : process_Request line: dromaeo_css 5784.97 graph.html#tests=[[72,64,57]] 11:47:12 INFO - 2015-11-15 11:47:12,515 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:47:12 INFO - 2015-11-15 11:47:12,542 DEBUG : process_Request line: kraken 1884.90 graph.html#tests=[[232,64,57]] 11:47:12 INFO - 2015-11-15 11:47:12,542 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:47:12 INFO - 2015-11-15 11:47:12,565 DEBUG : process_Request line: v8_7 14157.38 graph.html#tests=[[230,64,57]] 11:47:12 INFO - 2015-11-15 11:47:12,566 INFO : javascript benchmark 11:47:12 INFO - 2015-11-15 11:47:12,568 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [279.6490404542299, 281.3149979799189, 282.7102220224271, 282.87270728172325, 283.8084293102156, 12595.244285342886, 14514.63713407164, 14864.182469964162, 15051.096934183957, 15560.68878622427, 14777.187254700988, 14813.037152585075, 15126.621834454145, 15174.696506069871, 15254.237288135577, 4487.730736155841, 4578.404807375036, 4603.49361570227, 4626.884327891796, 4666.0, 4577.33628623851, 4580.954190458103, 4617.976910115444, 4654.953450465486, 4664.230401983668, 3284.687954644305, 4399.472063352402, 4577.519360467153, 4597.908041839178, 5130.56390206831, 4992.425871024842, 5044.419891712463, 5075.619328550355, 5113.821016264432, 5132.153194722866, 4233.788310584489, 4331.740095594243, 4350.6736994725525, 4351.325544540601, 4395.758233297167, 16973.236204370834, 16977.49067527976, 16986.40547580841, 17247.482575522754, 17602.11989400525, 1728.956776080608, 1773.0779994402967, 1779.2693279584594, 1826.3881599664128, 1832.3861506395374, 11100.611478598292, 11186.608468703556, 11454.0, 11613.30320180792, 11799.469023893946, 1407.247122789303, 1417.5109587192505, 1459.7007613439218, 1488.918109503977, 1514.3488300030983, 46011.769941150415, 47406.0, 47747.76126119382, 47957.76021119907, 49290.7535462324, 7894.763157105296, 8044.6379912902885, 8201.343892488587, 8263.462874913112, 8299.875501867476, 10028.398296102258, 10028.498575071364, 10066.396016239049, 10079.042490963348, 10195.184385249162, 6267.561270711007, 6359.332270111571, 6381.744730210739, 6394.721055788861, 6416.230052393649, 6189.907151392733, 6204.5967012144065, 6246.875062498724, 6318.494520438354, 6407.167068281186, 4882.414110306715, 4947.134251506044, 4950.975245123751, 5027.748612569357, 5041.697498150123, 1392.5752645443035, 1437.4896911596443, 1445.6891768269873, 1450.4923276853017, 1463.4219483304248, 340.11739535904286, 340.144536490726, 348.67050637148157, 776.7436745873848, 952.8189643967625, 8392.916070839214, 8503.428560004813, 8585.098564650621, 8698.91301086981, 8942.284617230605, 324.8668046101087, 338.67994744965773, 344.8189700407256, 350.6563567703665, 352.70020482590104, 4653.930191047137, 4779.808807647724, 4903.092927808367, 4953.90092198154, 4981.950180498221, 482320.0, 487149.0, 498710.0, 504772.0, 510255.0, 60413.395866041654, 62385.68807155935, 62604.0, 62896.371036289966, 64729.35270647328, 373.824302577788, 377.9697624190058, 378.89390970528297, 379.86135060703197, 383.2297082863409, 8382.538960357238, 8452.704155354779, 8566.314694824274, 8612.526311052952, 8688.91311086881, 27686.0, 27969.0, 28497.145085647462, 29197.85401072981, 29308.267293317836, 40400.39399408952, 40465.59534404618, 40847.591524084375, 41113.0, 41656.0, 6206.06908963641, 6437.710303036468, 6503.804885853432, 6517.543771935919, 6552.0, 9408.76478088026, 9656.855147172657, 9788.804223915624, 9832.950835245778, 9907.207423406255, 7221.891671625035, 8147.837043258983, 8335.49987000782, 8420.536870472182, 8546.2308392245, 7490.5131166474, 8073.273405393308, 8216.876746848682, 8316.584170791557, 8489.4481858679, 8018.679252830055, 8499.617517211864, 8543.444676096035, 8722.215000649972, 8726.825463490568, 6160.9383906160365, 6502.349765023459, 6502.479801615954, 6504.934950650433, 6638.800835974928, 8260.463069900437, 8305.501669899826, 8348.415610907177, 8573.699920502753, 8622.353323500887], "dojo.html": [2652.2441104285276, 2656.203139058282, 2708.63433436486, 2722.877470513826, 2734.5898115282716, 4430.6012458878695, 4482.462104547455, 4497.640188784898, 4512.503624601291, 4638.00282939168, 4363.869083927487, 4394.450693663292, 4479.664025198115, 4487.12501062293, 4560.33875088112, 4115.36211887158, 4211.157768446307, 4216.599423054805, 4228.471441069866, 4274.5939135782055, 235.94241445137544, 4182.498100227962, 4229.851955181569, 4285.400043993828, 4304.289792184286, 3974.721769476138, 4057.8173982170724, 4085.3667681509414, 4112.465379500676, 4228.260054490467, 4144.668426525871, 4147.875563733093, 4155.501339839238, 4188.099558594886, 4203.390508376268, 3966.920661586781, 4125.443065186191, 4159.771212583307, 4173.64524015459, 4201.915961680749, 4198.286291330481, 4310.288802347609, 4377.6935614507, 4407.757573333465, 4451.488078870907, 4798.5441383068555, 4803.2554953981835, 4829.203181475053, 4837.105135549935, 4876.878078048042, 4669.34629151919, 4683.320918466838, 4774.140654682155, 4917.631177661689, 4926.9014619707405, 4445.222086134913, 4473.373727678128, 4474.8881277967985, 4543.636509079266, 4569.29175977724, 4837.903241935212, 4902.558769710743, 4918.754062296871, 4954.752262386866, 4961.231009193581, 4484.708493947948, 4586.724796512153, 4625.236835922103, 4641.512641172696, 4711.387519622427, 4788.856334309976, 4827.903441931212, 4865.56209941107, 4878.926816097762, 4902.4362198346935, 4746.1931471649905, 4756.120117778222, 4768.237082066853, 4802.84731664405, 4824.8793780155775, 4531.524189960072, 4653.883652908637, 4683.15703173432, 4804.807807687724, 4826.372571565674, 3698.7041036716996, 3719.702423806089, 3746.7751934883995, 3759.8496060157286, 3766.0020094674933, 3305.4545999909747, 3386.847591858323, 3408.880689175867, 3425.1608355952453, 3442.7762195457217, 4501.752403617833, 4514.68397212192, 4521.1409832131785, 4557.430321209848, 4577.954220457819, 4835.854924352275, 4877.731724755102, 4887.0714564232685, 4887.95112048882, 4900.779464924087, 4358.716683415568, 4564.2012647786505, 4572.7942242599165, 4581.198290299184, 4590.334401511829, 4130.979345103256, 4166.66666666672, 4200.327947528381, 4206.137741762931, 4256.936145957813, 4967.925481117786, 5012.273220383024, 5029.245613157982, 5066.544011039025, 5129.358830146231, 4768.713877167381, 4772.7136371817805, 4875.68308059975, 4889.413270407432, 4938.7530623467965, 5016.072026675077, 5036.244563315532, 5046.949530504648, 5054.873628159326, 5135.7432128394175, 4752.42970843501, 4769.856904292877, 4770.117528257283, 4770.7853146607795, 4826.565609095198, 4686.62506999446, 4753.47711751714, 4826.3243145958895, 4839.540243676845, 4935.506449355035, 4735.052989402202, 4752.453467851241, 4805.038992201504, 4815.422149342101, 4845.055214233191, 4754.690945088558, 4761.904761904673, 4783.115123702126, 4794.952050479451, 4804.8318308859025, 4478.619317358061, 4510.075434535846, 4512.729236245836, 4521.367008618862, 4548.090381923563, 4715.174844402284, 4724.244120940771, 4744.312074749073, 4787.736674482937, 4852.636052296162, 4685.835995740133, 4698.389209402756, 4705.882352941204, 4737.502562230916, 4750.9287360690305], "mootools.html": [1184.792661284275, 1204.614523352527, 1204.8734882837302, 1482.9999999999993, 1530.5867415797727, 5942.138389933457, 5991.460768530831, 6777.728890844366, 6912.343327383896, 6945.0, 6553.868922621545, 6647.368499992493, 6720.731170753164, 6727.091842601248, 6769.4584433245345, 1916.492129585661, 1919.3857965451061, 1925.3357591630865, 1932.391296741529, 1941.7184508246296, 1954.198778500815, 1957.8727382720149, 1969.9704504432445, 2010.5074256807102, 2026.3616960657419, 1900.1734245603138, 1929.5851391950728, 1932.5361913140885, 1934.94195174145, 1951.6877299632063, 1903.3338331583973, 1934.1006432009183, 1936.1093896807345, 1937.7287179794769, 1965.931192408266, 1958.3243780895712, 1971.842252619787, 1981.1184023109722, 1991.0442987366146, 2027.0776796557532, 6736.360045795642, 6804.55770374924, 6822.488313376517, 6827.726890924407, 6848.0, 4209.7474151551005, 4282.229198744225, 4295.763732994684, 4300.956990430118, 4322.222000039991, 2457.6436416719475, 2534.721180670125, 2564.474282772046, 2587.0815860369485, 2616.515944550264, 789.471054393552, 800.4476910931497, 802.9156938521429, 812.715549557656, 829.0714399872181, 8862.778430539223, 8876.378653494257, 8884.555772211364, 8964.238039766627, 9003.0, 3856.787876666754, 3869.1294458746556, 3954.7033972451604, 3958.3072962232072, 3973.1060511385285, 7756.844863102707, 7771.184025677222, 7773.650185741655, 7830.33442157423, 7899.921000790034, 4296.076343586082, 4297.505786834491, 4326.113146804897, 4336.934945975813, 4389.561043895649, 3440.3119376124873, 3548.716102711777, 3896.5324161100284, 3915.9021024474614, 3924.7448915820382, 3127.890523831655, 3206.679332066821, 3216.823074730912, 3253.398121347558, 3265.8367081645824, 1048.365738728074, 1059.7350662334416, 1063.409807556798, 1064.7284942339809, 1072.5977758340623, 955.1594596754811, 1015.720676813882, 1123.3316176874746, 1134.1323887226279, 1138.0610995928228, 6384.553081284358, 6390.7443702251385, 6425.903611445832, 6457.063725759833, 6480.027995800668, 940.7177846645978, 970.8203982263304, 977.5258999385293, 981.2003217377815, 988.2094324540338, 4843.128236917389, 4848.636352273594, 4965.875853103629, 5005.099082165245, 5013.24801279811, 7788.493747906368, 8108.270255677017, 8108.554029528433, 8114.675412983414, 8115.8782618260775, 7983.600819958979, 7988.320992715684, 8005.319547838382, 8033.477823941542, 8092.635831387602, 6121.785737499166, 6272.592281501779, 6420.807375778734, 6450.5484616077365, 6452.741890324428, 6341.207349081365, 6417.294097649162, 6417.647029413427, 6466.030095485715, 6514.153160089348, 7057.7176912922905, 7147.356737893615, 7262.600556969417, 7276.1996180419055, 7332.120145582564, 7295.744648937261, 7470.589117598584, 7516.0, 7533.284337987882, 7567.772966811004, 5433.972830135824, 5571.693556854412, 5601.80393686219, 5646.7458964347525, 5688.829335119953, 6169.784057557964, 6349.936500634934, 6431.389018043278, 6473.061406095995, 6525.445337146396, 5620.606557541097, 5656.6888821115235, 5864.882702346014, 5910.143029260819, 6181.227346581677, 5879.853003674772, 5947.226860508106, 5995.700214989321, 6068.393160683896, 6102.908456373247, 5951.7619295227705, 5994.340622531431, 6000.939990600038, 6009.669468179117, 6152.292486363946, 5503.504684578407, 5540.0, 5540.667559946416, 5576.7211639417055, 5605.691686957257, 5585.748641311069, 5587.776488940397, 5637.408072152365, 5662.915056274242, 5699.857503562278], "ext.html": [447.1035573674782, 465.4856383696016, 467.7146940366377, 477.35556998052624, 493.66924160812255, 31474.213144671394, 31558.99999999994, 31573.842130789344, 31762.364752704932, 31976.520352194737, 35465.46801797975, 36304.45543316852, 36664.08339791506, 36756.26487470256, 37380.0, 7601.733939312126, 7732.884006739875, 7846.450748447611, 7867.881981770278, 7926.0, 7598.658060387296, 7699.576523291216, 7770.184130666284, 7788.454808163431, 7792.844143117134, 7737.613119344011, 7789.883151752728, 7823.0612326520895, 7868.567228802413, 7896.960515197416, 7608.315251627352, 7672.884906726404, 7705.499142555716, 7747.38020958322, 7809.921900780976, 7478.2895624915545, 7584.5070070445245, 7648.196939321347, 7676.501027433199, 7715.614219289013, 33267.833660831544, 33770.83114584412, 33817.83091084529, 34031.489527657104, 34076.14809629754, 2435.0, 2573.8841752121198, 2606.9348266293496, 2644.0217119665654, 3075.984620076885, 22657.660135097987, 22681.2061577844, 22946.77053229463, 22981.77018229813, 23052.308430747104, 2025.3923822853233, 2037.724907137547, 2065.0707181768266, 2083.468715477559, 2085.2597327948665, 233634.0, 237917.0, 239090.99999999825, 239290.0, 239736.0, 52170.73914630478, 52452.213216801014, 52493.21260181101, 52613.47386526162, 52780.20829687558, 46635.76682116568, 47263.29105063427, 59052.0, 60851.0, 61145.69427152836, 12275.754484910252, 12341.568045118378, 12497.0, 12536.686582835502, 12723.0, 9096.135867092615, 9278.536073196314, 9284.814303713887, 9341.0, 9405.482698451651, 17134.742978855327, 17483.475495735147, 17545.0, 17611.38360157414, 17649.294028238728, 7207.711691532385, 7491.400687944952, 7554.244575542401, 7592.772216833504, 7625.809354766065, 787.1144961917843, 882.280941033056, 921.9950254222929, 926.545992463688, 929.0, 23691.644625330635, 23694.289171324886, 23952.28143155708, 24041.27876163718, 24121.86415765939, 871.4596949891109, 875.671623141322, 895.0959530873864, 946.7443790176613, 951.4053716427233, 12565.246085234916, 12690.365481725878, 13409.396577154052, 14306.642333941734, 14378.784318235235, 335810.0, 342177.0, 345255.0, 345501.0, 346621.0, 48388.27417588739, 48802.51197488051, 49083.50916490861, 49802.50197497979, 49847.75076124596, 998.9111868063845, 1144.7080994346388, 1150.0167356909722, 1165.9825102623468, 1169.029705344562, 24997.250082497554, 25302.0, 25626.359341016625, 25678.358041049123, 25840.741592583832, 40294.0, 40674.38988415117, 40765.592344076176, 41238.79380603078, 41578.79210603928, 244515.0, 244558.0, 248776.0, 249191.0, 249401.0, 27171.320716982234, 36848.63151368452, 38893.80553097217, 38910.0, 39844.80077599709, 36218.0, 36871.0, 37118.62881371152, 37125.257494849415, 37754.8112259437, 32818.0, 34217.486737698455, 34762.82618586891, 34930.825345873105, 35165.82417087898, 30070.24824379408, 30484.542731858597, 30568.235794105327, 30592.388152237276, 30615.387692246477, 30907.0727878164, 31149.532757008208, 31151.065468035995, 31439.0, 31739.841300794273, 25959.480810384066, 29518.55722164212, 29728.554071689374, 30127.0, 30268.84865575658, 20539.589208215453, 20578.0, 20613.278535251193, 20846.0, 20911.0], "prototype.html": [266.63737317248547, 270.56979402749636, 274.3484224965707, 279.054006916553, 279.2961736424211, 5256.211568264762, 5375.623706340552, 5431.809886653958, 5520.9171862422045, 5584.162375643656, 5219.765110570024, 5310.176922576997, 5340.786368545254, 5390.407055223922, 5453.509184173424, 4079.77561234132, 4085.2238074765846, 4140.648044916178, 4161.646260067898, 4164.75011499311, 4086.734362266443, 4088.080181959065, 4113.136241389297, 4143.647789937859, 4158.958410415902, 3823.770573765583, 4026.7986600669997, 4049.9797501012454, 4116.423700681907, 4127.62851343379, 3963.98018009911, 3969.98015009926, 4012.378081397359, 4016.819243134066, 4078.1843631273864, 3398.065531978701, 3401.6188667932297, 3419.9658003419895, 3426.1777173478436, 3463.9653603463894, 5211.42674305826, 5261.394939581959, 5263.578913686896, 5271.314729085233, 5329.973350133263, 4385.0, 4536.523665015159, 4551.203539380595, 4564.2012647786505, 4601.079784043205, 5419.485148910847, 5599.804006859781, 5606.327240731098, 5622.803201887955, 5665.507176842218, 3692.058525076115, 3709.2581483703366, 3727.701783857312, 3736.962630373716, 3754.7747135171976, 5840.591158618899, 5941.584089113764, 5955.880882382328, 5982.521398288127, 6015.939840601582, 3653.908652283714, 3746.9063273418383, 3779.962200378016, 3780.281746468162, 3784.280986612535, 3772.43413487979, 3840.519935008124, 3845.134844659929, 3848.9615103849164, 3879.4180872869297, 4481.641468682563, 4502.257127573979, 4509.1658043262105, 4577.427821522309, 4585.312203169551, 5599.524040456526, 5618.381977982419, 5633.352164501053, 5634.971825140848, 5729.942700573024, 1322.550332886823, 1354.106289848695, 1355.4713661671956, 1357.5859362894412, 1367.8700523450257, 814.1614137438448, 825.8885050518223, 852.9829403411896, 856.1310270075878, 872.1409411729442, 5346.572274218053, 5373.919391209135, 5391.81128660495, 5410.810621628224, 5425.430329815392, 5839.153322768175, 5859.648421094748, 5898.203742494708, 5903.793367232212, 5912.083627037816, 5394.595405344615, 5401.2168235606405, 5427.674339539641, 5447.237386765856, 5462.044142275086, 3046.086174147747, 3127.202563346332, 3152.7004934531183, 3161.573187619688, 3190.664980177048, 6037.969810150921, 6078.118672792509, 6080.665563394055, 6126.295476020315, 6163.3836616338, 5965.880682386328, 5995.61028533144, 5997.910031349533, 6009.06859436788, 6141.57009009374, 5861.706914654335, 6074.817755467343, 6084.361142080106, 6092.512598991982, 6098.0852872069545, 5776.075827867521, 5808.854778630399, 5868.3251426086545, 5881.441263080001, 5920.851978700394, 5715.685637289989, 5731.971340143273, 5743.59794814359, 5793.478586927196, 5827.446392592697, 5852.619579727304, 6025.126356678345, 6051.33435322123, 6071.150038994456, 6102.176206212104, 3798.525184351956, 3805.372113601225, 3819.5416550014174, 3821.5032045833864, 3843.308204523101, 5737.655740655574, 5804.535637148933, 5807.070868661163, 5837.532997360286, 5844.912326315024, 5607.0, 5618.269624948894, 5622.634528755618, 5690.544756419559, 5691.7438715257085, 5420.864478388072, 5618.550515958796, 5660.85847853807, 5663.093904975184, 5713.628614140068, 5467.507924286833, 5488.341399032141, 5498.615096943336, 5606.691631960118, 5620.072688006433, 5409.594280428905, 5534.501894829485, 5632.746526406239, 5652.773889044557, 5686.914696279642, 5493.945060549503, 5556.444355564411, 5578.60949733531, 5610.438956104357, 5620.04459241938], "yui.html": [620.8509018650241, 634.9587276827003, 643.391994565136, 647.6535053746245, 661.157024793388, 11436.771264574714, 11721.70695732605, 11875.28748275104, 12002.339871307075, 12040.397980100994, 10978.0, 11095.4452277386, 11106.389148596823, 11136.777264454706, 11143.442827858615, 587.1779508687829, 597.2951916738247, 724.5399171526079, 734.0457405373021, 744.2297222374843, 747.9326860582546, 751.9962400187991, 754.8678981178272, 759.8290384663434, 761.1627210068907, 775.728495026739, 785.2853902948318, 785.4030936488253, 789.0964845252183, 795.4948607634136, 778.4317448262772, 781.1719577248107, 781.9374450043982, 788.8934993775881, 789.1004255149135, 583.0903790087477, 583.9562032847554, 585.096026638844, 588.479195911617, 589.2251689028956, 11450.94274528622, 11509.424528773612, 11617.419129043514, 11732.17874748768, 11843.407829608484, 9504.762380940532, 9560.56977436017, 9879.950600247024, 10232.693019209435, 10284.0, 7716.0, 7804.765857024298, 7848.609138669021, 8038.914746509205, 8211.466254693425, 2539.6952365716047, 2573.7812285955715, 2629.6975847777367, 2920.328324485359, 2935.339548601569, 39507.8024609878, 39711.205775884606, 39792.20415591701, 39942.20115597672, 40240.0, 5768.596198266081, 5900.6164599301765, 5915.497182739516, 6031.24609423822, 6170.784022559189, 9924.900750992541, 9971.351862128939, 10005.44970026641, 10143.289969702199, 10146.746331341776, 5040.571551418097, 5155.639105262596, 5155.948440515622, 5163.870903227375, 5343.145096784574, 3042.787004909635, 3047.3143542703156, 3082.3064810417477, 3145.119366577362, 3172.08009677191, 2216.9889150554145, 2638.037116452481, 2735.6990731019573, 2748.807583469138, 2756.131818477173, 454.1008802570928, 466.1446246138306, 475.230127193948, 481.47519204067737, 485.16067203737026, 462.4381376627414, 497.67337696269794, 499.2735569746011, 520.1833121998426, 536.000359329847, 6641.103451034145, 6751.763688270985, 6895.896561551581, 6960.756373526902, 6976.651167441608, 497.572088004316, 526.2606038515814, 530.6815910453697, 537.3578573604505, 539.4847920236165, 3270.640229574745, 3390.2541440882965, 3393.7624366294617, 3494.7378946579106, 3548.503209550665, 47132.293015604795, 47333.0, 48056.759716201894, 48238.51761482411, 48600.0, 42685.35971960423, 43154.0, 43276.0, 43862.0, 44068.3389749154, 38713.80643096766, 38725.6127438722, 38929.026774330305, 39488.80255598704, 39786.0, 6809.69356378974, 6889.414399776075, 6927.89608155868, 7165.176004759519, 7226.855462890608, 28090.578641320804, 28123.0, 28691.569626455203, 28741.0, 29031.0, 35918.8204058978, 36361.27277454489, 36422.8178859104, 38048.23903521859, 38681.0, 6424.432341018329, 6436.324185960407, 6447.290798012309, 6577.2436169841085, 6682.9331706682315, 9152.084791521062, 9292.0, 9355.158035776813, 9475.620975160917, 10161.644342447978, 8618.0, 8799.736007919773, 8884.955575222082, 8970.506622135585, 9698.563564639468, 8467.323651452301, 8482.491050536988, 8881.955590222007, 8917.28661707075, 8922.420042697204, 8916.465012099296, 8921.598528066383, 8960.103989600988, 9018.549072546477, 9052.592633331647, 7594.544327340377, 7885.605719713876, 7942.722004729807, 8076.515409075474, 8094.716684915999, 7283.308085732059, 7412.592307423143, 7681.692732290646, 7744.148143704076, 8105.716299929474]}, "summary": {"lowerIsBetter": false, "suite": 5784.971017042, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6436.460189075146, "unit": "ms", "value": 6436.460189075146}, "dojo.html": {"lowerIsBetter": false, "filtered": 4432.193931099021, "unit": "ms", "value": 4432.193931099021}, "mootools.html": {"lowerIsBetter": false, "filtered": 3884.608476734393, "unit": "ms", "value": 3884.608476734393}, "ext.html": {"lowerIsBetter": false, "filtered": 16006.92698552093, "unit": "ms", "value": 16006.92698552093}, "prototype.html": {"lowerIsBetter": false, "filtered": 4199.755730928474, "unit": "ms", "value": 4199.755730928474}, "yui.html": {"lowerIsBetter": false, "filtered": 5030.583399968868, "unit": "ms", "value": 5030.583399968868}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0057.e"}, "testrun": {"date": 1447615617, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151115092632", "branch": "Fx-Team", "revision": "3f0651985bf0e3403b5fd4984a907813689ee3a9"}}, {"talos_counters": {}, "results": {"audio-dft": [197.0, 215.0, 209.0, 205.0, 204.0, 202.0, 205.0, 206.0, 205.0, 205.0], "ai-astar": [130.0, 123.0, 133.0, 140.0, 141.0, 146.0, 134.0, 132.0, 133.0, 133.0], "imaging-gaussian-blur": [152.0, 144.0, 142.0, 149.0, 149.0, 157.0, 151.0, 150.0, 149.0, 142.0], "audio-beat-detection": [183.0, 167.0, 192.0, 207.0, 165.0, 178.0, 180.0, 164.0, 205.0, 161.0], "json-stringify-tinderbox": [80.0, 87.0, 85.0, 86.0, 87.0, 87.0, 87.0, 87.0, 87.0, 87.0], "stanford-crypto-pbkdf2": [171.0, 191.0, 192.0, 192.0, 194.0, 178.0, 192.0, 191.0, 193.0, 180.0], "json-parse-financial": [74.0, 76.0, 75.0, 78.0, 78.0, 78.0, 79.0, 84.0, 78.0, 78.0], "stanford-crypto-sha256-iterative": [81.0, 85.0, 88.0, 88.0, 87.0, 88.0, 90.0, 92.0, 92.0, 87.0], "audio-fft": [86.0, 89.0, 101.0, 156.0, 84.0, 89.0, 89.0, 85.0, 119.0, 80.0], "imaging-darkroom": [157.0, 164.0, 158.0, 156.0, 156.0, 158.0, 156.0, 157.0, 156.0, 158.0], "stanford-crypto-ccm": [170.0, 163.0, 166.0, 177.0, 158.0, 164.0, 171.0, 174.0, 174.0, 155.0], "audio-oscillator": [101.0, 109.0, 153.0, 110.0, 114.0, 113.0, 151.0, 108.0, 110.0, 155.0], "stanford-crypto-aes": [102.0, 106.0, 108.0, 110.0, 112.0, 111.0, 107.0, 108.0, 108.0, 109.0], "imaging-desaturate": [118.0, 138.0, 124.0, 124.0, 121.0, 125.0, 124.0, 124.0, 117.0, 128.0]}, "summary": {"lowerIsBetter": true, "suite": 1884.8999999999999, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 97.8, "unit": "ms", "value": 97.8}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 187.4, "unit": "ms", "value": 187.4}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 180.2, "unit": "ms", "value": 180.2}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 167.2, "unit": "ms", "value": 167.2}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 157.6, "unit": "ms", "value": 157.6}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 77.8, "unit": "ms", "value": 77.8}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 122.4, "unit": "ms", "value": 122.4}, "ai-astar": {"lowerIsBetter": true, "filtered": 134.5, "unit": "ms", "value": 134.5}, "audio-dft": {"lowerIsBetter": true, "filtered": 205.3, "unit": "ms", "value": 205.3}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 87.8, "unit": "ms", "value": 87.8}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 86.0, "unit": "ms", "value": 86.0}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 148.5, "unit": "ms", "value": 148.5}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 108.1, "unit": "ms", "value": 108.1}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 124.3, "unit": "ms", "value": 124.3}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0057.e"}, "testrun": {"date": 1447615617, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151115092632", "branch": "Fx-Team", "revision": "3f0651985bf0e3403b5fd4984a907813689ee3a9"}}, {"talos_counters": {}, "results": {"DeltaBlue": [236.85457129322597], "Encrypt": [380.517503805175], "NavierStokes": [6777.027027027027], "Decrypt": [6972.222222222223], "Splay": [716.8458781362007], "Richards": [877.9631255487269], "RegExp": [34913.793103448275], "Earley": [956.0229445506692], "Boyer": [16225.806451612903], "RayTrace": [1358.695652173913]}, "summary": {"lowerIsBetter": false, "suite": 14157.375224525254, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 279.15019600000005, "unit": "score", "value": 279.15019600000005}, "Encrypt": {"lowerIsBetter": false, "filtered": 699.5236679999998, "unit": "score", "value": 699.5236679999998}, "NavierStokes": {"lowerIsBetter": false, "filtered": 218.97507477567297, "unit": "score", "value": 218.97507477567297}, "Decrypt": {"lowerIsBetter": false, "filtered": 38.177354581673285, "unit": "score", "value": 38.177354581673285}, "Splay": {"lowerIsBetter": false, "filtered": 113.67994499999998, "unit": "score", "value": 113.67994499999998}, "RegExp": {"lowerIsBetter": false, "filtered": 26.092409876543226, "unit": "score", "value": 26.092409876543226}, "Richards": {"lowerIsBetter": false, "filtered": 40.20897799999999, "unit": "score", "value": 40.20897799999999}, "Earley": {"lowerIsBetter": false, "filtered": 697.1202979999998, "unit": "score", "value": 697.1202979999998}, "Boyer": {"lowerIsBetter": false, "filtered": 41.074260437375735, "unit": "score", "value": 41.074260437375735}, "RayTrace": {"lowerIsBetter": false, "filtered": 544.6319040000002, "unit": "score", "value": 544.6319040000002}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0057.e"}, "testrun": {"date": 1447615617, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151115092632", "branch": "Fx-Team", "revision": "3f0651985bf0e3403b5fd4984a907813689ee3a9"}}] 11:47:12 INFO - RETURN: dromaeo_css: 5784.97 11:47:12 INFO - RETURN: kraken: 1884.90 11:47:12 INFO - RETURN: v8_7: 14157.38 11:47:12 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,57]]", "result": "14157.38"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,57]]", "result": "1884.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,57]]", "result": "5784.97"}}} 11:47:12 INFO - Return code: 0 11:47:12 INFO - # TBPL SUCCESS # 11:47:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:47:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:47:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:47:12 INFO - 2015-11-15 11:47:12.695 screenresolution[1998:14024] starting screenresolution argv=screenresolution get 11:47:12 INFO - 2015-11-15 11:47:12.698 screenresolution[1998:14024] Display 0: 1600x1200x32@60 11:47:12 INFO - 2015-11-15 11:47:12.705 screenresolution[1999:14027] starting screenresolution argv=screenresolution list 11:47:12 INFO - Available Modes on Display 0 11:47:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:47:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:47:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:47:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:47:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:47:12 INFO - Intel HD Graphics 3000: 11:47:12 INFO - Chipset Model: Intel HD Graphics 3000 11:47:12 INFO - Type: GPU 11:47:12 INFO - Bus: Built-In 11:47:12 INFO - VRAM (Total): 512 MB 11:47:12 INFO - VRAM (Dynamic, Max): 10 11:47:12 INFO - Vendor: Intel (0x8086) 11:47:12 INFO - Device ID: 0x0116 11:47:12 INFO - Revision ID: 0x0009 11:47:12 INFO - Displays: 11:47:12 INFO - Display: 11:47:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:47:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:47:12 INFO - Display Serial Number: 1600x1200 60 11:47:12 INFO - Main Display: Yes 11:47:12 INFO - Mirror: Off 11:47:12 INFO - Online: Yes 11:47:12 INFO - Rotation: Supported 11:47:12 INFO - Return code: 0 11:47:12 INFO - Running post-action listener: _resource_record_post_action 11:47:12 INFO - Running post-run listener: _resource_record_post_run 11:47:14 INFO - Total resource usage - Wall time: 1258s; CPU: 30.0%; Read bytes: 790528; Write bytes: 689048576; Read time: 463; Write time: 55378 11:47:14 INFO - install - Wall time: 43s; CPU: 30.0%; Read bytes: 338592256; Write bytes: 336089088; Read time: 37250; Write time: 6956 11:47:14 INFO - run-tests - Wall time: 1216s; CPU: 30.0%; Read bytes: 790528; Write bytes: 341761024; Read time: 463; Write time: 48017 11:47:14 INFO - Running post-run listener: _upload_blobber_files 11:47:14 INFO - Blob upload gear active. 11:47:14 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 11:47:14 INFO - Copying logs to upload dir... 11:47:14 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1316.038842 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 56 secs) (at 2015-11-15 11:47:14.172734) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-15 11:47:14.176747) ========= 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.gF3LuyrGwH/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.l5mTGs2n5e/Listeners TMPDIR=/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/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:0x0:0x0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010941 build_url: 'https://queue.taskcluster.net/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-15 11:47:14.208714) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 11:47:14.209116) ========= 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.gF3LuyrGwH/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.l5mTGs2n5e/Listeners TMPDIR=/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/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:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005890 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 11:47:14.262431) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-15 11:47:14.262983) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-15 11:47:14.263494) ========= ========= Total master_lag: 0.24 =========