builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0042 starttime: 1447876677.07 results: success (0) buildid: 20151118092126 builduid: 0a7b776fd0504809a962747b95fc7dad revision: f622e6d5fd171a3ef6456c393f1617ec9d7eb3a7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 11:57:57.067896) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 11:57:57.068460) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 11:57:57.068798) ========= 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.8mF7QktIEF/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.aOi4xildNJ/Listeners TMPDIR=/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005720 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 11:57:57.090480) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 11:57:57.090862) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 11:57:57.107830) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 11:57:57.108189) ========= 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.8mF7QktIEF/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.aOi4xildNJ/Listeners TMPDIR=/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005192 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 11:57:57.159529) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 11:57:57.159844) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 11:57:57.160204) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 11:57:57.160546) ========= 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.8mF7QktIEF/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.aOi4xildNJ/Listeners TMPDIR=/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2015-11-18 11:57:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.41G=0s 2015-11-18 11:57:57 (1.41 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.112775 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 11:57:57.286605) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 11:57:57.286920) ========= 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.8mF7QktIEF/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.aOi4xildNJ/Listeners TMPDIR=/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.019932 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 11:57:57.339431) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 11:57:57.340977) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f622e6d5fd171a3ef6456c393f1617ec9d7eb3a7 --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 f622e6d5fd171a3ef6456c393f1617ec9d7eb3a7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8mF7QktIEF/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.aOi4xildNJ/Listeners TMPDIR=/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2015-11-18 11:57:57,411 truncating revision to first 12 chars 2015-11-18 11:57:57,411 Setting DEBUG logging. 2015-11-18 11:57:57,411 attempt 1/10 2015-11-18 11:57:57,411 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f622e6d5fd17?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-18 11:57:58,150 unpacking tar archive at: fx-team-f622e6d5fd17/testing/mozharness/ program finished with exit code 0 elapsedTime=0.977501 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 11:57:58.337555) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 11:57:58.337954) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 11:57:58.349609) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 11:57:58.350009) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 11:57:58.356182) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 37 secs) (at 2015-11-18 11:57:58.356610) ========= /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.8mF7QktIEF/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.aOi4xildNJ/Listeners TMPDIR=/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 11:57:58 INFO - MultiFileLogger online at 20151118 11:57:58 in /builds/slave/test 11:57:58 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:57:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:57:58 INFO - {'append_to_log': False, 11:57:58 INFO - 'base_work_dir': '/builds/slave/test', 11:57:58 INFO - 'blob_upload_branch': 'Fx-Team', 11:57:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:57:58 INFO - 'branch': 'Fx-Team', 11:57:58 INFO - 'buildbot_json_path': 'buildprops.json', 11:57:58 INFO - 'config_files': ('talos/mac_config.py',), 11:57:58 INFO - 'default_actions': ('clobber', 11:57:58 INFO - 'read-buildbot-config', 11:57:58 INFO - 'download-and-extract', 11:57:58 INFO - 'populate-webroot', 11:57:58 INFO - 'create-virtualenv', 11:57:58 INFO - 'install', 11:57:58 INFO - 'run-tests'), 11:57:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:57:58 INFO - 'download_minidump_stackwalk': True, 11:57:58 INFO - 'download_symbols': 'ondemand', 11:57:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:57:58 INFO - 'tooltool.py': '/tools/tooltool.py', 11:57:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:57:58 INFO - '/tools/misc-python/virtualenv.py')}, 11:57:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:57:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:57:58 INFO - 'installer_path': 'installer.exe', 11:57:58 INFO - 'log_level': 'info', 11:57:58 INFO - 'log_name': 'talos', 11:57:58 INFO - 'log_to_console': True, 11:57:58 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:57:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:57:58 INFO - 'opt_config_files': (), 11:57:58 INFO - 'pip_index': False, 11:57:58 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:57:58 INFO - 'cmd': ('bash', 11:57:58 INFO - '-c', 11:57:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:57:58 INFO - 'enabled': True, 11:57:58 INFO - 'halt_on_failure': False, 11:57:58 INFO - 'name': 'check_screen_resolution'},), 11:57:58 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:57:58 INFO - 'cmd': ('bash', 11:57:58 INFO - '-c', 11:57:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:57:58 INFO - 'enabled': True, 11:57:58 INFO - 'halt_on_failure': False, 11:57:58 INFO - 'name': 'check_screen_resolution'},), 11:57:58 INFO - 'run_cmd_checks_enabled': True, 11:57:58 INFO - 'sps_profile': False, 11:57:58 INFO - 'sps_profile_interval': 0, 11:57:58 INFO - 'suite': 'dromaeojs-e10s', 11:57:58 INFO - 'system_bits': '64', 11:57:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:57:58 INFO - 'title': 't-yosemite-r7-0042', 11:57:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:57:58 INFO - 'use_talos_json': True, 11:57:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:57:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:57:58 INFO - 'work_dir': 'build'} 11:57:58 INFO - ##### 11:57:58 INFO - ##### Running clobber step. 11:57:58 INFO - ##### 11:57:58 INFO - Running pre-action listener: _resource_record_pre_action 11:57:58 INFO - Running main action method: clobber 11:57:58 INFO - rmtree: /builds/slave/test/build 11:57:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:58:00 INFO - Running post-action listener: _resource_record_post_action 11:58:00 INFO - ##### 11:58:00 INFO - ##### Running read-buildbot-config step. 11:58:00 INFO - ##### 11:58:00 INFO - Running pre-action listener: _resource_record_pre_action 11:58:00 INFO - Running main action method: read_buildbot_config 11:58:00 INFO - Using buildbot properties: 11:58:00 INFO - { 11:58:00 INFO - "properties": { 11:58:00 INFO - "buildnumber": 2, 11:58:00 INFO - "product": "firefox", 11:58:00 INFO - "script_repo_revision": "production", 11:58:00 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 11:58:00 INFO - "repository": "", 11:58:00 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 11:58:00 INFO - "buildid": "20151118092126", 11:58:00 INFO - "slavename": "t-yosemite-r7-0042", 11:58:00 INFO - "pgo_build": "False", 11:58:00 INFO - "basedir": "/builds/slave/test", 11:58:00 INFO - "project": "", 11:58:00 INFO - "platform": "yosemite_r7", 11:58:00 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 11:58:00 INFO - "slavebuilddir": "test", 11:58:00 INFO - "scheduler": "tests-fx-team-macosx64-talos", 11:58:00 INFO - "branch": "fx-team", 11:58:00 INFO - "repo_path": "integration/fx-team", 11:58:00 INFO - "stage_platform": "macosx64", 11:58:00 INFO - "builduid": "0a7b776fd0504809a962747b95fc7dad", 11:58:00 INFO - "revision": "f622e6d5fd171a3ef6456c393f1617ec9d7eb3a7" 11:58:00 INFO - }, 11:58:00 INFO - "sourcestamp": { 11:58:00 INFO - "repository": "", 11:58:00 INFO - "hasPatch": false, 11:58:00 INFO - "project": "", 11:58:00 INFO - "branch": "fx-team-macosx64-talos", 11:58:00 INFO - "changes": [ 11:58:00 INFO - { 11:58:00 INFO - "category": null, 11:58:00 INFO - "files": [ 11:58:00 INFO - { 11:58:00 INFO - "url": null, 11:58:00 INFO - "name": "https://queue.taskcluster.net/v1/task/NLcgCYbDRjWGDRX6tYSFww/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 11:58:00 INFO - } 11:58:00 INFO - ], 11:58:00 INFO - "repository": "", 11:58:00 INFO - "rev": "f622e6d5fd171a3ef6456c393f1617ec9d7eb3a7", 11:58:00 INFO - "who": "mconley@mozilla.com", 11:58:00 INFO - "when": 1447872399, 11:58:00 INFO - "number": 6678225, 11:58:00 INFO - "comments": "Backout fix for bug 1175267 (76a433881e4b) for causing bug 1213650.", 11:58:00 INFO - "project": "", 11:58:00 INFO - "at": "Wed 18 Nov 2015 10:46:39", 11:58:00 INFO - "branch": "fx-team-macosx64-talos", 11:58:00 INFO - "revlink": "", 11:58:00 INFO - "properties": [ 11:58:00 INFO - [ 11:58:00 INFO - "buildid", 11:58:00 INFO - "20151118092126", 11:58:00 INFO - "Change" 11:58:00 INFO - ], 11:58:00 INFO - [ 11:58:00 INFO - "builduid", 11:58:00 INFO - "0a7b776fd0504809a962747b95fc7dad", 11:58:00 INFO - "Change" 11:58:00 INFO - ], 11:58:00 INFO - [ 11:58:00 INFO - "pgo_build", 11:58:00 INFO - "False", 11:58:00 INFO - "Change" 11:58:00 INFO - ] 11:58:00 INFO - ], 11:58:00 INFO - "revision": "f622e6d5fd171a3ef6456c393f1617ec9d7eb3a7" 11:58:00 INFO - } 11:58:00 INFO - ], 11:58:00 INFO - "revision": "f622e6d5fd171a3ef6456c393f1617ec9d7eb3a7" 11:58:00 INFO - } 11:58:00 INFO - } 11:58:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/NLcgCYbDRjWGDRX6tYSFww/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 11:58:00 INFO - Running post-action listener: _resource_record_post_action 11:58:00 INFO - ##### 11:58:00 INFO - ##### Running download-and-extract step. 11:58:00 INFO - ##### 11:58:00 INFO - Running pre-action listener: _resource_record_pre_action 11:58:00 INFO - Running main action method: download_and_extract 11:58:00 INFO - mkdir: /builds/slave/test/build/tests 11:58:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:58:00 INFO - https://queue.taskcluster.net/v1/task/NLcgCYbDRjWGDRX6tYSFww/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:58:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NLcgCYbDRjWGDRX6tYSFww/artifacts/public/build/test_packages.json 11:58:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NLcgCYbDRjWGDRX6tYSFww/artifacts/public/build/test_packages.json 11:58:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NLcgCYbDRjWGDRX6tYSFww/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 11:58:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NLcgCYbDRjWGDRX6tYSFww/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 11:58:01 INFO - Downloaded 1149 bytes. 11:58:01 INFO - Reading from file /builds/slave/test/build/test_packages.json 11:58:01 INFO - Using the following test package requirements: 11:58:01 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 11:58:01 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:58:01 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 11:58:01 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:58:01 INFO - u'jsshell-mac.zip'], 11:58:01 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:58:01 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 11:58:01 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 11:58:01 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:58:01 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 11:58:01 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:58:01 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 11:58:01 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:58:01 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 11:58:01 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 11:58:01 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:58:01 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 11:58:01 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:58: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:58:01 INFO - https://queue.taskcluster.net/v1/task/NLcgCYbDRjWGDRX6tYSFww/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:58:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NLcgCYbDRjWGDRX6tYSFww/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:58:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NLcgCYbDRjWGDRX6tYSFww/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:58:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NLcgCYbDRjWGDRX6tYSFww/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:58:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NLcgCYbDRjWGDRX6tYSFww/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:58:02 INFO - Downloaded 17476858 bytes. 11:58:02 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:58:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:58:02 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 11:58:05 INFO - Return code: 0 11:58:05 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:58:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:58:05 INFO - https://queue.taskcluster.net/v1/task/NLcgCYbDRjWGDRX6tYSFww/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:58:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NLcgCYbDRjWGDRX6tYSFww/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:58:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NLcgCYbDRjWGDRX6tYSFww/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:58:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NLcgCYbDRjWGDRX6tYSFww/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:58:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NLcgCYbDRjWGDRX6tYSFww/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:58:06 INFO - Downloaded 17476858 bytes. 11:58:06 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:58:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:58:06 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 11:58:10 INFO - Return code: 0 11:58:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:58:10 INFO - https://queue.taskcluster.net/v1/task/NLcgCYbDRjWGDRX6tYSFww/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 11:58:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NLcgCYbDRjWGDRX6tYSFww/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 11:58:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NLcgCYbDRjWGDRX6tYSFww/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 11:58:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NLcgCYbDRjWGDRX6tYSFww/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:58:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NLcgCYbDRjWGDRX6tYSFww/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:58:11 INFO - Downloaded 11130997 bytes. 11:58:11 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:58:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 11:58:11 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 11:58:11 INFO - Return code: 0 11:58:11 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:58:11 INFO - https://queue.taskcluster.net/v1/task/NLcgCYbDRjWGDRX6tYSFww/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 11:58:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NLcgCYbDRjWGDRX6tYSFww/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 11:58:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NLcgCYbDRjWGDRX6tYSFww/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 11:58:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NLcgCYbDRjWGDRX6tYSFww/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 11:58:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NLcgCYbDRjWGDRX6tYSFww/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:58:14 INFO - Downloaded 108849283 bytes. 11:58:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NLcgCYbDRjWGDRX6tYSFww/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 11:58:14 INFO - mkdir: /builds/slave/test/properties 11:58:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:58:14 INFO - Writing to file /builds/slave/test/properties/build_url 11:58:14 INFO - Contents: 11:58:14 INFO - build_url:https://queue.taskcluster.net/v1/task/NLcgCYbDRjWGDRX6tYSFww/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 11:58:14 INFO - Running post-action listener: _resource_record_post_action 11:58:14 INFO - Running post-action listener: set_extra_try_arguments 11:58:14 INFO - ##### 11:58:14 INFO - ##### Running populate-webroot step. 11:58:14 INFO - ##### 11:58:14 INFO - Running pre-action listener: _resource_record_pre_action 11:58:14 INFO - Running main action method: populate_webroot 11:58:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:58:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:58:14 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 11:58:14 INFO - '../fennec_ids.txt'], 11:58:14 INFO - 'tests': ['tcheck2']}, 11:58:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:58:14 INFO - '--tppagecycles', 11:58:14 INFO - '7'], 11:58:14 INFO - 'tests': ['tsvgm']}}, 11:58:14 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:58:14 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:58:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:58:14 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:58:14 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:58:14 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:58:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:58:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:58:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:58:14 INFO - 'talos_options': ['--e10s'], 11:58:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:58:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:58:14 INFO - 'tests': ['damp', 'tps']}, 11:58:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:58:14 INFO - 'talos_options': ['--e10s'], 11:58:14 INFO - 'tests': ['damp', 'tps']}, 11:58:14 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:58:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:58:14 INFO - 'other': {'tests': ['a11yr', 11:58:14 INFO - 'ts_paint', 11:58:14 INFO - 'tpaint', 11:58:14 INFO - 'sessionrestore', 11:58:14 INFO - 'sessionrestore_no_auto_restore']}, 11:58:14 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:58:14 INFO - 'tests': ['a11yr', 11:58:14 INFO - 'ts_paint', 11:58:14 INFO - 'tpaint', 11:58:14 INFO - 'sessionrestore', 11:58:14 INFO - 'sessionrestore_no_auto_restore']}, 11:58:14 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:58:14 INFO - 'tests': ['a11yr', 11:58:14 INFO - 'ts_paint', 11:58:14 INFO - 'tpaint', 11:58:14 INFO - 'sessionrestore', 11:58:14 INFO - 'sessionrestore_no_auto_restore']}, 11:58:14 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:58:14 INFO - 'tests': ['a11yr', 11:58:14 INFO - 'ts_paint', 11:58:14 INFO - 'tpaint', 11:58:14 INFO - 'sessionrestore', 11:58:14 INFO - 'sessionrestore_no_auto_restore']}, 11:58:14 INFO - 'other_l64': {'tests': ['a11yr', 11:58:14 INFO - 'ts_paint', 11:58:14 INFO - 'tpaint', 11:58:14 INFO - 'sessionrestore', 11:58:14 INFO - 'sessionrestore_no_auto_restore']}, 11:58:14 INFO - 'other_nol64': {'tests': ['a11yr', 11:58:14 INFO - 'ts_paint', 11:58:14 INFO - 'tpaint', 11:58:14 INFO - 'sessionrestore', 11:58:14 INFO - 'sessionrestore_no_auto_restore']}, 11:58:14 INFO - 'svgr': {'tests': ['tsvgx', 11:58:14 INFO - 'tsvgr_opacity', 11:58:14 INFO - 'tart', 11:58:14 INFO - 'tscrollx', 11:58:14 INFO - 'cart']}, 11:58:14 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:58:14 INFO - 'tests': ['tsvgx', 11:58:14 INFO - 'tsvgr_opacity', 11:58:14 INFO - 'tart', 11:58:14 INFO - 'tscrollx', 11:58:14 INFO - 'cart']}, 11:58:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:58:14 INFO - 'tests': ['tp5o']}, 11:58:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:58:14 INFO - 'talos_options': ['--e10s'], 11:58:14 INFO - 'tests': ['tp5o']}, 11:58:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:58:14 INFO - 'talos_options': ['--xperf_path', 11:58:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:58:14 INFO - 'tests': ['tp5n']}, 11:58:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:58:14 INFO - 'talos_options': ['--e10s', 11:58:14 INFO - '--xperf_path', 11:58:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:58:14 INFO - 'tests': ['tp5n']}}, 11:58:14 INFO - 'talos.zip': {'path': '', 11:58:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:58:14 INFO - Running post-action listener: _resource_record_post_action 11:58:14 INFO - ##### 11:58:14 INFO - ##### Running create-virtualenv step. 11:58:14 INFO - ##### 11:58:14 INFO - Running pre-action listener: _resource_record_pre_action 11:58:14 INFO - Running main action method: create_virtualenv 11:58:14 INFO - Creating virtualenv /builds/slave/test/build/venv 11:58:14 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:58:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:58:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:58:14 INFO - Using real prefix '/tools/python27' 11:58:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:58:15 INFO - Installing distribute.............................................................................................................................................................................................done. 11:58:17 INFO - Installing pip.................done. 11:58:18 INFO - Return code: 0 11:58:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:58:18 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:58:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:18 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:58:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:18 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 0x10119b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101178228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91f1d652a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010bf9f0>, '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 0x100e1edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010b28c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8mF7QktIEF/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.aOi4xildNJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:58:18 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:58:18 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:58:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8mF7QktIEF/Render', 11:58:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:58:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:58:18 INFO - 'HOME': '/Users/cltbld', 11:58:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:58:18 INFO - 'LOGNAME': 'cltbld', 11:58:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:18 INFO - 'MOZ_NO_REMOTE': '1', 11:58:18 INFO - 'NO_EM_RESTART': '1', 11:58:18 INFO - 'PAGER': '/bin/cat', 11:58:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:58:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:18 INFO - 'PWD': '/builds/slave/test', 11:58:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:58:18 INFO - 'SHELL': '/bin/bash', 11:58:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aOi4xildNJ/Listeners', 11:58:18 INFO - 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/', 11:58:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:58:18 INFO - 'USER': 'cltbld', 11:58:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:58:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:58:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:18 INFO - 'XPC_FLAGS': '0x0', 11:58:18 INFO - 'XPC_SERVICE_NAME': '0', 11:58:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:58:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:18 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:58:18 INFO - Cleaning up... 11:58:18 INFO - Return code: 0 11:58:18 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:58:18 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:58:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:18 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:58:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:18 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 0x10119b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101178228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91f1d652a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010bf9f0>, '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 0x100e1edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010b28c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8mF7QktIEF/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.aOi4xildNJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:58:18 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:58:18 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:58:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8mF7QktIEF/Render', 11:58:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:58:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:58:18 INFO - 'HOME': '/Users/cltbld', 11:58:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:58:18 INFO - 'LOGNAME': 'cltbld', 11:58:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:18 INFO - 'MOZ_NO_REMOTE': '1', 11:58:18 INFO - 'NO_EM_RESTART': '1', 11:58:18 INFO - 'PAGER': '/bin/cat', 11:58:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:58:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:18 INFO - 'PWD': '/builds/slave/test', 11:58:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:58:18 INFO - 'SHELL': '/bin/bash', 11:58:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aOi4xildNJ/Listeners', 11:58:18 INFO - 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/', 11:58:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:58:18 INFO - 'USER': 'cltbld', 11:58:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:58:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:58:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:18 INFO - 'XPC_FLAGS': '0x0', 11:58:18 INFO - 'XPC_SERVICE_NAME': '0', 11:58:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:58:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:18 INFO - Downloading/unpacking psutil>=0.7.1 11:58:18 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:58:18 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:58:18 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:58:18 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:58:18 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:58:18 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:58:20 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 11:58:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 11:58:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:58:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:58:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:58:20 INFO - Installing collected packages: psutil 11:58:20 INFO - Running setup.py install for psutil 11:58:21 INFO - building 'psutil._psutil_osx' extension 11:58:21 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:58:21 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:58:21 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:58:21 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:58:21 INFO - building 'psutil._psutil_posix' extension 11:58:21 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:58:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:58:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:58:21 INFO - ^ 11:58:21 INFO - 1 warning generated. 11:58:21 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:58:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:58:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:58:21 INFO - Successfully installed psutil 11:58:21 INFO - Cleaning up... 11:58:21 INFO - Return code: 0 11:58:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:58: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:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58: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:58:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:21 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 0x10119b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101178228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91f1d652a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010bf9f0>, '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 0x100e1edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010b28c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8mF7QktIEF/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.aOi4xildNJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:58:21 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:58:21 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:58:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8mF7QktIEF/Render', 11:58:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:58:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:58:21 INFO - 'HOME': '/Users/cltbld', 11:58:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:58:21 INFO - 'LOGNAME': 'cltbld', 11:58:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:21 INFO - 'MOZ_NO_REMOTE': '1', 11:58:21 INFO - 'NO_EM_RESTART': '1', 11:58:21 INFO - 'PAGER': '/bin/cat', 11:58:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:58:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:21 INFO - 'PWD': '/builds/slave/test', 11:58:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:58:21 INFO - 'SHELL': '/bin/bash', 11:58:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aOi4xildNJ/Listeners', 11:58:21 INFO - 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/', 11:58:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:58:21 INFO - 'USER': 'cltbld', 11:58:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:58:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:58:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:21 INFO - 'XPC_FLAGS': '0x0', 11:58:21 INFO - 'XPC_SERVICE_NAME': '0', 11:58:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:58:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:22 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:58:22 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:58:22 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:58:22 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:58:22 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:58:22 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:58:22 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:58:24 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:58:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 11:58:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:58:24 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:58:24 INFO - Installing collected packages: mozsystemmonitor 11:58:24 INFO - Running setup.py install for mozsystemmonitor 11:58:24 INFO - Successfully installed mozsystemmonitor 11:58:24 INFO - Cleaning up... 11:58:24 INFO - Return code: 0 11:58:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:58:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:58:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:58:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:24 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 0x10119b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101178228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91f1d652a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010bf9f0>, '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 0x100e1edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010b28c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8mF7QktIEF/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.aOi4xildNJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:58:24 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:58:24 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:58:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8mF7QktIEF/Render', 11:58:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:58:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:58:24 INFO - 'HOME': '/Users/cltbld', 11:58:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:58:24 INFO - 'LOGNAME': 'cltbld', 11:58:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:24 INFO - 'MOZ_NO_REMOTE': '1', 11:58:24 INFO - 'NO_EM_RESTART': '1', 11:58:24 INFO - 'PAGER': '/bin/cat', 11:58:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:58:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:24 INFO - 'PWD': '/builds/slave/test', 11:58:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:58:24 INFO - 'SHELL': '/bin/bash', 11:58:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aOi4xildNJ/Listeners', 11:58:24 INFO - 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/', 11:58:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:58:24 INFO - 'USER': 'cltbld', 11:58:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:58:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:58:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:24 INFO - 'XPC_FLAGS': '0x0', 11:58:24 INFO - 'XPC_SERVICE_NAME': '0', 11:58:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:58:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:24 INFO - Downloading/unpacking blobuploader==1.2.4 11:58:24 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:58:24 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:58:24 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:58:24 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:58:24 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:58:24 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:58:26 INFO - Downloading blobuploader-1.2.4.tar.gz 11:58:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 11:58:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:58:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:58:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:58:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:58:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:58:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:58:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:58:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:58:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 11:58:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:58:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:58:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:58:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:58:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:58:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:58:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:58:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:58:27 INFO - Downloading docopt-0.6.1.tar.gz 11:58:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 11:58:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:58:28 INFO - Installing collected packages: blobuploader, requests, docopt 11:58:28 INFO - Running setup.py install for blobuploader 11:58:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:58:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:58:28 INFO - Running setup.py install for requests 11:58:28 INFO - Running setup.py install for docopt 11:58:28 INFO - Successfully installed blobuploader requests docopt 11:58:28 INFO - Cleaning up... 11:58:28 INFO - Return code: 0 11:58:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:58:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:58:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:58:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:28 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 0x10119b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101178228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91f1d652a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010bf9f0>, '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 0x100e1edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010b28c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8mF7QktIEF/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.aOi4xildNJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:58:28 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:58:28 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:58:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8mF7QktIEF/Render', 11:58:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:58:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:58:28 INFO - 'HOME': '/Users/cltbld', 11:58:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:58:28 INFO - 'LOGNAME': 'cltbld', 11:58:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:28 INFO - 'MOZ_NO_REMOTE': '1', 11:58:28 INFO - 'NO_EM_RESTART': '1', 11:58:28 INFO - 'PAGER': '/bin/cat', 11:58:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:58:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:28 INFO - 'PWD': '/builds/slave/test', 11:58:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:58:28 INFO - 'SHELL': '/bin/bash', 11:58:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aOi4xildNJ/Listeners', 11:58:28 INFO - 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/', 11:58:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:58:28 INFO - 'USER': 'cltbld', 11:58:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:58:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:58:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:28 INFO - 'XPC_FLAGS': '0x0', 11:58:28 INFO - 'XPC_SERVICE_NAME': '0', 11:58:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:58:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:58:29 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-Zy2Hw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:58:29 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-72IfEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:58:29 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-OvSzVq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:58:29 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-Uq5iiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:58:29 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-lza7Po-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:58:29 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-9DVV4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:58:29 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-aIXqi4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:58:29 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-wrJnlD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:58:29 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-UBbq2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:58:30 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-8BgdjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:58:30 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-pHz3cj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:58:30 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-W1k5I2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:58:30 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-FSHItX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:58:30 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-esv4Oo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:58:30 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-gN3A9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:58:30 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-FuEHku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:58:30 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-eFmlMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:58:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:58:30 INFO - Running setup.py install for manifestparser 11:58:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:58:31 INFO - Running setup.py install for mozcrash 11:58:31 INFO - Running setup.py install for mozdebug 11:58:31 INFO - Running setup.py install for mozdevice 11:58:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:58:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:58:31 INFO - Running setup.py install for mozfile 11:58:31 INFO - Running setup.py install for mozhttpd 11:58:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:58:31 INFO - Running setup.py install for mozinfo 11:58:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:58:31 INFO - Running setup.py install for mozInstall 11:58:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:58:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:58:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:58:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:58:32 INFO - Running setup.py install for mozleak 11:58:32 INFO - Running setup.py install for mozlog 11:58:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:58:32 INFO - Running setup.py install for moznetwork 11:58:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:58:32 INFO - Running setup.py install for mozprocess 11:58:32 INFO - Running setup.py install for mozprofile 11:58:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:58:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:58:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:58:32 INFO - Running setup.py install for mozrunner 11:58:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:58:33 INFO - Running setup.py install for mozscreenshot 11:58:33 INFO - Running setup.py install for moztest 11:58:33 INFO - Running setup.py install for mozversion 11:58:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:58:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:58:33 INFO - Cleaning up... 11:58:33 INFO - Return code: 0 11:58:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:58:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:58:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:58:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:33 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 0x10119b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101178228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91f1d652a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010bf9f0>, '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 0x100e1edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010b28c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8mF7QktIEF/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.aOi4xildNJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:58:33 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:58:33 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:58:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8mF7QktIEF/Render', 11:58:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:58:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:58:33 INFO - 'HOME': '/Users/cltbld', 11:58:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:58:33 INFO - 'LOGNAME': 'cltbld', 11:58:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:33 INFO - 'MOZ_NO_REMOTE': '1', 11:58:33 INFO - 'NO_EM_RESTART': '1', 11:58:33 INFO - 'PAGER': '/bin/cat', 11:58:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:58:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:33 INFO - 'PWD': '/builds/slave/test', 11:58:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:58:33 INFO - 'SHELL': '/bin/bash', 11:58:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aOi4xildNJ/Listeners', 11:58:33 INFO - 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/', 11:58:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:58:33 INFO - 'USER': 'cltbld', 11:58:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:58:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:58:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:33 INFO - 'XPC_FLAGS': '0x0', 11:58:33 INFO - 'XPC_SERVICE_NAME': '0', 11:58:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:58:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:58:33 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-WU1P3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:58:33 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:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:58:33 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-JvU0oj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:58:33 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:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:58:33 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-TEFfKo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:58:34 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:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:58:34 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-h_hpeN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:58:34 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:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:58:34 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-5fsAGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:58:34 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:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:58:34 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-dymzIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:58:34 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:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:58:34 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-LPvFQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:58:34 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:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:58:34 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-kI79Yu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:58:34 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:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:58:34 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-Nvbxqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:58:34 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:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:58:34 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-_RYj4f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:58:34 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:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:58:34 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-VFAi6M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:58:34 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:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:58:34 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-bCVFdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:58:34 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:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:58:34 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-luH4aS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:58:35 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:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:58:35 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-Mj2OcY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:58:35 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:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:58:35 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-7lkUc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:58:35 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:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:58:35 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-ljsuhD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:58:35 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:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:58:35 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-TprwDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:58:35 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:58:35 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:58:35 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:58:35 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:58:35 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:58:35 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:58:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:58:35 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:58:35 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:58:35 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:58:35 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:58:35 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:58:35 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:58:37 INFO - Downloading blessings-1.5.1.tar.gz 11:58:37 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:58:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:58:37 INFO - Installing collected packages: blessings 11:58:37 INFO - Running setup.py install for blessings 11:58:37 INFO - Successfully installed blessings 11:58:37 INFO - Cleaning up... 11:58:37 INFO - Return code: 0 11:58:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:58:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:58:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:58:38 INFO - Reading from file tmpfile_stdout 11:58:38 INFO - Current package versions: 11:58:38 INFO - blessings == 1.5.1 11:58:38 INFO - blobuploader == 1.2.4 11:58:38 INFO - docopt == 0.6.1 11:58:38 INFO - manifestparser == 1.1 11:58:38 INFO - mozInstall == 1.12 11:58:38 INFO - mozcrash == 0.16 11:58:38 INFO - mozdebug == 0.1 11:58:38 INFO - mozdevice == 0.47 11:58:38 INFO - mozfile == 1.2 11:58:38 INFO - mozhttpd == 0.7 11:58:38 INFO - mozinfo == 0.9 11:58:38 INFO - mozleak == 0.1 11:58:38 INFO - mozlog == 3.0 11:58:38 INFO - moznetwork == 0.27 11:58:38 INFO - mozprocess == 0.22 11:58:38 INFO - mozprofile == 0.27 11:58:38 INFO - mozrunner == 6.11 11:58:38 INFO - mozscreenshot == 0.1 11:58:38 INFO - mozsystemmonitor == 0.0 11:58:38 INFO - moztest == 0.7 11:58:38 INFO - mozversion == 1.4 11:58:38 INFO - psutil == 3.1.1 11:58:38 INFO - requests == 1.2.3 11:58:38 INFO - wsgiref == 0.1.2 11:58:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:58: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:58:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58: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:58:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:38 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 0x10119b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101178228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91f1d652a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010bf9f0>, '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 0x100e1edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010b28c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8mF7QktIEF/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.aOi4xildNJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:58:38 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:58:38 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:58:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8mF7QktIEF/Render', 11:58:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:58:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:58:38 INFO - 'HOME': '/Users/cltbld', 11:58:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:58:38 INFO - 'LOGNAME': 'cltbld', 11:58:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:38 INFO - 'MOZ_NO_REMOTE': '1', 11:58:38 INFO - 'NO_EM_RESTART': '1', 11:58:38 INFO - 'PAGER': '/bin/cat', 11:58:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:58:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:38 INFO - 'PWD': '/builds/slave/test', 11:58:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:58:38 INFO - 'SHELL': '/bin/bash', 11:58:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aOi4xildNJ/Listeners', 11:58:38 INFO - 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/', 11:58:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:58:38 INFO - 'USER': 'cltbld', 11:58:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:58:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:58:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:38 INFO - 'XPC_FLAGS': '0x0', 11:58:38 INFO - 'XPC_SERVICE_NAME': '0', 11:58:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:58:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:38 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:58:38 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:58:38 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:58:38 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:58:38 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:58:38 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:58:38 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:58:38 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:58:38 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:58:38 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:58:38 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:58:38 INFO - Cleaning up... 11:58:38 INFO - Return code: 0 11:58:38 INFO - Running post-action listener: _resource_record_post_action 11:58:38 INFO - Running post-action listener: _start_resource_monitoring 11:58:38 INFO - Starting resource monitoring. 11:58:38 INFO - ##### 11:58:38 INFO - ##### Running install step. 11:58:38 INFO - ##### 11:58:38 INFO - Running pre-action listener: _resource_record_pre_action 11:58:38 INFO - Running main action method: install 11:58:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:58:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:58:38 INFO - Reading from file tmpfile_stdout 11:58:38 INFO - Detecting whether we're running mozinstall >=1.0... 11:58:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:58:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:58:38 INFO - Reading from file tmpfile_stdout 11:58:38 INFO - Output received: 11:58:38 INFO - Usage: mozinstall [options] installer 11:58:38 INFO - Options: 11:58:38 INFO - -h, --help show this help message and exit 11:58:38 INFO - -d DEST, --destination=DEST 11:58:38 INFO - Directory to install application into. [default: 11:58:38 INFO - "/builds/slave/test"] 11:58:38 INFO - --app=APP Application being installed. [default: firefox] 11:58:38 INFO - mkdir: /builds/slave/test/build/application 11:58:38 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:58:38 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:59:08 INFO - Reading from file tmpfile_stdout 11:59:08 INFO - Output received: 11:59:08 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:59:08 INFO - Running post-action listener: _resource_record_post_action 11:59:08 INFO - ##### 11:59:08 INFO - ##### Running run-tests step. 11:59:08 INFO - ##### 11:59:08 INFO - Running pre-action listener: _resource_record_pre_action 11:59:08 INFO - Running main action method: run_tests 11:59:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:59:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:59:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:59:08 INFO - 2015-11-18 11:59:08.989 screenresolution[1921:18040] starting screenresolution argv=screenresolution get 11:59:08 INFO - 2015-11-18 11:59:08.992 screenresolution[1921:18040] Display 0: 1600x1200x32@60 11:59:08 INFO - 2015-11-18 11:59:08.998 screenresolution[1922:18042] starting screenresolution argv=screenresolution list 11:59:09 INFO - Available Modes on Display 0 11:59:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:59:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:59:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:59:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:59:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:59:09 INFO - Intel Iris: 11:59:09 INFO - Chipset Model: Intel Iris 11:59:09 INFO - Type: GPU 11:59:09 INFO - Bus: Built-In 11:59:09 INFO - VRAM (Dynamic, Max): 1536 MB 11:59:09 INFO - Vendor: Intel (0x8086) 11:59:09 INFO - Device ID: 0x0a2e 11:59:09 INFO - Revision ID: 0x0009 11:59:09 INFO - Displays: 11:59:09 INFO - Display: 11:59:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:59:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:59:09 INFO - Display Serial Number: 1600x1200 60 11:59:09 INFO - Main Display: Yes 11:59:09 INFO - Mirror: Off 11:59:09 INFO - Online: Yes 11:59:09 INFO - Rotation: Supported 11:59:09 INFO - Return code: 0 11:59:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:59:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:59:09 INFO - Python 2.7.3 11:59:09 INFO - Return code: 0 11:59:09 INFO - grabbing minidump binary from tooltool 11:59:09 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:59:09 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 0x1010bf9f0>, '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 0x100e1edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010b28c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:59:09 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:59:09 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:59:09 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:59:09 INFO - Return code: 0 11:59:09 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:59:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:59:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:59:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:59:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:59:09 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/NLcgCYbDRjWGDRX6tYSFww/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0042', '--webServer', 'localhost'] in /builds/slave/test/build 11:59:09 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/NLcgCYbDRjWGDRX6tYSFww/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0042 --webServer localhost 11:59:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8mF7QktIEF/Render', 11:59:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:59:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:59:09 INFO - 'HOME': '/Users/cltbld', 11:59:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:59:09 INFO - 'LOGNAME': 'cltbld', 11:59:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:59:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:59:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:09 INFO - 'MOZ_NO_REMOTE': '1', 11:59:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:59:09 INFO - 'NO_EM_RESTART': '1', 11:59:09 INFO - 'PAGER': '/bin/cat', 11:59:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:59:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:09 INFO - 'PWD': '/builds/slave/test', 11:59:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:59:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:59:09 INFO - 'SHELL': '/bin/bash', 11:59:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aOi4xildNJ/Listeners', 11:59:09 INFO - 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/', 11:59:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:59:09 INFO - 'USER': 'cltbld', 11:59:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:59:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:59:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:09 INFO - 'XPC_FLAGS': '0x0', 11:59:09 INFO - 'XPC_SERVICE_NAME': '0', 11:59:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:59:09 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/NLcgCYbDRjWGDRX6tYSFww/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0042', '--webServer', 'localhost'] with output_timeout 3600 11:59:09 INFO - mozversion INFO | application_buildid: 20151118092126 11:59:09 INFO - mozversion INFO | application_changeset: f622e6d5fd171a3ef6456c393f1617ec9d7eb3a7 11:59:09 INFO - mozversion INFO | application_display_name: Nightly 11:59:09 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:59:09 INFO - mozversion INFO | application_name: Firefox 11:59:09 INFO - mozversion INFO | application_remotingname: firefox 11:59:09 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 11:59:09 INFO - mozversion INFO | application_vendor: Mozilla 11:59:09 INFO - mozversion INFO | application_version: 45.0a1 11:59:09 INFO - mozversion INFO | platform_buildid: 20151118092126 11:59:09 INFO - mozversion INFO | platform_changeset: f622e6d5fd171a3ef6456c393f1617ec9d7eb3a7 11:59:09 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 11:59:09 INFO - mozversion INFO | platform_version: 45.0a1 11:59:09 INFO - 2015-11-18 11:59:09,533 DEBUG : using testdate: 1447876749 11:59:09 INFO - 2015-11-18 11:59:09,533 DEBUG : actual date: 1447876749 11:59:10 INFO - 2015-11-18 11:59:10,011 INFO : starting webserver on 'localhost:57246' 11:59:10 INFO - 2015-11-18 11:59:10,012 INFO : Starting test suite t-yosemite-r7-0042.e 11:59:10 INFO - 2015-11-18 11:59:10,012 INFO : Starting test dromaeo_css 11:59:10 INFO - 2015-11-18 11:59:10,012 DEBUG : operating with platform_type : mac_ 11:59:10 INFO - 2015-11-18 11:59:10,013 INFO : Initialising browser for dromaeo_css test... 11:59:10 INFO - 2015-11-18 11:59:10,025 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/tmpSnVlpV/profile http://localhost:57246/getInfo.html 11:59:12 INFO - 2015-11-18 11:59:12,427 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:59:12 INFO - 2015-11-18 11:59:12,428 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:59:12 INFO - 2015-11-18 11:59:12,428 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 11:59:12 INFO - 2015-11-18 11:59:12,428 DEBUG : BROWSER_OUTPUT: __metrics 11:59:13 INFO - 2015-11-18 11:59:13,020 INFO : Browser initialized. 11:59:13 INFO - 2015-11-18 11:59:13,021 INFO : Running cycle 1/1 for dromaeo_css test... 11:59:13 INFO - 2015-11-18 11:59:13,021 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/tmpSnVlpV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:59:24 INFO - 2015-11-18 11:59:24,874 DEBUG : BROWSER_OUTPUT: RSS: Main: 236990464 11:59:24 INFO - 2015-11-18 11:59:24,874 DEBUG : BROWSER_OUTPUT: 12:00:14 INFO - 2015-11-18 12:00:14,549 DEBUG : BROWSER_OUTPUT: 1447876814546 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] 12:02:24 INFO - 2015-11-18 12:02:24,215 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57246/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57246/tests/dromaeo/cssquery-ext.html) 12:02:25 INFO - 2015-11-18 12:02:25,453 DEBUG : BROWSER_OUTPUT: RSS: Main: 252301312 12:02:25 INFO - 2015-11-18 12:02:25,453 DEBUG : BROWSER_OUTPUT: 12:05:27 INFO - 2015-11-18 12:05:27,389 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57246/tests/dromaeo/cssquery-ext.html (next: http://localhost:57246/tests/dromaeo/cssquery-jquery.html) 12:05:27 INFO - 2015-11-18 12:05:27,980 DEBUG : BROWSER_OUTPUT: RSS: Main: 262746112 12:05:27 INFO - 2015-11-18 12:05:27,981 DEBUG : BROWSER_OUTPUT: 12:08:29 INFO - 2015-11-18 12:08:29,572 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57246/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57246/tests/dromaeo/cssquery-mootools.html) 12:08:30 INFO - 2015-11-18 12:08:30,177 DEBUG : BROWSER_OUTPUT: RSS: Main: 264687616 12:08:30 INFO - 2015-11-18 12:08:30,177 DEBUG : BROWSER_OUTPUT: 12:11:31 INFO - 2015-11-18 12:11:31,789 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57246/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57246/tests/dromaeo/cssquery-prototype.html) 12:11:32 INFO - 2015-11-18 12:11:32,392 DEBUG : BROWSER_OUTPUT: RSS: Main: 265523200 12:11:32 INFO - 2015-11-18 12:11:32,393 DEBUG : BROWSER_OUTPUT: 12:14:34 INFO - 2015-11-18 12:14:34,842 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57246/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57246/tests/dromaeo/cssquery-yui.html) 12:14:35 INFO - 2015-11-18 12:14:35,456 DEBUG : BROWSER_OUTPUT: RSS: Main: 270217216 12:14:35 INFO - 2015-11-18 12:14:35,456 DEBUG : BROWSER_OUTPUT: 12:17:37 INFO - 2015-11-18 12:17:37,667 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57246/tests/dromaeo/cssquery-yui.html (next: http://localhost:57246/tests/dromaeo/cssquery-dojo.html) 12:17:37 INFO - 2015-11-18 12:17:37,925 DEBUG : BROWSER_OUTPUT: RSS: Main: 270909440 12:17:37 INFO - 2015-11-18 12:17:37,926 DEBUG : BROWSER_OUTPUT: 12:17:37 INFO - 2015-11-18 12:17:37,926 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:17:37 INFO - 2015-11-18 12:17:37,926 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:17:37 INFO - 2015-11-18 12:17:37,926 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:17:37 INFO - 2015-11-18 12:17:37,926 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:17:37 INFO - 2015-11-18 12:17:37,926 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3256.2673398485344;3393.5079413485046;3399.7280217582597;3449.3963556377644;3493.772904761189;4750.952490475094;5591.580631452637;5638.267025286717;5671.319441667;5713.485786279234;5511.9724401377935;5539.889202215953;5680.914786278209;5695.117256825199;5755.827325180241;4466.441694788152;5088.745562721859;5165.992631436871;5206.062908676437;5296.09966305729;5106.617003724717;5146.845594632167;5319.388270348902;5321.467853214686;5343.438938911417;5067.467915868818;5217.58259339252;5227.3465816772905;5252.921206181911;5295.152775555912;5064.898702025939;5165.741712914377;5177.611679124081;5181.274621552986;5187.221916712486;5157.174852023658;5228.686278823283;5248.160294352923;5257.815976440845;5264.763085661154;5183.118869792144;5266.92099618506;5434.565234781208;5552.194931734916;5595.944040559583;6219.160413344186;6222.43998040174;6241.032639940817;6264.686765661699;6267.937320626781;6289.339619339995;6293.590916590407;6294.968525157345;6314.305426403092;6321.367863213642;5656.858578535528;5711.685857277848;5801.245838041028;5863.970680146572;5880.9411905880825;6293.590916590407;6318.526110541728;6359.046143078575;6367.4906007519285;6371.745130194833;6168.0439531872635;6175.876482470415;6179.258488981351;6180.567360284737;6199.132121502993;5934;5989.371116032841;6137.232845894263;6245.968770156211;6247.718852651642;6191.19514463117;6198.504119670415;6217.564770466114;6236.812895613139;6242.531810114259;5912.142739302863;6211.440970312694;6259.843503912439;6261.373862613702;6268.937310626927;4325.567443255649;4854.563089321978;4864.927026094611;4918.729469879191;4948.035133149074;4439.445069366329;4447.555244475527;4483.596476317147;4506;4522.389477420572;5448.618596698272;5667.631603945731;5757.280339957505;5785.681787501728;5799.246098007232;5198.376194856642;6137.938620613737;6235.3452887446165;6284.497240220771;6308.905366419507;5691.146328050742;5704.11586204139;5757.568182386254;5757.913631295534;5788.565857560699;5240.71176085319;5380.892382152335;5392.352917649907;5399.271098401744;5407.242985981966;5761.711914404263;6065.181200537871;6079.817605471843;6371.617702937839;6435.485161187094;5661.631993920382;6326.6836658165985;6344.651044192614;6359.872802544016;6361.427471527585;5159.742012899265;6192.938070619236;6357.396047375492;6361.491080713439;6407.583507072025;6230.376962303733;6235.968820156052;6244.937550624436;6246.562740608114;6256.5307601930945;6318.0838778375955;6330.620162790247;6336.112944187909;6341.619502829845;6355.745770169141;5267.473252674855;5740.741666624928;5912.817436512801;5919.733611987557;6132.908006379818;5998.880022399615;6064.211652485149;6069.969650151721;6075.2405949256345;6098.573099882966;5882;5915.645061296336;5919.993601087739;5931.792387266425;5934.762609495572;5763.36602973681;5943.286805583358;6025.975584150792;6069.453749162597;6070.484008859296;5967.164596956516;5974.492168165754;5982.102684597346;5982.611130276518;5984.970075149597 12:17:37 INFO - 2015-11-18 12:17:37,926 DEBUG : BROWSER_OUTPUT: |1;ext.html;515.0960065085774;540.7728753923352;582.2023827356522;589.3899813692829;617.9412955769202;41678.16643667125;42089.94775130616;42182.7890860546;42267.15465690692;42348.15303693924;44690.32964505535;44991.55008449915;45170;45348.773256133754;45476.3178552322;9992.700218993423;10067.49662516875;10095.697129086102;10107.444090575016;10168.64409745659;9899.45552994585;10028.047335503115;10034.147097496721;10062.195024398066;10101.141402980755;9876.654317098903;9900.158486528653;10002.249831262649;10005.349652272615;10007.899921000806;9981.550830212622;10014.39913605186;10017.899821001769;10020.59917603295;10057.849132263022;9866.309358344919;9975.70072897807;9993.650222242259;10011.549480273405;10024;41637.375439368436;41819.790901045606;41855.58144418578;41974.79012604917;42136.57863421357;3248.772585918987;3268.9346213075605;3279.5736554247796;3309.9503507447407;3691.593924668284;28732.281692957633;29348.532573371245;29865.850670746724;30039.849800751075;30492.932747353738;2271.5684020036306;2583.19920824545;2591.9870400647874;2613.294410509171;2634.473105378932;445504;445769.7711511454;446547;447244;448273;38737;46342.76828615835;46400.53599463962;46905;46979.530204698196;47121;47430.5256947433;47490.05019899583;47659.52340476551;47733.52266477291;15444.768328475082;15519.224038798015;15560;15590.064596124268;15597.610059748597;10413.635522756667;12448.937755311166;12515.186512876633;12613.432395542222;13027.674308142372;15354.539363819104;15380.61548461275;15421.614459638598;15441.919065665521;15588.688226235412;6565.80302590923;6677.732890684415;6680.465562754968;6710.328967103251;6718.596884186867;803.2569872867574;920.8480600700809;1056.6037735849056;1096.2819353323587;1101.091599430473;30497;30822.830918975586;30997.0700878974;31074;31306.843465782524;1058.5448257249457;1111.3443068589409;1155.5955415604471;1187.400362816772;1206.2943178240828;15638.609034774221;15653.295601697951;15749.763753543706;15818.841811581737;16024.679506409806;455467.72266138456;549226;549771;552379;553870;60284.397156028754;60792.48018799565;61023;61284.693576531834;61426.692866535384;1429.756941319978;1436.4685066525453;1456.4975083596355;1460.3793387810351;1467.0537503310518;23993.760062399153;30184.24539386533;30372.848135760065;30585.23536911595;30838.845805770827;43474.34788478112;53289.46710532845;53567.19649205187;53850.461495384545;53978.73010634922;498648;502183;502264;504352;509030;33911.66088339085;46788;47582.52417475781;48471.75764121157;48543;47013;47384;47440;48597.757011216134;48857.77855553498;37220.6277937228;38954.80522597369;39358.212835743696;40990.385144222266;43007.78496107499;39763.80118099391;41194.176116476905;41432.3785143217;42452.787736061124;42501.78749106234;28670.856645716638;31024.22439439032;34604.13489662779;38400.6159938397;38598.61401386063;33845.83077084599;34243.65756342404;34786.82606587052;35100.82449587736;35258.8237058813;24180.39549011289;25078.498430030933;25456.23631291064;25761.613575796004;26330.60504092402 12:17:37 INFO - 2015-11-18 12:17:37,926 DEBUG : BROWSER_OUTPUT: |2;jquery.html;358.8062446279008;365.91583935694774;365.9451082337649;367.21232955310865;367.52038589640523;12350.258984460927;12509.937450312736;12691.301978391197;12826.871731282685;19221.903890480546;12283.07876909231;12327.198732082408;12523.99808015359;12567.748645027094;12571.245725256491;3713.554373475187;4102.917941641165;4748.620110391178;4851;4875.9756201219125;5269.1832765921345;5284.471552844704;5286.550643195333;5292.761825717852;5340.465953404648;5104;5191.091558977164;5219.86950326243;5228.947710522884;5274.525292723673;5170.302009228743;5180.922286165711;5193.584513238932;5201.2458193561915;5215.921761173548;4173.08192197716;4404.031113155101;4425.181341451809;4444.866654000385;4449.154660614473;13353.132046416951;13537.458501659921;13676.384562694702;13874.306284685725;13978.440862365493;1649.7772800671996;1852.6202128563611;1881.8306352428347;1891.508207865951;1942.8931408772512;10023.047810457994;10060.446675432848;10097.394156350643;10327.896721032768;10343.534540945675;1569.9686006279924;1640.7949006374204;1649.1424459281106;1662.0443245134097;1662.742274947385;78796.60601697012;82035;83393;90615.54692226562;91707.99999999933;6769.815282325573;6819.659017049128;6834.897476537856;6840;6887.655617219119;7662.463627546018;7725.22747725223;7733.651985660659;7757.418193635387;7766.9611651942505;5732.713364331767;5742.224799651994;5751.194832723339;5777.335606405233;5787.334456537468;6164.445199932027;6174.66039367839;6212.9068063979075;6215.533834962396;6273.65494897785;2889.624348834638;2936.339323652161;3042.39152169567;3048.756099512034;3100.5814215081127;1088.7441451258949;1090.095220966596;1095.7589330347312;1099.6206308823444;1126.8674981643396;382.0982481344026;385.23146323085626;423.2022637328658;476.8045101508365;478.7989044601276;9243.907560924305;10913.399763012952;11082.889171108185;11526.88473115275;11687.766244675058;411.1202027660808;431.1291191792561;440.70913197289633;444.09626410255623;452.7577745905925;5981.5214782817275;6023.427774361428;6106.358832322631;6112.419320164578;6120.14317995481;663349;742622.2868885621;754919;760685;770937;88562;108093.45953270183;111203;113573.4321328388;113801.4309928445;516.9302144210559;535.2506490912675;537.8278950735727;540.2760301196415;540.3839622829977;10726.570937162738;11905.226160299553;11984.04127669767;12004.819927701266;12024.879751202376;50116;50526.24210636917;50884.23673644824;51004.44977751172;51025.48974510356;70441.29558704347;71274.28725712885;71308.93036604559;72535.63732181305;72749.27250727425;6313.273973493107;6361.618302901656;6385.712642931172;6408.359164083555;6425;11674.70813229676;11792.882071179522;12059.939700301442;12320.260784352968;12349.444275007825;9970.651027214013;10101;10138.797224055625;10757.515911784145;10884.945575272073;10490.160787137163;10559.788804224027;10618;10669.679909602724;10798.082163016232;10081.193504519475;10128.34165779222;10253.33353332031;10392.740181495523;10930.56277748881;6421.903671445026;6449.516286278454;6460.030995350735;6465.0948867157695;6503.154589903283;10701.839472408075;10737.14102871784;10904.945475272572;11086.833697494383;11090.611828585961 12:17:37 INFO - 2015-11-18 12:17:37,930 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1485.3093311610098;1525.252626213156;1790.9731354029684;1854.9072546372681;1860.4976656302804;6901.516174022597;7097.574145551271;7573.826056961166;7902.407319451036;7902.723404680844;7494.288042635954;7671.194524574909;7772.3393511551585;7789.805254868631;7843.568603726792;2283.1894677389537;2302.26327575176;2317.640765681322;2328.2433209206993;2336.836421450499;2334.101370972171;2358.6108292131776;2377.4294169399304;2379.6192609182535;2393.7845593896545;2312.8843557822124;2333.1717240379676;2362.6337917622795;2366.633171858356;2367.6093444581625;2290.576243394977;2301.0795681727277;2306.9769302307013;2330.4290448840143;2335.544568809083;2351.341624345169;2355.9764402355927;2386.940326491834;2388.820838437124;2389.3668177932864;7722.382209423289;7800.843983120306;7811.140774514799;7818.06183258007;7864.2922137007945;4858.368412106439;4882.218844984785;4889.168841296988;4966.776495057731;4968.801247950078;2993.7754668399957;3272.067460773692;3317.668233176687;3360.983195084009;3376.848041838123;1027.2244455436173;1046.1222106319176;1056.7622284985894;1056.9365838049741;1066.0565399621314;10060.94969525155;10087.49562521871;10106.14097801695;10109.494525273707;10159.288849780518;3298.505224216339;3848.191879705237;4273.829046838154;4369.890752731144;4374.993751437188;8113.35093192555;8205.302549283379;8349.081601023883;8410.453320534145;8423.410361274651;4895.8041678332465;4902.093112774148;4932.827351042768;4973.950260497421;4977.850664480072;4604.194266003436;4610.76946152691;4611.077784443125;4623.676342655982;4644.930326045112;3487.232808782064;3528.1179705073732;3549.0062782420964;3563;3567.910802229965;1060.6499855047816;1134.6539305511733;1145.3013661666378;1150.2983180260035;1153.0890596428894;1210.4189988805422;1261.6467389131058;1283.6598301450124;1309.2668105860748;1362.6048445950762;7347.08161479815;7447.1063472382575;7450.403967682572;7469.439792015512;7478.326950574475;478.6984199954007;481.674869463111;482.48615224785493;482.4885621241425;498.7730582584915;5121.743912804345;5862.355140934494;5883.794067207627;5954.46409823118;5969.283685957713;8512.659493620185;8875.068117847663;9230.723078307661;9232.630694772268;9302.16280534755;9154.176124148858;9200.6779762708;9214.953925230331;9220.400673956172;9237.399569027992;7281.1262648482525;7468.738594149178;7492.887606685904;7494.962525187449;7618.276263754934;7321.707131714672;7392.519486233377;7393.149787774475;7433.851322973402;7486.588237646763;8117.715879944174;8282.71010514629;8383.245507904317;8387.161283871808;8403.117672644528;8541.060483346952;8595.699150529701;8599.226069653761;8605.612747426507;8608.354373421893;6521.902171467526;6573.375529324707;6598.241202261801;6605.801825945229;6636.469082473294;7569.318761311509;7577.0907491101425;7587.544747315179;7600.46796724224;7603.201663825219;5870.178175055581;6919.308069193041;7057.0472986146215;7096.858062838611;7183.245759195209;6937.722491100501;6942;6958.8956165658565;6991.545549539263;7042.683079261548;7089.539179953286;7112.928870711226;7140.39306658919;7191;7234.312740289664;6528.6735663215695;6559.573627714183;6567;6574.04676321921;6585.703643336157;5483.533899618577;5717.256756621613;6567.408933196035;6591.6374599397495;6601.768938087144 12:17:37 INFO - 2015-11-18 12:17:37,931 DEBUG : BROWSER_OUTPUT: |4;prototype.html;283.7474647563668;325.5393618030487;328.3695305014372;329.13109391207234;329.4251531078269;6753.527253092279;6896.758613448524;6902.206246281679;6981.581105133696;7051.224365319811;6496.96751516243;6897.758578449755;6905.102336696223;6948.062011628429;6958.930410695892;4863.589559027895;5033.974830125844;5034.270030845516;5054.368203974504;5062.974685126569;5038.193888977764;5041.445441001487;5052;5056.544910958013;5067.366579177603;4957.3059771632;4984.077945580061;4995.775190116436;5002.074616195997;5019.397672279313;4995.175795993657;4997.975010124963;4999.3000979862845;5003.099442100421;5011.799528018875;3545.769524980868;4119.340905455113;4212.115455754295;4231.788410579458;4236.851710190129;5444.428335024805;6501.732162228367;6595.109660195908;6601.910684737013;6626.337366263383;5434.695673038482;5910.645361278337;5910.645361278337;5911.881762364728;5936.257967754031;6522.347765223487;7097.89353159703;7315.4879158458925;7326.67029983652;7363.153237377716;4662.044280922437;4697.53024697531;4701.694389864648;4706.341112244254;4714.363560919266;7708.961455192744;7822.9608851955945;7824.726134585262;7828.725994590219;7834.647440865175;4768.1642567611025;4774.3077253798;4776.761161941889;4781.617470602343;4784.043191361672;4652.255639097728;4803.015381846713;4808.519148085164;4854.68444551103;4859.24681674334;5743.770249190069;5769.798057067983;5816.011278082736;5816.592838501264;5820.650760954356;5863.648181109147;7307;7309.086364204474;7318.670659820321;7358.374538164316;1344.737776133664;1413.8515455876984;1626.3657173702265;1676.6143786929074;1695.304924980752;1064.11678307005;1070.8286674132257;1075.4783929794044;1080.6433876820631;1084.5553323137476;6732.461403087741;6872.587644741231;6889.517733758689;6896.448284137257;6912.377885990184;7773.572453515111;7816.53100813953;7818.843623127505;7825.608719563999;7838.568878711726;7028.191757947901;7047.295270472911;7051.1891132519395;7058.400035996998;7102.644867756591;3932.5674175840636;4107.979460102681;4115.97942010294;4125.566815484331;4133.338665813455;8040.984630763463;8079.070906845788;8085.312748416451;8086.15095414973;8112.878306825402;6659.933400665931;7677.30904218623;7985.08171560278;8036.718714844952;8065.677372905136;8053.798655033671;8062.314703250289;8082.2725954664365;8089.110197878229;8090.878636820453;7745.883811742716;7760.223977602194;7777.883331749915;7787.10448298453;7793.4154938378715;7276.818079547842;7528.548287102792;7567.697292108254;7573.583452909922;7623.352015078781;8032.277095061472;8078.757637270891;8080.111187769458;8083.959580202061;8096.230858068474;4263.253930562078;4713.269443236304;4751.928721069117;4774.856754297377;4794.448638406628;7416.7774966751085;7661.770146895602;7680.423968202295;7682.769516914502;7687.615619218905;6623.238327592196;6727.764528241488;7384.852302954018;7390.741324053847;7416.96291518539;7077.858442831011;7343.3390994810725;7359.190489046307;7368.042154519878;7374.078240219973;6436.9678151610815;6590.879550476335;7219.566825990458;7259;7290.744823931349;5811.389804070681;7047.964760176166;7151.499395042297;7264.309890560388;7348.338649521569;7244.420446364384;7252.927470725225;7262.491625586158;7268.236835132235;7299.5255308404785 12:17:37 INFO - 2015-11-18 12:17:37,934 DEBUG : BROWSER_OUTPUT: |5;yui.html;580.608089539561;703.4688809948489;715.606416470941;743.2678811370798;799.0611032037355;15241.085534867916;15604.219789010533;15650.904436689421;15665.686686266283;15733.685326293467;11576.47905844237;14190.21953792541;14348.497802576912;14429.92785036076;14452.494162704308;933.5425641435698;955.8375076237022;958.7123862841155;959.1942768074816;961.5721004153155;950.9952450237739;954.613381580461;963.8216929867997;966.3622009473748;968.5883499512679;992.5384696116305;1000.0599436529675;1000.5497526113242;1006.6275478073123;1016.6848277034106;879.2921698033081;995.3480470291934;1000.634768309569;1004.9598016079348;1006.5722068121056;722.4725950056488;730.5580124024995;732.4909188114262;735.6395366270489;747.8167848877006;13237.73524529504;13372.732545349136;13375.866241337559;13400.798988015187;13495.392707328194;9336.906630933672;9369.625214991393;9518.381305215138;9543.761405964837;9813.607455701764;9583.424994500352;9770.560324785401;9936.254780891462;10373.481325933673;10419.739506512398;2781.429806889603;3273.672632736731;3408.0968543336035;3417.111550996734;3449.862005519776;63847.6807615959;63959;67172.5627334238;71052.22369440754;78175.60912195402;7104.7158113675905;7127.429805615642;7190.928090719026;7227.9638601806655;7339.74310899116;11649.88350116488;12214;12656.746865062647;12794.552190673281;12929;6518.967405162944;6590.406863382223;6717.093192419059;6773.695183716744;6794.184697836291;4073.1446396256524;4124.391487319947;4143.254214241466;4228.4080228768;4374.081442896963;3118.8908388206305;3130.8591113399953;3132.780705350649;3139.4662907305815;3147.763917706181;473.95971342435587;475.9571638552547;481.6604293972741;482.71278589239347;485.1994209554264;494.2043310270462;494.8169177404383;508.26809394471843;521.3092652235803;560.5431573267774;7940.642671079815;7948.085970113511;8472.74581762548;8620.13798620133;8805.955970220108;577.5466258986676;587.4595372257534;590.4361334925136;611.065070442224;623.1587357068013;4396.824127034947;4443.844465443694;4504.572065653758;4549.818007279738;4565.383673204141;67651.98522022173;89377.21245575183;92054.53972730093;92396;94167.52916235375;76546.61726691443;78592;87564.56217718998;87950;88238.55880720555;67210;69954.30045699478;70270.945935811;72850;75279;7934.484258523177;9055.456672599665;9125.45247285165;9170.082991700776;9187.448753074837;52429;52474.950500989005;53369.46630533645;54037.91924161573;54878.90242195214;68972;70122.64938675275;70332;70454.23864403431;72879;11679.766404671689;11885.76228475443;11950.46222919988;12410.069244806495;12594.496220151092;11842.585509507126;12081.093917956012;12084.516619335129;12191.390430478263;12552.686182845502;9958.352707074017;11539.07687385024;11973.220156614027;12233.204841685261;12238;11057.83413248818;11451.965065502118;11514.424278786195;11812.688368745174;12026.699332516757;11425.428728563373;11670.396704363073;11783.057355411718;11879.049676025725;12092.576759813364;8657.307415406627;9717.805643887225;9798.265130115413;10318.793624127626;10523.105536029523;8094.433389662902;10217.284790064625;10296.845547316647;10332.793344133226;10392.116670083127 12:17:37 INFO - 2015-11-18 12:17:37,934 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:17:37 INFO - 2015-11-18 12:17:37,934 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:17:37 INFO - 2015-11-18 12:17:37,934 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,324 12:17:37 INFO - 2015-11-18 12:17:37,934 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:17:37 INFO - 2015-11-18 12:17:37,935 DEBUG : BROWSER_OUTPUT: __startTimestamp1447877857919__endTimestamp 12:17:37 INFO - 2015-11-18 12:17:37,935 DEBUG : BROWSER_OUTPUT: 12:17:37 INFO - 2015-11-18 12:17:37,935 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:17:37 INFO - 2015-11-18 12:17:37,935 DEBUG : BROWSER_OUTPUT: Number of tests: 6 12:17:37 INFO - 2015-11-18 12:17:37,935 DEBUG : BROWSER_OUTPUT: 12:17:37 INFO - 2015-11-18 12:17:37,935 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5697.38 Median:5882.00 stddev:654.52 (11.1%) stddev-sans-first:627.89 12:17:37 INFO - 2015-11-18 12:17:37,935 DEBUG : BROWSER_OUTPUT: Values: 3256.3 3393.5 3399.7 3449.4 3493.8 4751.0 5591.6 5638.3 5671.3 5713.5 5512.0 5539.9 5680.9 5695.1 5755.8 4466.4 5088.7 5166.0 5206.1 5296.1 5106.6 5146.8 5319.4 5321.5 5343.4 5067.5 5217.6 5227.3 5252.9 5295.2 5064.9 5165.7 5177.6 5181.3 5187.2 5157.2 5228.7 5248.2 5257.8 5264.8 5183.1 5266.9 5434.6 5552.2 5595.9 6219.2 6222.4 6241.0 6264.7 6267.9 6289.3 6293.6 6295.0 6314.3 6321.4 5656.9 5711.7 5801.2 5864.0 5880.9 6293.6 6318.5 6359.0 6367.5 6371.7 6168.0 6175.9 6179.3 6180.6 6199.1 5934.0 5989.4 6137.2 6246.0 6247.7 6191.2 6198.5 6217.6 6236.8 6242.5 5912.1 6211.4 6259.8 6261.4 6268.9 4325.6 4854.6 4864.9 4918.7 4948.0 4439.4 4447.6 4483.6 4506.0 4522.4 5448.6 5667.6 5757.3 5785.7 5799.2 5198.4 6137.9 6235.3 6284.5 6308.9 5691.1 5704.1 5757.6 5757.9 5788.6 5240.7 5380.9 5392.4 5399.3 5407.2 5761.7 6065.2 6079.8 6371.6 6435.5 5661.6 6326.7 6344.7 6359.9 6361.4 5159.7 6192.9 6357.4 6361.5 6407.6 6230.4 6236.0 6244.9 6246.6 6256.5 6318.1 6330.6 6336.1 6341.6 6355.7 5267.5 5740.7 5912.8 5919.7 6132.9 5998.9 6064.2 6070.0 6075.2 6098.6 5882.0 5915.6 5920.0 5931.8 5934.8 5763.4 5943.3 6026.0 6069.5 6070.5 5967.2 5974.5 5982.1 5982.6 5985.0 12:17:37 INFO - 2015-11-18 12:17:37,935 DEBUG : BROWSER_OUTPUT: 12:17:37 INFO - 2015-11-18 12:17:37,935 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:63903.79 Median:38499.62 stddev:131766.74 (342.3%) stddev-sans-first:132050.43 12:17:37 INFO - 2015-11-18 12:17:37,937 DEBUG : BROWSER_OUTPUT: Values: 515.1 540.8 582.2 589.4 617.9 41678.2 42089.9 42182.8 42267.2 42348.2 44690.3 44991.6 45170.0 45348.8 45476.3 9992.7 10067.5 10095.7 10107.4 10168.6 9899.5 10028.0 10034.1 10062.2 10101.1 9876.7 9900.2 10002.2 10005.3 10007.9 9981.6 10014.4 10017.9 10020.6 10057.8 9866.3 9975.7 9993.7 10011.5 10024.0 41637.4 41819.8 41855.6 41974.8 42136.6 3248.8 3268.9 3279.6 3310.0 3691.6 28732.3 29348.5 29865.9 30039.8 30492.9 2271.6 2583.2 2592.0 2613.3 2634.5 445504.0 445769.8 446547.0 447244.0 448273.0 38737.0 46342.8 46400.5 46905.0 46979.5 47121.0 47430.5 47490.1 47659.5 47733.5 15444.8 15519.2 15560.0 15590.1 15597.6 10413.6 12448.9 12515.2 12613.4 13027.7 15354.5 15380.6 15421.6 15441.9 15588.7 6565.8 6677.7 6680.5 6710.3 6718.6 803.3 920.8 1056.6 1096.3 1101.1 30497.0 30822.8 30997.1 31074.0 31306.8 1058.5 1111.3 1155.6 1187.4 1206.3 15638.6 15653.3 15749.8 15818.8 16024.7 455467.7 549226.0 549771.0 552379.0 553870.0 60284.4 60792.5 61023.0 61284.7 61426.7 1429.8 1436.5 1456.5 1460.4 1467.1 23993.8 30184.2 30372.8 30585.2 30838.8 43474.3 53289.5 53567.2 53850.5 53978.7 498648.0 502183.0 502264.0 504352.0 509030.0 33911.7 46788.0 47582.5 48471.8 48543.0 47013.0 47384.0 47440.0 48597.8 48857.8 37220.6 38954.8 39358.2 40990.4 43007.8 39763.8 41194.2 41432.4 42452.8 42501.8 28670.9 31024.2 34604.1 38400.6 38598.6 33845.8 34243.7 34786.8 35100.8 35258.8 24180.4 25078.5 25456.2 25761.6 26330.6 12:17:37 INFO - 2015-11-18 12:17:37,937 DEBUG : BROWSER_OUTPUT: 12:17:37 INFO - 2015-11-18 12:17:37,937 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:34991.40 Median:2422.37 stddev:121822.11 (5029.0%) stddev-sans-first:122136.09 12:17:37 INFO - 2015-11-18 12:17:37,937 DEBUG : BROWSER_OUTPUT: Values: 358.8 365.9 365.9 367.2 367.5 12350.3 12509.9 12691.3 12826.9 19221.9 12283.1 12327.2 12524.0 12567.7 12571.2 3713.6 4102.9 4748.6 4851.0 4876.0 5269.2 5284.5 5286.6 5292.8 5340.5 5104.0 5191.1 5219.9 5228.9 5274.5 5170.3 5180.9 5193.6 5201.2 5215.9 4173.1 4404.0 4425.2 4444.9 4449.2 13353.1 13537.5 13676.4 13874.3 13978.4 1649.8 1852.6 1881.8 1891.5 1942.9 10023.0 10060.4 10097.4 10327.9 10343.5 1570.0 1640.8 1649.1 1662.0 1662.7 78796.6 82035.0 83393.0 90615.5 91708.0 6769.8 6819.7 6834.9 6840.0 6887.7 7662.5 7725.2 7733.7 7757.4 7767.0 5732.7 5742.2 5751.2 5777.3 5787.3 6164.4 6174.7 6212.9 6215.5 6273.7 2889.6 2936.3 3042.4 3048.8 3100.6 1088.7 1090.1 1095.8 1099.6 1126.9 382.1 385.2 423.2 476.8 478.8 9243.9 10913.4 11082.9 11526.9 11687.8 411.1 431.1 440.7 444.1 452.8 5981.5 6023.4 6106.4 6112.4 6120.1 663349.0 742622.3 754919.0 760685.0 770937.0 88562.0 108093.5 111203.0 113573.4 113801.4 516.9 535.3 537.8 540.3 540.4 10726.6 11905.2 11984.0 12004.8 12024.9 50116.0 50526.2 50884.2 51004.4 51025.5 70441.3 71274.3 71308.9 72535.6 72749.3 6313.3 6361.6 6385.7 6408.4 6425.0 11674.7 11792.9 12059.9 12320.3 12349.4 9970.7 10101.0 10138.8 10757.5 10884.9 10490.2 10559.8 10618.0 10669.7 10798.1 10081.2 10128.3 10253.3 10392.7 10930.6 6421.9 6449.5 6460.0 6465.1 6503.2 10701.8 10737.1 10904.9 11086.8 11090.6 12:17:37 INFO - 2015-11-18 12:17:37,938 DEBUG : BROWSER_OUTPUT: 12:17:37 INFO - 2015-11-18 12:17:37,938 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5421.46 Median:5919.13 stddev:2753.23 (46.5%) stddev-sans-first:2745.06 12:17:37 INFO - 2015-11-18 12:17:37,939 DEBUG : BROWSER_OUTPUT: Values: 1485.3 1525.3 1791.0 1854.9 1860.5 6901.5 7097.6 7573.8 7902.4 7902.7 7494.3 7671.2 7772.3 7789.8 7843.6 2283.2 2302.3 2317.6 2328.2 2336.8 2334.1 2358.6 2377.4 2379.6 2393.8 2312.9 2333.2 2362.6 2366.6 2367.6 2290.6 2301.1 2307.0 2330.4 2335.5 2351.3 2356.0 2386.9 2388.8 2389.4 7722.4 7800.8 7811.1 7818.1 7864.3 4858.4 4882.2 4889.2 4966.8 4968.8 2993.8 3272.1 3317.7 3361.0 3376.8 1027.2 1046.1 1056.8 1056.9 1066.1 10060.9 10087.5 10106.1 10109.5 10159.3 3298.5 3848.2 4273.8 4369.9 4375.0 8113.4 8205.3 8349.1 8410.5 8423.4 4895.8 4902.1 4932.8 4974.0 4977.9 4604.2 4610.8 4611.1 4623.7 4644.9 3487.2 3528.1 3549.0 3563.0 3567.9 1060.6 1134.7 1145.3 1150.3 1153.1 1210.4 1261.6 1283.7 1309.3 1362.6 7347.1 7447.1 7450.4 7469.4 7478.3 478.7 481.7 482.5 482.5 498.8 5121.7 5862.4 5883.8 5954.5 5969.3 8512.7 8875.1 9230.7 9232.6 9302.2 9154.2 9200.7 9215.0 9220.4 9237.4 7281.1 7468.7 7492.9 7495.0 7618.3 7321.7 7392.5 7393.1 7433.9 7486.6 8117.7 8282.7 8383.2 8387.2 8403.1 8541.1 8595.7 8599.2 8605.6 8608.4 6521.9 6573.4 6598.2 6605.8 6636.5 7569.3 7577.1 7587.5 7600.5 7603.2 5870.2 6919.3 7057.0 7096.9 7183.2 6937.7 6942.0 6958.9 6991.5 7042.7 7089.5 7112.9 7140.4 7191.0 7234.3 6528.7 6559.6 6567.0 6574.0 6585.7 5483.5 5717.3 6567.4 6591.6 6601.8 12:17:37 INFO - 2015-11-18 12:17:37,939 DEBUG : BROWSER_OUTPUT: 12:17:37 INFO - 2015-11-18 12:17:37,939 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5997.00 Median:6813.06 stddev:1966.88 (28.9%) stddev-sans-first:1925.08 12:17:37 INFO - 2015-11-18 12:17:37,941 DEBUG : BROWSER_OUTPUT: Values: 283.7 325.5 328.4 329.1 329.4 6753.5 6896.8 6902.2 6981.6 7051.2 6497.0 6897.8 6905.1 6948.1 6958.9 4863.6 5034.0 5034.3 5054.4 5063.0 5038.2 5041.4 5052.0 5056.5 5067.4 4957.3 4984.1 4995.8 5002.1 5019.4 4995.2 4998.0 4999.3 5003.1 5011.8 3545.8 4119.3 4212.1 4231.8 4236.9 5444.4 6501.7 6595.1 6601.9 6626.3 5434.7 5910.6 5910.6 5911.9 5936.3 6522.3 7097.9 7315.5 7326.7 7363.2 4662.0 4697.5 4701.7 4706.3 4714.4 7709.0 7823.0 7824.7 7828.7 7834.6 4768.2 4774.3 4776.8 4781.6 4784.0 4652.3 4803.0 4808.5 4854.7 4859.2 5743.8 5769.8 5816.0 5816.6 5820.7 5863.6 7307.0 7309.1 7318.7 7358.4 1344.7 1413.9 1626.4 1676.6 1695.3 1064.1 1070.8 1075.5 1080.6 1084.6 6732.5 6872.6 6889.5 6896.4 6912.4 7773.6 7816.5 7818.8 7825.6 7838.6 7028.2 7047.3 7051.2 7058.4 7102.6 3932.6 4108.0 4116.0 4125.6 4133.3 8041.0 8079.1 8085.3 8086.2 8112.9 6659.9 7677.3 7985.1 8036.7 8065.7 8053.8 8062.3 8082.3 8089.1 8090.9 7745.9 7760.2 7777.9 7787.1 7793.4 7276.8 7528.5 7567.7 7573.6 7623.4 8032.3 8078.8 8080.1 8084.0 8096.2 4263.3 4713.3 4751.9 4774.9 4794.4 7416.8 7661.8 7680.4 7682.8 7687.6 6623.2 6727.8 7384.9 7390.7 7417.0 7077.9 7343.3 7359.2 7368.0 7374.1 6437.0 6590.9 7219.6 7259.0 7290.7 5811.4 7048.0 7151.5 7264.3 7348.3 7244.4 7252.9 7262.5 7268.2 7299.5 12:17:37 INFO - 2015-11-18 12:17:37,941 DEBUG : BROWSER_OUTPUT: 12:17:37 INFO - 2015-11-18 12:17:37,941 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:17821.83 Median:53703.69 stddev:25420.24 (47.3%) stddev-sans-first:25458.59 12:17:37 INFO - 2015-11-18 12:17:37,942 DEBUG : BROWSER_OUTPUT: Values: 580.6 703.5 715.6 743.3 799.1 15241.1 15604.2 15650.9 15665.7 15733.7 11576.5 14190.2 14348.5 14429.9 14452.5 933.5 955.8 958.7 959.2 961.6 951.0 954.6 963.8 966.4 968.6 992.5 1000.1 1000.5 1006.6 1016.7 879.3 995.3 1000.6 1005.0 1006.6 722.5 730.6 732.5 735.6 747.8 13237.7 13372.7 13375.9 13400.8 13495.4 9336.9 9369.6 9518.4 9543.8 9813.6 9583.4 9770.6 9936.3 10373.5 10419.7 2781.4 3273.7 3408.1 3417.1 3449.9 63847.7 63959.0 67172.6 71052.2 78175.6 7104.7 7127.4 7190.9 7228.0 7339.7 11649.9 12214.0 12656.7 12794.6 12929.0 6519.0 6590.4 6717.1 6773.7 6794.2 4073.1 4124.4 4143.3 4228.4 4374.1 3118.9 3130.9 3132.8 3139.5 3147.8 474.0 476.0 481.7 482.7 485.2 494.2 494.8 508.3 521.3 560.5 7940.6 7948.1 8472.7 8620.1 8806.0 577.5 587.5 590.4 611.1 623.2 4396.8 4443.8 4504.6 4549.8 4565.4 67652.0 89377.2 92054.5 92396.0 94167.5 76546.6 78592.0 87564.6 87950.0 88238.6 67210.0 69954.3 70270.9 72850.0 75279.0 7934.5 9055.5 9125.5 9170.1 9187.4 52429.0 52475.0 53369.5 54037.9 54878.9 68972.0 70122.6 70332.0 70454.2 72879.0 11679.8 11885.8 11950.5 12410.1 12594.5 11842.6 12081.1 12084.5 12191.4 12552.7 9958.4 11539.1 11973.2 12233.2 12238.0 11057.8 11452.0 11514.4 11812.7 12026.7 11425.4 11670.4 11783.1 11879.0 12092.6 8657.3 9717.8 9798.3 10318.8 10523.1 8094.4 10217.3 10296.8 10332.8 10392.1 12:17:37 INFO - 2015-11-18 12:17:37,942 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:17:37 INFO - 2015-11-18 12:17:37,942 DEBUG : BROWSER_OUTPUT: 12:17:38 INFO - 2015-11-18 12:17:38,371 INFO : Browser exited with error code: 0 12:17:38 INFO - 2015-11-18 12:17:38,395 INFO : Completed test dromaeo_css (00:18:28) 12:17:38 INFO - 2015-11-18 12:17:38,396 INFO : Starting test kraken 12:17:38 INFO - 2015-11-18 12:17:38,396 DEBUG : operating with platform_type : mac_ 12:17:38 INFO - 2015-11-18 12:17:38,396 INFO : Initialising browser for kraken test... 12:17:38 INFO - 2015-11-18 12:17:38,409 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/tmpfh6CDJ/profile http://localhost:57246/getInfo.html 12:17:40 INFO - 2015-11-18 12:17:40,958 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:17:40 INFO - 2015-11-18 12:17:40,958 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:17:40 INFO - 2015-11-18 12:17:40,958 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 12:17:40 INFO - 2015-11-18 12:17:40,958 DEBUG : BROWSER_OUTPUT: __metrics 12:17:41 INFO - 2015-11-18 12:17:41,550 INFO : Browser initialized. 12:17:41 INFO - 2015-11-18 12:17:41,550 INFO : Running cycle 1/1 for kraken test... 12:17:41 INFO - 2015-11-18 12:17:41,551 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/tmpfh6CDJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:17:53 INFO - 2015-11-18 12:17:53,403 DEBUG : BROWSER_OUTPUT: RSS: Main: 237146112 12:17:53 INFO - 2015-11-18 12:17:53,404 DEBUG : BROWSER_OUTPUT: 12:17:56 INFO - 2015-11-18 12:17:56,145 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57246/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57246/tests/kraken/driver.html?testName=audio-beat-detection) 12:17:56 INFO - 2015-11-18 12:17:56,768 DEBUG : BROWSER_OUTPUT: RSS: Main: 249307136 12:17:56 INFO - 2015-11-18 12:17:56,768 DEBUG : BROWSER_OUTPUT: 12:17:59 INFO - 2015-11-18 12:17:59,423 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57246/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57246/tests/kraken/driver.html?testName=audio-dft) 12:18:00 INFO - 2015-11-18 12:18:00,024 DEBUG : BROWSER_OUTPUT: RSS: Main: 258568192 12:18:00 INFO - 2015-11-18 12:18:00,024 DEBUG : BROWSER_OUTPUT: 12:18:03 INFO - 2015-11-18 12:18:03,233 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57246/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57246/tests/kraken/driver.html?testName=audio-fft) 12:18:03 INFO - 2015-11-18 12:18:03,821 DEBUG : BROWSER_OUTPUT: RSS: Main: 261312512 12:18:03 INFO - 2015-11-18 12:18:03,821 DEBUG : BROWSER_OUTPUT: 12:18:05 INFO - 2015-11-18 12:18:05,816 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57246/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57246/tests/kraken/driver.html?testName=audio-oscillator) 12:18:06 INFO - 2015-11-18 12:18:06,420 DEBUG : BROWSER_OUTPUT: RSS: Main: 263614464 12:18:06 INFO - 2015-11-18 12:18:06,421 DEBUG : BROWSER_OUTPUT: 12:18:08 INFO - 2015-11-18 12:18:08,486 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57246/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57246/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:18:09 INFO - 2015-11-18 12:18:09,070 DEBUG : BROWSER_OUTPUT: RSS: Main: 263786496 12:18:09 INFO - 2015-11-18 12:18:09,070 DEBUG : BROWSER_OUTPUT: 12:18:11 INFO - 2015-11-18 12:18:11,909 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57246/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57246/tests/kraken/driver.html?testName=imaging-darkroom) 12:18:12 INFO - 2015-11-18 12:18:12,509 DEBUG : BROWSER_OUTPUT: RSS: Main: 265322496 12:18:12 INFO - 2015-11-18 12:18:12,509 DEBUG : BROWSER_OUTPUT: 12:18:15 INFO - 2015-11-18 12:18:15,526 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57246/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57246/tests/kraken/driver.html?testName=imaging-desaturate) 12:18:16 INFO - 2015-11-18 12:18:16,121 DEBUG : BROWSER_OUTPUT: RSS: Main: 265261056 12:18:16 INFO - 2015-11-18 12:18:16,121 DEBUG : BROWSER_OUTPUT: 12:18:19 INFO - 2015-11-18 12:18:19,003 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57246/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57246/tests/kraken/driver.html?testName=json-parse-financial) 12:18:19 INFO - 2015-11-18 12:18:19,606 DEBUG : BROWSER_OUTPUT: RSS: Main: 263872512 12:18:19 INFO - 2015-11-18 12:18:19,607 DEBUG : BROWSER_OUTPUT: 12:18:21 INFO - 2015-11-18 12:18:21,124 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57246/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57246/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:18:21 INFO - 2015-11-18 12:18:21,706 DEBUG : BROWSER_OUTPUT: RSS: Main: 263897088 12:18:21 INFO - 2015-11-18 12:18:21,706 DEBUG : BROWSER_OUTPUT: 12:18:23 INFO - 2015-11-18 12:18:23,570 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57246/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57246/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:18:24 INFO - 2015-11-18 12:18:24,201 DEBUG : BROWSER_OUTPUT: RSS: Main: 264736768 12:18:24 INFO - 2015-11-18 12:18:24,201 DEBUG : BROWSER_OUTPUT: 12:18:26 INFO - 2015-11-18 12:18:26,227 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57246/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57246/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:18:26 INFO - 2015-11-18 12:18:26,815 DEBUG : BROWSER_OUTPUT: RSS: Main: 264937472 12:18:26 INFO - 2015-11-18 12:18:26,816 DEBUG : BROWSER_OUTPUT: 12:18:29 INFO - 2015-11-18 12:18:29,365 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57246/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:18:29 INFO - 2015-11-18 12:18:29,983 DEBUG : BROWSER_OUTPUT: RSS: Main: 264364032 12:18:29 INFO - 2015-11-18 12:18:29,983 DEBUG : BROWSER_OUTPUT: 12:18:32 INFO - 2015-11-18 12:18:32,488 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:18:33 INFO - 2015-11-18 12:18:33,079 DEBUG : BROWSER_OUTPUT: RSS: Main: 264384512 12:18:33 INFO - 2015-11-18 12:18:33,079 DEBUG : BROWSER_OUTPUT: 12:18:34 INFO - 2015-11-18 12:18:34,715 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57246/tests/kraken/driver.html?testName=ai-astar) 12:18:34 INFO - 2015-11-18 12:18:34,972 DEBUG : BROWSER_OUTPUT: RSS: Main: 265248768 12:18:34 INFO - 2015-11-18 12:18:34,972 DEBUG : BROWSER_OUTPUT: 12:18:34 INFO - 2015-11-18 12:18:34,972 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:18:34 INFO - 2015-11-18 12:18:34,972 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:18:34 INFO - 2015-11-18 12:18:34,972 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:18:34 INFO - 2015-11-18 12:18:34,972 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:18:34 INFO - 2015-11-18 12:18:34,972 DEBUG : BROWSER_OUTPUT: |0;ai-astar;115;109;117;118;116;126;114;118;117;114 12:18:34 INFO - 2015-11-18 12:18:34,972 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;143;121;160;172;119;141;152;146;159;151 12:18:34 INFO - 2015-11-18 12:18:34,973 DEBUG : BROWSER_OUTPUT: |2;audio-dft;197;192;193;201;205;219;195;199;198;197 12:18:34 INFO - 2015-11-18 12:18:34,973 DEBUG : BROWSER_OUTPUT: |3;audio-fft;64;65;88;148;66;56;61;76;146;81 12:18:34 INFO - 2015-11-18 12:18:34,973 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;79;81;129;108;97;86;112;77;76;110 12:18:34 INFO - 2015-11-18 12:18:34,973 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;101;117;88;103;122;89;119;88;89;88 12:18:34 INFO - 2015-11-18 12:18:34,973 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;122;96;96;95;95;96;109;111;149;151 12:18:34 INFO - 2015-11-18 12:18:34,973 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;149;146;93;90;90;93;93;91;89;116 12:18:34 INFO - 2015-11-18 12:18:34,973 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;60;60;59;59;61;59;59;64;59;58 12:18:34 INFO - 2015-11-18 12:18:34,973 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;66;65;66;65;68;66;67;91;98;98 12:18:34 INFO - 2015-11-18 12:18:34,973 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;85;85;82;87;85;85;83;85;84 12:18:34 INFO - 2015-11-18 12:18:34,973 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;142;121;129;124;124;130;133;105;134;142 12:18:34 INFO - 2015-11-18 12:18:34,973 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;135;141;170;168;159;137;135;136;136 12:18:34 INFO - 2015-11-18 12:18:34,973 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;64;67;65;66;67;64;67;66;65;87 12:18:34 INFO - 2015-11-18 12:18:34,973 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:18:34 INFO - 2015-11-18 12:18:34,973 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:18:34 INFO - 2015-11-18 12:18:34,974 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,826 12:18:34 INFO - 2015-11-18 12:18:34,974 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:18:34 INFO - 2015-11-18 12:18:34,974 DEBUG : BROWSER_OUTPUT: __startTimestamp1447877914966__endTimestamp 12:18:34 INFO - 2015-11-18 12:18:34,974 DEBUG : BROWSER_OUTPUT: 12:18:34 INFO - 2015-11-18 12:18:34,974 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:18:34 INFO - 2015-11-18 12:18:34,974 DEBUG : BROWSER_OUTPUT: Number of tests: 14 12:18:34 INFO - 2015-11-18 12:18:34,974 DEBUG : BROWSER_OUTPUT: 12:18:34 INFO - 2015-11-18 12:18:34,974 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:116.40 Median:117.00 stddev:4.30 (3.7%) stddev-sans-first:4.53 12:18:34 INFO - 2015-11-18 12:18:34,974 DEBUG : BROWSER_OUTPUT: Values: 115.0 109.0 117.0 118.0 116.0 126.0 114.0 118.0 117.0 114.0 12:18:34 INFO - 2015-11-18 12:18:34,974 DEBUG : BROWSER_OUTPUT: 12:18:34 INFO - 2015-11-18 12:18:34,974 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.40 Median:151.50 stddev:16.63 (11.0%) stddev-sans-first:17.59 12:18:34 INFO - 2015-11-18 12:18:34,974 DEBUG : BROWSER_OUTPUT: Values: 143.0 121.0 160.0 172.0 119.0 141.0 152.0 146.0 159.0 151.0 12:18:34 INFO - 2015-11-18 12:18:34,974 DEBUG : BROWSER_OUTPUT: 12:18:34 INFO - 2015-11-18 12:18:34,974 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:199.60 Median:198.50 stddev:7.79 (3.9%) stddev-sans-first:8.21 12:18:34 INFO - 2015-11-18 12:18:34,975 DEBUG : BROWSER_OUTPUT: Values: 197.0 192.0 193.0 201.0 205.0 219.0 195.0 199.0 198.0 197.0 12:18:34 INFO - 2015-11-18 12:18:34,975 DEBUG : BROWSER_OUTPUT: 12:18:34 INFO - 2015-11-18 12:18:34,975 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:85.10 Median:65.50 stddev:34.02 (51.9%) stddev-sans-first:35.21 12:18:34 INFO - 2015-11-18 12:18:34,975 DEBUG : BROWSER_OUTPUT: Values: 64.0 65.0 88.0 148.0 66.0 56.0 61.0 76.0 146.0 81.0 12:18:34 INFO - 2015-11-18 12:18:34,975 DEBUG : BROWSER_OUTPUT: 12:18:34 INFO - 2015-11-18 12:18:34,975 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:95.50 Median:78.00 stddev:18.43 (23.6%) stddev-sans-first:18.56 12:18:34 INFO - 2015-11-18 12:18:34,975 DEBUG : BROWSER_OUTPUT: Values: 79.0 81.0 129.0 108.0 97.0 86.0 112.0 77.0 76.0 110.0 12:18:34 INFO - 2015-11-18 12:18:34,975 DEBUG : BROWSER_OUTPUT: 12:18:34 INFO - 2015-11-18 12:18:34,975 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:100.40 Median:88.00 stddev:14.21 (16.1%) stddev-sans-first:15.07 12:18:34 INFO - 2015-11-18 12:18:34,975 DEBUG : BROWSER_OUTPUT: Values: 101.0 117.0 88.0 103.0 122.0 89.0 119.0 88.0 89.0 88.0 12:18:34 INFO - 2015-11-18 12:18:34,975 DEBUG : BROWSER_OUTPUT: 12:18:34 INFO - 2015-11-18 12:18:34,975 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:112.00 Median:95.00 stddev:21.97 (23.1%) stddev-sans-first:23.01 12:18:34 INFO - 2015-11-18 12:18:34,975 DEBUG : BROWSER_OUTPUT: Values: 122.0 96.0 96.0 95.0 95.0 96.0 109.0 111.0 149.0 151.0 12:18:34 INFO - 2015-11-18 12:18:34,975 DEBUG : BROWSER_OUTPUT: 12:18:34 INFO - 2015-11-18 12:18:34,976 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:105.00 Median:90.50 stddev:23.74 (26.2%) stddev-sans-first:19.11 12:18:34 INFO - 2015-11-18 12:18:34,976 DEBUG : BROWSER_OUTPUT: Values: 149.0 146.0 93.0 90.0 90.0 93.0 93.0 91.0 89.0 116.0 12:18:34 INFO - 2015-11-18 12:18:34,976 DEBUG : BROWSER_OUTPUT: 12:18:34 INFO - 2015-11-18 12:18:34,976 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.80 Median:59.50 stddev:1.69 (2.8%) stddev-sans-first:1.79 12:18:34 INFO - 2015-11-18 12:18:34,976 DEBUG : BROWSER_OUTPUT: Values: 60.0 60.0 59.0 59.0 61.0 59.0 59.0 64.0 59.0 58.0 12:18:34 INFO - 2015-11-18 12:18:34,976 DEBUG : BROWSER_OUTPUT: 12:18:34 INFO - 2015-11-18 12:18:34,976 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:75.00 Median:67.50 stddev:14.41 (21.4%) stddev-sans-first:14.92 12:18:34 INFO - 2015-11-18 12:18:34,976 DEBUG : BROWSER_OUTPUT: Values: 66.0 65.0 66.0 65.0 68.0 66.0 67.0 91.0 98.0 98.0 12:18:34 INFO - 2015-11-18 12:18:34,976 DEBUG : BROWSER_OUTPUT: 12:18:34 INFO - 2015-11-18 12:18:34,976 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:85.00 stddev:1.43 (1.7%) stddev-sans-first:1.42 12:18:34 INFO - 2015-11-18 12:18:34,976 DEBUG : BROWSER_OUTPUT: Values: 83.0 85.0 85.0 82.0 87.0 85.0 85.0 83.0 85.0 84.0 12:18:34 INFO - 2015-11-18 12:18:34,976 DEBUG : BROWSER_OUTPUT: 12:18:34 INFO - 2015-11-18 12:18:34,976 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:128.40 Median:131.50 stddev:10.89 (8.3%) stddev-sans-first:10.37 12:18:34 INFO - 2015-11-18 12:18:34,977 DEBUG : BROWSER_OUTPUT: Values: 142.0 121.0 129.0 124.0 124.0 130.0 133.0 105.0 134.0 142.0 12:18:34 INFO - 2015-11-18 12:18:34,977 DEBUG : BROWSER_OUTPUT: 12:18:34 INFO - 2015-11-18 12:18:34,977 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.50 Median:139.50 stddev:14.29 (10.2%) stddev-sans-first:14.90 12:18:34 INFO - 2015-11-18 12:18:34,977 DEBUG : BROWSER_OUTPUT: Values: 138.0 135.0 141.0 170.0 168.0 159.0 137.0 135.0 136.0 136.0 12:18:34 INFO - 2015-11-18 12:18:34,977 DEBUG : BROWSER_OUTPUT: 12:18:34 INFO - 2015-11-18 12:18:34,977 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:66.50 stddev:6.84 (10.3%) stddev-sans-first:7.12 12:18:34 INFO - 2015-11-18 12:18:34,977 DEBUG : BROWSER_OUTPUT: Values: 64.0 67.0 65.0 66.0 67.0 64.0 67.0 66.0 65.0 87.0 12:18:34 INFO - 2015-11-18 12:18:34,977 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:18:34 INFO - 2015-11-18 12:18:34,977 DEBUG : BROWSER_OUTPUT: 12:18:35 INFO - 2015-11-18 12:18:35,601 INFO : Browser exited with error code: 0 12:18:35 INFO - 2015-11-18 12:18:35,646 INFO : Completed test kraken (00:00:57) 12:18:35 INFO - 2015-11-18 12:18:35,646 INFO : Starting test v8_7 12:18:35 INFO - 2015-11-18 12:18:35,646 DEBUG : operating with platform_type : mac_ 12:18:35 INFO - 2015-11-18 12:18:35,647 INFO : Initialising browser for v8_7 test... 12:18:35 INFO - 2015-11-18 12:18:35,660 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/tmpCdufQ9/profile http://localhost:57246/getInfo.html 12:18:38 INFO - 2015-11-18 12:18:38,156 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:18:38 INFO - 2015-11-18 12:18:38,156 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:18:38 INFO - 2015-11-18 12:18:38,156 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 12:18:38 INFO - 2015-11-18 12:18:38,156 DEBUG : BROWSER_OUTPUT: __metrics 12:18:38 INFO - 2015-11-18 12:18:38,751 INFO : Browser initialized. 12:18:38 INFO - 2015-11-18 12:18:38,752 INFO : Running cycle 1/1 for v8_7 test... 12:18:38 INFO - 2015-11-18 12:18:38,752 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/tmpCdufQ9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:18:50 INFO - 2015-11-18 12:18:50,657 DEBUG : BROWSER_OUTPUT: RSS: Main: 237199360 12:18:50 INFO - 2015-11-18 12:18:50,657 DEBUG : BROWSER_OUTPUT: 12:19:12 INFO - 2015-11-18 12:19:12,043 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57246/tests/v8_7/run.html (next: http://localhost:57246/tests/v8_7/run.html) 12:19:12 INFO - 2015-11-18 12:19:12,303 DEBUG : BROWSER_OUTPUT: RSS: Main: 247484416 12:19:12 INFO - 2015-11-18 12:19:12,303 DEBUG : BROWSER_OUTPUT: 12:19:12 INFO - 2015-11-18 12:19:12,303 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:19:12 INFO - 2015-11-18 12:19:12,303 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:19:12 INFO - 2015-11-18 12:19:12,303 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:19:12 INFO - 2015-11-18 12:19:12,303 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:19:12 INFO - 2015-11-18 12:19:12,303 DEBUG : BROWSER_OUTPUT: |0;Richards;622.66500622665 12:19:12 INFO - 2015-11-18 12:19:12,303 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;157.08451146716934 12:19:12 INFO - 2015-11-18 12:19:12,303 DEBUG : BROWSER_OUTPUT: |2;Encrypt;287.5215641173088 12:19:12 INFO - 2015-11-18 12:19:12,303 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4776.190476190476 12:19:12 INFO - 2015-11-18 12:19:12,303 DEBUG : BROWSER_OUTPUT: |4;RayTrace;949.667616334283 12:19:12 INFO - 2015-11-18 12:19:12,304 DEBUG : BROWSER_OUTPUT: |5;Earley;1053.740779768177 12:19:12 INFO - 2015-11-18 12:19:12,304 DEBUG : BROWSER_OUTPUT: |6;Boyer;13025.641025641025 12:19:12 INFO - 2015-11-18 12:19:12,304 DEBUG : BROWSER_OUTPUT: |7;RegExp;27675.675675675677 12:19:12 INFO - 2015-11-18 12:19:12,304 DEBUG : BROWSER_OUTPUT: |8;Splay;843.8818565400844 12:19:12 INFO - 2015-11-18 12:19:12,304 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4513.513513513513 12:19:12 INFO - 2015-11-18 12:19:12,304 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:19:12 INFO - 2015-11-18 12:19:12,304 DEBUG : BROWSER_OUTPUT: __startTimestamp1447877952294__endTimestamp 12:19:12 INFO - 2015-11-18 12:19:12,304 DEBUG : BROWSER_OUTPUT: 12:19:12 INFO - 2015-11-18 12:19:12,304 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:19:12 INFO - 2015-11-18 12:19:12,304 DEBUG : BROWSER_OUTPUT: Number of tests: 10 12:19:12 INFO - 2015-11-18 12:19:12,304 DEBUG : BROWSER_OUTPUT: 12:19:12 INFO - 2015-11-18 12:19:12,304 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:622.67 Median:622.67 stddev:0.00 (0.0%) 12:19:12 INFO - 2015-11-18 12:19:12,304 DEBUG : BROWSER_OUTPUT: Values: 622.7 12:19:12 INFO - 2015-11-18 12:19:12,304 DEBUG : BROWSER_OUTPUT: 12:19:12 INFO - 2015-11-18 12:19:12,305 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:157.08 Median:157.08 stddev:0.00 (0.0%) 12:19:12 INFO - 2015-11-18 12:19:12,305 DEBUG : BROWSER_OUTPUT: Values: 157.1 12:19:12 INFO - 2015-11-18 12:19:12,305 DEBUG : BROWSER_OUTPUT: 12:19:12 INFO - 2015-11-18 12:19:12,305 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:287.52 Median:287.52 stddev:0.00 (0.0%) 12:19:12 INFO - 2015-11-18 12:19:12,305 DEBUG : BROWSER_OUTPUT: Values: 287.5 12:19:12 INFO - 2015-11-18 12:19:12,305 DEBUG : BROWSER_OUTPUT: 12:19:12 INFO - 2015-11-18 12:19:12,305 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4776.19 Median:4776.19 stddev:0.00 (0.0%) 12:19:12 INFO - 2015-11-18 12:19:12,305 DEBUG : BROWSER_OUTPUT: Values: 4776.2 12:19:12 INFO - 2015-11-18 12:19:12,305 DEBUG : BROWSER_OUTPUT: 12:19:12 INFO - 2015-11-18 12:19:12,305 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:949.67 Median:949.67 stddev:0.00 (0.0%) 12:19:12 INFO - 2015-11-18 12:19:12,305 DEBUG : BROWSER_OUTPUT: Values: 949.7 12:19:12 INFO - 2015-11-18 12:19:12,305 DEBUG : BROWSER_OUTPUT: 12:19:12 INFO - 2015-11-18 12:19:12,305 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:1053.74 Median:1053.74 stddev:0.00 (0.0%) 12:19:12 INFO - 2015-11-18 12:19:12,305 DEBUG : BROWSER_OUTPUT: Values: 1053.7 12:19:12 INFO - 2015-11-18 12:19:12,306 DEBUG : BROWSER_OUTPUT: 12:19:12 INFO - 2015-11-18 12:19:12,306 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:13025.64 Median:13025.64 stddev:0.00 (0.0%) 12:19:12 INFO - 2015-11-18 12:19:12,306 DEBUG : BROWSER_OUTPUT: Values: 13025.6 12:19:12 INFO - 2015-11-18 12:19:12,306 DEBUG : BROWSER_OUTPUT: 12:19:12 INFO - 2015-11-18 12:19:12,306 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27675.68 Median:27675.68 stddev:0.00 (0.0%) 12:19:12 INFO - 2015-11-18 12:19:12,306 DEBUG : BROWSER_OUTPUT: Values: 27675.7 12:19:12 INFO - 2015-11-18 12:19:12,306 DEBUG : BROWSER_OUTPUT: 12:19:12 INFO - 2015-11-18 12:19:12,306 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:843.88 Median:843.88 stddev:0.00 (0.0%) 12:19:12 INFO - 2015-11-18 12:19:12,306 DEBUG : BROWSER_OUTPUT: Values: 843.9 12:19:12 INFO - 2015-11-18 12:19:12,306 DEBUG : BROWSER_OUTPUT: 12:19:12 INFO - 2015-11-18 12:19:12,306 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4513.51 Median:4513.51 stddev:0.00 (0.0%) 12:19:12 INFO - 2015-11-18 12:19:12,306 DEBUG : BROWSER_OUTPUT: Values: 4513.5 12:19:12 INFO - 2015-11-18 12:19:12,306 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:19:12 INFO - 2015-11-18 12:19:12,307 DEBUG : BROWSER_OUTPUT: 12:19:13 INFO - 2015-11-18 12:19:13,074 INFO : Browser exited with error code: 0 12:19:13 INFO - 2015-11-18 12:19:13,091 INFO : Completed test v8_7 (00:00:37) 12:19:13 INFO - 2015-11-18 12:19:13,385 INFO : Completed test suite (00:20:03) 12:19:13 INFO - 2015-11-18 12:19:13,385 DEBUG : Working with test: dromaeo_css 12:19:13 INFO - 2015-11-18 12:19:13,385 DEBUG : Generating results file: dromaeo_css 12:19:13 INFO - 2015-11-18 12:19:13,386 DEBUG : Working with test: kraken 12:19:13 INFO - 2015-11-18 12:19:13,386 DEBUG : Generating results file: kraken 12:19:13 INFO - 2015-11-18 12:19:13,386 INFO : javascript benchmark 12:19:13 INFO - 2015-11-18 12:19:13,386 DEBUG : Working with test: v8_7 12:19:13 INFO - 2015-11-18 12:19:13,386 DEBUG : Generating results file: v8_7 12:19:13 INFO - 2015-11-18 12:19:13,386 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:19:13 INFO - 2015-11-18 12:19:13,444 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 12:19:13 INFO - 2015-11-18 12:19:13,444 DEBUG : process_Request line: dromaeo_css 7076.99 graph.html#tests=[[72,64,61]] 12:19:13 INFO - 2015-11-18 12:19:13,444 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:19:13 INFO - 2015-11-18 12:19:13,476 DEBUG : process_Request line: kraken 1521.30 graph.html#tests=[[232,64,61]] 12:19:13 INFO - 2015-11-18 12:19:13,476 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:19:13 INFO - 2015-11-18 12:19:13,506 DEBUG : process_Request line: v8_7 17915.33 graph.html#tests=[[230,64,61]] 12:19:13 INFO - 2015-11-18 12:19:13,507 INFO : javascript benchmark 12:19:13 INFO - 2015-11-18 12:19:13,509 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3256.2673398485344, 3393.5079413485046, 3399.7280217582597, 3449.3963556377644, 3493.772904761189, 4750.952490475094, 5591.580631452637, 5638.267025286717, 5671.319441667, 5713.485786279234, 5511.9724401377935, 5539.889202215953, 5680.914786278209, 5695.117256825199, 5755.827325180241, 4466.441694788152, 5088.745562721859, 5165.992631436871, 5206.062908676437, 5296.09966305729, 5106.617003724717, 5146.845594632167, 5319.388270348902, 5321.467853214686, 5343.438938911417, 5067.467915868818, 5217.58259339252, 5227.3465816772905, 5252.921206181911, 5295.152775555912, 5064.898702025939, 5165.741712914377, 5177.611679124081, 5181.274621552986, 5187.221916712486, 5157.174852023658, 5228.686278823283, 5248.160294352923, 5257.815976440845, 5264.763085661154, 5183.118869792144, 5266.92099618506, 5434.565234781208, 5552.194931734916, 5595.944040559583, 6219.160413344186, 6222.43998040174, 6241.032639940817, 6264.686765661699, 6267.937320626781, 6289.339619339995, 6293.590916590407, 6294.968525157345, 6314.305426403092, 6321.367863213642, 5656.858578535528, 5711.685857277848, 5801.245838041028, 5863.970680146572, 5880.9411905880825, 6293.590916590407, 6318.526110541728, 6359.046143078575, 6367.4906007519285, 6371.745130194833, 6168.0439531872635, 6175.876482470415, 6179.258488981351, 6180.567360284737, 6199.132121502993, 5934.0, 5989.371116032841, 6137.232845894263, 6245.968770156211, 6247.718852651642, 6191.19514463117, 6198.504119670415, 6217.564770466114, 6236.812895613139, 6242.531810114259, 5912.142739302863, 6211.440970312694, 6259.843503912439, 6261.373862613702, 6268.937310626927, 4325.567443255649, 4854.563089321978, 4864.927026094611, 4918.729469879191, 4948.035133149074, 4439.445069366329, 4447.555244475527, 4483.596476317147, 4506.0, 4522.389477420572, 5448.618596698272, 5667.631603945731, 5757.280339957505, 5785.681787501728, 5799.246098007232, 5198.376194856642, 6137.938620613737, 6235.3452887446165, 6284.497240220771, 6308.905366419507, 5691.146328050742, 5704.11586204139, 5757.568182386254, 5757.913631295534, 5788.565857560699, 5240.71176085319, 5380.892382152335, 5392.352917649907, 5399.271098401744, 5407.242985981966, 5761.711914404263, 6065.181200537871, 6079.817605471843, 6371.617702937839, 6435.485161187094, 5661.631993920382, 6326.6836658165985, 6344.651044192614, 6359.872802544016, 6361.427471527585, 5159.742012899265, 6192.938070619236, 6357.396047375492, 6361.491080713439, 6407.583507072025, 6230.376962303733, 6235.968820156052, 6244.937550624436, 6246.562740608114, 6256.5307601930945, 6318.0838778375955, 6330.620162790247, 6336.112944187909, 6341.619502829845, 6355.745770169141, 5267.473252674855, 5740.741666624928, 5912.817436512801, 5919.733611987557, 6132.908006379818, 5998.880022399615, 6064.211652485149, 6069.969650151721, 6075.2405949256345, 6098.573099882966, 5882.0, 5915.645061296336, 5919.993601087739, 5931.792387266425, 5934.762609495572, 5763.36602973681, 5943.286805583358, 6025.975584150792, 6069.453749162597, 6070.484008859296, 5967.164596956516, 5974.492168165754, 5982.102684597346, 5982.611130276518, 5984.970075149597], "unit": "ms", "name": "dojo.html", "value": 5656.790652034358}, {"lowerIsBetter": false, "replicates": [515.0960065085774, 540.7728753923352, 582.2023827356522, 589.3899813692829, 617.9412955769202, 41678.16643667125, 42089.94775130616, 42182.7890860546, 42267.15465690692, 42348.15303693924, 44690.32964505535, 44991.55008449915, 45170.0, 45348.773256133754, 45476.3178552322, 9992.700218993423, 10067.49662516875, 10095.697129086102, 10107.444090575016, 10168.64409745659, 9899.45552994585, 10028.047335503115, 10034.147097496721, 10062.195024398066, 10101.141402980755, 9876.654317098903, 9900.158486528653, 10002.249831262649, 10005.349652272615, 10007.899921000806, 9981.550830212622, 10014.39913605186, 10017.899821001769, 10020.59917603295, 10057.849132263022, 9866.309358344919, 9975.70072897807, 9993.650222242259, 10011.549480273405, 10024.0, 41637.375439368436, 41819.790901045606, 41855.58144418578, 41974.79012604917, 42136.57863421357, 3248.772585918987, 3268.9346213075605, 3279.5736554247796, 3309.9503507447407, 3691.593924668284, 28732.281692957633, 29348.532573371245, 29865.850670746724, 30039.849800751075, 30492.932747353738, 2271.5684020036306, 2583.19920824545, 2591.9870400647874, 2613.294410509171, 2634.473105378932, 445504.0, 445769.7711511454, 446547.0, 447244.0, 448273.0, 38737.0, 46342.76828615835, 46400.53599463962, 46905.0, 46979.530204698196, 47121.0, 47430.5256947433, 47490.05019899583, 47659.52340476551, 47733.52266477291, 15444.768328475082, 15519.224038798015, 15560.0, 15590.064596124268, 15597.610059748597, 10413.635522756667, 12448.937755311166, 12515.186512876633, 12613.432395542222, 13027.674308142372, 15354.539363819104, 15380.61548461275, 15421.614459638598, 15441.919065665521, 15588.688226235412, 6565.80302590923, 6677.732890684415, 6680.465562754968, 6710.328967103251, 6718.596884186867, 803.2569872867574, 920.8480600700809, 1056.6037735849056, 1096.2819353323587, 1101.091599430473, 30497.0, 30822.830918975586, 30997.0700878974, 31074.0, 31306.843465782524, 1058.5448257249457, 1111.3443068589409, 1155.5955415604471, 1187.400362816772, 1206.2943178240828, 15638.609034774221, 15653.295601697951, 15749.763753543706, 15818.841811581737, 16024.679506409806, 455467.72266138456, 549226.0, 549771.0, 552379.0, 553870.0, 60284.397156028754, 60792.48018799565, 61023.0, 61284.693576531834, 61426.692866535384, 1429.756941319978, 1436.4685066525453, 1456.4975083596355, 1460.3793387810351, 1467.0537503310518, 23993.760062399153, 30184.24539386533, 30372.848135760065, 30585.23536911595, 30838.845805770827, 43474.34788478112, 53289.46710532845, 53567.19649205187, 53850.461495384545, 53978.73010634922, 498648.0, 502183.0, 502264.0, 504352.0, 509030.0, 33911.66088339085, 46788.0, 47582.52417475781, 48471.75764121157, 48543.0, 47013.0, 47384.0, 47440.0, 48597.757011216134, 48857.77855553498, 37220.6277937228, 38954.80522597369, 39358.212835743696, 40990.385144222266, 43007.78496107499, 39763.80118099391, 41194.176116476905, 41432.3785143217, 42452.787736061124, 42501.78749106234, 28670.856645716638, 31024.22439439032, 34604.13489662779, 38400.6159938397, 38598.61401386063, 33845.83077084599, 34243.65756342404, 34786.82606587052, 35100.82449587736, 35258.8237058813, 24180.39549011289, 25078.498430030933, 25456.23631291064, 25761.613575796004, 26330.60504092402], "unit": "ms", "name": "ext.html", "value": 19780.278309305326}, {"lowerIsBetter": false, "replicates": [358.8062446279008, 365.91583935694774, 365.9451082337649, 367.21232955310865, 367.52038589640523, 12350.258984460927, 12509.937450312736, 12691.301978391197, 12826.871731282685, 19221.903890480546, 12283.07876909231, 12327.198732082408, 12523.99808015359, 12567.748645027094, 12571.245725256491, 3713.554373475187, 4102.917941641165, 4748.620110391178, 4851.0, 4875.9756201219125, 5269.1832765921345, 5284.471552844704, 5286.550643195333, 5292.761825717852, 5340.465953404648, 5104.0, 5191.091558977164, 5219.86950326243, 5228.947710522884, 5274.525292723673, 5170.302009228743, 5180.922286165711, 5193.584513238932, 5201.2458193561915, 5215.921761173548, 4173.08192197716, 4404.031113155101, 4425.181341451809, 4444.866654000385, 4449.154660614473, 13353.132046416951, 13537.458501659921, 13676.384562694702, 13874.306284685725, 13978.440862365493, 1649.7772800671996, 1852.6202128563611, 1881.8306352428347, 1891.508207865951, 1942.8931408772512, 10023.047810457994, 10060.446675432848, 10097.394156350643, 10327.896721032768, 10343.534540945675, 1569.9686006279924, 1640.7949006374204, 1649.1424459281106, 1662.0443245134097, 1662.742274947385, 78796.60601697012, 82035.0, 83393.0, 90615.54692226562, 91707.99999999933, 6769.815282325573, 6819.659017049128, 6834.897476537856, 6840.0, 6887.655617219119, 7662.463627546018, 7725.22747725223, 7733.651985660659, 7757.418193635387, 7766.9611651942505, 5732.713364331767, 5742.224799651994, 5751.194832723339, 5777.335606405233, 5787.334456537468, 6164.445199932027, 6174.66039367839, 6212.9068063979075, 6215.533834962396, 6273.65494897785, 2889.624348834638, 2936.339323652161, 3042.39152169567, 3048.756099512034, 3100.5814215081127, 1088.7441451258949, 1090.095220966596, 1095.7589330347312, 1099.6206308823444, 1126.8674981643396, 382.0982481344026, 385.23146323085626, 423.2022637328658, 476.8045101508365, 478.7989044601276, 9243.907560924305, 10913.399763012952, 11082.889171108185, 11526.88473115275, 11687.766244675058, 411.1202027660808, 431.1291191792561, 440.70913197289633, 444.09626410255623, 452.7577745905925, 5981.5214782817275, 6023.427774361428, 6106.358832322631, 6112.419320164578, 6120.14317995481, 663349.0, 742622.2868885621, 754919.0, 760685.0, 770937.0, 88562.0, 108093.45953270183, 111203.0, 113573.4321328388, 113801.4309928445, 516.9302144210559, 535.2506490912675, 537.8278950735727, 540.2760301196415, 540.3839622829977, 10726.570937162738, 11905.226160299553, 11984.04127669767, 12004.819927701266, 12024.879751202376, 50116.0, 50526.24210636917, 50884.23673644824, 51004.44977751172, 51025.48974510356, 70441.29558704347, 71274.28725712885, 71308.93036604559, 72535.63732181305, 72749.27250727425, 6313.273973493107, 6361.618302901656, 6385.712642931172, 6408.359164083555, 6425.0, 11674.70813229676, 11792.882071179522, 12059.939700301442, 12320.260784352968, 12349.444275007825, 9970.651027214013, 10101.0, 10138.797224055625, 10757.515911784145, 10884.945575272073, 10490.160787137163, 10559.788804224027, 10618.0, 10669.679909602724, 10798.082163016232, 10081.193504519475, 10128.34165779222, 10253.33353332031, 10392.740181495523, 10930.56277748881, 6421.903671445026, 6449.516286278454, 6460.030995350735, 6465.0948867157695, 6503.154589903283, 10701.839472408075, 10737.14102871784, 10904.945475272572, 11086.833697494383, 11090.611828585961], "unit": "ms", "name": "jquery.html", "value": 7142.7103135879215}, {"lowerIsBetter": false, "replicates": [1485.3093311610098, 1525.252626213156, 1790.9731354029684, 1854.9072546372681, 1860.4976656302804, 6901.516174022597, 7097.574145551271, 7573.826056961166, 7902.407319451036, 7902.723404680844, 7494.288042635954, 7671.194524574909, 7772.3393511551585, 7789.805254868631, 7843.568603726792, 2283.1894677389537, 2302.26327575176, 2317.640765681322, 2328.2433209206993, 2336.836421450499, 2334.101370972171, 2358.6108292131776, 2377.4294169399304, 2379.6192609182535, 2393.7845593896545, 2312.8843557822124, 2333.1717240379676, 2362.6337917622795, 2366.633171858356, 2367.6093444581625, 2290.576243394977, 2301.0795681727277, 2306.9769302307013, 2330.4290448840143, 2335.544568809083, 2351.341624345169, 2355.9764402355927, 2386.940326491834, 2388.820838437124, 2389.3668177932864, 7722.382209423289, 7800.843983120306, 7811.140774514799, 7818.06183258007, 7864.2922137007945, 4858.368412106439, 4882.218844984785, 4889.168841296988, 4966.776495057731, 4968.801247950078, 2993.7754668399957, 3272.067460773692, 3317.668233176687, 3360.983195084009, 3376.848041838123, 1027.2244455436173, 1046.1222106319176, 1056.7622284985894, 1056.9365838049741, 1066.0565399621314, 10060.94969525155, 10087.49562521871, 10106.14097801695, 10109.494525273707, 10159.288849780518, 3298.505224216339, 3848.191879705237, 4273.829046838154, 4369.890752731144, 4374.993751437188, 8113.35093192555, 8205.302549283379, 8349.081601023883, 8410.453320534145, 8423.410361274651, 4895.8041678332465, 4902.093112774148, 4932.827351042768, 4973.950260497421, 4977.850664480072, 4604.194266003436, 4610.76946152691, 4611.077784443125, 4623.676342655982, 4644.930326045112, 3487.232808782064, 3528.1179705073732, 3549.0062782420964, 3563.0, 3567.910802229965, 1060.6499855047816, 1134.6539305511733, 1145.3013661666378, 1150.2983180260035, 1153.0890596428894, 1210.4189988805422, 1261.6467389131058, 1283.6598301450124, 1309.2668105860748, 1362.6048445950762, 7347.08161479815, 7447.1063472382575, 7450.403967682572, 7469.439792015512, 7478.326950574475, 478.6984199954007, 481.674869463111, 482.48615224785493, 482.4885621241425, 498.7730582584915, 5121.743912804345, 5862.355140934494, 5883.794067207627, 5954.46409823118, 5969.283685957713, 8512.659493620185, 8875.068117847663, 9230.723078307661, 9232.630694772268, 9302.16280534755, 9154.176124148858, 9200.6779762708, 9214.953925230331, 9220.400673956172, 9237.399569027992, 7281.1262648482525, 7468.738594149178, 7492.887606685904, 7494.962525187449, 7618.276263754934, 7321.707131714672, 7392.519486233377, 7393.149787774475, 7433.851322973402, 7486.588237646763, 8117.715879944174, 8282.71010514629, 8383.245507904317, 8387.161283871808, 8403.117672644528, 8541.060483346952, 8595.699150529701, 8599.226069653761, 8605.612747426507, 8608.354373421893, 6521.902171467526, 6573.375529324707, 6598.241202261801, 6605.801825945229, 6636.469082473294, 7569.318761311509, 7577.0907491101425, 7587.544747315179, 7600.46796724224, 7603.201663825219, 5870.178175055581, 6919.308069193041, 7057.0472986146215, 7096.858062838611, 7183.245759195209, 6937.722491100501, 6942.0, 6958.8956165658565, 6991.545549539263, 7042.683079261548, 7089.539179953286, 7112.928870711226, 7140.39306658919, 7191.0, 7234.312740289664, 6528.6735663215695, 6559.573627714183, 6567.0, 6574.04676321921, 6585.703643336157, 5483.533899618577, 5717.256756621613, 6567.408933196035, 6591.6374599397495, 6601.768938087144], "unit": "ms", "name": "mootools.html", "value": 4419.539829993362}, {"lowerIsBetter": false, "replicates": [283.7474647563668, 325.5393618030487, 328.3695305014372, 329.13109391207234, 329.4251531078269, 6753.527253092279, 6896.758613448524, 6902.206246281679, 6981.581105133696, 7051.224365319811, 6496.96751516243, 6897.758578449755, 6905.102336696223, 6948.062011628429, 6958.930410695892, 4863.589559027895, 5033.974830125844, 5034.270030845516, 5054.368203974504, 5062.974685126569, 5038.193888977764, 5041.445441001487, 5052.0, 5056.544910958013, 5067.366579177603, 4957.3059771632, 4984.077945580061, 4995.775190116436, 5002.074616195997, 5019.397672279313, 4995.175795993657, 4997.975010124963, 4999.3000979862845, 5003.099442100421, 5011.799528018875, 3545.769524980868, 4119.340905455113, 4212.115455754295, 4231.788410579458, 4236.851710190129, 5444.428335024805, 6501.732162228367, 6595.109660195908, 6601.910684737013, 6626.337366263383, 5434.695673038482, 5910.645361278337, 5910.645361278337, 5911.881762364728, 5936.257967754031, 6522.347765223487, 7097.89353159703, 7315.4879158458925, 7326.67029983652, 7363.153237377716, 4662.044280922437, 4697.53024697531, 4701.694389864648, 4706.341112244254, 4714.363560919266, 7708.961455192744, 7822.9608851955945, 7824.726134585262, 7828.725994590219, 7834.647440865175, 4768.1642567611025, 4774.3077253798, 4776.761161941889, 4781.617470602343, 4784.043191361672, 4652.255639097728, 4803.015381846713, 4808.519148085164, 4854.68444551103, 4859.24681674334, 5743.770249190069, 5769.798057067983, 5816.011278082736, 5816.592838501264, 5820.650760954356, 5863.648181109147, 7307.0, 7309.086364204474, 7318.670659820321, 7358.374538164316, 1344.737776133664, 1413.8515455876984, 1626.3657173702265, 1676.6143786929074, 1695.304924980752, 1064.11678307005, 1070.8286674132257, 1075.4783929794044, 1080.6433876820631, 1084.5553323137476, 6732.461403087741, 6872.587644741231, 6889.517733758689, 6896.448284137257, 6912.377885990184, 7773.572453515111, 7816.53100813953, 7818.843623127505, 7825.608719563999, 7838.568878711726, 7028.191757947901, 7047.295270472911, 7051.1891132519395, 7058.400035996998, 7102.644867756591, 3932.5674175840636, 4107.979460102681, 4115.97942010294, 4125.566815484331, 4133.338665813455, 8040.984630763463, 8079.070906845788, 8085.312748416451, 8086.15095414973, 8112.878306825402, 6659.933400665931, 7677.30904218623, 7985.08171560278, 8036.718714844952, 8065.677372905136, 8053.798655033671, 8062.314703250289, 8082.2725954664365, 8089.110197878229, 8090.878636820453, 7745.883811742716, 7760.223977602194, 7777.883331749915, 7787.10448298453, 7793.4154938378715, 7276.818079547842, 7528.548287102792, 7567.697292108254, 7573.583452909922, 7623.352015078781, 8032.277095061472, 8078.757637270891, 8080.111187769458, 8083.959580202061, 8096.230858068474, 4263.253930562078, 4713.269443236304, 4751.928721069117, 4774.856754297377, 4794.448638406628, 7416.7774966751085, 7661.770146895602, 7680.423968202295, 7682.769516914502, 7687.615619218905, 6623.238327592196, 6727.764528241488, 7384.852302954018, 7390.741324053847, 7416.96291518539, 7077.858442831011, 7343.3390994810725, 7359.190489046307, 7368.042154519878, 7374.078240219973, 6436.9678151610815, 6590.879550476335, 7219.566825990458, 7259.0, 7290.744823931349, 5811.389804070681, 7047.964760176166, 7151.499395042297, 7264.309890560388, 7348.338649521569, 7244.420446364384, 7252.927470725225, 7262.491625586158, 7268.236835132235, 7299.5255308404785], "unit": "ms", "name": "prototype.html", "value": 5322.690366205008}, {"lowerIsBetter": false, "replicates": [580.608089539561, 703.4688809948489, 715.606416470941, 743.2678811370798, 799.0611032037355, 15241.085534867916, 15604.219789010533, 15650.904436689421, 15665.686686266283, 15733.685326293467, 11576.47905844237, 14190.21953792541, 14348.497802576912, 14429.92785036076, 14452.494162704308, 933.5425641435698, 955.8375076237022, 958.7123862841155, 959.1942768074816, 961.5721004153155, 950.9952450237739, 954.613381580461, 963.8216929867997, 966.3622009473748, 968.5883499512679, 992.5384696116305, 1000.0599436529675, 1000.5497526113242, 1006.6275478073123, 1016.6848277034106, 879.2921698033081, 995.3480470291934, 1000.634768309569, 1004.9598016079348, 1006.5722068121056, 722.4725950056488, 730.5580124024995, 732.4909188114262, 735.6395366270489, 747.8167848877006, 13237.73524529504, 13372.732545349136, 13375.866241337559, 13400.798988015187, 13495.392707328194, 9336.906630933672, 9369.625214991393, 9518.381305215138, 9543.761405964837, 9813.607455701764, 9583.424994500352, 9770.560324785401, 9936.254780891462, 10373.481325933673, 10419.739506512398, 2781.429806889603, 3273.672632736731, 3408.0968543336035, 3417.111550996734, 3449.862005519776, 63847.6807615959, 63959.0, 67172.5627334238, 71052.22369440754, 78175.60912195402, 7104.7158113675905, 7127.429805615642, 7190.928090719026, 7227.9638601806655, 7339.74310899116, 11649.88350116488, 12214.0, 12656.746865062647, 12794.552190673281, 12929.0, 6518.967405162944, 6590.406863382223, 6717.093192419059, 6773.695183716744, 6794.184697836291, 4073.1446396256524, 4124.391487319947, 4143.254214241466, 4228.4080228768, 4374.081442896963, 3118.8908388206305, 3130.8591113399953, 3132.780705350649, 3139.4662907305815, 3147.763917706181, 473.95971342435587, 475.9571638552547, 481.6604293972741, 482.71278589239347, 485.1994209554264, 494.2043310270462, 494.8169177404383, 508.26809394471843, 521.3092652235803, 560.5431573267774, 7940.642671079815, 7948.085970113511, 8472.74581762548, 8620.13798620133, 8805.955970220108, 577.5466258986676, 587.4595372257534, 590.4361334925136, 611.065070442224, 623.1587357068013, 4396.824127034947, 4443.844465443694, 4504.572065653758, 4549.818007279738, 4565.383673204141, 67651.98522022173, 89377.21245575183, 92054.53972730093, 92396.0, 94167.52916235375, 76546.61726691443, 78592.0, 87564.56217718998, 87950.0, 88238.55880720555, 67210.0, 69954.30045699478, 70270.945935811, 72850.0, 75279.0, 7934.484258523177, 9055.456672599665, 9125.45247285165, 9170.082991700776, 9187.448753074837, 52429.0, 52474.950500989005, 53369.46630533645, 54037.91924161573, 54878.90242195214, 68972.0, 70122.64938675275, 70332.0, 70454.23864403431, 72879.0, 11679.766404671689, 11885.76228475443, 11950.46222919988, 12410.069244806495, 12594.496220151092, 11842.585509507126, 12081.093917956012, 12084.516619335129, 12191.390430478263, 12552.686182845502, 9958.352707074017, 11539.07687385024, 11973.220156614027, 12233.204841685261, 12238.0, 11057.83413248818, 11451.965065502118, 11514.424278786195, 11812.688368745174, 12026.699332516757, 11425.428728563373, 11670.396704363073, 11783.057355411718, 11879.049676025725, 12092.576759813364, 8657.307415406627, 9717.805643887225, 9798.265130115413, 10318.793624127626, 10523.105536029523, 8094.433389662902, 10217.284790064625, 10296.845547316647, 10332.793344133226, 10392.116670083127], "unit": "ms", "name": "yui.html", "value": 6681.59689489673}], "name": "dromaeo_css", "value": 7076.986617258057}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 109.0, 117.0, 118.0, 116.0, 126.0, 114.0, 118.0, 117.0, 114.0], "unit": "ms", "name": "ai-astar", "value": 116.4}, {"lowerIsBetter": true, "replicates": [143.0, 121.0, 160.0, 172.0, 119.0, 141.0, 152.0, 146.0, 159.0, 151.0], "unit": "ms", "name": "audio-beat-detection", "value": 146.4}, {"lowerIsBetter": true, "replicates": [197.0, 192.0, 193.0, 201.0, 205.0, 219.0, 195.0, 199.0, 198.0, 197.0], "unit": "ms", "name": "audio-dft", "value": 199.6}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 88.0, 148.0, 66.0, 56.0, 61.0, 76.0, 146.0, 81.0], "unit": "ms", "name": "audio-fft", "value": 85.1}, {"lowerIsBetter": true, "replicates": [79.0, 81.0, 129.0, 108.0, 97.0, 86.0, 112.0, 77.0, 76.0, 110.0], "unit": "ms", "name": "audio-oscillator", "value": 95.5}, {"lowerIsBetter": true, "replicates": [101.0, 117.0, 88.0, 103.0, 122.0, 89.0, 119.0, 88.0, 89.0, 88.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 100.4}, {"lowerIsBetter": true, "replicates": [122.0, 96.0, 96.0, 95.0, 95.0, 96.0, 109.0, 111.0, 149.0, 151.0], "unit": "ms", "name": "imaging-darkroom", "value": 112.0}, {"lowerIsBetter": true, "replicates": [149.0, 146.0, 93.0, 90.0, 90.0, 93.0, 93.0, 91.0, 89.0, 116.0], "unit": "ms", "name": "imaging-desaturate", "value": 105.0}, {"lowerIsBetter": true, "replicates": [60.0, 60.0, 59.0, 59.0, 61.0, 59.0, 59.0, 64.0, 59.0, 58.0], "unit": "ms", "name": "json-parse-financial", "value": 59.8}, {"lowerIsBetter": true, "replicates": [66.0, 65.0, 66.0, 65.0, 68.0, 66.0, 67.0, 91.0, 98.0, 98.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 75.0}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 85.0, 82.0, 87.0, 85.0, 85.0, 83.0, 85.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.4}, {"lowerIsBetter": true, "replicates": [142.0, 121.0, 129.0, 124.0, 124.0, 130.0, 133.0, 105.0, 134.0, 142.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 128.4}, {"lowerIsBetter": true, "replicates": [138.0, 135.0, 141.0, 170.0, 168.0, 159.0, 137.0, 135.0, 136.0, 136.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.5}, {"lowerIsBetter": true, "replicates": [64.0, 67.0, 65.0, 66.0, 67.0, 64.0, 67.0, 66.0, 65.0, 87.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.8}], "name": "kraken", "value": 1521.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [622.66500622665], "unit": "score", "name": "Richards", "value": 56.695012000000006}, {"lowerIsBetter": false, "replicates": [157.08451146716934], "unit": "score", "name": "DeltaBlue", "value": 420.9071879999999}, {"lowerIsBetter": false, "replicates": [287.5215641173088], "unit": "score", "name": "Encrypt", "value": 925.777518}, {"lowerIsBetter": false, "replicates": [4776.190476190476], "unit": "score", "name": "Decrypt", "value": 55.73081754735795}, {"lowerIsBetter": false, "replicates": [949.667616334283], "unit": "score", "name": "RayTrace", "value": 779.2084170000002}, {"lowerIsBetter": false, "replicates": [1053.740779768177], "unit": "score", "name": "Earley", "value": 632.473387}, {"lowerIsBetter": false, "replicates": [13025.641025641025], "unit": "score", "name": "Boyer", "value": 51.16546653543307}, {"lowerIsBetter": false, "replicates": [27675.675675675677], "unit": "score", "name": "RegExp", "value": 32.91645019531249}, {"lowerIsBetter": false, "replicates": [843.8818565400844], "unit": "score", "name": "Splay", "value": 96.56683500000003}, {"lowerIsBetter": false, "replicates": [4513.513513513513], "unit": "score", "name": "NavierStokes", "value": 328.7904191616765}], "name": "v8_7", "value": 17915.331040797802}]} 12:19:13 INFO - RETURN: dromaeo_css: 7076.99 12:19:13 INFO - RETURN: kraken: 1521.30 12:19:13 INFO - RETURN: v8_7: 17915.33 12:19:13 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,61]]", "result": "17915.33"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1521.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7076.99"}}} 12:19:13 INFO - Return code: 0 12:19:13 INFO - # TBPL SUCCESS # 12:19:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:19:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:19:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:19:13 INFO - 2015-11-18 12:19:13.622 screenresolution[1955:21417] starting screenresolution argv=screenresolution get 12:19:13 INFO - 2015-11-18 12:19:13.625 screenresolution[1955:21417] Display 0: 1600x1200x32@60 12:19:13 INFO - 2015-11-18 12:19:13.631 screenresolution[1956:21420] starting screenresolution argv=screenresolution list 12:19:13 INFO - Available Modes on Display 0 12:19:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:19:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:19:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:19:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:19:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:19:13 INFO - Intel Iris: 12:19:13 INFO - Chipset Model: Intel Iris 12:19:13 INFO - Type: GPU 12:19:13 INFO - Bus: Built-In 12:19:13 INFO - VRAM (Dynamic, Max): 1536 MB 12:19:13 INFO - Vendor: Intel (0x8086) 12:19:13 INFO - Device ID: 0x0a2e 12:19:13 INFO - Revision ID: 0x0009 12:19:13 INFO - Displays: 12:19:13 INFO - Display: 12:19:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:19:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:19:13 INFO - Display Serial Number: 1600x1200 60 12:19:13 INFO - Main Display: Yes 12:19:13 INFO - Mirror: Off 12:19:13 INFO - Online: Yes 12:19:13 INFO - Rotation: Supported 12:19:13 INFO - Return code: 0 12:19:13 INFO - Running post-action listener: _resource_record_post_action 12:19:13 INFO - Running post-run listener: _resource_record_post_run 12:19:14 INFO - Total resource usage - Wall time: 1234s; CPU: 53.0%; Read bytes: 143360; Write bytes: 688990720; Read time: 5; Write time: 2035 12:19:14 INFO - install - Wall time: 30s; CPU: 54.0%; Read bytes: 339235328; Write bytes: 334808576; Read time: 26046; Write time: 588 12:19:14 INFO - run-tests - Wall time: 1205s; CPU: 53.0%; Read bytes: 143360; Write bytes: 342762496; Read time: 5; Write time: 1411 12:19:14 INFO - Running post-run listener: _upload_blobber_files 12:19:14 INFO - Blob upload gear active. 12:19:14 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 12:19:14 INFO - Copying logs to upload dir... 12:19:14 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1276.593505 ========= master_lag: 20.53 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 37 secs) (at 2015-11-18 12:19:35.479321) ========= ========= Started set props: build_url (results: 0, elapsed: 7 secs) (at 2015-11-18 12:19:35.486749) ========= 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.8mF7QktIEF/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.aOi4xildNJ/Listeners TMPDIR=/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/NLcgCYbDRjWGDRX6tYSFww/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009978 build_url: 'https://queue.taskcluster.net/v1/task/NLcgCYbDRjWGDRX6tYSFww/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 7.46 ========= ========= Finished set props: build_url (results: 0, elapsed: 7 secs) (at 2015-11-18 12:19:42.953339) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 7 secs) (at 2015-11-18 12:19:42.953748) ========= 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.8mF7QktIEF/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.aOi4xildNJ/Listeners TMPDIR=/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005146 ========= master_lag: 7.68 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 7 secs) (at 2015-11-18 12:19:50.636310) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 12:19:50.636631) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 12:19:50.684625) ========= ========= Total master_lag: 35.79 =========