builder: mozilla-central_yosemite_test-dromaeojs slave: t-yosemite-r5-0027 starttime: 1447857252.16 results: success (0) buildid: 20151118054724 builduid: 46de06312a414b0cad49ec49aa314709 revision: fc29bf8b72a0d1712a051cb549694471f495bfd1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 06:34:12.156242) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 06:34:12.156796) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 06:34:12.157181) ========= 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.of44Ut3Zpm/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.FvDGVSSEOe/Listeners TMPDIR=/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006204 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 06:34:12.180789) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 06:34:12.181176) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 06:34:12.197759) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 06:34:12.198149) ========= 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.of44Ut3Zpm/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.FvDGVSSEOe/Listeners TMPDIR=/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005355 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 06:34:12.247743) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 06:34:12.248120) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 06:34:12.248534) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 06:34:12.248908) ========= 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.of44Ut3Zpm/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.FvDGVSSEOe/Listeners TMPDIR=/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False --2015-11-18 06:34:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 7.76M=0.001s 2015-11-18 06:34:12 (7.76 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118190 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 06:34:12.382848) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 06:34:12.383202) ========= 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.of44Ut3Zpm/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.FvDGVSSEOe/Listeners TMPDIR=/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.020009 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 06:34:12.433087) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-18 06:34:12.433482) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fc29bf8b72a0d1712a051cb549694471f495bfd1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev fc29bf8b72a0d1712a051cb549694471f495bfd1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.of44Ut3Zpm/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.FvDGVSSEOe/Listeners TMPDIR=/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 2015-11-18 06:34:12,508 truncating revision to first 12 chars 2015-11-18 06:34:12,508 Setting DEBUG logging. 2015-11-18 06:34:12,509 attempt 1/10 2015-11-18 06:34:12,509 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fc29bf8b72a0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-18 06:34:13,479 unpacking tar archive at: mozilla-central-fc29bf8b72a0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.270217 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-18 06:34:13.721980) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 06:34:13.722327) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 06:34:13.735916) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 06:34:13.736248) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 06:34:13.736689) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 46 secs) (at 2015-11-18 06:34:13.737029) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.of44Ut3Zpm/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.FvDGVSSEOe/Listeners TMPDIR=/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 06:34:13 INFO - MultiFileLogger online at 20151118 06:34:13 in /builds/slave/test 06:34:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:34:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:34:13 INFO - {'append_to_log': False, 06:34:13 INFO - 'base_work_dir': '/builds/slave/test', 06:34:13 INFO - 'blob_upload_branch': 'Firefox', 06:34:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:34:13 INFO - 'branch': 'Firefox', 06:34:13 INFO - 'buildbot_json_path': 'buildprops.json', 06:34:13 INFO - 'config_files': ('talos/mac_config.py',), 06:34:13 INFO - 'default_actions': ('clobber', 06:34:13 INFO - 'read-buildbot-config', 06:34:13 INFO - 'download-and-extract', 06:34:13 INFO - 'populate-webroot', 06:34:13 INFO - 'create-virtualenv', 06:34:13 INFO - 'install', 06:34:13 INFO - 'run-tests'), 06:34:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:34:13 INFO - 'download_minidump_stackwalk': True, 06:34:13 INFO - 'download_symbols': 'ondemand', 06:34:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:34:13 INFO - 'tooltool.py': '/tools/tooltool.py', 06:34:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:34:13 INFO - '/tools/misc-python/virtualenv.py')}, 06:34:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:34:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:34:13 INFO - 'installer_path': 'installer.exe', 06:34:13 INFO - 'log_level': 'info', 06:34:13 INFO - 'log_name': 'talos', 06:34:13 INFO - 'log_to_console': True, 06:34:13 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:34:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:34:13 INFO - 'opt_config_files': (), 06:34:13 INFO - 'pip_index': False, 06:34:13 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:34:13 INFO - 'cmd': ('bash', 06:34:13 INFO - '-c', 06:34:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:34:13 INFO - 'enabled': True, 06:34:13 INFO - 'halt_on_failure': False, 06:34:13 INFO - 'name': 'check_screen_resolution'},), 06:34:13 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:34:13 INFO - 'cmd': ('bash', 06:34:13 INFO - '-c', 06:34:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:34:13 INFO - 'enabled': True, 06:34:13 INFO - 'halt_on_failure': False, 06:34:13 INFO - 'name': 'check_screen_resolution'},), 06:34:13 INFO - 'run_cmd_checks_enabled': True, 06:34:13 INFO - 'sps_profile': False, 06:34:13 INFO - 'sps_profile_interval': 0, 06:34:13 INFO - 'suite': 'dromaeojs', 06:34:13 INFO - 'system_bits': '64', 06:34:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:34:13 INFO - 'title': 't-yosemite-r5-0027', 06:34:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:34:13 INFO - 'use_talos_json': True, 06:34:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:34:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:34:13 INFO - 'work_dir': 'build'} 06:34:13 INFO - ##### 06:34:13 INFO - ##### Running clobber step. 06:34:13 INFO - ##### 06:34:13 INFO - Running pre-action listener: _resource_record_pre_action 06:34:13 INFO - Running main action method: clobber 06:34:13 INFO - rmtree: /builds/slave/test/build 06:34:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:34:16 INFO - Running post-action listener: _resource_record_post_action 06:34:16 INFO - ##### 06:34:16 INFO - ##### Running read-buildbot-config step. 06:34:16 INFO - ##### 06:34:16 INFO - Running pre-action listener: _resource_record_pre_action 06:34:16 INFO - Running main action method: read_buildbot_config 06:34:16 INFO - Using buildbot properties: 06:34:16 INFO - { 06:34:16 INFO - "properties": { 06:34:16 INFO - "buildnumber": 485, 06:34:16 INFO - "product": "firefox", 06:34:16 INFO - "script_repo_revision": "production", 06:34:16 INFO - "builddir": "mozilla-central_yosemite_test-dromaeojs", 06:34:16 INFO - "repository": "", 06:34:16 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-central talos dromaeojs", 06:34:16 INFO - "buildid": "20151118054724", 06:34:16 INFO - "slavename": "t-yosemite-r5-0027", 06:34:16 INFO - "pgo_build": "False", 06:34:16 INFO - "basedir": "/builds/slave/test", 06:34:16 INFO - "project": "", 06:34:16 INFO - "platform": "yosemite", 06:34:16 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 06:34:16 INFO - "slavebuilddir": "test", 06:34:16 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 06:34:16 INFO - "branch": "mozilla-central", 06:34:16 INFO - "repo_path": "mozilla-central", 06:34:16 INFO - "stage_platform": "macosx64", 06:34:16 INFO - "builduid": "46de06312a414b0cad49ec49aa314709", 06:34:16 INFO - "revision": "fc29bf8b72a0d1712a051cb549694471f495bfd1" 06:34:16 INFO - }, 06:34:16 INFO - "sourcestamp": { 06:34:16 INFO - "repository": "", 06:34:16 INFO - "hasPatch": false, 06:34:16 INFO - "project": "", 06:34:16 INFO - "branch": "mozilla-central-macosx64-talos", 06:34:16 INFO - "changes": [ 06:34:16 INFO - { 06:34:16 INFO - "category": null, 06:34:16 INFO - "files": [ 06:34:16 INFO - { 06:34:16 INFO - "url": null, 06:34:16 INFO - "name": "https://queue.taskcluster.net/v1/task/8rflomTMTRerYAMWKmGr9w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 06:34:16 INFO - } 06:34:16 INFO - ], 06:34:16 INFO - "repository": "", 06:34:16 INFO - "rev": "fc29bf8b72a0d1712a051cb549694471f495bfd1", 06:34:16 INFO - "who": "cbook@mozilla.com", 06:34:16 INFO - "when": 1447857179, 06:34:16 INFO - "number": 6677038, 06:34:16 INFO - "comments": "Bumping manifests a=b2g-bump", 06:34:16 INFO - "project": "", 06:34:16 INFO - "at": "Wed 18 Nov 2015 06:32:59", 06:34:16 INFO - "branch": "mozilla-central-macosx64-talos", 06:34:16 INFO - "revlink": "", 06:34:16 INFO - "properties": [ 06:34:16 INFO - [ 06:34:16 INFO - "buildid", 06:34:16 INFO - "20151118054724", 06:34:16 INFO - "Change" 06:34:16 INFO - ], 06:34:16 INFO - [ 06:34:16 INFO - "builduid", 06:34:16 INFO - "46de06312a414b0cad49ec49aa314709", 06:34:16 INFO - "Change" 06:34:16 INFO - ], 06:34:16 INFO - [ 06:34:16 INFO - "pgo_build", 06:34:16 INFO - "False", 06:34:16 INFO - "Change" 06:34:16 INFO - ] 06:34:16 INFO - ], 06:34:16 INFO - "revision": "fc29bf8b72a0d1712a051cb549694471f495bfd1" 06:34:16 INFO - } 06:34:16 INFO - ], 06:34:16 INFO - "revision": "fc29bf8b72a0d1712a051cb549694471f495bfd1" 06:34:16 INFO - } 06:34:16 INFO - } 06:34:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/8rflomTMTRerYAMWKmGr9w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 06:34:16 INFO - Running post-action listener: _resource_record_post_action 06:34:16 INFO - ##### 06:34:16 INFO - ##### Running download-and-extract step. 06:34:16 INFO - ##### 06:34:16 INFO - Running pre-action listener: _resource_record_pre_action 06:34:16 INFO - Running main action method: download_and_extract 06:34:16 INFO - mkdir: /builds/slave/test/build/tests 06:34:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:34:16 INFO - https://queue.taskcluster.net/v1/task/8rflomTMTRerYAMWKmGr9w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:34:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8rflomTMTRerYAMWKmGr9w/artifacts/public/build/test_packages.json 06:34:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8rflomTMTRerYAMWKmGr9w/artifacts/public/build/test_packages.json 06:34:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8rflomTMTRerYAMWKmGr9w/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 06:34:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8rflomTMTRerYAMWKmGr9w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 06:34:18 INFO - Downloaded 1149 bytes. 06:34:18 INFO - Reading from file /builds/slave/test/build/test_packages.json 06:34:18 INFO - Using the following test package requirements: 06:34:18 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 06:34:18 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 06:34:18 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 06:34:18 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 06:34:18 INFO - u'jsshell-mac.zip'], 06:34:18 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 06:34:18 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 06:34:18 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 06:34:18 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 06:34:18 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 06:34:18 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 06:34:18 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 06:34:18 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 06:34:18 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 06:34:18 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 06:34:18 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 06:34:18 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 06:34:18 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:34: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')]} 06:34:18 INFO - https://queue.taskcluster.net/v1/task/8rflomTMTRerYAMWKmGr9w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:34:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8rflomTMTRerYAMWKmGr9w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 06:34:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8rflomTMTRerYAMWKmGr9w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 06:34:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8rflomTMTRerYAMWKmGr9w/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 06:34:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8rflomTMTRerYAMWKmGr9w/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 06:34:19 INFO - Downloaded 17463480 bytes. 06:34:19 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 06:34:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 06:34:19 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 06:34:24 INFO - Return code: 0 06:34:24 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 06:34: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')]} 06:34:24 INFO - https://queue.taskcluster.net/v1/task/8rflomTMTRerYAMWKmGr9w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:34:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8rflomTMTRerYAMWKmGr9w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 06:34:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8rflomTMTRerYAMWKmGr9w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 06:34:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8rflomTMTRerYAMWKmGr9w/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 06:34:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8rflomTMTRerYAMWKmGr9w/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 06:34:26 INFO - Downloaded 17463480 bytes. 06:34:26 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 06:34:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 06:34:26 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 06:34:32 INFO - Return code: 0 06:34:32 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')]} 06:34:32 INFO - https://queue.taskcluster.net/v1/task/8rflomTMTRerYAMWKmGr9w/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 06:34:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8rflomTMTRerYAMWKmGr9w/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 06:34:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8rflomTMTRerYAMWKmGr9w/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 06:34:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8rflomTMTRerYAMWKmGr9w/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 06:34:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8rflomTMTRerYAMWKmGr9w/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 06:34:33 INFO - Downloaded 11131693 bytes. 06:34:33 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 06:34:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 06:34:33 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 06:34:33 INFO - Return code: 0 06:34: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')]} 06:34:33 INFO - https://queue.taskcluster.net/v1/task/8rflomTMTRerYAMWKmGr9w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 06:34:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8rflomTMTRerYAMWKmGr9w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 06:34:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8rflomTMTRerYAMWKmGr9w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 06:34:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8rflomTMTRerYAMWKmGr9w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 06:34:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8rflomTMTRerYAMWKmGr9w/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 06:34:40 INFO - Downloaded 108839956 bytes. 06:34:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/8rflomTMTRerYAMWKmGr9w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 06:34:40 INFO - mkdir: /builds/slave/test/properties 06:34:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:34:40 INFO - Writing to file /builds/slave/test/properties/build_url 06:34:40 INFO - Contents: 06:34:40 INFO - build_url:https://queue.taskcluster.net/v1/task/8rflomTMTRerYAMWKmGr9w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 06:34:40 INFO - Running post-action listener: _resource_record_post_action 06:34:40 INFO - Running post-action listener: set_extra_try_arguments 06:34:40 INFO - ##### 06:34:40 INFO - ##### Running populate-webroot step. 06:34:40 INFO - ##### 06:34:40 INFO - Running pre-action listener: _resource_record_pre_action 06:34:40 INFO - Running main action method: populate_webroot 06:34:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:34:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:34:40 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 06:34:40 INFO - '../fennec_ids.txt'], 06:34:40 INFO - 'tests': ['tcheck2']}, 06:34:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:34:40 INFO - '--tppagecycles', 06:34:40 INFO - '7'], 06:34:40 INFO - 'tests': ['tsvgm']}}, 06:34:40 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:34:40 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:34:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:34:40 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:34:40 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:34:40 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:34:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:34:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:34:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:34:40 INFO - 'talos_options': ['--e10s'], 06:34:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:34:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:34:40 INFO - 'tests': ['damp', 'tps']}, 06:34:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:34:40 INFO - 'talos_options': ['--e10s'], 06:34:40 INFO - 'tests': ['damp', 'tps']}, 06:34:40 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:34:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:34:40 INFO - 'other': {'tests': ['a11yr', 06:34:40 INFO - 'ts_paint', 06:34:40 INFO - 'tpaint', 06:34:40 INFO - 'sessionrestore', 06:34:40 INFO - 'sessionrestore_no_auto_restore']}, 06:34:40 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:34:40 INFO - 'tests': ['a11yr', 06:34:40 INFO - 'ts_paint', 06:34:40 INFO - 'tpaint', 06:34:40 INFO - 'sessionrestore', 06:34:40 INFO - 'sessionrestore_no_auto_restore']}, 06:34:40 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:34:40 INFO - 'tests': ['a11yr', 06:34:40 INFO - 'ts_paint', 06:34:40 INFO - 'tpaint', 06:34:40 INFO - 'sessionrestore', 06:34:40 INFO - 'sessionrestore_no_auto_restore']}, 06:34:40 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:34:40 INFO - 'tests': ['a11yr', 06:34:40 INFO - 'ts_paint', 06:34:40 INFO - 'tpaint', 06:34:40 INFO - 'sessionrestore', 06:34:40 INFO - 'sessionrestore_no_auto_restore']}, 06:34:40 INFO - 'other_l64': {'tests': ['a11yr', 06:34:40 INFO - 'ts_paint', 06:34:40 INFO - 'tpaint', 06:34:40 INFO - 'sessionrestore', 06:34:40 INFO - 'sessionrestore_no_auto_restore']}, 06:34:40 INFO - 'other_nol64': {'tests': ['a11yr', 06:34:40 INFO - 'ts_paint', 06:34:40 INFO - 'tpaint', 06:34:40 INFO - 'sessionrestore', 06:34:40 INFO - 'sessionrestore_no_auto_restore']}, 06:34:40 INFO - 'svgr': {'tests': ['tsvgx', 06:34:40 INFO - 'tsvgr_opacity', 06:34:40 INFO - 'tart', 06:34:40 INFO - 'tscrollx', 06:34:40 INFO - 'cart']}, 06:34:40 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:34:40 INFO - 'tests': ['tsvgx', 06:34:40 INFO - 'tsvgr_opacity', 06:34:40 INFO - 'tart', 06:34:40 INFO - 'tscrollx', 06:34:40 INFO - 'cart']}, 06:34:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:34:40 INFO - 'tests': ['tp5o']}, 06:34:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:34:40 INFO - 'talos_options': ['--e10s'], 06:34:40 INFO - 'tests': ['tp5o']}, 06:34:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:34:40 INFO - 'talos_options': ['--xperf_path', 06:34:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:34:40 INFO - 'tests': ['tp5n']}, 06:34:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:34:40 INFO - 'talos_options': ['--e10s', 06:34:40 INFO - '--xperf_path', 06:34:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:34:40 INFO - 'tests': ['tp5n']}}, 06:34:40 INFO - 'talos.zip': {'path': '', 06:34:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:34:40 INFO - Running post-action listener: _resource_record_post_action 06:34:40 INFO - ##### 06:34:40 INFO - ##### Running create-virtualenv step. 06:34:40 INFO - ##### 06:34:40 INFO - Running pre-action listener: _resource_record_pre_action 06:34:40 INFO - Running main action method: create_virtualenv 06:34:40 INFO - Creating virtualenv /builds/slave/test/build/venv 06:34:40 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 06:34:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:34:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:34:40 INFO - Using real prefix '/tools/python27' 06:34:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:34:40 INFO - Installing distribute.............................................................................................................................................................................................done. 06:34:44 INFO - Installing pip.................done. 06:34:44 INFO - Return code: 0 06:34:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:34:44 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')]} 06:34:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:34:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:44 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')]} 06:34:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:34:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:44 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 0x10ed3e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed1b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab1b64a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec619f0>, '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 0x10e9c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec558c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.of44Ut3Zpm/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.FvDGVSSEOe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:34:44 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 06:34:44 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 06:34:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.of44Ut3Zpm/Render', 06:34:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:34:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:34:44 INFO - 'HOME': '/Users/cltbld', 06:34:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:34:44 INFO - 'LOGNAME': 'cltbld', 06:34:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:34:44 INFO - 'MOZ_NO_REMOTE': '1', 06:34:44 INFO - 'NO_EM_RESTART': '1', 06:34:44 INFO - 'PAGER': '/bin/cat', 06:34:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:34:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:34:44 INFO - 'PWD': '/builds/slave/test', 06:34:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:34:44 INFO - 'SHELL': '/bin/bash', 06:34:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FvDGVSSEOe/Listeners', 06:34:44 INFO - 'TMPDIR': '/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/', 06:34:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:34:44 INFO - 'USER': 'cltbld', 06:34:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:34:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:34:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:34:44 INFO - 'XPC_FLAGS': '0x0', 06:34:44 INFO - 'XPC_SERVICE_NAME': '0', 06:34:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 06:34:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:34:44 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 06:34:44 INFO - Cleaning up... 06:34:44 INFO - Return code: 0 06:34:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:34:44 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')]} 06:34:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:34:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:44 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')]} 06:34:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:34:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:44 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 0x10ed3e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed1b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab1b64a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec619f0>, '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 0x10e9c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec558c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.of44Ut3Zpm/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.FvDGVSSEOe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:34:44 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 06:34:44 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 06:34:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.of44Ut3Zpm/Render', 06:34:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:34:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:34:44 INFO - 'HOME': '/Users/cltbld', 06:34:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:34:44 INFO - 'LOGNAME': 'cltbld', 06:34:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:34:44 INFO - 'MOZ_NO_REMOTE': '1', 06:34:44 INFO - 'NO_EM_RESTART': '1', 06:34:44 INFO - 'PAGER': '/bin/cat', 06:34:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:34:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:34:44 INFO - 'PWD': '/builds/slave/test', 06:34:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:34:44 INFO - 'SHELL': '/bin/bash', 06:34:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FvDGVSSEOe/Listeners', 06:34:44 INFO - 'TMPDIR': '/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/', 06:34:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:34:44 INFO - 'USER': 'cltbld', 06:34:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:34:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:34:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:34:44 INFO - 'XPC_FLAGS': '0x0', 06:34:44 INFO - 'XPC_SERVICE_NAME': '0', 06:34:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 06:34:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:34:45 INFO - Downloading/unpacking psutil>=0.7.1 06:34:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:34:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:34:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:34:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:34:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:34:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:34:47 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 06:34:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 06:34:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:34:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:34:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:34:47 INFO - Installing collected packages: psutil 06:34:47 INFO - Running setup.py install for psutil 06:34:47 INFO - building 'psutil._psutil_osx' extension 06:34:47 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 06:34:48 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 06:34:48 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 06:34:48 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 06:34:48 INFO - building 'psutil._psutil_posix' extension 06:34:48 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 06:34:48 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:34:48 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:34:48 INFO - ^ 06:34:48 INFO - 1 warning generated. 06:34:48 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 06:34:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:34:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:34:48 INFO - Successfully installed psutil 06:34:48 INFO - Cleaning up... 06:34:48 INFO - Return code: 0 06:34:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:34:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:34:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:34:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:34:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ed3e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed1b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab1b64a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec619f0>, '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 0x10e9c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec558c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.of44Ut3Zpm/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.FvDGVSSEOe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:34:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 06:34:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 06:34:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.of44Ut3Zpm/Render', 06:34:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:34:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:34:48 INFO - 'HOME': '/Users/cltbld', 06:34:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:34:48 INFO - 'LOGNAME': 'cltbld', 06:34:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:34:48 INFO - 'MOZ_NO_REMOTE': '1', 06:34:48 INFO - 'NO_EM_RESTART': '1', 06:34:48 INFO - 'PAGER': '/bin/cat', 06:34:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:34:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:34:48 INFO - 'PWD': '/builds/slave/test', 06:34:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:34:48 INFO - 'SHELL': '/bin/bash', 06:34:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FvDGVSSEOe/Listeners', 06:34:48 INFO - 'TMPDIR': '/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/', 06:34:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:34:48 INFO - 'USER': 'cltbld', 06:34:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:34:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:34:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:34:48 INFO - 'XPC_FLAGS': '0x0', 06:34:48 INFO - 'XPC_SERVICE_NAME': '0', 06:34:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 06:34:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:34:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:34:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:34:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:34:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:34:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:34:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:34:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:34:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:34:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 06:34:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:34:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:34:51 INFO - Installing collected packages: mozsystemmonitor 06:34:51 INFO - Running setup.py install for mozsystemmonitor 06:34:51 INFO - Successfully installed mozsystemmonitor 06:34:51 INFO - Cleaning up... 06:34:51 INFO - Return code: 0 06:34:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:34:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:34:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:34:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:34:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ed3e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed1b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab1b64a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec619f0>, '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 0x10e9c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec558c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.of44Ut3Zpm/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.FvDGVSSEOe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:34:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:34:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:34:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.of44Ut3Zpm/Render', 06:34:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:34:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:34:51 INFO - 'HOME': '/Users/cltbld', 06:34:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:34:51 INFO - 'LOGNAME': 'cltbld', 06:34:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:34:51 INFO - 'MOZ_NO_REMOTE': '1', 06:34:51 INFO - 'NO_EM_RESTART': '1', 06:34:51 INFO - 'PAGER': '/bin/cat', 06:34:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:34:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:34:51 INFO - 'PWD': '/builds/slave/test', 06:34:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:34:51 INFO - 'SHELL': '/bin/bash', 06:34:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FvDGVSSEOe/Listeners', 06:34:51 INFO - 'TMPDIR': '/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/', 06:34:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:34:51 INFO - 'USER': 'cltbld', 06:34:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:34:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:34:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:34:51 INFO - 'XPC_FLAGS': '0x0', 06:34:51 INFO - 'XPC_SERVICE_NAME': '0', 06:34:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 06:34:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:34:52 INFO - Downloading/unpacking blobuploader==1.2.4 06:34:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:34:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:34:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:34:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:34:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:34:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:34:54 INFO - Downloading blobuploader-1.2.4.tar.gz 06:34:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 06:34:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:34:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:34:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:34:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:34:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:34:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:34:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:34:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:34:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 06:34:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:34:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:34:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:34:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:34:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:34:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:34:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:34:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:34:55 INFO - Downloading docopt-0.6.1.tar.gz 06:34:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 06:34:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:34:55 INFO - Installing collected packages: blobuploader, requests, docopt 06:34:55 INFO - Running setup.py install for blobuploader 06:34:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:34:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:34:55 INFO - Running setup.py install for requests 06:34:56 INFO - Running setup.py install for docopt 06:34:56 INFO - Successfully installed blobuploader requests docopt 06:34:56 INFO - Cleaning up... 06:34:56 INFO - Return code: 0 06:34:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:34:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:34:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:34:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:34:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:34:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ed3e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed1b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab1b64a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec619f0>, '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 0x10e9c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec558c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.of44Ut3Zpm/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.FvDGVSSEOe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:34:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:34:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:34:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.of44Ut3Zpm/Render', 06:34:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:34:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:34:56 INFO - 'HOME': '/Users/cltbld', 06:34:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:34:56 INFO - 'LOGNAME': 'cltbld', 06:34:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:34:56 INFO - 'MOZ_NO_REMOTE': '1', 06:34:56 INFO - 'NO_EM_RESTART': '1', 06:34:56 INFO - 'PAGER': '/bin/cat', 06:34:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:34:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:34:56 INFO - 'PWD': '/builds/slave/test', 06:34:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:34:56 INFO - 'SHELL': '/bin/bash', 06:34:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FvDGVSSEOe/Listeners', 06:34:56 INFO - 'TMPDIR': '/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/', 06:34:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:34:56 INFO - 'USER': 'cltbld', 06:34:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:34:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:34:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:34:56 INFO - 'XPC_FLAGS': '0x0', 06:34:56 INFO - 'XPC_SERVICE_NAME': '0', 06:34:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 06:34:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:34:57 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-RddabD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:34:57 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-QC3X5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:34:57 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-oHUMaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:34:57 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-EFVgme-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:34:57 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-arMXD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:34:57 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-j5E2Qj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:34:57 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-N9niT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:34:57 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-OXlmyy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:34:58 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-KPICON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:34:58 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-P5f8Og-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:34:58 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-HUWS0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:34:58 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-5b6QhA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:34:58 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-E9BuxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:34:58 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-Dy8qEM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:34:58 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-DU6O9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:34:58 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-rgb03z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:34:59 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-hvnSSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:34:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:34:59 INFO - Running setup.py install for manifestparser 06:34:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:34:59 INFO - Running setup.py install for mozcrash 06:34:59 INFO - Running setup.py install for mozdebug 06:34:59 INFO - Running setup.py install for mozdevice 06:34:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:34:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:34:59 INFO - Running setup.py install for mozfile 06:35:00 INFO - Running setup.py install for mozhttpd 06:35:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:35:00 INFO - Running setup.py install for mozinfo 06:35:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:35:00 INFO - Running setup.py install for mozInstall 06:35:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:35:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:35:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:35:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:35:00 INFO - Running setup.py install for mozleak 06:35:00 INFO - Running setup.py install for mozlog 06:35:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:35:00 INFO - Running setup.py install for moznetwork 06:35:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:35:01 INFO - Running setup.py install for mozprocess 06:35:01 INFO - Running setup.py install for mozprofile 06:35:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:35:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:35:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:35:01 INFO - Running setup.py install for mozrunner 06:35:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:35:01 INFO - Running setup.py install for mozscreenshot 06:35:01 INFO - Running setup.py install for moztest 06:35:01 INFO - Running setup.py install for mozversion 06:35:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:35:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:35:02 INFO - Cleaning up... 06:35:02 INFO - Return code: 0 06:35:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:35:02 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')]} 06:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:02 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')]} 06:35:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:02 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 0x10ed3e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed1b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab1b64a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec619f0>, '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 0x10e9c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec558c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.of44Ut3Zpm/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.FvDGVSSEOe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:35:02 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 06:35:02 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 06:35:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.of44Ut3Zpm/Render', 06:35:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:35:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:35:02 INFO - 'HOME': '/Users/cltbld', 06:35:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:35:02 INFO - 'LOGNAME': 'cltbld', 06:35:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:02 INFO - 'MOZ_NO_REMOTE': '1', 06:35:02 INFO - 'NO_EM_RESTART': '1', 06:35:02 INFO - 'PAGER': '/bin/cat', 06:35:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:35:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:02 INFO - 'PWD': '/builds/slave/test', 06:35:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:35:02 INFO - 'SHELL': '/bin/bash', 06:35:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FvDGVSSEOe/Listeners', 06:35:02 INFO - 'TMPDIR': '/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/', 06:35:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:35:02 INFO - 'USER': 'cltbld', 06:35:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:35:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:35:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:02 INFO - 'XPC_FLAGS': '0x0', 06:35:02 INFO - 'XPC_SERVICE_NAME': '0', 06:35:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 06:35:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:35:02 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-NKqbTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:35:02 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)) 06:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:35:02 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-MZYqkj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:35:02 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)) 06:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:35:02 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-9f7IMJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:35:02 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)) 06:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:35:02 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-N2_MOm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:35:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:35:02 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-WDaKMc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:35:03 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)) 06:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:35:03 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-SKbZis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:35:03 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)) 06:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:35:03 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-0s8gC1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:35:03 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)) 06:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:35:03 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-_SiOAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:35:03 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)) 06:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:35:03 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-sg5erz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:35:03 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)) 06:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:35:03 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-bCBReh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:35:03 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)) 06:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:35:03 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-6Ymex5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:35:03 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)) 06:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:35:03 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-UXu6ur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:35:03 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)) 06:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:35:03 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-dFSfUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:35:04 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)) 06:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:35:04 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-yx8HbY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:35:04 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)) 06:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:35:04 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-jx1lec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:35:04 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)) 06:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:35:04 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-z3X4U3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:35:04 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)) 06:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:35:04 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-YvPEZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:35:04 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)) 06:35:04 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)) 06:35:04 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)) 06:35:04 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)) 06:35:04 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)) 06:35:04 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)) 06:35:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:35:04 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 06:35:04 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 06:35:04 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 06:35:04 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 06:35:04 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 06:35:04 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 06:35:06 INFO - Downloading blessings-1.5.1.tar.gz 06:35:06 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 06:35:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:35:07 INFO - Installing collected packages: blessings 06:35:07 INFO - Running setup.py install for blessings 06:35:07 INFO - Successfully installed blessings 06:35:07 INFO - Cleaning up... 06:35:07 INFO - Return code: 0 06:35:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:35:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:35:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:35:07 INFO - Reading from file tmpfile_stdout 06:35:07 INFO - Current package versions: 06:35:07 INFO - blessings == 1.5.1 06:35:07 INFO - blobuploader == 1.2.4 06:35:07 INFO - docopt == 0.6.1 06:35:07 INFO - manifestparser == 1.1 06:35:07 INFO - mozInstall == 1.12 06:35:07 INFO - mozcrash == 0.16 06:35:07 INFO - mozdebug == 0.1 06:35:07 INFO - mozdevice == 0.47 06:35:07 INFO - mozfile == 1.2 06:35:07 INFO - mozhttpd == 0.7 06:35:07 INFO - mozinfo == 0.9 06:35:07 INFO - mozleak == 0.1 06:35:07 INFO - mozlog == 3.0 06:35:07 INFO - moznetwork == 0.27 06:35:07 INFO - mozprocess == 0.22 06:35:07 INFO - mozprofile == 0.27 06:35:07 INFO - mozrunner == 6.11 06:35:07 INFO - mozscreenshot == 0.1 06:35:07 INFO - mozsystemmonitor == 0.0 06:35:07 INFO - moztest == 0.7 06:35:07 INFO - mozversion == 1.4 06:35:07 INFO - psutil == 3.1.1 06:35:07 INFO - requests == 1.2.3 06:35:07 INFO - wsgiref == 0.1.2 06:35:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:35:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:35:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:35:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x10ed3e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed1b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab1b64a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec619f0>, '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 0x10e9c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec558c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.of44Ut3Zpm/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.FvDGVSSEOe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:35:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 06:35:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/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 06:35:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.of44Ut3Zpm/Render', 06:35:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:35:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:35:07 INFO - 'HOME': '/Users/cltbld', 06:35:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:35:07 INFO - 'LOGNAME': 'cltbld', 06:35:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:07 INFO - 'MOZ_NO_REMOTE': '1', 06:35:07 INFO - 'NO_EM_RESTART': '1', 06:35:07 INFO - 'PAGER': '/bin/cat', 06:35:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:35:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:07 INFO - 'PWD': '/builds/slave/test', 06:35:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:35:07 INFO - 'SHELL': '/bin/bash', 06:35:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FvDGVSSEOe/Listeners', 06:35:07 INFO - 'TMPDIR': '/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/', 06:35:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:35:07 INFO - 'USER': 'cltbld', 06:35:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:35:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:35:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:07 INFO - 'XPC_FLAGS': '0x0', 06:35:07 INFO - 'XPC_SERVICE_NAME': '0', 06:35:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 06:35:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:35:08 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)) 06:35:08 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)) 06:35:08 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)) 06:35:08 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)) 06:35:08 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)) 06:35:08 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)) 06:35:08 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)) 06:35:08 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)) 06:35:08 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)) 06:35:08 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)) 06:35:08 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)) 06:35:08 INFO - Cleaning up... 06:35:08 INFO - Return code: 0 06:35:08 INFO - Running post-action listener: _resource_record_post_action 06:35:08 INFO - Running post-action listener: _start_resource_monitoring 06:35:08 INFO - Starting resource monitoring. 06:35:08 INFO - ##### 06:35:08 INFO - ##### Running install step. 06:35:08 INFO - ##### 06:35:08 INFO - Running pre-action listener: _resource_record_pre_action 06:35:08 INFO - Running main action method: install 06:35:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:35:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:35:08 INFO - Reading from file tmpfile_stdout 06:35:08 INFO - Detecting whether we're running mozinstall >=1.0... 06:35:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:35:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:35:08 INFO - Reading from file tmpfile_stdout 06:35:08 INFO - Output received: 06:35:08 INFO - Usage: mozinstall [options] installer 06:35:08 INFO - Options: 06:35:08 INFO - -h, --help show this help message and exit 06:35:08 INFO - -d DEST, --destination=DEST 06:35:08 INFO - Directory to install application into. [default: 06:35:08 INFO - "/builds/slave/test"] 06:35:08 INFO - --app=APP Application being installed. [default: firefox] 06:35:08 INFO - mkdir: /builds/slave/test/build/application 06:35:08 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'] 06:35:08 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 06:35:45 INFO - Reading from file tmpfile_stdout 06:35:45 INFO - Output received: 06:35:45 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:35:45 INFO - Running post-action listener: _resource_record_post_action 06:35:45 INFO - ##### 06:35:45 INFO - ##### Running run-tests step. 06:35:45 INFO - ##### 06:35:45 INFO - Running pre-action listener: _resource_record_pre_action 06:35:45 INFO - Running main action method: run_tests 06:35:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:35:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:35:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:35:45 INFO - 2015-11-18 06:35:45.983 screenresolution[1945:21346] starting screenresolution argv=screenresolution get 06:35:45 INFO - 2015-11-18 06:35:45.986 screenresolution[1945:21346] Display 0: 1600x1200x32@60 06:35:45 INFO - 2015-11-18 06:35:45.993 screenresolution[1946:21349] starting screenresolution argv=screenresolution list 06:35:45 INFO - Available Modes on Display 0 06:35:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:35:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:35:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:35:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:35:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:35:46 INFO - Intel HD Graphics 3000: 06:35:46 INFO - Chipset Model: Intel HD Graphics 3000 06:35:46 INFO - Type: GPU 06:35:46 INFO - Bus: Built-In 06:35:46 INFO - VRAM (Total): 512 MB 06:35:46 INFO - VRAM (Dynamic, Max): 10 06:35:46 INFO - Vendor: Intel (0x8086) 06:35:46 INFO - Device ID: 0x0116 06:35:46 INFO - Revision ID: 0x0009 06:35:46 INFO - Displays: 06:35:46 INFO - Display: 06:35:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:35:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:35:46 INFO - Display Serial Number: 1600x1200 60 06:35:46 INFO - Main Display: Yes 06:35:46 INFO - Mirror: Off 06:35:46 INFO - Online: Yes 06:35:46 INFO - Rotation: Supported 06:35:46 INFO - Return code: 0 06:35:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:35:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:35:46 INFO - Python 2.7.3 06:35:46 INFO - Return code: 0 06:35:46 INFO - grabbing minidump binary from tooltool 06:35:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:35:46 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 0x10ec619f0>, '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 0x10e9c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec558c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:35:46 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 06:35:46 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 06:35:46 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:35:46 INFO - Return code: 0 06:35:46 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:35:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:35:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:35:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:35:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:35:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/8rflomTMTRerYAMWKmGr9w/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0027', '--webServer', 'localhost'] in /builds/slave/test/build 06:35:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/8rflomTMTRerYAMWKmGr9w/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0027 --webServer localhost 06:35:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.of44Ut3Zpm/Render', 06:35:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:35:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:35:46 INFO - 'HOME': '/Users/cltbld', 06:35:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:35:46 INFO - 'LOGNAME': 'cltbld', 06:35:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:35:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:35:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:46 INFO - 'MOZ_NO_REMOTE': '1', 06:35:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:35:46 INFO - 'NO_EM_RESTART': '1', 06:35:46 INFO - 'PAGER': '/bin/cat', 06:35:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:35:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:46 INFO - 'PWD': '/builds/slave/test', 06:35:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:35:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:35:46 INFO - 'SHELL': '/bin/bash', 06:35:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FvDGVSSEOe/Listeners', 06:35:46 INFO - 'TMPDIR': '/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/', 06:35:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:35:46 INFO - 'USER': 'cltbld', 06:35:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:35:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:35:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:46 INFO - 'XPC_FLAGS': '0x0', 06:35:46 INFO - 'XPC_SERVICE_NAME': '0', 06:35:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 06:35:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/8rflomTMTRerYAMWKmGr9w/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0027', '--webServer', 'localhost'] with output_timeout 3600 06:35:46 INFO - mozversion INFO | application_buildid: 20151118054724 06:35:46 INFO - mozversion INFO | application_changeset: fc29bf8b72a0d1712a051cb549694471f495bfd1 06:35:46 INFO - mozversion INFO | application_display_name: Nightly 06:35:46 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:35:46 INFO - mozversion INFO | application_name: Firefox 06:35:46 INFO - mozversion INFO | application_remotingname: firefox 06:35:46 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 06:35:46 INFO - mozversion INFO | application_vendor: Mozilla 06:35:46 INFO - mozversion INFO | application_version: 45.0a1 06:35:46 INFO - mozversion INFO | platform_buildid: 20151118054724 06:35:46 INFO - mozversion INFO | platform_changeset: fc29bf8b72a0d1712a051cb549694471f495bfd1 06:35:46 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 06:35:46 INFO - mozversion INFO | platform_version: 45.0a1 06:35:46 INFO - 2015-11-18 06:35:46,594 DEBUG : using testdate: 1447857346 06:35:46 INFO - 2015-11-18 06:35:46,594 DEBUG : actual date: 1447857346 06:35:46 INFO - 2015-11-18 06:35:46,680 INFO : starting webserver on 'localhost:50755' 06:35:46 INFO - 2015-11-18 06:35:46,681 INFO : Starting test suite t-yosemite-r5-0027 06:35:46 INFO - 2015-11-18 06:35:46,681 INFO : Starting test dromaeo_css 06:35:46 INFO - 2015-11-18 06:35:46,681 DEBUG : operating with platform_type : mac_ 06:35:46 INFO - 2015-11-18 06:35:46,682 INFO : Initialising browser for dromaeo_css test... 06:35:46 INFO - 2015-11-18 06:35:46,709 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/tmpF11nSA/profile http://localhost:50755/getInfo.html 06:35:49 INFO - 2015-11-18 06:35:49,981 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:35:49 INFO - 2015-11-18 06:35:49,981 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:35:49 INFO - 2015-11-18 06:35:49,981 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 06:35:49 INFO - 2015-11-18 06:35:49,981 DEBUG : BROWSER_OUTPUT: __metrics 06:35:49 INFO - 2015-11-18 06:35:49,999 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:35:50 INFO - 2015-11-18 06:35:50,718 INFO : Browser initialized. 06:35:50 INFO - 2015-11-18 06:35:50,718 INFO : Running cycle 1/1 for dromaeo_css test... 06:35:50 INFO - 2015-11-18 06:35:50,719 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/tmpF11nSA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:36:02 INFO - 2015-11-18 06:36:02,696 DEBUG : BROWSER_OUTPUT: RSS: Main: 229888000 06:36:02 INFO - 2015-11-18 06:36:02,696 DEBUG : BROWSER_OUTPUT: 06:36:54 INFO - 2015-11-18 06:36:54,486 DEBUG : BROWSER_OUTPUT: 1447857414483 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] 06:39:04 INFO - 2015-11-18 06:39:04,680 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50755/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50755/tests/dromaeo/cssquery-ext.html) 06:39:06 INFO - 2015-11-18 06:39:06,150 DEBUG : BROWSER_OUTPUT: RSS: Main: 358952960 06:39:06 INFO - 2015-11-18 06:39:06,150 DEBUG : BROWSER_OUTPUT: 06:42:08 INFO - 2015-11-18 06:42:08,783 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50755/tests/dromaeo/cssquery-ext.html (next: http://localhost:50755/tests/dromaeo/cssquery-jquery.html) 06:42:09 INFO - 2015-11-18 06:42:09,369 DEBUG : BROWSER_OUTPUT: RSS: Main: 364896256 06:42:09 INFO - 2015-11-18 06:42:09,369 DEBUG : BROWSER_OUTPUT: 06:45:11 INFO - 2015-11-18 06:45:11,593 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50755/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50755/tests/dromaeo/cssquery-mootools.html) 06:45:12 INFO - 2015-11-18 06:45:12,176 DEBUG : BROWSER_OUTPUT: RSS: Main: 334610432 06:45:12 INFO - 2015-11-18 06:45:12,176 DEBUG : BROWSER_OUTPUT: 06:48:14 INFO - 2015-11-18 06:48:14,237 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50755/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50755/tests/dromaeo/cssquery-prototype.html) 06:48:14 INFO - 2015-11-18 06:48:14,818 DEBUG : BROWSER_OUTPUT: RSS: Main: 326533120 06:48:14 INFO - 2015-11-18 06:48:14,818 DEBUG : BROWSER_OUTPUT: 06:51:18 INFO - 2015-11-18 06:51:18,192 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50755/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50755/tests/dromaeo/cssquery-yui.html) 06:51:18 INFO - 2015-11-18 06:51:18,795 DEBUG : BROWSER_OUTPUT: RSS: Main: 327499776 06:51:18 INFO - 2015-11-18 06:51:18,795 DEBUG : BROWSER_OUTPUT: 06:54:21 INFO - 2015-11-18 06:54:21,443 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50755/tests/dromaeo/cssquery-yui.html (next: http://localhost:50755/tests/dromaeo/cssquery-dojo.html) 06:54:21 INFO - 2015-11-18 06:54:21,702 DEBUG : BROWSER_OUTPUT: RSS: Main: 373800960 06:54:21 INFO - 2015-11-18 06:54:21,703 DEBUG : BROWSER_OUTPUT: 06:54:21 INFO - 2015-11-18 06:54:21,703 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:54:21 INFO - 2015-11-18 06:54:21,703 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:54:21 INFO - 2015-11-18 06:54:21,703 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:54:21 INFO - 2015-11-18 06:54:21,703 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:54:21 INFO - 2015-11-18 06:54:21,703 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3029.8788048478064;3031.227037105538;3157.7947433416825;3235.579374681291;3278.0493656839526;4943.728094954776;5060.190369540865;5100.770465329065;5113.335266415365;5151.381834179899;5034.723090230036;5109.284700141974;5115.10485665008;5128.410232823227;5212;4660.487346391894;4715.434147902257;4716.363290955712;4766.904661906777;4791.616670666338;4781.235002399617;4834.734089625069;4851;4881.915510262721;4909.435414927293;4516.728996260202;4622.676412651116;4623;4767.952320476803;4789.185838407479;4567.2692369221095;4657;4660.930086048712;4691.413573303337;4697.88255293617;4642.396488456513;4682.929756053662;4686.2267725825195;4697.459792123916;4698.154332220199;5061.139606266944;5117.104506711311;5125;5147.3308469898675;5194.532492075694;5380.730963451851;5412.891742165135;5442.9727851360885;5451.100568406208;5456.61803673743;5234.97382513085;5513.558915286768;5522.66863988158;5524.033294173503;5571.944280557183;4923.950760492385;4986.3019177314845;5003.224500202475;5072.340595722532;5085.516875896784;5496.890062198813;5566;5575.972120139373;5581.469760372758;5635.718214089361;5065.974670126626;5289.841304760864;5315.893682126336;5325.201219817059;5340.652857564246;5417.18742188667;5447.591430642718;5476.726163691799;5495;5503.889922201533;5384.111621582395;5419.485148910847;5443.727813609304;5445.128779395357;5448.346198456132;5240.6069544784295;5420.34955805298;5438.673679579238;5445.50990410857;5487.368952570426;4138.172365526846;4140.958590414118;4170.16596680665;4193.559676234013;4231.492220933507;3834.578196398394;3845.769253844778;3866.38137897935;3876.6511014008875;3887.727859049896;4927.95072049282;5223.451537588575;5247.816326428557;5250.3962044364625;5292.338457692788;5393.703346315911;5422.8373148805595;5434.076207044812;5496;5522.392536820947;5149.227615857576;5202.687838729613;5205.9739701302005;5227.424983251839;5231.947680523146;4570;4834.540718631724;4846.5638092571835;4875.219964805685;4882.2432522959;5575.135853942646;5613.158026296088;5618.466245706733;5631.774729010794;5644.096944488862;5535.059039963136;5572.693501857275;5593.021221286177;5607.775688972559;5619.80330688424;5245.659032162897;5659.886802264014;5699.9999999998345;5708.115242137475;5711.371749107512;5317.1492561190025;5321.148616221386;5323.228131920772;5355.839324820262;5413.079776437936;5471.835844924659;5512.2558454608115;5521.751521181476;5522.944770552243;5523.502884740393;5085.694858308513;5324.547413469743;5340.49265319794;5374.919376209438;5443.183522471502;5143.794248230029;5153.1754919214245;5252.816151434681;5309.867253318698;5337.519623233928;5094.898102037864;5209.505097015777;5213.739313034409;5221.660592061656;5223.686578805284;5120.564751996122;5325.147976323925;5349.545288650508;5351.03681337363;5409.161579955114;5132.79468821243;5178.042062218502;5189.870253243699;5198.116320225495;5228.58171346299 06:54:21 INFO - 2015-11-18 06:54:21,707 DEBUG : BROWSER_OUTPUT: |1;ext.html;525.3275806967082;528.6537318056672;529.9046171689097;542.2435702195439;547.7042397105563;29370.2657433564;30276.091717248462;30348.393032139345;36256.274874502495;37180.256394872085;39168.41247381292;39465;39661.20677586446;39674;39927.80036099815;8596.613152408157;8680.392372533925;8768.254698350647;8770.386072974894;8803;7989.480683755566;8104.5542495162745;8130.146334634866;8140.43016988811;8159.939207902964;10598.841017384746;10729.731756706067;10734.677959661183;10766.24636275461;10800.351978881254;10376.896231037706;10528.473576321154;10529.736756581071;10544.578216871316;10571.101456376216;8013.19868013194;8032.919670803276;10166.237532185041;10292.073713365759;10396.896031039743;35708.821455892816;36484.0878978025;36628.816855915815;36636.63363366359;36686.26627467462;2939.8824047038092;3112.859921303547;3169.746420286395;3255.755818313612;3302.620198677159;25711.74288257112;26158.476830463474;26198.214053578424;26278.868605656848;26467.01539529476;2250.22367283287;2272.7727227277305;2285.3029825903095;2303.389601755536;2414.5291668124723;236730;245056;245391;246987;247607.9999999982;53755;54065.72967135139;54313.72843135759;54319.72840135774;54352.45647543553;56140.43859561434;56565;56568;56575;56719;14977.176255306063;15359.078455292494;15426.305816238297;15601.375944962074;15605.531834044998;11241.381724005094;11769.17615766888;11918.106142039382;11920.463579138786;11931.821022684666;17166.31334746621;17399.565010874576;17519.912400437915;17567.912160439115;17579.64840703179;7412.332890039922;7624.27569380908;7689.769306920802;7699.307062364414;7715.537067775951;849.3074572369687;870.2646263906988;871;895.417978314088;962.20617990157;26375.20874373772;27175.45649087007;27201.036191994735;27598.5860212097;28588.857055714587;951.7335146158948;960.4861399151561;986.8963758805365;1027.547878933267;1035.29082578434;12771;13053.673658158432;13080.934595326962;13082.149660272053;13146.671333216746;275320.59774918953;278159;278928;279309;280347;48366.75816620894;48449.97475366052;48589.75705121522;48598;48763.51236487661;1106.5794997900907;1125.352922069813;1130.5421304371744;1130.5929865248504;1256.384371657881;25551.488970220118;26215.737842622093;26315.736842632094;26392.20823375302;26440.8677956609;43984.780076099414;44201.33697994597;44214.557854421044;44215.778921105186;44294.557054429046;267200;273536;274333;274422;275948;27203.72796272012;28112.43775124527;28208.85895570509;28332.291692707848;28369.29076773097;38068.80965595154;38374.616253837106;38651.03372415712;38947.221055578164;39417.802910985265;30741.23146921345;31981;32326;32328.191795205308;32413.67586324201;31406.371872561966;31689.36621267608;31975.520367194975;32064.51903221407;32129.839350803097;32188;32950.34099318048;33232.833835830665;33526.497102543966;33569.83215083909;25920.61119083253;27197.72802271952;27245.86377068181;27371.45257094807;27684.723152768216;22143.889280553492;22407.327780166623;22438.88780556087;22487.775122248568;22563.887180563994 06:54:21 INFO - 2015-11-18 06:54:21,708 DEBUG : BROWSER_OUTPUT: |2;jquery.html;303.17536301260566;318.8788260461026;319.24020830423586;320.67131190529705;323.75718211341484;13238.66903327416;13614.523491677794;16428.425005124824;16737.581560460996;17610.11949402531;16711.498655040337;17300.22149003295;17435.3025878965;17746.64506709865;17796.288148474046;3729.366007778684;3884;5090.287359769635;5242.973785131069;5253.57971362292;3835.789031603261;3851.9422208666892;3868.845246190149;3878.146807702301;5525.585581081415;4313.15893400787;5570.359408668014;5603.971980140114;5626.971865140668;5667.064934285838;4528.592426681598;4543.182227199103;4545.5908968193025;4555.931661025087;4566.84016059438;2814.2542226310043;2900.9709902900913;3806.923861522754;3867.671247943928;3873.9418908716393;12040.698982525419;12120.696982575506;12379.504819807196;12442;12473.189242699196;1557.1513525128719;1602.8877978541507;1737.391912830512;1741.5646088477881;1814.6467919636991;9026.593803278802;9047.18575328217;9220.21628161607;9242.306826988002;9377.39046961952;1452.876505497034;1485.6657252118296;1493.6191271225875;1498.7002599480147;1501.8423065578065;54527.18209226825;55195.448045519835;55255.44744552583;55358.723206384115;55881;6181.721822517998;6182.412670796267;6203.31763506014;6233.532485063638;6235.407636274546;7021.5787052777;7035.577865328097;7044.929550704427;7078.221395646475;7078.92921070793;4945.085159245551;4963.776630051656;4972.129877271535;5009.0232404681465;5021.748912554431;5163.793448262028;5179;5183.714895680774;5214.582833373321;5229.294045303835;2751.257160566676;2769.487644785721;2800.383915538578;2802.383475635357;2812.8607913794945;962.1821451766083;968.4915419404728;973.338130071544;978.9461579613047;1031.8452232165234;368.37560335231524;406.4411434277868;414.41774307098575;418.64206103781436;434.38534473719335;8527.616257268437;9575.281853860988;9913.355631883904;9956.651517197008;9997.300188986701;397.74146804577254;401.73084033697495;404.61561516559385;410.96712263018884;421.7300927406462;4682.9531704683195;5450.373207081237;5502.202180683778;5517.475839795213;5575.860603484945;442690;447309.03296484804;468997;480979;485717;64864.675676621315;69593.65203173952;69776.30223697698;70218.29781702117;71572;405.3109713487084;418.6002367738802;420.45131103909694;420.5878239325417;420.81694462908735;9517.191038761783;9520.428774273565;9559.904400955902;9734.951325243328;9749.853752193581;31806.204844879063;32628.916286574076;33535.16162095967;33593.83203083969;33719.32561348809;44964;45363.36969612158;45573.54426455826;45803;45981.31028034649;5614.9719251403485;5757.740901659519;5860.648361098348;5884.08796636522;5905.852353691193;10274.434906079938;10951.123910087334;10988.120950324115;10999.890001099886;11003.779924401628;9309.72070837876;9370.859437108586;9436.905630943602;9602.279829012712;9638.807223855623;9105.27157827359;9274.721758347261;9276.582553784961;9293.72118836436;9309.86035209486;9494.430334179971;9687.70936871895;9792.167665748206;9823;9838;5821.854453638693;5917.023691091094;5958.19564358806;5969.492593129633;5981.0729336952845;9441.905580944378;9527.666531671359;9838.60645574169;9870;9910.058544438267 06:54:21 INFO - 2015-11-18 06:54:21,712 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1188.9821652675205;1307.849597296311;1366.4465891314019;1428.2787192467802;1676.7987841459026;6293;6599.07612934189;6620.172478440195;6625.5030872684565;6630;6367;6701.195856497215;6850.897236541456;6897;6926.445884329254;2034.5320576267468;2090.1012564597218;2093.152273329304;2115.883626400547;2118.851680382374;1845.7231415287747;1892.0161516011665;2063.215977928385;2074.1703318672503;2083.510375061859;2054.815066644002;2060.6702927531596;2071.8860462674547;2082.1671331467383;2083.677030060343;2001.8898960557165;2033.3086750504826;2038.4394291569863;2049.385184444661;2057.043474784218;2038.847086468506;2043.7751847296786;2099.4436474334316;2102.358780571925;2104.368689393176;6786.219584747768;6863.725450981955;6865.725370985155;6888.070110535064;6902.171739391305;4286.57134286572;4356.6514678825615;4382.474103107647;4397.384366188736;4404.361367601712;2689.462107578492;2732.248631626299;2740.1505533284744;2748;2800.0759749282893;844.5270648436895;860.2816648098845;861.8190180062195;863.6977058029702;879.9189915849036;9232.399894006936;9252.583633736498;9264.49045302508;9280.396774209656;9299.814003719888;3531.2937412517085;3608.585012723518;3978.5026871641044;4020.175863947942;4036.4056197802292;7424.703011879572;7686.192949740309;7885.2114788520685;7892.250236227549;7915.16890726477;4186.309258972296;4222.894427639334;4226.070264541796;4238.17355615652;4263.893402664959;3790.223004284115;3793.2223894102194;3799.4680744695765;3799.848006079781;3813.1801662642665;3150.401423729484;3162.794418362799;3186.2193762527863;3209.3741720364774;3223.3069889973767;1038.5586125896464;1050.7110544600296;1054.746860753429;1055.773008803111;1064.5103252503934;1187.7327601289642;1197.2577002258656;1219.0978675779859;1233.6915771057236;1236.8701286364983;6629.966850165815;6645.335466453413;6673.9666301668185;6687.799366019027;6690.632015239208;592.4697395830793;636.9076483909807;639.1339734659563;644.5133923887529;645.6223109480912;5095.159298715745;5122.667026643257;5124.436312005676;5154.123798954111;5195.610329225247;8183.590820458953;8323.458975166595;8401.411901166983;8416.83166336682;8421.284190843724;8081.27268545822;8228.300594449538;8243.917560824435;8247.876281855777;8287.709930152536;6397.136386587751;6483.902741458882;6505.804825855232;6541.672916354163;6577.177852768404;6394.648294343856;6428.678566071584;6441.516886233645;6442.710078046405;6446.065320528591;7139.678714457758;7352.154502232312;7358.705651773869;7370.44721645868;7458.627068646654;7446.553206807609;7675.884861726967;7777.883331750141;7780.105287891738;7786.961065194638;5557.194206840067;5848.2689663792025;6104.359042300672;6121.867454520928;6141.907871382022;6706.195256569243;6726.293739157318;6746.4940129489505;6746.628935408599;6765.661716914036;6204.534659900616;6283.088952102011;6320.38830098322;6406.679666016774;6418.743250269937;6059.969700151471;6145.139680444652;6149.354317796567;6253.312135664983;6294.8111556653375;6311.400416960381;6325.240971083315;6338.809835704937;6354.841128971628;6360.395762402564;5737.368889422244;5746.569007324384;5791.247137872049;5794.420557944172;5794.739236734273;5614.69119198448;5768.105943578752;5818.709064546841;5851;5893.2044174035955 06:54:21 INFO - 2015-11-18 06:54:21,713 DEBUG : BROWSER_OUTPUT: |4;prototype.html;296.06738772865475;298.05962189292774;299.63594233006893;302.2624795498981;310.5745129173033;5812.970935145324;5846.415358464157;5886.764529418829;5895.616784908978;5929.970350148254;5833.854153646161;5857.502112320458;5860.794872179475;5869.7358618862145;5875.236219291497;4280.935785963213;4468.620167285784;4486.842960496383;4489.663275254353;4510.639148868099;4304.332828411586;4369.912601747963;4457.88855278619;4464.575865292808;4467.798949047285;4349.325854492558;4405.3391991201415;4420.160169567772;4424;4424.247877860771;4210.663146948237;4364.978175109136;4426.977865110686;4431.401760762305;4445.644348452132;3731.70146388291;3807.505024346845;3814.828332725034;3829.7319187656876;3839.2513459875336;5401.648892821954;5677.318721753416;5681.744321505542;5693.715314234313;5703.372629010805;4958.132326842824;5011;5016.2224855147515;5017.8243761468175;5024.472430394792;5980.880382392371;6080.087986801971;6103.450689437927;6134.079888016833;6149.754009839601;4040.252553277653;4058.6144316289906;4074.449949256842;4084.0606660468256;4084.1627466369323;6419.775307864203;6484;6484.870302593922;6499.837504062389;6538.934610653832;4128.256913755553;4145.0880806222585;4149.97925010373;4157.731891773038;4160.292750232467;4096.672266218755;4202.285611446;4249.490061192615;4265.125649241898;4271;4968.776405061709;4977.552020318189;4977.825776097891;4991.4758950310425;4993.825216117419;6088;6210.50315974721;6212.099245609361;6215.751369945152;6219.222597175353;1465.5896349022291;1484.2578710644677;1496.9670927060295;1498.3706843125913;1499.9925000374928;943.7876477792441;959.9904000959901;962.1725316228038;972.3290929258931;982.6511588386163;5946.4053594641055;5958.255218097738;5967.880642387128;5969.895654259847;5988.191594134823;6401.327860574573;6423.807285781434;6427.646479443675;6439.130717353191;6458.903116453257;5951;5959.195508606369;5976.641401515923;5981.132735753292;5983.341832398432;3324.900252992414;3382.4609802539785;3429.5884493860895;3454.671806178409;3480.147363895862;6679.9332006679315;6719.193696756421;6730.764423245163;6746.763863264762;6752.898706519406;6627.536072474881;6648.634325112165;6652.501062420338;6654.733810647616;6663.20041595002;6514.315996820361;6712.194536655633;6712.395884370332;6736.797896063028;6737.124173857367;6484;6496.7726129585235;6501.349865013461;6514.250861151028;6516.478681705357;6297.653629050446;6309.779157729457;6345.2702939160745;6372.74509019634;6373.649449280334;6475.384838440341;6682.732690692318;6693.431058360094;6695.564788288746;6698.799036028927;4180.352045432963;4200.684948628927;4217.97891010543;4233.6401405879615;4243.872683819491;6424.100625912282;6447.9032814508755;6470.773522926675;6470.805875823733;6490.383413575702;5968.432998865101;6264.968675156595;6273.96863015682;6275.309715931336;6302.968485157545;6211.472024877755;6243.500519958302;6249.937500624936;6251.906221406592;6270.15352927349;6049.3950604939155;6118.847028824315;6119.8776024478375;6131.080337949344;6135.171751813448;6050.42520960508;6275.654838983717;6277.497800176066;6280.560360774702;6299.118123462627;6104.053871649901;6169.907451388322;6191.25704915413;6194;6207.782727604512 06:54:21 INFO - 2015-11-18 06:54:21,716 DEBUG : BROWSER_OUTPUT: |5;yui.html;700.488643290398;710.7157137145141;717.9928200717991;725.7604990353184;755.5428965475891;12822.166559173671;12852;13082.345882705862;13107.213567185963;13544.1196322239;12322.260664360145;12378.566750163745;12410.069244806631;12471.875281247185;12495.750084998295;646.9741210351581;664.7307840324652;818.8034871630796;837.1335667584052;853.2107800284742;814.311906439058;820.0815087102453;828.8176601147737;830.4311546590575;835.1564919431388;862.3790870573177;871.0027019063169;872.6596627315353;874.2001069021837;880.1638443478689;663.4791688524485;669.1134247122582;674.7604600366898;683.1187767779559;683.4088513435892;616.929053158888;643.0193954219806;643.797203880776;643.893757530007;644.3234603666178;12690.682732931658;13058.085933984625;13066.412011459412;13082.803757943639;13196.406161722649;10736.19478539105;10967;11067.667969960914;11205.551777928873;11466.369349685763;8883.11168883113;9048.41185322952;9049.592768325441;9164.8625270621;9263.305252106118;3098.256418459576;3108.8290144042066;3122.5324097674056;3187.4103290891258;3276.3774882772436;46591.30113048307;46996.29505557419;47119.29321060187;47626.76186619079;48241.75879120582;8451;8546.829063418696;8571.22858942698;8591.65633374658;9033.77415564616;18106;18143.818561814212;18169.45491635253;18238.179281932345;18249.27002919895;6437.420632143036;6495.0582165586675;6566;6635.8009259722285;6777.830554236183;3512.1921957949817;3570.0003998880356;3617.2042150726797;3634.1821354910508;3634.273145370936;2764.737349951751;2777.333439974432;2782.8886844526396;2784.8746806393356;2792.3577577157366;405.1956865621739;405.21388506298274;418.18662701046173;418.9685773566995;419.490319262098;525.1649876696072;537.6263496869637;539.0620320642055;543;559.2282649943053;6683.532152749261;6826.419754320839;7293.0519032525435;7479.252074792477;7561.584112873735;433.68124428544996;448.8832903445128;458.67434121773914;461.2389557230529;468.2320993570547;3276.1318250663594;3278.068398445058;3284.4416449203213;3565.7682250654143;3627.4558816177782;57019.71490142523;57150;57442.42557574454;57733.71133144391;57874;48609;49284.26073608899;49968.50031499638;50053.74973125111;50341.993160137325;40955.385669214986;41213.79393103015;41254.1749165015;44418.333724994154;44527;7099.964500177466;7321.414286856932;7381.33567978863;7592.39260859141;7618.885716714143;31262.99999999909;32061.679383206803;32211.35577288488;33660.15849603681;33997.66002339945;39853.2029359417;41281.793591031856;41950.79024604979;42399.57600423956;42493.787531062146;6568;6882.965585172243;7016.263292354433;7045.154581450259;7047.436205103682;10111.24165687591;10163.288569800043;10255.641052563124;10276.126529245097;10442.791144177227;9476.857847132436;9645.469499177612;9733;9749.415035097916;9805.136543218456;9792.755181120529;9817.901820981699;10083.092521673085;10247.231457640557;10300.484975751333;9649.565769540248;9727.756806079904;9764.707058788248;10104.69685909424;10259.538320775433;8156.510609363457;8225;8319.916800832156;8434.072252052392;8745.868811967954;7799.805004874924;8449.535275559658;8482.109378515168;8649.048604653357;8817.206451419403 06:54:21 INFO - 2015-11-18 06:54:21,716 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:54:21 INFO - 2015-11-18 06:54:21,717 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:54:21 INFO - 2015-11-18 06:54:21,717 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1149 06:54:21 INFO - 2015-11-18 06:54:21,717 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:54:21 INFO - 2015-11-18 06:54:21,717 DEBUG : BROWSER_OUTPUT: __startTimestamp1447858461700__endTimestamp 06:54:21 INFO - 2015-11-18 06:54:21,717 DEBUG : BROWSER_OUTPUT: 06:54:21 INFO - 2015-11-18 06:54:21,718 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:54:21 INFO - 2015-11-18 06:54:21,718 DEBUG : BROWSER_OUTPUT: Number of tests: 6 06:54:21 INFO - 2015-11-18 06:54:21,718 DEBUG : BROWSER_OUTPUT: 06:54:21 INFO - 2015-11-18 06:54:21,718 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5081.82 Median:5223.45 stddev:533.28 (10.2%) stddev-sans-first:510.04 06:54:21 INFO - 2015-11-18 06:54:21,718 DEBUG : BROWSER_OUTPUT: Values: 3029.9 3031.2 3157.8 3235.6 3278.0 4943.7 5060.2 5100.8 5113.3 5151.4 5034.7 5109.3 5115.1 5128.4 5212.0 4660.5 4715.4 4716.4 4766.9 4791.6 4781.2 4834.7 4851.0 4881.9 4909.4 4516.7 4622.7 4623.0 4768.0 4789.2 4567.3 4657.0 4660.9 4691.4 4697.9 4642.4 4682.9 4686.2 4697.5 4698.2 5061.1 5117.1 5125.0 5147.3 5194.5 5380.7 5412.9 5443.0 5451.1 5456.6 5235.0 5513.6 5522.7 5524.0 5571.9 4924.0 4986.3 5003.2 5072.3 5085.5 5496.9 5566.0 5576.0 5581.5 5635.7 5066.0 5289.8 5315.9 5325.2 5340.7 5417.2 5447.6 5476.7 5495.0 5503.9 5384.1 5419.5 5443.7 5445.1 5448.3 5240.6 5420.3 5438.7 5445.5 5487.4 4138.2 4141.0 4170.2 4193.6 4231.5 3834.6 3845.8 3866.4 3876.7 3887.7 4928.0 5223.5 5247.8 5250.4 5292.3 5393.7 5422.8 5434.1 5496.0 5522.4 5149.2 5202.7 5206.0 5227.4 5231.9 4570.0 4834.5 4846.6 4875.2 4882.2 5575.1 5613.2 5618.5 5631.8 5644.1 5535.1 5572.7 5593.0 5607.8 5619.8 5245.7 5659.9 5700.0 5708.1 5711.4 5317.1 5321.1 5323.2 5355.8 5413.1 5471.8 5512.3 5521.8 5522.9 5523.5 5085.7 5324.5 5340.5 5374.9 5443.2 5143.8 5153.2 5252.8 5309.9 5337.5 5094.9 5209.5 5213.7 5221.7 5223.7 5120.6 5325.1 5349.5 5351.0 5409.2 5132.8 5178.0 5189.9 5198.1 5228.6 06:54:21 INFO - 2015-11-18 06:54:21,718 DEBUG : BROWSER_OUTPUT: 06:54:21 INFO - 2015-11-18 06:54:21,718 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42293.14 Median:16155.07 stddev:69314.16 (429.1%) stddev-sans-first:69437.66 06:54:21 INFO - 2015-11-18 06:54:21,718 DEBUG : BROWSER_OUTPUT: Values: 525.3 528.7 529.9 542.2 547.7 29370.3 30276.1 30348.4 36256.3 37180.3 39168.4 39465.0 39661.2 39674.0 39927.8 8596.6 8680.4 8768.3 8770.4 8803.0 7989.5 8104.6 8130.1 8140.4 8159.9 10598.8 10729.7 10734.7 10766.2 10800.4 10376.9 10528.5 10529.7 10544.6 10571.1 8013.2 8032.9 10166.2 10292.1 10396.9 35708.8 36484.1 36628.8 36636.6 36686.3 2939.9 3112.9 3169.7 3255.8 3302.6 25711.7 26158.5 26198.2 26278.9 26467.0 2250.2 2272.8 2285.3 2303.4 2414.5 236730.0 245056.0 245391.0 246987.0 247608.0 53755.0 54065.7 54313.7 54319.7 54352.5 56140.4 56565.0 56568.0 56575.0 56719.0 14977.2 15359.1 15426.3 15601.4 15605.5 11241.4 11769.2 11918.1 11920.5 11931.8 17166.3 17399.6 17519.9 17567.9 17579.6 7412.3 7624.3 7689.8 7699.3 7715.5 849.3 870.3 871.0 895.4 962.2 26375.2 27175.5 27201.0 27598.6 28588.9 951.7 960.5 986.9 1027.5 1035.3 12771.0 13053.7 13080.9 13082.1 13146.7 275320.6 278159.0 278928.0 279309.0 280347.0 48366.8 48450.0 48589.8 48598.0 48763.5 1106.6 1125.4 1130.5 1130.6 1256.4 25551.5 26215.7 26315.7 26392.2 26440.9 43984.8 44201.3 44214.6 44215.8 44294.6 267200.0 273536.0 274333.0 274422.0 275948.0 27203.7 28112.4 28208.9 28332.3 28369.3 38068.8 38374.6 38651.0 38947.2 39417.8 30741.2 31981.0 32326.0 32328.2 32413.7 31406.4 31689.4 31975.5 32064.5 32129.8 32188.0 32950.3 33232.8 33526.5 33569.8 25920.6 27197.7 27245.9 27371.5 27684.7 22143.9 22407.3 22438.9 22487.8 22563.9 06:54:21 INFO - 2015-11-18 06:54:21,719 DEBUG : BROWSER_OUTPUT: 06:54:21 INFO - 2015-11-18 06:54:21,719 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:23944.53 Median:4967.95 stddev:76376.11 (1537.4%) stddev-sans-first:76569.74 06:54:21 INFO - 2015-11-18 06:54:21,720 DEBUG : BROWSER_OUTPUT: Values: 303.2 318.9 319.2 320.7 323.8 13238.7 13614.5 16428.4 16737.6 17610.1 16711.5 17300.2 17435.3 17746.6 17796.3 3729.4 3884.0 5090.3 5243.0 5253.6 3835.8 3851.9 3868.8 3878.1 5525.6 4313.2 5570.4 5604.0 5627.0 5667.1 4528.6 4543.2 4545.6 4555.9 4566.8 2814.3 2901.0 3806.9 3867.7 3873.9 12040.7 12120.7 12379.5 12442.0 12473.2 1557.2 1602.9 1737.4 1741.6 1814.6 9026.6 9047.2 9220.2 9242.3 9377.4 1452.9 1485.7 1493.6 1498.7 1501.8 54527.2 55195.4 55255.4 55358.7 55881.0 6181.7 6182.4 6203.3 6233.5 6235.4 7021.6 7035.6 7044.9 7078.2 7078.9 4945.1 4963.8 4972.1 5009.0 5021.7 5163.8 5179.0 5183.7 5214.6 5229.3 2751.3 2769.5 2800.4 2802.4 2812.9 962.2 968.5 973.3 978.9 1031.8 368.4 406.4 414.4 418.6 434.4 8527.6 9575.3 9913.4 9956.7 9997.3 397.7 401.7 404.6 411.0 421.7 4683.0 5450.4 5502.2 5517.5 5575.9 442690.0 447309.0 468997.0 480979.0 485717.0 64864.7 69593.7 69776.3 70218.3 71572.0 405.3 418.6 420.5 420.6 420.8 9517.2 9520.4 9559.9 9735.0 9749.9 31806.2 32628.9 33535.2 33593.8 33719.3 44964.0 45363.4 45573.5 45803.0 45981.3 5615.0 5757.7 5860.6 5884.1 5905.9 10274.4 10951.1 10988.1 10999.9 11003.8 9309.7 9370.9 9436.9 9602.3 9638.8 9105.3 9274.7 9276.6 9293.7 9309.9 9494.4 9687.7 9792.2 9823.0 9838.0 5821.9 5917.0 5958.2 5969.5 5981.1 9441.9 9527.7 9838.6 9870.0 9910.1 06:54:21 INFO - 2015-11-18 06:54:21,720 DEBUG : BROWSER_OUTPUT: 06:54:21 INFO - 2015-11-18 06:54:21,720 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4838.89 Median:6131.89 stddev:2480.82 (40.5%) stddev-sans-first:2472.60 06:54:21 INFO - 2015-11-18 06:54:21,722 DEBUG : BROWSER_OUTPUT: Values: 1189.0 1307.8 1366.4 1428.3 1676.8 6293.0 6599.1 6620.2 6625.5 6630.0 6367.0 6701.2 6850.9 6897.0 6926.4 2034.5 2090.1 2093.2 2115.9 2118.9 1845.7 1892.0 2063.2 2074.2 2083.5 2054.8 2060.7 2071.9 2082.2 2083.7 2001.9 2033.3 2038.4 2049.4 2057.0 2038.8 2043.8 2099.4 2102.4 2104.4 6786.2 6863.7 6865.7 6888.1 6902.2 4286.6 4356.7 4382.5 4397.4 4404.4 2689.5 2732.2 2740.2 2748.0 2800.1 844.5 860.3 861.8 863.7 879.9 9232.4 9252.6 9264.5 9280.4 9299.8 3531.3 3608.6 3978.5 4020.2 4036.4 7424.7 7686.2 7885.2 7892.3 7915.2 4186.3 4222.9 4226.1 4238.2 4263.9 3790.2 3793.2 3799.5 3799.8 3813.2 3150.4 3162.8 3186.2 3209.4 3223.3 1038.6 1050.7 1054.7 1055.8 1064.5 1187.7 1197.3 1219.1 1233.7 1236.9 6630.0 6645.3 6674.0 6687.8 6690.6 592.5 636.9 639.1 644.5 645.6 5095.2 5122.7 5124.4 5154.1 5195.6 8183.6 8323.5 8401.4 8416.8 8421.3 8081.3 8228.3 8243.9 8247.9 8287.7 6397.1 6483.9 6505.8 6541.7 6577.2 6394.6 6428.7 6441.5 6442.7 6446.1 7139.7 7352.2 7358.7 7370.4 7458.6 7446.6 7675.9 7777.9 7780.1 7787.0 5557.2 5848.3 6104.4 6121.9 6141.9 6706.2 6726.3 6746.5 6746.6 6765.7 6204.5 6283.1 6320.4 6406.7 6418.7 6060.0 6145.1 6149.4 6253.3 6294.8 6311.4 6325.2 6338.8 6354.8 6360.4 5737.4 5746.6 5791.2 5794.4 5794.7 5614.7 5768.1 5818.7 5851.0 5893.2 06:54:21 INFO - 2015-11-18 06:54:21,722 DEBUG : BROWSER_OUTPUT: 06:54:21 INFO - 2015-11-18 06:54:21,722 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5159.45 Median:5969.16 stddev:1614.14 (27.0%) stddev-sans-first:1576.85 06:54:21 INFO - 2015-11-18 06:54:21,723 DEBUG : BROWSER_OUTPUT: Values: 296.1 298.1 299.6 302.3 310.6 5813.0 5846.4 5886.8 5895.6 5930.0 5833.9 5857.5 5860.8 5869.7 5875.2 4280.9 4468.6 4486.8 4489.7 4510.6 4304.3 4369.9 4457.9 4464.6 4467.8 4349.3 4405.3 4420.2 4424.0 4424.2 4210.7 4365.0 4427.0 4431.4 4445.6 3731.7 3807.5 3814.8 3829.7 3839.3 5401.6 5677.3 5681.7 5693.7 5703.4 4958.1 5011.0 5016.2 5017.8 5024.5 5980.9 6080.1 6103.5 6134.1 6149.8 4040.3 4058.6 4074.4 4084.1 4084.2 6419.8 6484.0 6484.9 6499.8 6538.9 4128.3 4145.1 4150.0 4157.7 4160.3 4096.7 4202.3 4249.5 4265.1 4271.0 4968.8 4977.6 4977.8 4991.5 4993.8 6088.0 6210.5 6212.1 6215.8 6219.2 1465.6 1484.3 1497.0 1498.4 1500.0 943.8 960.0 962.2 972.3 982.7 5946.4 5958.3 5967.9 5969.9 5988.2 6401.3 6423.8 6427.6 6439.1 6458.9 5951.0 5959.2 5976.6 5981.1 5983.3 3324.9 3382.5 3429.6 3454.7 3480.1 6679.9 6719.2 6730.8 6746.8 6752.9 6627.5 6648.6 6652.5 6654.7 6663.2 6514.3 6712.2 6712.4 6736.8 6737.1 6484.0 6496.8 6501.3 6514.3 6516.5 6297.7 6309.8 6345.3 6372.7 6373.6 6475.4 6682.7 6693.4 6695.6 6698.8 4180.4 4200.7 4218.0 4233.6 4243.9 6424.1 6447.9 6470.8 6470.8 6490.4 5968.4 6265.0 6274.0 6275.3 6303.0 6211.5 6243.5 6249.9 6251.9 6270.2 6049.4 6118.8 6119.9 6131.1 6135.2 6050.4 6275.7 6277.5 6280.6 6299.1 6104.1 6169.9 6191.3 6194.0 6207.8 06:54:21 INFO - 2015-11-18 06:54:21,723 DEBUG : BROWSER_OUTPUT: 06:54:21 INFO - 2015-11-18 06:54:21,724 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12784.26 Median:531.40 stddev:15511.77 (2919.1%) stddev-sans-first:15528.74 06:54:21 INFO - 2015-11-18 06:54:21,725 DEBUG : BROWSER_OUTPUT: Values: 700.5 710.7 718.0 725.8 755.5 12822.2 12852.0 13082.3 13107.2 13544.1 12322.3 12378.6 12410.1 12471.9 12495.8 647.0 664.7 818.8 837.1 853.2 814.3 820.1 828.8 830.4 835.2 862.4 871.0 872.7 874.2 880.2 663.5 669.1 674.8 683.1 683.4 616.9 643.0 643.8 643.9 644.3 12690.7 13058.1 13066.4 13082.8 13196.4 10736.2 10967.0 11067.7 11205.6 11466.4 8883.1 9048.4 9049.6 9164.9 9263.3 3098.3 3108.8 3122.5 3187.4 3276.4 46591.3 46996.3 47119.3 47626.8 48241.8 8451.0 8546.8 8571.2 8591.7 9033.8 18106.0 18143.8 18169.5 18238.2 18249.3 6437.4 6495.1 6566.0 6635.8 6777.8 3512.2 3570.0 3617.2 3634.2 3634.3 2764.7 2777.3 2782.9 2784.9 2792.4 405.2 405.2 418.2 419.0 419.5 525.2 537.6 539.1 543.0 559.2 6683.5 6826.4 7293.1 7479.3 7561.6 433.7 448.9 458.7 461.2 468.2 3276.1 3278.1 3284.4 3565.8 3627.5 57019.7 57150.0 57442.4 57733.7 57874.0 48609.0 49284.3 49968.5 50053.7 50342.0 40955.4 41213.8 41254.2 44418.3 44527.0 7100.0 7321.4 7381.3 7592.4 7618.9 31263.0 32061.7 32211.4 33660.2 33997.7 39853.2 41281.8 41950.8 42399.6 42493.8 6568.0 6883.0 7016.3 7045.2 7047.4 10111.2 10163.3 10255.6 10276.1 10442.8 9476.9 9645.5 9733.0 9749.4 9805.1 9792.8 9817.9 10083.1 10247.2 10300.5 9649.6 9727.8 9764.7 10104.7 10259.5 8156.5 8225.0 8319.9 8434.1 8745.9 7799.8 8449.5 8482.1 8649.0 8817.2 06:54:21 INFO - 2015-11-18 06:54:21,725 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:54:21 INFO - 2015-11-18 06:54:21,725 DEBUG : BROWSER_OUTPUT: 06:54:22 INFO - 2015-11-18 06:54:22,171 INFO : Browser exited with error code: 0 06:54:22 INFO - 2015-11-18 06:54:22,200 INFO : Completed test dromaeo_css (00:18:35) 06:54:22 INFO - 2015-11-18 06:54:22,201 INFO : Starting test kraken 06:54:22 INFO - 2015-11-18 06:54:22,201 DEBUG : operating with platform_type : mac_ 06:54:22 INFO - 2015-11-18 06:54:22,201 INFO : Initialising browser for kraken test... 06:54:22 INFO - 2015-11-18 06:54:22,214 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/tmpLNtL3C/profile http://localhost:50755/getInfo.html 06:54:24 INFO - 2015-11-18 06:54:24,512 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:54:24 INFO - 2015-11-18 06:54:24,512 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:54:24 INFO - 2015-11-18 06:54:24,512 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 06:54:24 INFO - 2015-11-18 06:54:24,512 DEBUG : BROWSER_OUTPUT: __metrics 06:54:24 INFO - 2015-11-18 06:54:24,530 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:54:25 INFO - 2015-11-18 06:54:25,223 INFO : Browser initialized. 06:54:25 INFO - 2015-11-18 06:54:25,223 INFO : Running cycle 1/1 for kraken test... 06:54:25 INFO - 2015-11-18 06:54:25,224 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/tmpLNtL3C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:54:37 INFO - 2015-11-18 06:54:37,234 DEBUG : BROWSER_OUTPUT: RSS: Main: 227979264 06:54:37 INFO - 2015-11-18 06:54:37,234 DEBUG : BROWSER_OUTPUT: 06:54:39 INFO - 2015-11-18 06:54:39,768 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50755/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50755/tests/kraken/driver.html?testName=audio-beat-detection) 06:54:40 INFO - 2015-11-18 06:54:40,352 DEBUG : BROWSER_OUTPUT: RSS: Main: 286277632 06:54:40 INFO - 2015-11-18 06:54:40,352 DEBUG : BROWSER_OUTPUT: 06:54:43 INFO - 2015-11-18 06:54:43,050 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50755/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50755/tests/kraken/driver.html?testName=audio-dft) 06:54:43 INFO - 2015-11-18 06:54:43,626 DEBUG : BROWSER_OUTPUT: RSS: Main: 299503616 06:54:43 INFO - 2015-11-18 06:54:43,626 DEBUG : BROWSER_OUTPUT: 06:54:46 INFO - 2015-11-18 06:54:46,691 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50755/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50755/tests/kraken/driver.html?testName=audio-fft) 06:54:47 INFO - 2015-11-18 06:54:47,275 DEBUG : BROWSER_OUTPUT: RSS: Main: 280928256 06:54:47 INFO - 2015-11-18 06:54:47,275 DEBUG : BROWSER_OUTPUT: 06:54:49 INFO - 2015-11-18 06:54:49,348 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50755/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50755/tests/kraken/driver.html?testName=audio-oscillator) 06:54:49 INFO - 2015-11-18 06:54:49,924 DEBUG : BROWSER_OUTPUT: RSS: Main: 283820032 06:54:49 INFO - 2015-11-18 06:54:49,924 DEBUG : BROWSER_OUTPUT: 06:54:52 INFO - 2015-11-18 06:54:52,177 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50755/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50755/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:54:52 INFO - 2015-11-18 06:54:52,748 DEBUG : BROWSER_OUTPUT: RSS: Main: 285065216 06:54:52 INFO - 2015-11-18 06:54:52,748 DEBUG : BROWSER_OUTPUT: 06:54:55 INFO - 2015-11-18 06:54:55,950 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50755/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50755/tests/kraken/driver.html?testName=imaging-darkroom) 06:54:56 INFO - 2015-11-18 06:54:56,541 DEBUG : BROWSER_OUTPUT: RSS: Main: 284999680 06:54:56 INFO - 2015-11-18 06:54:56,542 DEBUG : BROWSER_OUTPUT: 06:54:59 INFO - 2015-11-18 06:54:59,817 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50755/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50755/tests/kraken/driver.html?testName=imaging-desaturate) 06:55:00 INFO - 2015-11-18 06:55:00,402 DEBUG : BROWSER_OUTPUT: RSS: Main: 284192768 06:55:00 INFO - 2015-11-18 06:55:00,402 DEBUG : BROWSER_OUTPUT: 06:55:03 INFO - 2015-11-18 06:55:03,426 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50755/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50755/tests/kraken/driver.html?testName=json-parse-financial) 06:55:04 INFO - 2015-11-18 06:55:04,009 DEBUG : BROWSER_OUTPUT: RSS: Main: 284237824 06:55:04 INFO - 2015-11-18 06:55:04,010 DEBUG : BROWSER_OUTPUT: 06:55:05 INFO - 2015-11-18 06:55:05,616 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50755/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50755/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:55:06 INFO - 2015-11-18 06:55:06,179 DEBUG : BROWSER_OUTPUT: RSS: Main: 319688704 06:55:06 INFO - 2015-11-18 06:55:06,180 DEBUG : BROWSER_OUTPUT: 06:55:08 INFO - 2015-11-18 06:55:08,082 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50755/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50755/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:55:08 INFO - 2015-11-18 06:55:08,691 DEBUG : BROWSER_OUTPUT: RSS: Main: 320483328 06:55:08 INFO - 2015-11-18 06:55:08,691 DEBUG : BROWSER_OUTPUT: 06:55:10 INFO - 2015-11-18 06:55:10,865 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50755/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50755/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:55:11 INFO - 2015-11-18 06:55:11,449 DEBUG : BROWSER_OUTPUT: RSS: Main: 329211904 06:55:11 INFO - 2015-11-18 06:55:11,450 DEBUG : BROWSER_OUTPUT: 06:55:14 INFO - 2015-11-18 06:55:14,157 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50755/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50755/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:55:14 INFO - 2015-11-18 06:55:14,754 DEBUG : BROWSER_OUTPUT: RSS: Main: 329084928 06:55:14 INFO - 2015-11-18 06:55:14,754 DEBUG : BROWSER_OUTPUT: 06:55:17 INFO - 2015-11-18 06:55:17,545 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50755/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50755/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:55:18 INFO - 2015-11-18 06:55:18,128 DEBUG : BROWSER_OUTPUT: RSS: Main: 330039296 06:55:18 INFO - 2015-11-18 06:55:18,128 DEBUG : BROWSER_OUTPUT: 06:55:19 INFO - 2015-11-18 06:55:19,915 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50755/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50755/tests/kraken/driver.html?testName=ai-astar) 06:55:20 INFO - 2015-11-18 06:55:20,162 DEBUG : BROWSER_OUTPUT: RSS: Main: 389292032 06:55:20 INFO - 2015-11-18 06:55:20,162 DEBUG : BROWSER_OUTPUT: 06:55:20 INFO - 2015-11-18 06:55:20,162 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:55:20 INFO - 2015-11-18 06:55:20,162 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:55:20 INFO - 2015-11-18 06:55:20,162 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:55:20 INFO - 2015-11-18 06:55:20,162 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:55:20 INFO - 2015-11-18 06:55:20,163 DEBUG : BROWSER_OUTPUT: |0;ai-astar;105;104;100;109;106;106;107;107;102;107 06:55:20 INFO - 2015-11-18 06:55:20,163 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;158;133;154;163;131;154;150;134;187;132 06:55:20 INFO - 2015-11-18 06:55:20,163 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;162;170;174;174;173;169;174;174 06:55:20 INFO - 2015-11-18 06:55:20,163 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;85;92;90;70;70;73;87;91;75 06:55:20 INFO - 2015-11-18 06:55:20,163 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;100;103;136;92;94;101;138;94;94;134 06:55:20 INFO - 2015-11-18 06:55:20,163 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;125;124;116;127;130;135;123;123;129;129 06:55:20 INFO - 2015-11-18 06:55:20,163 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;125;130;135;136;136;135;135;141;136;136 06:55:20 INFO - 2015-11-18 06:55:20,164 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;103;109;106;105;110;108;109;104;105;111 06:55:20 INFO - 2015-11-18 06:55:20,164 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;59;59;59;61;62;64;73;62;63 06:55:20 INFO - 2015-11-18 06:55:20,164 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;70;71;76;76;76;76;76;76 06:55:20 INFO - 2015-11-18 06:55:20,164 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;86;88;92;95;96;96;91;92;94;94 06:55:20 INFO - 2015-11-18 06:55:20,166 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;126;132;136;138;143;137;143;138;145;137 06:55:20 INFO - 2015-11-18 06:55:20,166 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;161;149;172;170;169;169;172;165;169;165 06:55:20 INFO - 2015-11-18 06:55:20,166 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;72;72;73;72;76;76;76;78;79;78 06:55:20 INFO - 2015-11-18 06:55:20,166 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:55:20 INFO - 2015-11-18 06:55:20,167 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:55:20 INFO - 2015-11-18 06:55:20,167 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,916 06:55:20 INFO - 2015-11-18 06:55:20,167 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:55:20 INFO - 2015-11-18 06:55:20,167 DEBUG : BROWSER_OUTPUT: __startTimestamp1447858520161__endTimestamp 06:55:20 INFO - 2015-11-18 06:55:20,167 DEBUG : BROWSER_OUTPUT: 06:55:20 INFO - 2015-11-18 06:55:20,167 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:55:20 INFO - 2015-11-18 06:55:20,167 DEBUG : BROWSER_OUTPUT: Number of tests: 14 06:55:20 INFO - 2015-11-18 06:55:20,168 DEBUG : BROWSER_OUTPUT: 06:55:20 INFO - 2015-11-18 06:55:20,168 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:105.30 Median:106.50 stddev:2.67 (2.5%) stddev-sans-first:2.83 06:55:20 INFO - 2015-11-18 06:55:20,168 DEBUG : BROWSER_OUTPUT: Values: 105.0 104.0 100.0 109.0 106.0 106.0 107.0 107.0 102.0 107.0 06:55:20 INFO - 2015-11-18 06:55:20,168 DEBUG : BROWSER_OUTPUT: 06:55:20 INFO - 2015-11-18 06:55:20,170 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.60 Median:154.00 stddev:17.83 (11.6%) stddev-sans-first:18.65 06:55:20 INFO - 2015-11-18 06:55:20,170 DEBUG : BROWSER_OUTPUT: Values: 158.0 133.0 154.0 163.0 131.0 154.0 150.0 134.0 187.0 132.0 06:55:20 INFO - 2015-11-18 06:55:20,170 DEBUG : BROWSER_OUTPUT: 06:55:20 INFO - 2015-11-18 06:55:20,170 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:169.20 Median:173.50 stddev:5.71 (3.3%) stddev-sans-first:5.23 06:55:20 INFO - 2015-11-18 06:55:20,170 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 162.0 170.0 174.0 174.0 173.0 169.0 174.0 174.0 06:55:20 INFO - 2015-11-18 06:55:20,170 DEBUG : BROWSER_OUTPUT: 06:55:20 INFO - 2015-11-18 06:55:20,171 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.60 Median:86.00 stddev:9.18 (10.7%) stddev-sans-first:9.32 06:55:20 INFO - 2015-11-18 06:55:20,171 DEBUG : BROWSER_OUTPUT: Values: 73.0 85.0 92.0 90.0 70.0 70.0 73.0 87.0 91.0 75.0 06:55:20 INFO - 2015-11-18 06:55:20,171 DEBUG : BROWSER_OUTPUT: 06:55:20 INFO - 2015-11-18 06:55:20,171 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:108.60 Median:115.00 stddev:19.26 (16.7%) stddev-sans-first:20.17 06:55:20 INFO - 2015-11-18 06:55:20,171 DEBUG : BROWSER_OUTPUT: Values: 100.0 103.0 136.0 92.0 94.0 101.0 138.0 94.0 94.0 134.0 06:55:20 INFO - 2015-11-18 06:55:20,171 DEBUG : BROWSER_OUTPUT: 06:55:20 INFO - 2015-11-18 06:55:20,172 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:126.10 Median:128.00 stddev:5.15 (4.0%) stddev-sans-first:5.45 06:55:20 INFO - 2015-11-18 06:55:20,172 DEBUG : BROWSER_OUTPUT: Values: 125.0 124.0 116.0 127.0 130.0 135.0 123.0 123.0 129.0 129.0 06:55:20 INFO - 2015-11-18 06:55:20,172 DEBUG : BROWSER_OUTPUT: 06:55:20 INFO - 2015-11-18 06:55:20,172 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:134.50 Median:136.00 stddev:4.25 (3.1%) stddev-sans-first:2.79 06:55:20 INFO - 2015-11-18 06:55:20,172 DEBUG : BROWSER_OUTPUT: Values: 125.0 130.0 135.0 136.0 136.0 135.0 135.0 141.0 136.0 136.0 06:55:20 INFO - 2015-11-18 06:55:20,172 DEBUG : BROWSER_OUTPUT: 06:55:20 INFO - 2015-11-18 06:55:20,173 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:107.00 Median:108.50 stddev:2.75 (2.5%) stddev-sans-first:2.51 06:55:20 INFO - 2015-11-18 06:55:20,173 DEBUG : BROWSER_OUTPUT: Values: 103.0 109.0 106.0 105.0 110.0 108.0 109.0 104.0 105.0 111.0 06:55:20 INFO - 2015-11-18 06:55:20,173 DEBUG : BROWSER_OUTPUT: 06:55:20 INFO - 2015-11-18 06:55:20,173 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:62.10 Median:62.00 stddev:4.25 (6.9%) stddev-sans-first:4.36 06:55:20 INFO - 2015-11-18 06:55:20,173 DEBUG : BROWSER_OUTPUT: Values: 59.0 59.0 59.0 59.0 61.0 62.0 64.0 73.0 62.0 63.0 06:55:20 INFO - 2015-11-18 06:55:20,173 DEBUG : BROWSER_OUTPUT: 06:55:20 INFO - 2015-11-18 06:55:20,173 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:73.30 Median:76.00 stddev:3.59 (4.7%) stddev-sans-first:3.26 06:55:20 INFO - 2015-11-18 06:55:20,173 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 70.0 71.0 76.0 76.0 76.0 76.0 76.0 76.0 06:55:20 INFO - 2015-11-18 06:55:20,173 DEBUG : BROWSER_OUTPUT: 06:55:20 INFO - 2015-11-18 06:55:20,174 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:92.40 Median:94.00 stddev:3.34 (3.6%) stddev-sans-first:2.62 06:55:20 INFO - 2015-11-18 06:55:20,174 DEBUG : BROWSER_OUTPUT: Values: 86.0 88.0 92.0 95.0 96.0 96.0 91.0 92.0 94.0 94.0 06:55:20 INFO - 2015-11-18 06:55:20,174 DEBUG : BROWSER_OUTPUT: 06:55:20 INFO - 2015-11-18 06:55:20,174 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:137.50 Median:138.00 stddev:5.60 (4.1%) stddev-sans-first:4.12 06:55:20 INFO - 2015-11-18 06:55:20,174 DEBUG : BROWSER_OUTPUT: Values: 126.0 132.0 136.0 138.0 143.0 137.0 143.0 138.0 145.0 137.0 06:55:20 INFO - 2015-11-18 06:55:20,174 DEBUG : BROWSER_OUTPUT: 06:55:20 INFO - 2015-11-18 06:55:20,174 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.10 Median:169.00 stddev:6.92 (4.1%) stddev-sans-first:7.09 06:55:20 INFO - 2015-11-18 06:55:20,174 DEBUG : BROWSER_OUTPUT: Values: 161.0 149.0 172.0 170.0 169.0 169.0 172.0 165.0 169.0 165.0 06:55:20 INFO - 2015-11-18 06:55:20,174 DEBUG : BROWSER_OUTPUT: 06:55:20 INFO - 2015-11-18 06:55:20,175 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.20 Median:76.00 stddev:2.74 (3.6%) stddev-sans-first:2.65 06:55:20 INFO - 2015-11-18 06:55:20,175 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 73.0 72.0 76.0 76.0 76.0 78.0 79.0 78.0 06:55:20 INFO - 2015-11-18 06:55:20,175 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:55:20 INFO - 2015-11-18 06:55:20,175 DEBUG : BROWSER_OUTPUT: 06:55:20 INFO - 2015-11-18 06:55:20,860 INFO : Browser exited with error code: 0 06:55:20 INFO - 2015-11-18 06:55:20,912 INFO : Completed test kraken (00:00:58) 06:55:20 INFO - 2015-11-18 06:55:20,912 INFO : Starting test v8_7 06:55:20 INFO - 2015-11-18 06:55:20,912 DEBUG : operating with platform_type : mac_ 06:55:20 INFO - 2015-11-18 06:55:20,912 INFO : Initialising browser for v8_7 test... 06:55:20 INFO - 2015-11-18 06:55:20,926 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/tmp9ntEUB/profile http://localhost:50755/getInfo.html 06:55:23 INFO - 2015-11-18 06:55:23,198 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:55:23 INFO - 2015-11-18 06:55:23,198 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:55:23 INFO - 2015-11-18 06:55:23,200 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 06:55:23 INFO - 2015-11-18 06:55:23,200 DEBUG : BROWSER_OUTPUT: __metrics 06:55:23 INFO - 2015-11-18 06:55:23,219 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:55:23 INFO - 2015-11-18 06:55:23,897 INFO : Browser initialized. 06:55:23 INFO - 2015-11-18 06:55:23,897 INFO : Running cycle 1/1 for v8_7 test... 06:55:23 INFO - 2015-11-18 06:55:23,898 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/tmp9ntEUB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:55:35 INFO - 2015-11-18 06:55:35,906 DEBUG : BROWSER_OUTPUT: RSS: Main: 229625856 06:55:35 INFO - 2015-11-18 06:55:35,906 DEBUG : BROWSER_OUTPUT: 06:55:57 INFO - 2015-11-18 06:55:57,482 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50755/tests/v8_7/run.html (next: http://localhost:50755/tests/v8_7/run.html) 06:55:57 INFO - 2015-11-18 06:55:57,741 DEBUG : BROWSER_OUTPUT: RSS: Main: 745783296 06:55:57 INFO - 2015-11-18 06:55:57,741 DEBUG : BROWSER_OUTPUT: 06:55:57 INFO - 2015-11-18 06:55:57,741 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:55:57 INFO - 2015-11-18 06:55:57,741 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:55:57 INFO - 2015-11-18 06:55:57,741 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:55:57 INFO - 2015-11-18 06:55:57,741 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:55:57 INFO - 2015-11-18 06:55:57,742 DEBUG : BROWSER_OUTPUT: |0;Richards;168.89039013680122 06:55:57 INFO - 2015-11-18 06:55:57,742 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;200.3606491685033 06:55:57 INFO - 2015-11-18 06:55:57,742 DEBUG : BROWSER_OUTPUT: |2;Encrypt;345.78146611341634 06:55:57 INFO - 2015-11-18 06:55:57,742 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6172.83950617284 06:55:57 INFO - 2015-11-18 06:55:57,742 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2068.181818181818 06:55:57 INFO - 2015-11-18 06:55:57,742 DEBUG : BROWSER_OUTPUT: |5;Earley;1022.1327967806841 06:55:57 INFO - 2015-11-18 06:55:57,742 DEBUG : BROWSER_OUTPUT: |6;Boyer;14507.246376811594 06:55:57 INFO - 2015-11-18 06:55:57,742 DEBUG : BROWSER_OUTPUT: |7;RegExp;30969.696969696968 06:55:57 INFO - 2015-11-18 06:55:57,742 DEBUG : BROWSER_OUTPUT: |8;Splay;769.2862292718097 06:55:57 INFO - 2015-11-18 06:55:57,743 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6134.9693251533745 06:55:57 INFO - 2015-11-18 06:55:57,743 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:55:57 INFO - 2015-11-18 06:55:57,743 DEBUG : BROWSER_OUTPUT: __startTimestamp1447858557733__endTimestamp 06:55:57 INFO - 2015-11-18 06:55:57,743 DEBUG : BROWSER_OUTPUT: 06:55:57 INFO - 2015-11-18 06:55:57,743 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:55:57 INFO - 2015-11-18 06:55:57,743 DEBUG : BROWSER_OUTPUT: Number of tests: 10 06:55:57 INFO - 2015-11-18 06:55:57,743 DEBUG : BROWSER_OUTPUT: 06:55:57 INFO - 2015-11-18 06:55:57,743 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.89 Median:168.89 stddev:0.00 (0.0%) 06:55:57 INFO - 2015-11-18 06:55:57,744 DEBUG : BROWSER_OUTPUT: Values: 168.9 06:55:57 INFO - 2015-11-18 06:55:57,744 DEBUG : BROWSER_OUTPUT: 06:55:57 INFO - 2015-11-18 06:55:57,744 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:200.36 Median:200.36 stddev:0.00 (0.0%) 06:55:57 INFO - 2015-11-18 06:55:57,744 DEBUG : BROWSER_OUTPUT: Values: 200.4 06:55:57 INFO - 2015-11-18 06:55:57,744 DEBUG : BROWSER_OUTPUT: 06:55:57 INFO - 2015-11-18 06:55:57,744 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:345.78 Median:345.78 stddev:0.00 (0.0%) 06:55:57 INFO - 2015-11-18 06:55:57,744 DEBUG : BROWSER_OUTPUT: Values: 345.8 06:55:57 INFO - 2015-11-18 06:55:57,744 DEBUG : BROWSER_OUTPUT: 06:55:57 INFO - 2015-11-18 06:55:57,744 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6172.84 Median:6172.84 stddev:0.00 (0.0%) 06:55:57 INFO - 2015-11-18 06:55:57,745 DEBUG : BROWSER_OUTPUT: Values: 6172.8 06:55:57 INFO - 2015-11-18 06:55:57,745 DEBUG : BROWSER_OUTPUT: 06:55:57 INFO - 2015-11-18 06:55:57,745 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2068.18 Median:2068.18 stddev:0.00 (0.0%) 06:55:57 INFO - 2015-11-18 06:55:57,745 DEBUG : BROWSER_OUTPUT: Values: 2068.2 06:55:57 INFO - 2015-11-18 06:55:57,745 DEBUG : BROWSER_OUTPUT: 06:55:57 INFO - 2015-11-18 06:55:57,745 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:1022.13 Median:1022.13 stddev:0.00 (0.0%) 06:55:57 INFO - 2015-11-18 06:55:57,745 DEBUG : BROWSER_OUTPUT: Values: 1022.1 06:55:57 INFO - 2015-11-18 06:55:57,745 DEBUG : BROWSER_OUTPUT: 06:55:57 INFO - 2015-11-18 06:55:57,746 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:14507.25 Median:14507.25 stddev:0.00 (0.0%) 06:55:57 INFO - 2015-11-18 06:55:57,746 DEBUG : BROWSER_OUTPUT: Values: 14507.2 06:55:57 INFO - 2015-11-18 06:55:57,746 DEBUG : BROWSER_OUTPUT: 06:55:57 INFO - 2015-11-18 06:55:57,746 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:30969.70 Median:30969.70 stddev:0.00 (0.0%) 06:55:57 INFO - 2015-11-18 06:55:57,746 DEBUG : BROWSER_OUTPUT: Values: 30969.7 06:55:57 INFO - 2015-11-18 06:55:57,746 DEBUG : BROWSER_OUTPUT: 06:55:57 INFO - 2015-11-18 06:55:57,746 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:769.29 Median:769.29 stddev:0.00 (0.0%) 06:55:57 INFO - 2015-11-18 06:55:57,746 DEBUG : BROWSER_OUTPUT: Values: 769.3 06:55:57 INFO - 2015-11-18 06:55:57,746 DEBUG : BROWSER_OUTPUT: 06:55:57 INFO - 2015-11-18 06:55:57,747 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6134.97 Median:6134.97 stddev:0.00 (0.0%) 06:55:57 INFO - 2015-11-18 06:55:57,747 DEBUG : BROWSER_OUTPUT: Values: 6135.0 06:55:57 INFO - 2015-11-18 06:55:57,747 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:55:57 INFO - 2015-11-18 06:55:57,747 DEBUG : BROWSER_OUTPUT: 06:55:58 INFO - 2015-11-18 06:55:58,444 INFO : Browser exited with error code: 0 06:55:58 INFO - 2015-11-18 06:55:58,465 INFO : Completed test v8_7 (00:00:37) 06:55:58 INFO - 2015-11-18 06:55:58,756 INFO : Completed test suite (00:20:12) 06:55:58 INFO - 2015-11-18 06:55:58,756 DEBUG : Working with test: dromaeo_css 06:55:58 INFO - 2015-11-18 06:55:58,756 DEBUG : Generating results file: dromaeo_css 06:55:58 INFO - 2015-11-18 06:55:58,757 DEBUG : Working with test: kraken 06:55:58 INFO - 2015-11-18 06:55:58,757 DEBUG : Generating results file: kraken 06:55:58 INFO - 2015-11-18 06:55:58,758 INFO : javascript benchmark 06:55:58 INFO - 2015-11-18 06:55:58,758 DEBUG : Working with test: v8_7 06:55:58 INFO - 2015-11-18 06:55:58,758 DEBUG : Generating results file: v8_7 06:55:58 INFO - 2015-11-18 06:55:58,758 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:55:58 INFO - 2015-11-18 06:55:58,826 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,55]] 06:55:58 INFO - 2015-11-18 06:55:58,826 DEBUG : process_Request line: dromaeo_css 6162.16 graph.html#tests=[[72,1,55]] 06:55:58 INFO - 2015-11-18 06:55:58,826 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:55:58 INFO - 2015-11-18 06:55:58,856 DEBUG : process_Request line: kraken 1587.50 graph.html#tests=[[232,1,55]] 06:55:58 INFO - 2015-11-18 06:55:58,856 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:55:58 INFO - 2015-11-18 06:55:58,897 DEBUG : process_Request line: v8_7 16931.82 graph.html#tests=[[230,1,55]] 06:55:58 INFO - 2015-11-18 06:55:58,898 INFO : javascript benchmark 06:55:58 INFO - 2015-11-18 06:55:58,900 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [303.17536301260566, 318.8788260461026, 319.24020830423586, 320.67131190529705, 323.75718211341484, 13238.66903327416, 13614.523491677794, 16428.425005124824, 16737.581560460996, 17610.11949402531, 16711.498655040337, 17300.22149003295, 17435.3025878965, 17746.64506709865, 17796.288148474046, 3729.366007778684, 3884.0, 5090.287359769635, 5242.973785131069, 5253.57971362292, 3835.789031603261, 3851.9422208666892, 3868.845246190149, 3878.146807702301, 5525.585581081415, 4313.15893400787, 5570.359408668014, 5603.971980140114, 5626.971865140668, 5667.064934285838, 4528.592426681598, 4543.182227199103, 4545.5908968193025, 4555.931661025087, 4566.84016059438, 2814.2542226310043, 2900.9709902900913, 3806.923861522754, 3867.671247943928, 3873.9418908716393, 12040.698982525419, 12120.696982575506, 12379.504819807196, 12442.0, 12473.189242699196, 1557.1513525128719, 1602.8877978541507, 1737.391912830512, 1741.5646088477881, 1814.6467919636991, 9026.593803278802, 9047.18575328217, 9220.21628161607, 9242.306826988002, 9377.39046961952, 1452.876505497034, 1485.6657252118296, 1493.6191271225875, 1498.7002599480147, 1501.8423065578065, 54527.18209226825, 55195.448045519835, 55255.44744552583, 55358.723206384115, 55881.0, 6181.721822517998, 6182.412670796267, 6203.31763506014, 6233.532485063638, 6235.407636274546, 7021.5787052777, 7035.577865328097, 7044.929550704427, 7078.221395646475, 7078.92921070793, 4945.085159245551, 4963.776630051656, 4972.129877271535, 5009.0232404681465, 5021.748912554431, 5163.793448262028, 5179.0, 5183.714895680774, 5214.582833373321, 5229.294045303835, 2751.257160566676, 2769.487644785721, 2800.383915538578, 2802.383475635357, 2812.8607913794945, 962.1821451766083, 968.4915419404728, 973.338130071544, 978.9461579613047, 1031.8452232165234, 368.37560335231524, 406.4411434277868, 414.41774307098575, 418.64206103781436, 434.38534473719335, 8527.616257268437, 9575.281853860988, 9913.355631883904, 9956.651517197008, 9997.300188986701, 397.74146804577254, 401.73084033697495, 404.61561516559385, 410.96712263018884, 421.7300927406462, 4682.9531704683195, 5450.373207081237, 5502.202180683778, 5517.475839795213, 5575.860603484945, 442690.0, 447309.03296484804, 468997.0, 480979.0, 485717.0, 64864.675676621315, 69593.65203173952, 69776.30223697698, 70218.29781702117, 71572.0, 405.3109713487084, 418.6002367738802, 420.45131103909694, 420.5878239325417, 420.81694462908735, 9517.191038761783, 9520.428774273565, 9559.904400955902, 9734.951325243328, 9749.853752193581, 31806.204844879063, 32628.916286574076, 33535.16162095967, 33593.83203083969, 33719.32561348809, 44964.0, 45363.36969612158, 45573.54426455826, 45803.0, 45981.31028034649, 5614.9719251403485, 5757.740901659519, 5860.648361098348, 5884.08796636522, 5905.852353691193, 10274.434906079938, 10951.123910087334, 10988.120950324115, 10999.890001099886, 11003.779924401628, 9309.72070837876, 9370.859437108586, 9436.905630943602, 9602.279829012712, 9638.807223855623, 9105.27157827359, 9274.721758347261, 9276.582553784961, 9293.72118836436, 9309.86035209486, 9494.430334179971, 9687.70936871895, 9792.167665748206, 9823.0, 9838.0, 5821.854453638693, 5917.023691091094, 5958.19564358806, 5969.492593129633, 5981.0729336952845, 9441.905580944378, 9527.666531671359, 9838.60645574169, 9870.0, 9910.058544438267], "dojo.html": [3029.8788048478064, 3031.227037105538, 3157.7947433416825, 3235.579374681291, 3278.0493656839526, 4943.728094954776, 5060.190369540865, 5100.770465329065, 5113.335266415365, 5151.381834179899, 5034.723090230036, 5109.284700141974, 5115.10485665008, 5128.410232823227, 5212.0, 4660.487346391894, 4715.434147902257, 4716.363290955712, 4766.904661906777, 4791.616670666338, 4781.235002399617, 4834.734089625069, 4851.0, 4881.915510262721, 4909.435414927293, 4516.728996260202, 4622.676412651116, 4623.0, 4767.952320476803, 4789.185838407479, 4567.2692369221095, 4657.0, 4660.930086048712, 4691.413573303337, 4697.88255293617, 4642.396488456513, 4682.929756053662, 4686.2267725825195, 4697.459792123916, 4698.154332220199, 5061.139606266944, 5117.104506711311, 5125.0, 5147.3308469898675, 5194.532492075694, 5380.730963451851, 5412.891742165135, 5442.9727851360885, 5451.100568406208, 5456.61803673743, 5234.97382513085, 5513.558915286768, 5522.66863988158, 5524.033294173503, 5571.944280557183, 4923.950760492385, 4986.3019177314845, 5003.224500202475, 5072.340595722532, 5085.516875896784, 5496.890062198813, 5566.0, 5575.972120139373, 5581.469760372758, 5635.718214089361, 5065.974670126626, 5289.841304760864, 5315.893682126336, 5325.201219817059, 5340.652857564246, 5417.18742188667, 5447.591430642718, 5476.726163691799, 5495.0, 5503.889922201533, 5384.111621582395, 5419.485148910847, 5443.727813609304, 5445.128779395357, 5448.346198456132, 5240.6069544784295, 5420.34955805298, 5438.673679579238, 5445.50990410857, 5487.368952570426, 4138.172365526846, 4140.958590414118, 4170.16596680665, 4193.559676234013, 4231.492220933507, 3834.578196398394, 3845.769253844778, 3866.38137897935, 3876.6511014008875, 3887.727859049896, 4927.95072049282, 5223.451537588575, 5247.816326428557, 5250.3962044364625, 5292.338457692788, 5393.703346315911, 5422.8373148805595, 5434.076207044812, 5496.0, 5522.392536820947, 5149.227615857576, 5202.687838729613, 5205.9739701302005, 5227.424983251839, 5231.947680523146, 4570.0, 4834.540718631724, 4846.5638092571835, 4875.219964805685, 4882.2432522959, 5575.135853942646, 5613.158026296088, 5618.466245706733, 5631.774729010794, 5644.096944488862, 5535.059039963136, 5572.693501857275, 5593.021221286177, 5607.775688972559, 5619.80330688424, 5245.659032162897, 5659.886802264014, 5699.9999999998345, 5708.115242137475, 5711.371749107512, 5317.1492561190025, 5321.148616221386, 5323.228131920772, 5355.839324820262, 5413.079776437936, 5471.835844924659, 5512.2558454608115, 5521.751521181476, 5522.944770552243, 5523.502884740393, 5085.694858308513, 5324.547413469743, 5340.49265319794, 5374.919376209438, 5443.183522471502, 5143.794248230029, 5153.1754919214245, 5252.816151434681, 5309.867253318698, 5337.519623233928, 5094.898102037864, 5209.505097015777, 5213.739313034409, 5221.660592061656, 5223.686578805284, 5120.564751996122, 5325.147976323925, 5349.545288650508, 5351.03681337363, 5409.161579955114, 5132.79468821243, 5178.042062218502, 5189.870253243699, 5198.116320225495, 5228.58171346299], "mootools.html": [1188.9821652675205, 1307.849597296311, 1366.4465891314019, 1428.2787192467802, 1676.7987841459026, 6293.0, 6599.07612934189, 6620.172478440195, 6625.5030872684565, 6630.0, 6367.0, 6701.195856497215, 6850.897236541456, 6897.0, 6926.445884329254, 2034.5320576267468, 2090.1012564597218, 2093.152273329304, 2115.883626400547, 2118.851680382374, 1845.7231415287747, 1892.0161516011665, 2063.215977928385, 2074.1703318672503, 2083.510375061859, 2054.815066644002, 2060.6702927531596, 2071.8860462674547, 2082.1671331467383, 2083.677030060343, 2001.8898960557165, 2033.3086750504826, 2038.4394291569863, 2049.385184444661, 2057.043474784218, 2038.847086468506, 2043.7751847296786, 2099.4436474334316, 2102.358780571925, 2104.368689393176, 6786.219584747768, 6863.725450981955, 6865.725370985155, 6888.070110535064, 6902.171739391305, 4286.57134286572, 4356.6514678825615, 4382.474103107647, 4397.384366188736, 4404.361367601712, 2689.462107578492, 2732.248631626299, 2740.1505533284744, 2748.0, 2800.0759749282893, 844.5270648436895, 860.2816648098845, 861.8190180062195, 863.6977058029702, 879.9189915849036, 9232.399894006936, 9252.583633736498, 9264.49045302508, 9280.396774209656, 9299.814003719888, 3531.2937412517085, 3608.585012723518, 3978.5026871641044, 4020.175863947942, 4036.4056197802292, 7424.703011879572, 7686.192949740309, 7885.2114788520685, 7892.250236227549, 7915.16890726477, 4186.309258972296, 4222.894427639334, 4226.070264541796, 4238.17355615652, 4263.893402664959, 3790.223004284115, 3793.2223894102194, 3799.4680744695765, 3799.848006079781, 3813.1801662642665, 3150.401423729484, 3162.794418362799, 3186.2193762527863, 3209.3741720364774, 3223.3069889973767, 1038.5586125896464, 1050.7110544600296, 1054.746860753429, 1055.773008803111, 1064.5103252503934, 1187.7327601289642, 1197.2577002258656, 1219.0978675779859, 1233.6915771057236, 1236.8701286364983, 6629.966850165815, 6645.335466453413, 6673.9666301668185, 6687.799366019027, 6690.632015239208, 592.4697395830793, 636.9076483909807, 639.1339734659563, 644.5133923887529, 645.6223109480912, 5095.159298715745, 5122.667026643257, 5124.436312005676, 5154.123798954111, 5195.610329225247, 8183.590820458953, 8323.458975166595, 8401.411901166983, 8416.83166336682, 8421.284190843724, 8081.27268545822, 8228.300594449538, 8243.917560824435, 8247.876281855777, 8287.709930152536, 6397.136386587751, 6483.902741458882, 6505.804825855232, 6541.672916354163, 6577.177852768404, 6394.648294343856, 6428.678566071584, 6441.516886233645, 6442.710078046405, 6446.065320528591, 7139.678714457758, 7352.154502232312, 7358.705651773869, 7370.44721645868, 7458.627068646654, 7446.553206807609, 7675.884861726967, 7777.883331750141, 7780.105287891738, 7786.961065194638, 5557.194206840067, 5848.2689663792025, 6104.359042300672, 6121.867454520928, 6141.907871382022, 6706.195256569243, 6726.293739157318, 6746.4940129489505, 6746.628935408599, 6765.661716914036, 6204.534659900616, 6283.088952102011, 6320.38830098322, 6406.679666016774, 6418.743250269937, 6059.969700151471, 6145.139680444652, 6149.354317796567, 6253.312135664983, 6294.8111556653375, 6311.400416960381, 6325.240971083315, 6338.809835704937, 6354.841128971628, 6360.395762402564, 5737.368889422244, 5746.569007324384, 5791.247137872049, 5794.420557944172, 5794.739236734273, 5614.69119198448, 5768.105943578752, 5818.709064546841, 5851.0, 5893.2044174035955], "ext.html": [525.3275806967082, 528.6537318056672, 529.9046171689097, 542.2435702195439, 547.7042397105563, 29370.2657433564, 30276.091717248462, 30348.393032139345, 36256.274874502495, 37180.256394872085, 39168.41247381292, 39465.0, 39661.20677586446, 39674.0, 39927.80036099815, 8596.613152408157, 8680.392372533925, 8768.254698350647, 8770.386072974894, 8803.0, 7989.480683755566, 8104.5542495162745, 8130.146334634866, 8140.43016988811, 8159.939207902964, 10598.841017384746, 10729.731756706067, 10734.677959661183, 10766.24636275461, 10800.351978881254, 10376.896231037706, 10528.473576321154, 10529.736756581071, 10544.578216871316, 10571.101456376216, 8013.19868013194, 8032.919670803276, 10166.237532185041, 10292.073713365759, 10396.896031039743, 35708.821455892816, 36484.0878978025, 36628.816855915815, 36636.63363366359, 36686.26627467462, 2939.8824047038092, 3112.859921303547, 3169.746420286395, 3255.755818313612, 3302.620198677159, 25711.74288257112, 26158.476830463474, 26198.214053578424, 26278.868605656848, 26467.01539529476, 2250.22367283287, 2272.7727227277305, 2285.3029825903095, 2303.389601755536, 2414.5291668124723, 236730.0, 245056.0, 245391.0, 246987.0, 247607.9999999982, 53755.0, 54065.72967135139, 54313.72843135759, 54319.72840135774, 54352.45647543553, 56140.43859561434, 56565.0, 56568.0, 56575.0, 56719.0, 14977.176255306063, 15359.078455292494, 15426.305816238297, 15601.375944962074, 15605.531834044998, 11241.381724005094, 11769.17615766888, 11918.106142039382, 11920.463579138786, 11931.821022684666, 17166.31334746621, 17399.565010874576, 17519.912400437915, 17567.912160439115, 17579.64840703179, 7412.332890039922, 7624.27569380908, 7689.769306920802, 7699.307062364414, 7715.537067775951, 849.3074572369687, 870.2646263906988, 871.0, 895.417978314088, 962.20617990157, 26375.20874373772, 27175.45649087007, 27201.036191994735, 27598.5860212097, 28588.857055714587, 951.7335146158948, 960.4861399151561, 986.8963758805365, 1027.547878933267, 1035.29082578434, 12771.0, 13053.673658158432, 13080.934595326962, 13082.149660272053, 13146.671333216746, 275320.59774918953, 278159.0, 278928.0, 279309.0, 280347.0, 48366.75816620894, 48449.97475366052, 48589.75705121522, 48598.0, 48763.51236487661, 1106.5794997900907, 1125.352922069813, 1130.5421304371744, 1130.5929865248504, 1256.384371657881, 25551.488970220118, 26215.737842622093, 26315.736842632094, 26392.20823375302, 26440.8677956609, 43984.780076099414, 44201.33697994597, 44214.557854421044, 44215.778921105186, 44294.557054429046, 267200.0, 273536.0, 274333.0, 274422.0, 275948.0, 27203.72796272012, 28112.43775124527, 28208.85895570509, 28332.291692707848, 28369.29076773097, 38068.80965595154, 38374.616253837106, 38651.03372415712, 38947.221055578164, 39417.802910985265, 30741.23146921345, 31981.0, 32326.0, 32328.191795205308, 32413.67586324201, 31406.371872561966, 31689.36621267608, 31975.520367194975, 32064.51903221407, 32129.839350803097, 32188.0, 32950.34099318048, 33232.833835830665, 33526.497102543966, 33569.83215083909, 25920.61119083253, 27197.72802271952, 27245.86377068181, 27371.45257094807, 27684.723152768216, 22143.889280553492, 22407.327780166623, 22438.88780556087, 22487.775122248568, 22563.887180563994], "prototype.html": [296.06738772865475, 298.05962189292774, 299.63594233006893, 302.2624795498981, 310.5745129173033, 5812.970935145324, 5846.415358464157, 5886.764529418829, 5895.616784908978, 5929.970350148254, 5833.854153646161, 5857.502112320458, 5860.794872179475, 5869.7358618862145, 5875.236219291497, 4280.935785963213, 4468.620167285784, 4486.842960496383, 4489.663275254353, 4510.639148868099, 4304.332828411586, 4369.912601747963, 4457.88855278619, 4464.575865292808, 4467.798949047285, 4349.325854492558, 4405.3391991201415, 4420.160169567772, 4424.0, 4424.247877860771, 4210.663146948237, 4364.978175109136, 4426.977865110686, 4431.401760762305, 4445.644348452132, 3731.70146388291, 3807.505024346845, 3814.828332725034, 3829.7319187656876, 3839.2513459875336, 5401.648892821954, 5677.318721753416, 5681.744321505542, 5693.715314234313, 5703.372629010805, 4958.132326842824, 5011.0, 5016.2224855147515, 5017.8243761468175, 5024.472430394792, 5980.880382392371, 6080.087986801971, 6103.450689437927, 6134.079888016833, 6149.754009839601, 4040.252553277653, 4058.6144316289906, 4074.449949256842, 4084.0606660468256, 4084.1627466369323, 6419.775307864203, 6484.0, 6484.870302593922, 6499.837504062389, 6538.934610653832, 4128.256913755553, 4145.0880806222585, 4149.97925010373, 4157.731891773038, 4160.292750232467, 4096.672266218755, 4202.285611446, 4249.490061192615, 4265.125649241898, 4271.0, 4968.776405061709, 4977.552020318189, 4977.825776097891, 4991.4758950310425, 4993.825216117419, 6088.0, 6210.50315974721, 6212.099245609361, 6215.751369945152, 6219.222597175353, 1465.5896349022291, 1484.2578710644677, 1496.9670927060295, 1498.3706843125913, 1499.9925000374928, 943.7876477792441, 959.9904000959901, 962.1725316228038, 972.3290929258931, 982.6511588386163, 5946.4053594641055, 5958.255218097738, 5967.880642387128, 5969.895654259847, 5988.191594134823, 6401.327860574573, 6423.807285781434, 6427.646479443675, 6439.130717353191, 6458.903116453257, 5951.0, 5959.195508606369, 5976.641401515923, 5981.132735753292, 5983.341832398432, 3324.900252992414, 3382.4609802539785, 3429.5884493860895, 3454.671806178409, 3480.147363895862, 6679.9332006679315, 6719.193696756421, 6730.764423245163, 6746.763863264762, 6752.898706519406, 6627.536072474881, 6648.634325112165, 6652.501062420338, 6654.733810647616, 6663.20041595002, 6514.315996820361, 6712.194536655633, 6712.395884370332, 6736.797896063028, 6737.124173857367, 6484.0, 6496.7726129585235, 6501.349865013461, 6514.250861151028, 6516.478681705357, 6297.653629050446, 6309.779157729457, 6345.2702939160745, 6372.74509019634, 6373.649449280334, 6475.384838440341, 6682.732690692318, 6693.431058360094, 6695.564788288746, 6698.799036028927, 4180.352045432963, 4200.684948628927, 4217.97891010543, 4233.6401405879615, 4243.872683819491, 6424.100625912282, 6447.9032814508755, 6470.773522926675, 6470.805875823733, 6490.383413575702, 5968.432998865101, 6264.968675156595, 6273.96863015682, 6275.309715931336, 6302.968485157545, 6211.472024877755, 6243.500519958302, 6249.937500624936, 6251.906221406592, 6270.15352927349, 6049.3950604939155, 6118.847028824315, 6119.8776024478375, 6131.080337949344, 6135.171751813448, 6050.42520960508, 6275.654838983717, 6277.497800176066, 6280.560360774702, 6299.118123462627, 6104.053871649901, 6169.907451388322, 6191.25704915413, 6194.0, 6207.782727604512], "yui.html": [700.488643290398, 710.7157137145141, 717.9928200717991, 725.7604990353184, 755.5428965475891, 12822.166559173671, 12852.0, 13082.345882705862, 13107.213567185963, 13544.1196322239, 12322.260664360145, 12378.566750163745, 12410.069244806631, 12471.875281247185, 12495.750084998295, 646.9741210351581, 664.7307840324652, 818.8034871630796, 837.1335667584052, 853.2107800284742, 814.311906439058, 820.0815087102453, 828.8176601147737, 830.4311546590575, 835.1564919431388, 862.3790870573177, 871.0027019063169, 872.6596627315353, 874.2001069021837, 880.1638443478689, 663.4791688524485, 669.1134247122582, 674.7604600366898, 683.1187767779559, 683.4088513435892, 616.929053158888, 643.0193954219806, 643.797203880776, 643.893757530007, 644.3234603666178, 12690.682732931658, 13058.085933984625, 13066.412011459412, 13082.803757943639, 13196.406161722649, 10736.19478539105, 10967.0, 11067.667969960914, 11205.551777928873, 11466.369349685763, 8883.11168883113, 9048.41185322952, 9049.592768325441, 9164.8625270621, 9263.305252106118, 3098.256418459576, 3108.8290144042066, 3122.5324097674056, 3187.4103290891258, 3276.3774882772436, 46591.30113048307, 46996.29505557419, 47119.29321060187, 47626.76186619079, 48241.75879120582, 8451.0, 8546.829063418696, 8571.22858942698, 8591.65633374658, 9033.77415564616, 18106.0, 18143.818561814212, 18169.45491635253, 18238.179281932345, 18249.27002919895, 6437.420632143036, 6495.0582165586675, 6566.0, 6635.8009259722285, 6777.830554236183, 3512.1921957949817, 3570.0003998880356, 3617.2042150726797, 3634.1821354910508, 3634.273145370936, 2764.737349951751, 2777.333439974432, 2782.8886844526396, 2784.8746806393356, 2792.3577577157366, 405.1956865621739, 405.21388506298274, 418.18662701046173, 418.9685773566995, 419.490319262098, 525.1649876696072, 537.6263496869637, 539.0620320642055, 543.0, 559.2282649943053, 6683.532152749261, 6826.419754320839, 7293.0519032525435, 7479.252074792477, 7561.584112873735, 433.68124428544996, 448.8832903445128, 458.67434121773914, 461.2389557230529, 468.2320993570547, 3276.1318250663594, 3278.068398445058, 3284.4416449203213, 3565.7682250654143, 3627.4558816177782, 57019.71490142523, 57150.0, 57442.42557574454, 57733.71133144391, 57874.0, 48609.0, 49284.26073608899, 49968.50031499638, 50053.74973125111, 50341.993160137325, 40955.385669214986, 41213.79393103015, 41254.1749165015, 44418.333724994154, 44527.0, 7099.964500177466, 7321.414286856932, 7381.33567978863, 7592.39260859141, 7618.885716714143, 31262.99999999909, 32061.679383206803, 32211.35577288488, 33660.15849603681, 33997.66002339945, 39853.2029359417, 41281.793591031856, 41950.79024604979, 42399.57600423956, 42493.787531062146, 6568.0, 6882.965585172243, 7016.263292354433, 7045.154581450259, 7047.436205103682, 10111.24165687591, 10163.288569800043, 10255.641052563124, 10276.126529245097, 10442.791144177227, 9476.857847132436, 9645.469499177612, 9733.0, 9749.415035097916, 9805.136543218456, 9792.755181120529, 9817.901820981699, 10083.092521673085, 10247.231457640557, 10300.484975751333, 9649.565769540248, 9727.756806079904, 9764.707058788248, 10104.69685909424, 10259.538320775433, 8156.510609363457, 8225.0, 8319.916800832156, 8434.072252052392, 8745.868811967954, 7799.805004874924, 8449.535275559658, 8482.109378515168, 8649.048604653357, 8817.206451419403]}, "summary": {"lowerIsBetter": false, "suite": 6162.16185510248, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6208.775564437099, "unit": "ms", "value": 6208.775564437099}, "dojo.html": {"lowerIsBetter": false, "filtered": 5049.6858674084215, "unit": "ms", "value": 5049.6858674084215}, "mootools.html": {"lowerIsBetter": false, "filtered": 3962.2219775687986, "unit": "ms", "value": 3962.2219775687986}, "ext.html": {"lowerIsBetter": false, "filtered": 17056.467894943424, "unit": "ms", "value": 17056.467894943424}, "prototype.html": {"lowerIsBetter": false, "filtered": 4618.7491408617125, "unit": "ms", "value": 4618.7491408617125}, "yui.html": {"lowerIsBetter": false, "filtered": 5594.176921710224, "unit": "ms", "value": 5594.176921710224}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0027"}, "testrun": {"date": 1447857346, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151118054724", "branch": "Firefox", "revision": "fc29bf8b72a0d1712a051cb549694471f495bfd1"}}, {"talos_counters": {}, "results": {"audio-dft": [161.0, 161.0, 162.0, 170.0, 174.0, 174.0, 173.0, 169.0, 174.0, 174.0], "ai-astar": [105.0, 104.0, 100.0, 109.0, 106.0, 106.0, 107.0, 107.0, 102.0, 107.0], "imaging-gaussian-blur": [125.0, 124.0, 116.0, 127.0, 130.0, 135.0, 123.0, 123.0, 129.0, 129.0], "audio-beat-detection": [158.0, 133.0, 154.0, 163.0, 131.0, 154.0, 150.0, 134.0, 187.0, 132.0], "json-stringify-tinderbox": [68.0, 68.0, 70.0, 71.0, 76.0, 76.0, 76.0, 76.0, 76.0, 76.0], "stanford-crypto-pbkdf2": [161.0, 149.0, 172.0, 170.0, 169.0, 169.0, 172.0, 165.0, 169.0, 165.0], "json-parse-financial": [59.0, 59.0, 59.0, 59.0, 61.0, 62.0, 64.0, 73.0, 62.0, 63.0], "stanford-crypto-sha256-iterative": [72.0, 72.0, 73.0, 72.0, 76.0, 76.0, 76.0, 78.0, 79.0, 78.0], "audio-fft": [73.0, 85.0, 92.0, 90.0, 70.0, 70.0, 73.0, 87.0, 91.0, 75.0], "imaging-darkroom": [125.0, 130.0, 135.0, 136.0, 136.0, 135.0, 135.0, 141.0, 136.0, 136.0], "stanford-crypto-ccm": [126.0, 132.0, 136.0, 138.0, 143.0, 137.0, 143.0, 138.0, 145.0, 137.0], "audio-oscillator": [100.0, 103.0, 136.0, 92.0, 94.0, 101.0, 138.0, 94.0, 94.0, 134.0], "stanford-crypto-aes": [86.0, 88.0, 92.0, 95.0, 96.0, 96.0, 91.0, 92.0, 94.0, 94.0], "imaging-desaturate": [103.0, 109.0, 106.0, 105.0, 110.0, 108.0, 109.0, 104.0, 105.0, 111.0]}, "summary": {"lowerIsBetter": true, "suite": 1587.5, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 80.6, "unit": "ms", "value": 80.6}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 166.1, "unit": "ms", "value": 166.1}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 149.6, "unit": "ms", "value": 149.6}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 137.5, "unit": "ms", "value": 137.5}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 134.5, "unit": "ms", "value": 134.5}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 62.1, "unit": "ms", "value": 62.1}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 108.6, "unit": "ms", "value": 108.6}, "ai-astar": {"lowerIsBetter": true, "filtered": 105.3, "unit": "ms", "value": 105.3}, "audio-dft": {"lowerIsBetter": true, "filtered": 169.2, "unit": "ms", "value": 169.2}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 75.2, "unit": "ms", "value": 75.2}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 73.3, "unit": "ms", "value": 73.3}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 126.1, "unit": "ms", "value": 126.1}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 92.4, "unit": "ms", "value": 92.4}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 107.0, "unit": "ms", "value": 107.0}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0027"}, "testrun": {"date": 1447857346, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151118054724", "branch": "Firefox", "revision": "fc29bf8b72a0d1712a051cb549694471f495bfd1"}}, {"talos_counters": {}, "results": {"DeltaBlue": [200.3606491685033], "Encrypt": [345.78146611341634], "NavierStokes": [6134.9693251533745], "Decrypt": [6172.83950617284], "Splay": [769.2862292718097], "Richards": [168.89039013680122], "RegExp": [30969.696969696968], "Earley": [1022.1327967806841], "Boyer": [14507.246376811594], "RayTrace": [2068.181818181818]}, "summary": {"lowerIsBetter": false, "suite": 16931.820730750194, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 329.99493799999993, "unit": "score", "value": 329.99493799999993}, "Encrypt": {"lowerIsBetter": false, "filtered": 769.7954519999998, "unit": "score", "value": 769.7954519999998}, "NavierStokes": {"lowerIsBetter": false, "filtered": 241.89200000000014, "unit": "score", "value": 241.89200000000014}, "Decrypt": {"lowerIsBetter": false, "filtered": 43.12132199999997, "unit": "score", "value": 43.12132199999997}, "Splay": {"lowerIsBetter": false, "filtered": 105.93066260543578, "unit": "score", "value": 105.93066260543578}, "RegExp": {"lowerIsBetter": false, "filtered": 29.415366927592935, "unit": "score", "value": 29.415366927592935}, "Richards": {"lowerIsBetter": false, "filtered": 209.0231420000001, "unit": "score", "value": 209.0231420000001}, "Earley": {"lowerIsBetter": false, "filtered": 652.0317145669289, "unit": "score", "value": 652.0317145669289}, "Boyer": {"lowerIsBetter": false, "filtered": 45.94000699300701, "unit": "score", "value": 45.94000699300701}, "RayTrace": {"lowerIsBetter": false, "filtered": 357.79687912087917, "unit": "score", "value": 357.79687912087917}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0027"}, "testrun": {"date": 1447857346, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151118054724", "branch": "Firefox", "revision": "fc29bf8b72a0d1712a051cb549694471f495bfd1"}}] 06:55:58 INFO - RETURN: dromaeo_css: 6162.16 06:55:58 INFO - RETURN: kraken: 1587.50 06:55:58 INFO - RETURN: v8_7: 16931.82 06:55:58 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,55]]", "result": "16931.82"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,55]]", "result": "1587.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,55]]", "result": "6162.16"}}} 06:55:59 INFO - Return code: 0 06:55:59 INFO - # TBPL SUCCESS # 06:55:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:55:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:55:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:55:59 INFO - 2015-11-18 06:55:59.020 screenresolution[1976:23683] starting screenresolution argv=screenresolution get 06:55:59 INFO - 2015-11-18 06:55:59.023 screenresolution[1976:23683] Display 0: 1600x1200x32@60 06:55:59 INFO - 2015-11-18 06:55:59.029 screenresolution[1977:23685] starting screenresolution argv=screenresolution list 06:55:59 INFO - Available Modes on Display 0 06:55:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:55:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:55:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:55:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:55:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:55:59 INFO - Intel HD Graphics 3000: 06:55:59 INFO - Chipset Model: Intel HD Graphics 3000 06:55:59 INFO - Type: GPU 06:55:59 INFO - Bus: Built-In 06:55:59 INFO - VRAM (Total): 512 MB 06:55:59 INFO - VRAM (Dynamic, Max): 10 06:55:59 INFO - Vendor: Intel (0x8086) 06:55:59 INFO - Device ID: 0x0116 06:55:59 INFO - Revision ID: 0x0009 06:55:59 INFO - Displays: 06:55:59 INFO - Display: 06:55:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:55:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:55:59 INFO - Display Serial Number: 1600x1200 60 06:55:59 INFO - Main Display: Yes 06:55:59 INFO - Mirror: Off 06:55:59 INFO - Online: Yes 06:55:59 INFO - Rotation: Supported 06:55:59 INFO - Return code: 0 06:55:59 INFO - Running post-action listener: _resource_record_post_action 06:55:59 INFO - Running post-run listener: _resource_record_post_run 06:56:00 INFO - Total resource usage - Wall time: 1251s; CPU: 30.0%; Read bytes: 2695168; Write bytes: 688441344; Read time: 1575; Write time: 50296 06:56:00 INFO - install - Wall time: 38s; CPU: 30.0%; Read bytes: 335073792; Write bytes: 333867008; Read time: 32451; Write time: 5464 06:56:00 INFO - run-tests - Wall time: 1213s; CPU: 30.0%; Read bytes: 2695168; Write bytes: 344199168; Read time: 1575; Write time: 43992 06:56:00 INFO - Running post-run listener: _upload_blobber_files 06:56:00 INFO - Blob upload gear active. 06:56:00 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 06:56:00 INFO - Copying logs to upload dir... 06:56:00 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1306.661039 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 46 secs) (at 2015-11-18 06:56:00.428623) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 06:56:00.432421) ========= 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.of44Ut3Zpm/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.FvDGVSSEOe/Listeners TMPDIR=/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/8rflomTMTRerYAMWKmGr9w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009976 build_url: 'https://queue.taskcluster.net/v1/task/8rflomTMTRerYAMWKmGr9w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 06:56:00.458075) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 06:56:00.458424) ========= 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.of44Ut3Zpm/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.FvDGVSSEOe/Listeners TMPDIR=/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005300 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 06:56:00.508542) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 06:56:00.509042) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 06:56:00.509674) ========= ========= Total master_lag: 0.22 =========