builder: fx-team_yosemite_test-dromaeojs slave: t-yosemite-r5-0094 starttime: 1447690107.11 results: success (0) buildid: 20151116072434 builduid: c1c1635334504f4984fbd50f20796274 revision: 8e2b7001ebc461585bb003794e31e3f203a394c5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 08:08:27.110742) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 08:08:27.111199) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 08:08:27.111517) ========= 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.ryp4ZXMmmS/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.XDg6x8wVLa/Listeners TMPDIR=/var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/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.006419 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 08:08:27.158996) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 08:08:27.159329) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 08:08:27.280035) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 08:08:27.280342) ========= 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.ryp4ZXMmmS/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.XDg6x8wVLa/Listeners TMPDIR=/var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/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.005415 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 08:08:27.355033) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 08:08:27.355338) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 08:08:27.355744) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 08:08:27.356344) ========= 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.ryp4ZXMmmS/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.XDg6x8wVLa/Listeners TMPDIR=/var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/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-16 08:08:27-- 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.25, 63.245.215.102, ... Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.41G=0s 2015-11-16 08:08:27 (1.41 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.366364 ========= master_lag: 0.20 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 08:08:27.921551) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 08:08:27.921889) ========= 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.ryp4ZXMmmS/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.XDg6x8wVLa/Listeners TMPDIR=/var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/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.019531 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 08:08:28.033268) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 08:08:28.033574) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8e2b7001ebc461585bb003794e31e3f203a394c5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 8e2b7001ebc461585bb003794e31e3f203a394c5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ryp4ZXMmmS/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.XDg6x8wVLa/Listeners TMPDIR=/var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/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-16 08:08:28,127 truncating revision to first 12 chars 2015-11-16 08:08:28,127 Setting DEBUG logging. 2015-11-16 08:08:28,127 attempt 1/10 2015-11-16 08:08:28,127 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8e2b7001ebc4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-16 08:08:28,387 unpacking tar archive at: fx-team-8e2b7001ebc4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.508264 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 08:08:28.577702) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 08:08:28.577998) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 08:08:28.595036) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 08:08:28.595275) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 08:08:28.595649) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 8 secs) (at 2015-11-16 08:08:28.595939) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ryp4ZXMmmS/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.XDg6x8wVLa/Listeners TMPDIR=/var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/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 08:08:28 INFO - MultiFileLogger online at 20151116 08:08:28 in /builds/slave/test 08:08:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:08:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:08:28 INFO - {'append_to_log': False, 08:08:28 INFO - 'base_work_dir': '/builds/slave/test', 08:08:28 INFO - 'blob_upload_branch': 'Fx-Team', 08:08:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:08:28 INFO - 'branch': 'Fx-Team', 08:08:28 INFO - 'buildbot_json_path': 'buildprops.json', 08:08:28 INFO - 'config_files': ('talos/mac_config.py',), 08:08:28 INFO - 'default_actions': ('clobber', 08:08:28 INFO - 'read-buildbot-config', 08:08:28 INFO - 'download-and-extract', 08:08:28 INFO - 'populate-webroot', 08:08:28 INFO - 'create-virtualenv', 08:08:28 INFO - 'install', 08:08:28 INFO - 'run-tests'), 08:08:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:08:28 INFO - 'download_minidump_stackwalk': True, 08:08:28 INFO - 'download_symbols': 'ondemand', 08:08:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:08:28 INFO - 'tooltool.py': '/tools/tooltool.py', 08:08:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:08:28 INFO - '/tools/misc-python/virtualenv.py')}, 08:08:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:08:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:08:28 INFO - 'installer_path': 'installer.exe', 08:08:28 INFO - 'log_level': 'info', 08:08:28 INFO - 'log_name': 'talos', 08:08:28 INFO - 'log_to_console': True, 08:08:28 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:08:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:08:28 INFO - 'opt_config_files': (), 08:08:28 INFO - 'pip_index': False, 08:08:28 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:08:28 INFO - 'cmd': ('bash', 08:08:28 INFO - '-c', 08:08:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:08:28 INFO - 'enabled': True, 08:08:28 INFO - 'halt_on_failure': False, 08:08:28 INFO - 'name': 'check_screen_resolution'},), 08:08:28 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:08:28 INFO - 'cmd': ('bash', 08:08:28 INFO - '-c', 08:08:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:08:28 INFO - 'enabled': True, 08:08:28 INFO - 'halt_on_failure': False, 08:08:28 INFO - 'name': 'check_screen_resolution'},), 08:08:28 INFO - 'run_cmd_checks_enabled': True, 08:08:28 INFO - 'sps_profile': False, 08:08:28 INFO - 'sps_profile_interval': 0, 08:08:28 INFO - 'suite': 'dromaeojs', 08:08:28 INFO - 'system_bits': '64', 08:08:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:08:28 INFO - 'title': 't-yosemite-r5-0094', 08:08:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:08:28 INFO - 'use_talos_json': True, 08:08:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:08:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:08:28 INFO - 'work_dir': 'build'} 08:08:28 INFO - ##### 08:08:28 INFO - ##### Running clobber step. 08:08:28 INFO - ##### 08:08:28 INFO - Running pre-action listener: _resource_record_pre_action 08:08:28 INFO - Running main action method: clobber 08:08:28 INFO - rmtree: /builds/slave/test/build 08:08:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:08:31 INFO - Running post-action listener: _resource_record_post_action 08:08:31 INFO - ##### 08:08:31 INFO - ##### Running read-buildbot-config step. 08:08:31 INFO - ##### 08:08:31 INFO - Running pre-action listener: _resource_record_pre_action 08:08:31 INFO - Running main action method: read_buildbot_config 08:08:31 INFO - Using buildbot properties: 08:08:31 INFO - { 08:08:31 INFO - "properties": { 08:08:31 INFO - "buildnumber": 1235, 08:08:31 INFO - "product": "firefox", 08:08:31 INFO - "script_repo_revision": "production", 08:08:31 INFO - "builddir": "fx-team_yosemite_test-dromaeojs", 08:08:31 INFO - "repository": "", 08:08:31 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 fx-team talos dromaeojs", 08:08:31 INFO - "buildid": "20151116072434", 08:08:31 INFO - "slavename": "t-yosemite-r5-0094", 08:08:31 INFO - "pgo_build": "False", 08:08:31 INFO - "basedir": "/builds/slave/test", 08:08:31 INFO - "project": "", 08:08:31 INFO - "platform": "yosemite", 08:08:31 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 08:08:31 INFO - "slavebuilddir": "test", 08:08:31 INFO - "scheduler": "tests-fx-team-macosx64-talos", 08:08:31 INFO - "branch": "fx-team", 08:08:31 INFO - "repo_path": "integration/fx-team", 08:08:31 INFO - "stage_platform": "macosx64", 08:08:31 INFO - "builduid": "c1c1635334504f4984fbd50f20796274", 08:08:31 INFO - "revision": "8e2b7001ebc461585bb003794e31e3f203a394c5" 08:08:31 INFO - }, 08:08:31 INFO - "sourcestamp": { 08:08:31 INFO - "repository": "", 08:08:31 INFO - "hasPatch": false, 08:08:31 INFO - "project": "", 08:08:31 INFO - "branch": "fx-team-macosx64-talos", 08:08:31 INFO - "changes": [ 08:08:31 INFO - { 08:08:31 INFO - "category": null, 08:08:31 INFO - "files": [ 08:08:31 INFO - { 08:08:31 INFO - "url": null, 08:08:31 INFO - "name": "https://queue.taskcluster.net/v1/task/jzW4DwGySfOar5Op6FZX7A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 08:08:31 INFO - } 08:08:31 INFO - ], 08:08:31 INFO - "repository": "", 08:08:31 INFO - "rev": "8e2b7001ebc461585bb003794e31e3f203a394c5", 08:08:31 INFO - "who": "apoirot@mozilla.com", 08:08:31 INFO - "when": 1447690067, 08:08:31 INFO - "number": 6666349, 08:08:31 INFO - "comments": "Bug 1113865 - Replace all calls to dbg_assert with DevToolsUtils.assert. r=fitzgen", 08:08:31 INFO - "project": "", 08:08:31 INFO - "at": "Mon 16 Nov 2015 08:07:47", 08:08:31 INFO - "branch": "fx-team-macosx64-talos", 08:08:31 INFO - "revlink": "", 08:08:31 INFO - "properties": [ 08:08:31 INFO - [ 08:08:31 INFO - "buildid", 08:08:31 INFO - "20151116072434", 08:08:31 INFO - "Change" 08:08:31 INFO - ], 08:08:31 INFO - [ 08:08:31 INFO - "builduid", 08:08:31 INFO - "c1c1635334504f4984fbd50f20796274", 08:08:31 INFO - "Change" 08:08:31 INFO - ], 08:08:31 INFO - [ 08:08:31 INFO - "pgo_build", 08:08:31 INFO - "False", 08:08:31 INFO - "Change" 08:08:31 INFO - ] 08:08:31 INFO - ], 08:08:31 INFO - "revision": "8e2b7001ebc461585bb003794e31e3f203a394c5" 08:08:31 INFO - } 08:08:31 INFO - ], 08:08:31 INFO - "revision": "8e2b7001ebc461585bb003794e31e3f203a394c5" 08:08:31 INFO - } 08:08:31 INFO - } 08:08:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/jzW4DwGySfOar5Op6FZX7A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 08:08:31 INFO - Running post-action listener: _resource_record_post_action 08:08:31 INFO - ##### 08:08:31 INFO - ##### Running download-and-extract step. 08:08:31 INFO - ##### 08:08:31 INFO - Running pre-action listener: _resource_record_pre_action 08:08:31 INFO - Running main action method: download_and_extract 08:08:31 INFO - mkdir: /builds/slave/test/build/tests 08:08:31 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')]} 08:08:31 INFO - https://queue.taskcluster.net/v1/task/jzW4DwGySfOar5Op6FZX7A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:08:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jzW4DwGySfOar5Op6FZX7A/artifacts/public/build/test_packages.json 08:08:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jzW4DwGySfOar5Op6FZX7A/artifacts/public/build/test_packages.json 08:08:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jzW4DwGySfOar5Op6FZX7A/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 08:08:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jzW4DwGySfOar5Op6FZX7A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 08:08:33 INFO - Downloaded 1149 bytes. 08:08:33 INFO - Reading from file /builds/slave/test/build/test_packages.json 08:08:33 INFO - Using the following test package requirements: 08:08:33 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 08:08:33 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 08:08:33 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 08:08:33 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 08:08:33 INFO - u'jsshell-mac.zip'], 08:08:33 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 08:08:33 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 08:08:33 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 08:08:33 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 08:08:33 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 08:08:33 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 08:08:33 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 08:08:33 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 08:08:33 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 08:08:33 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 08:08:33 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 08:08:33 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 08:08:33 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:08: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')]} 08:08:33 INFO - https://queue.taskcluster.net/v1/task/jzW4DwGySfOar5Op6FZX7A/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:08:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jzW4DwGySfOar5Op6FZX7A/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 08:08:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jzW4DwGySfOar5Op6FZX7A/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 08:08:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jzW4DwGySfOar5Op6FZX7A/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 08:08:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jzW4DwGySfOar5Op6FZX7A/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 08:08:34 INFO - Downloaded 17464070 bytes. 08:08:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 08:08:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 08:08:34 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 08:08:39 INFO - Return code: 0 08:08:39 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 08:08:39 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')]} 08:08:39 INFO - https://queue.taskcluster.net/v1/task/jzW4DwGySfOar5Op6FZX7A/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:08:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jzW4DwGySfOar5Op6FZX7A/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 08:08:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jzW4DwGySfOar5Op6FZX7A/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 08:08:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jzW4DwGySfOar5Op6FZX7A/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 08:08:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jzW4DwGySfOar5Op6FZX7A/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 08:08:59 INFO - Downloaded 17464070 bytes. 08:08:59 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 08:08:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 08:08:59 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 08:09:04 INFO - Return code: 0 08:09:04 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')]} 08:09:04 INFO - https://queue.taskcluster.net/v1/task/jzW4DwGySfOar5Op6FZX7A/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 08:09:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jzW4DwGySfOar5Op6FZX7A/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 08:09:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jzW4DwGySfOar5Op6FZX7A/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 08:09:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jzW4DwGySfOar5Op6FZX7A/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 08:09:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jzW4DwGySfOar5Op6FZX7A/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 08:09:05 INFO - Downloaded 11131693 bytes. 08:09:05 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 08:09:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 08:09:05 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 08:09:06 INFO - Return code: 0 08:09:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:06 INFO - https://queue.taskcluster.net/v1/task/jzW4DwGySfOar5Op6FZX7A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 08:09:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jzW4DwGySfOar5Op6FZX7A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 08:09:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jzW4DwGySfOar5Op6FZX7A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 08:09:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jzW4DwGySfOar5Op6FZX7A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 08:09:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jzW4DwGySfOar5Op6FZX7A/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 08:09:09 INFO - Downloaded 108688555 bytes. 08:09:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/jzW4DwGySfOar5Op6FZX7A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 08:09:09 INFO - mkdir: /builds/slave/test/properties 08:09:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:09:09 INFO - Writing to file /builds/slave/test/properties/build_url 08:09:09 INFO - Contents: 08:09:09 INFO - build_url:https://queue.taskcluster.net/v1/task/jzW4DwGySfOar5Op6FZX7A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 08:09:09 INFO - Running post-action listener: _resource_record_post_action 08:09:09 INFO - Running post-action listener: set_extra_try_arguments 08:09:09 INFO - ##### 08:09:09 INFO - ##### Running populate-webroot step. 08:09:09 INFO - ##### 08:09:09 INFO - Running pre-action listener: _resource_record_pre_action 08:09:09 INFO - Running main action method: populate_webroot 08:09:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:09:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:09:09 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 08:09:09 INFO - '../fennec_ids.txt'], 08:09:09 INFO - 'tests': ['tcheck2']}, 08:09:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:09:09 INFO - '--tppagecycles', 08:09:09 INFO - '7'], 08:09:09 INFO - 'tests': ['tsvgm']}}, 08:09:09 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:09:09 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:09:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:09:09 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:09:09 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:09:09 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:09:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:09:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:09 INFO - 'talos_options': ['--e10s'], 08:09:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:09:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:09 INFO - 'tests': ['damp', 'tps']}, 08:09:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:09 INFO - 'talos_options': ['--e10s'], 08:09:09 INFO - 'tests': ['damp', 'tps']}, 08:09:09 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:09:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:09:09 INFO - 'other': {'tests': ['a11yr', 08:09:09 INFO - 'ts_paint', 08:09:09 INFO - 'tpaint', 08:09:09 INFO - 'sessionrestore', 08:09:09 INFO - 'sessionrestore_no_auto_restore']}, 08:09:09 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:09:09 INFO - 'tests': ['a11yr', 08:09:09 INFO - 'ts_paint', 08:09:09 INFO - 'tpaint', 08:09:09 INFO - 'sessionrestore', 08:09:09 INFO - 'sessionrestore_no_auto_restore']}, 08:09:09 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:09:09 INFO - 'tests': ['a11yr', 08:09:09 INFO - 'ts_paint', 08:09:09 INFO - 'tpaint', 08:09:09 INFO - 'sessionrestore', 08:09:09 INFO - 'sessionrestore_no_auto_restore']}, 08:09:09 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:09:09 INFO - 'tests': ['a11yr', 08:09:09 INFO - 'ts_paint', 08:09:09 INFO - 'tpaint', 08:09:09 INFO - 'sessionrestore', 08:09:09 INFO - 'sessionrestore_no_auto_restore']}, 08:09:09 INFO - 'other_l64': {'tests': ['a11yr', 08:09:09 INFO - 'ts_paint', 08:09:09 INFO - 'tpaint', 08:09:09 INFO - 'sessionrestore', 08:09:09 INFO - 'sessionrestore_no_auto_restore']}, 08:09:09 INFO - 'other_nol64': {'tests': ['a11yr', 08:09:09 INFO - 'ts_paint', 08:09:09 INFO - 'tpaint', 08:09:09 INFO - 'sessionrestore', 08:09:09 INFO - 'sessionrestore_no_auto_restore']}, 08:09:09 INFO - 'svgr': {'tests': ['tsvgx', 08:09:09 INFO - 'tsvgr_opacity', 08:09:09 INFO - 'tart', 08:09:09 INFO - 'tscrollx', 08:09:09 INFO - 'cart']}, 08:09:09 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:09:09 INFO - 'tests': ['tsvgx', 08:09:09 INFO - 'tsvgr_opacity', 08:09:09 INFO - 'tart', 08:09:09 INFO - 'tscrollx', 08:09:09 INFO - 'cart']}, 08:09:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:09 INFO - 'tests': ['tp5o']}, 08:09:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:09 INFO - 'talos_options': ['--e10s'], 08:09:09 INFO - 'tests': ['tp5o']}, 08:09:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:09 INFO - 'talos_options': ['--xperf_path', 08:09:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:09:09 INFO - 'tests': ['tp5n']}, 08:09:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:09 INFO - 'talos_options': ['--e10s', 08:09:09 INFO - '--xperf_path', 08:09:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:09:09 INFO - 'tests': ['tp5n']}}, 08:09:09 INFO - 'talos.zip': {'path': '', 08:09:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:09:09 INFO - Running post-action listener: _resource_record_post_action 08:09:09 INFO - ##### 08:09:09 INFO - ##### Running create-virtualenv step. 08:09:09 INFO - ##### 08:09:09 INFO - Running pre-action listener: _resource_record_pre_action 08:09:09 INFO - Running main action method: create_virtualenv 08:09:09 INFO - Creating virtualenv /builds/slave/test/build/venv 08:09:09 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 08:09:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:09:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:09:09 INFO - Using real prefix '/tools/python27' 08:09:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:09:10 INFO - Installing distribute.............................................................................................................................................................................................done. 08:09:14 INFO - Installing pip.................done. 08:09:14 INFO - Return code: 0 08:09:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:09:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f5c1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f59e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec31e68450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4e49f0>, '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 0x10f244db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4d88c8>, '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.ryp4ZXMmmS/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.XDg6x8wVLa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/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 08:09:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:09:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:09:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ryp4ZXMmmS/Render', 08:09:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:09:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:09:14 INFO - 'HOME': '/Users/cltbld', 08:09:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:09:14 INFO - 'LOGNAME': 'cltbld', 08:09:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:14 INFO - 'MOZ_NO_REMOTE': '1', 08:09:14 INFO - 'NO_EM_RESTART': '1', 08:09:14 INFO - 'PAGER': '/bin/cat', 08:09:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:09:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:14 INFO - 'PWD': '/builds/slave/test', 08:09:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:09:14 INFO - 'SHELL': '/bin/bash', 08:09:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XDg6x8wVLa/Listeners', 08:09:14 INFO - 'TMPDIR': '/var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/T/', 08:09:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:09:14 INFO - 'USER': 'cltbld', 08:09:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:09:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:09:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:14 INFO - 'XPC_FLAGS': '0x0', 08:09:14 INFO - 'XPC_SERVICE_NAME': '0', 08:09:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:09:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:14 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 08:09:14 INFO - Cleaning up... 08:09:14 INFO - Return code: 0 08:09:14 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:09:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f5c1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f59e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec31e68450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4e49f0>, '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 0x10f244db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4d88c8>, '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.ryp4ZXMmmS/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.XDg6x8wVLa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/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 08:09:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 08:09:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:09:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ryp4ZXMmmS/Render', 08:09:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:09:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:09:14 INFO - 'HOME': '/Users/cltbld', 08:09:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:09:14 INFO - 'LOGNAME': 'cltbld', 08:09:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:14 INFO - 'MOZ_NO_REMOTE': '1', 08:09:14 INFO - 'NO_EM_RESTART': '1', 08:09:14 INFO - 'PAGER': '/bin/cat', 08:09:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:09:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:14 INFO - 'PWD': '/builds/slave/test', 08:09:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:09:14 INFO - 'SHELL': '/bin/bash', 08:09:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XDg6x8wVLa/Listeners', 08:09:14 INFO - 'TMPDIR': '/var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/T/', 08:09:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:09:14 INFO - 'USER': 'cltbld', 08:09:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:09:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:09:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:14 INFO - 'XPC_FLAGS': '0x0', 08:09:14 INFO - 'XPC_SERVICE_NAME': '0', 08:09:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:09:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:15 INFO - Downloading/unpacking psutil>=0.7.1 08:09:15 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 08:09:15 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 08:09:15 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 08:09:15 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 08:09:15 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 08:09:15 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 08:09:17 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 08:09:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:09:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:09:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:09:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:09:17 INFO - Installing collected packages: psutil 08:09:17 INFO - Running setup.py install for psutil 08:09:17 INFO - building 'psutil._psutil_osx' extension 08:09:17 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 08:09:18 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 08:09:18 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 08:09:18 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 08:09:18 INFO - building 'psutil._psutil_posix' extension 08:09:18 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 08:09:18 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:09:18 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:09:18 INFO - ^ 08:09:18 INFO - 1 warning generated. 08:09:18 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 08:09:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:09:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:09:18 INFO - Successfully installed psutil 08:09:18 INFO - Cleaning up... 08:09:18 INFO - Return code: 0 08:09:18 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:09: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')]} 08:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09: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')]} 08:09:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f5c1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f59e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec31e68450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4e49f0>, '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 0x10f244db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4d88c8>, '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.ryp4ZXMmmS/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.XDg6x8wVLa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/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 08:09:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 08:09:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:09:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ryp4ZXMmmS/Render', 08:09:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:09:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:09:18 INFO - 'HOME': '/Users/cltbld', 08:09:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:09:18 INFO - 'LOGNAME': 'cltbld', 08:09:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:18 INFO - 'MOZ_NO_REMOTE': '1', 08:09:18 INFO - 'NO_EM_RESTART': '1', 08:09:18 INFO - 'PAGER': '/bin/cat', 08:09:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:09:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:18 INFO - 'PWD': '/builds/slave/test', 08:09:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:09:18 INFO - 'SHELL': '/bin/bash', 08:09:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XDg6x8wVLa/Listeners', 08:09:18 INFO - 'TMPDIR': '/var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/T/', 08:09:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:09:18 INFO - 'USER': 'cltbld', 08:09:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:09:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:09:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:18 INFO - 'XPC_FLAGS': '0x0', 08:09:18 INFO - 'XPC_SERVICE_NAME': '0', 08:09:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:09:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:18 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:21 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:09:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:09:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:09:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:09:21 INFO - Installing collected packages: mozsystemmonitor 08:09:21 INFO - Running setup.py install for mozsystemmonitor 08:09:21 INFO - Successfully installed mozsystemmonitor 08:09:21 INFO - Cleaning up... 08:09:21 INFO - Return code: 0 08:09:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:09:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f5c1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f59e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec31e68450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4e49f0>, '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 0x10f244db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4d88c8>, '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.ryp4ZXMmmS/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.XDg6x8wVLa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/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 08:09:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:09:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:09:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ryp4ZXMmmS/Render', 08:09:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:09:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:09:21 INFO - 'HOME': '/Users/cltbld', 08:09:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:09:21 INFO - 'LOGNAME': 'cltbld', 08:09:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:21 INFO - 'MOZ_NO_REMOTE': '1', 08:09:21 INFO - 'NO_EM_RESTART': '1', 08:09:21 INFO - 'PAGER': '/bin/cat', 08:09:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:09:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:21 INFO - 'PWD': '/builds/slave/test', 08:09:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:09:21 INFO - 'SHELL': '/bin/bash', 08:09:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XDg6x8wVLa/Listeners', 08:09:21 INFO - 'TMPDIR': '/var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/T/', 08:09:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:09:21 INFO - 'USER': 'cltbld', 08:09:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:09:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:09:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:21 INFO - 'XPC_FLAGS': '0x0', 08:09:21 INFO - 'XPC_SERVICE_NAME': '0', 08:09:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:09:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:21 INFO - Downloading/unpacking blobuploader==1.2.4 08:09:21 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 08:09:21 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 08:09:21 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 08:09:21 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 08:09:21 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 08:09:21 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 08:09:24 INFO - Downloading blobuploader-1.2.4.tar.gz 08:09:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:09:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:09:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:09:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:09:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:25 INFO - Downloading docopt-0.6.1.tar.gz 08:09:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:09:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:09:25 INFO - Installing collected packages: blobuploader, requests, docopt 08:09:25 INFO - Running setup.py install for blobuploader 08:09:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:09:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:09:25 INFO - Running setup.py install for requests 08:09:26 INFO - Running setup.py install for docopt 08:09:26 INFO - Successfully installed blobuploader requests docopt 08:09:26 INFO - Cleaning up... 08:09:26 INFO - Return code: 0 08:09:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:09:26 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')]} 08:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:26 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')]} 08:09:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:26 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 0x10f5c1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f59e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec31e68450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4e49f0>, '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 0x10f244db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4d88c8>, '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.ryp4ZXMmmS/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.XDg6x8wVLa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/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 08:09:26 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 08:09:26 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 08:09:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ryp4ZXMmmS/Render', 08:09:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:09:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:09:26 INFO - 'HOME': '/Users/cltbld', 08:09:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:09:26 INFO - 'LOGNAME': 'cltbld', 08:09:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:26 INFO - 'MOZ_NO_REMOTE': '1', 08:09:26 INFO - 'NO_EM_RESTART': '1', 08:09:26 INFO - 'PAGER': '/bin/cat', 08:09:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:09:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:26 INFO - 'PWD': '/builds/slave/test', 08:09:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:09:26 INFO - 'SHELL': '/bin/bash', 08:09:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XDg6x8wVLa/Listeners', 08:09:26 INFO - 'TMPDIR': '/var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/T/', 08:09:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:09:26 INFO - 'USER': 'cltbld', 08:09:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:09:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:09:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:26 INFO - 'XPC_FLAGS': '0x0', 08:09:26 INFO - 'XPC_SERVICE_NAME': '0', 08:09:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:09:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:09:26 INFO - Running setup.py (path:/var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/T/pip-XmtAbq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:09:26 INFO - Running setup.py (path:/var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/T/pip-zcTg7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:09:27 INFO - Running setup.py (path:/var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/T/pip-w9uAQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:09:27 INFO - Running setup.py (path:/var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/T/pip-8DxcvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:09:27 INFO - Running setup.py (path:/var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/T/pip-u6gIvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:09:27 INFO - Running setup.py (path:/var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/T/pip-z4JwSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:09:27 INFO - Running setup.py (path:/var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/T/pip-k7JWW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:09:27 INFO - Running setup.py (path:/var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/T/pip-PHC6e7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:09:27 INFO - Running setup.py (path:/var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/T/pip-y4bKTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:09:27 INFO - Running setup.py (path:/var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/T/pip-EOCoeL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:09:27 INFO - Running setup.py (path:/var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/T/pip-2dcyq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:09:28 INFO - Running setup.py (path:/var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/T/pip-mbpeLN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:09:28 INFO - Running setup.py (path:/var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/T/pip-wfiHXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:09:28 INFO - Running setup.py (path:/var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/T/pip-43puoL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:09:28 INFO - Running setup.py (path:/var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/T/pip-QmWWcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:09:28 INFO - Running setup.py (path:/var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/T/pip-x7PCxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:09:28 INFO - Running setup.py (path:/var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/T/pip-2x6Wgb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:09:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:09:28 INFO - Running setup.py install for manifestparser 08:09:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:09:28 INFO - Running setup.py install for mozcrash 08:09:29 INFO - Running setup.py install for mozdebug 08:09:29 INFO - Running setup.py install for mozdevice 08:09:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:09:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:09:29 INFO - Running setup.py install for mozfile 08:09:29 INFO - Running setup.py install for mozhttpd 08:09:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:09:29 INFO - Running setup.py install for mozinfo 08:09:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:09:29 INFO - Running setup.py install for mozInstall 08:09:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:09:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:09:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:09:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:09:30 INFO - Running setup.py install for mozleak 08:09:30 INFO - Running setup.py install for mozlog 08:09:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:09:30 INFO - Running setup.py install for moznetwork 08:09:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:09:30 INFO - Running setup.py install for mozprocess 08:09:30 INFO - Running setup.py install for mozprofile 08:09:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:09:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:09:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:09:30 INFO - Running setup.py install for mozrunner 08:09:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:09:31 INFO - Running setup.py install for mozscreenshot 08:09:31 INFO - Running setup.py install for moztest 08:09:31 INFO - Running setup.py install for mozversion 08:09:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:09:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:09:31 INFO - Cleaning up... 08:09:31 INFO - Return code: 0 08:09:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:09:31 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')]} 08:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:31 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')]} 08:09:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:31 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 0x10f5c1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f59e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec31e68450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4e49f0>, '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 0x10f244db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4d88c8>, '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.ryp4ZXMmmS/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.XDg6x8wVLa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/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 08:09:31 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 08:09:31 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 08:09:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ryp4ZXMmmS/Render', 08:09:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:09:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:09:31 INFO - 'HOME': '/Users/cltbld', 08:09:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:09:31 INFO - 'LOGNAME': 'cltbld', 08:09:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:31 INFO - 'MOZ_NO_REMOTE': '1', 08:09:31 INFO - 'NO_EM_RESTART': '1', 08:09:31 INFO - 'PAGER': '/bin/cat', 08:09:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:09:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:31 INFO - 'PWD': '/builds/slave/test', 08:09:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:09:31 INFO - 'SHELL': '/bin/bash', 08:09:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XDg6x8wVLa/Listeners', 08:09:31 INFO - 'TMPDIR': '/var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/T/', 08:09:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:09:31 INFO - 'USER': 'cltbld', 08:09:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:09:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:09:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:31 INFO - 'XPC_FLAGS': '0x0', 08:09:31 INFO - 'XPC_SERVICE_NAME': '0', 08:09:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:09:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:09:32 INFO - Running setup.py (path:/var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/T/pip-BCWsmT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:09:32 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)) 08:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:09:32 INFO - Running setup.py (path:/var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/T/pip-3boiSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:09:32 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)) 08:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:09:32 INFO - Running setup.py (path:/var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/T/pip-vMjWTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:09:32 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)) 08:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:09:32 INFO - Running setup.py (path:/var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/T/pip-04s4Vw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:09:32 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)) 08:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:09:32 INFO - Running setup.py (path:/var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/T/pip-7qI6SA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:09:32 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)) 08:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:09:32 INFO - Running setup.py (path:/var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/T/pip-v5h4JS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:09:32 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)) 08:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:09:32 INFO - Running setup.py (path:/var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/T/pip-NzQGxo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:09:32 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)) 08:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:09:32 INFO - Running setup.py (path:/var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/T/pip-cZcFpF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:09:33 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)) 08:09:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:09:33 INFO - Running setup.py (path:/var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/T/pip-7vjClo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:09:33 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)) 08:09:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:09:33 INFO - Running setup.py (path:/var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/T/pip-UxouvZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:09:33 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)) 08:09:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:09:33 INFO - Running setup.py (path:/var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/T/pip-w3r6JM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:09:33 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)) 08:09:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:09:33 INFO - Running setup.py (path:/var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/T/pip-SKA9zt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:09:33 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)) 08:09:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:09:33 INFO - Running setup.py (path:/var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/T/pip-zmZ7zm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:09:33 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)) 08:09:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:09:33 INFO - Running setup.py (path:/var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/T/pip-7Ojw9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:09:33 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)) 08:09:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:09:33 INFO - Running setup.py (path:/var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/T/pip-hbDnFQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:09:33 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)) 08:09:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:09:33 INFO - Running setup.py (path:/var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/T/pip-PD3wxd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:09:34 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)) 08:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:09:34 INFO - Running setup.py (path:/var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/T/pip-o9Am4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:09:34 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)) 08:09:34 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)) 08:09:34 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)) 08:09:34 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)) 08:09:34 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)) 08:09:34 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)) 08:09:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:09:34 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 08:09:34 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 08:09:34 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 08:09:34 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 08:09:34 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 08:09:34 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 08:09:36 INFO - Downloading blessings-1.5.1.tar.gz 08:09:36 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 08:09:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:09:36 INFO - Installing collected packages: blessings 08:09:36 INFO - Running setup.py install for blessings 08:09:36 INFO - Successfully installed blessings 08:09:36 INFO - Cleaning up... 08:09:36 INFO - Return code: 0 08:09:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:09:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:09:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:09:37 INFO - Reading from file tmpfile_stdout 08:09:37 INFO - Current package versions: 08:09:37 INFO - blessings == 1.5.1 08:09:37 INFO - blobuploader == 1.2.4 08:09:37 INFO - docopt == 0.6.1 08:09:37 INFO - manifestparser == 1.1 08:09:37 INFO - mozInstall == 1.12 08:09:37 INFO - mozcrash == 0.16 08:09:37 INFO - mozdebug == 0.1 08:09:37 INFO - mozdevice == 0.47 08:09:37 INFO - mozfile == 1.2 08:09:37 INFO - mozhttpd == 0.7 08:09:37 INFO - mozinfo == 0.9 08:09:37 INFO - mozleak == 0.1 08:09:37 INFO - mozlog == 3.0 08:09:37 INFO - moznetwork == 0.27 08:09:37 INFO - mozprocess == 0.22 08:09:37 INFO - mozprofile == 0.27 08:09:37 INFO - mozrunner == 6.11 08:09:37 INFO - mozscreenshot == 0.1 08:09:37 INFO - mozsystemmonitor == 0.0 08:09:37 INFO - moztest == 0.7 08:09:37 INFO - mozversion == 1.4 08:09:37 INFO - psutil == 3.1.1 08:09:37 INFO - requests == 1.2.3 08:09:37 INFO - wsgiref == 0.1.2 08:09:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:09:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:37 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 0x10f5c1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f59e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec31e68450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4e49f0>, '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 0x10f244db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4d88c8>, '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.ryp4ZXMmmS/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.XDg6x8wVLa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/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 08:09:37 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 08:09:37 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 08:09:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ryp4ZXMmmS/Render', 08:09:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:09:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:09:37 INFO - 'HOME': '/Users/cltbld', 08:09:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:09:37 INFO - 'LOGNAME': 'cltbld', 08:09:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:37 INFO - 'MOZ_NO_REMOTE': '1', 08:09:37 INFO - 'NO_EM_RESTART': '1', 08:09:37 INFO - 'PAGER': '/bin/cat', 08:09:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:09:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:37 INFO - 'PWD': '/builds/slave/test', 08:09:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:09:37 INFO - 'SHELL': '/bin/bash', 08:09:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XDg6x8wVLa/Listeners', 08:09:37 INFO - 'TMPDIR': '/var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/T/', 08:09:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:09:37 INFO - 'USER': 'cltbld', 08:09:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:09:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:09:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:37 INFO - 'XPC_FLAGS': '0x0', 08:09:37 INFO - 'XPC_SERVICE_NAME': '0', 08:09:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:09:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:37 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)) 08:09:37 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)) 08:09:37 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)) 08:09:37 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)) 08:09:37 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)) 08:09:37 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)) 08:09:37 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)) 08:09:37 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)) 08:09:37 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)) 08:09:37 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)) 08:09:37 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)) 08:09:37 INFO - Cleaning up... 08:09:37 INFO - Return code: 0 08:09:37 INFO - Running post-action listener: _resource_record_post_action 08:09:37 INFO - Running post-action listener: _start_resource_monitoring 08:09:37 INFO - Starting resource monitoring. 08:09:37 INFO - ##### 08:09:37 INFO - ##### Running install step. 08:09:37 INFO - ##### 08:09:37 INFO - Running pre-action listener: _resource_record_pre_action 08:09:37 INFO - Running main action method: install 08:09:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:09:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:09:37 INFO - Reading from file tmpfile_stdout 08:09:37 INFO - Detecting whether we're running mozinstall >=1.0... 08:09:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:09:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:09:37 INFO - Reading from file tmpfile_stdout 08:09:37 INFO - Output received: 08:09:37 INFO - Usage: mozinstall [options] installer 08:09:37 INFO - Options: 08:09:37 INFO - -h, --help show this help message and exit 08:09:37 INFO - -d DEST, --destination=DEST 08:09:37 INFO - Directory to install application into. [default: 08:09:37 INFO - "/builds/slave/test"] 08:09:37 INFO - --app=APP Application being installed. [default: firefox] 08:09:37 INFO - mkdir: /builds/slave/test/build/application 08:09:37 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'] 08:09:37 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 08:10:15 INFO - Reading from file tmpfile_stdout 08:10:15 INFO - Output received: 08:10:15 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:10:15 INFO - Running post-action listener: _resource_record_post_action 08:10:15 INFO - ##### 08:10:15 INFO - ##### Running run-tests step. 08:10:15 INFO - ##### 08:10:15 INFO - Running pre-action listener: _resource_record_pre_action 08:10:15 INFO - Running main action method: run_tests 08:10:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:10:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:10:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:10:15 INFO - 2015-11-16 08:10:15.309 screenresolution[1915:19185] starting screenresolution argv=screenresolution get 08:10:15 INFO - 2015-11-16 08:10:15.313 screenresolution[1915:19185] Display 0: 1600x1200x32@60 08:10:15 INFO - 2015-11-16 08:10:15.319 screenresolution[1916:19187] starting screenresolution argv=screenresolution list 08:10:15 INFO - Available Modes on Display 0 08:10:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:10:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:10:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:10:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:10:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:10:15 INFO - Intel HD Graphics 3000: 08:10:15 INFO - Chipset Model: Intel HD Graphics 3000 08:10:15 INFO - Type: GPU 08:10:15 INFO - Bus: Built-In 08:10:15 INFO - VRAM (Total): 512 MB 08:10:15 INFO - VRAM (Dynamic, Max): 10 08:10:15 INFO - Vendor: Intel (0x8086) 08:10:15 INFO - Device ID: 0x0116 08:10:15 INFO - Revision ID: 0x0009 08:10:15 INFO - Displays: 08:10:15 INFO - Display: 08:10:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:10:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:10:15 INFO - Display Serial Number: 1600x1200 60 08:10:15 INFO - Main Display: Yes 08:10:15 INFO - Mirror: Off 08:10:15 INFO - Online: Yes 08:10:15 INFO - Rotation: Supported 08:10:15 INFO - Return code: 0 08:10:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:10:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:10:15 INFO - Python 2.7.3 08:10:15 INFO - Return code: 0 08:10:15 INFO - grabbing minidump binary from tooltool 08:10:15 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')]} 08:10:15 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 0x10f4e49f0>, '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 0x10f244db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4d88c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:10:15 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 08:10:15 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 08:10:15 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:10:15 INFO - Return code: 0 08:10:15 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:10:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:10:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:10:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:10:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:10:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/jzW4DwGySfOar5Op6FZX7A/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0094', '--webServer', 'localhost'] in /builds/slave/test/build 08:10:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/jzW4DwGySfOar5Op6FZX7A/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0094 --webServer localhost 08:10:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ryp4ZXMmmS/Render', 08:10:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:10:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:10:15 INFO - 'HOME': '/Users/cltbld', 08:10:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:10:15 INFO - 'LOGNAME': 'cltbld', 08:10:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:10:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:10:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:15 INFO - 'MOZ_NO_REMOTE': '1', 08:10:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:10:15 INFO - 'NO_EM_RESTART': '1', 08:10:15 INFO - 'PAGER': '/bin/cat', 08:10:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:10:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:15 INFO - 'PWD': '/builds/slave/test', 08:10:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:10:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:10:15 INFO - 'SHELL': '/bin/bash', 08:10:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XDg6x8wVLa/Listeners', 08:10:15 INFO - 'TMPDIR': '/var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/T/', 08:10:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:10:15 INFO - 'USER': 'cltbld', 08:10:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:10:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:10:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:15 INFO - 'XPC_FLAGS': '0x0', 08:10:15 INFO - 'XPC_SERVICE_NAME': '0', 08:10:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:10:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/jzW4DwGySfOar5Op6FZX7A/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0094', '--webServer', 'localhost'] with output_timeout 3600 08:10:15 INFO - mozversion INFO | application_buildid: 20151116072434 08:10:15 INFO - mozversion INFO | application_changeset: 8e2b7001ebc461585bb003794e31e3f203a394c5 08:10:15 INFO - mozversion INFO | application_display_name: Nightly 08:10:15 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:10:15 INFO - mozversion INFO | application_name: Firefox 08:10:15 INFO - mozversion INFO | application_remotingname: firefox 08:10:15 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 08:10:15 INFO - mozversion INFO | application_vendor: Mozilla 08:10:15 INFO - mozversion INFO | application_version: 45.0a1 08:10:15 INFO - mozversion INFO | platform_buildid: 20151116072434 08:10:15 INFO - mozversion INFO | platform_changeset: 8e2b7001ebc461585bb003794e31e3f203a394c5 08:10:15 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 08:10:15 INFO - mozversion INFO | platform_version: 45.0a1 08:10:15 INFO - 2015-11-16 08:10:15,912 DEBUG : using testdate: 1447690215 08:10:15 INFO - 2015-11-16 08:10:15,912 DEBUG : actual date: 1447690215 08:10:16 INFO - 2015-11-16 08:10:16,069 INFO : starting webserver on 'localhost:57124' 08:10:16 INFO - 2015-11-16 08:10:16,070 INFO : Starting test suite t-yosemite-r5-0094 08:10:16 INFO - 2015-11-16 08:10:16,070 INFO : Starting test dromaeo_css 08:10:16 INFO - 2015-11-16 08:10:16,070 DEBUG : operating with platform_type : mac_ 08:10:16 INFO - 2015-11-16 08:10:16,071 INFO : Initialising browser for dromaeo_css test... 08:10:16 INFO - 2015-11-16 08:10:16,084 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/T/tmpVjDcUq/profile http://localhost:57124/getInfo.html 08:10:18 INFO - 2015-11-16 08:10:18,320 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:10:18 INFO - 2015-11-16 08:10:18,320 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:10:18 INFO - 2015-11-16 08:10:18,320 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 08:10:18 INFO - 2015-11-16 08:10:18,320 DEBUG : BROWSER_OUTPUT: __metrics 08:10:18 INFO - 2015-11-16 08:10:18,341 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:10:19 INFO - 2015-11-16 08:10:19,033 INFO : Browser initialized. 08:10:19 INFO - 2015-11-16 08:10:19,033 INFO : Running cycle 1/1 for dromaeo_css test... 08:10:19 INFO - 2015-11-16 08:10:19,033 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/T/tmpVjDcUq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:10:31 INFO - 2015-11-16 08:10:31,025 DEBUG : BROWSER_OUTPUT: RSS: Main: 229400576 08:10:31 INFO - 2015-11-16 08:10:31,026 DEBUG : BROWSER_OUTPUT: 08:11:22 INFO - 2015-11-16 08:11:22,827 DEBUG : BROWSER_OUTPUT: 1447690282826 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] 08:13:32 INFO - 2015-11-16 08:13:32,878 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57124/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57124/tests/dromaeo/cssquery-ext.html) 08:13:34 INFO - 2015-11-16 08:13:34,099 DEBUG : BROWSER_OUTPUT: RSS: Main: 352448512 08:13:34 INFO - 2015-11-16 08:13:34,099 DEBUG : BROWSER_OUTPUT: 08:16:36 INFO - 2015-11-16 08:16:36,684 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57124/tests/dromaeo/cssquery-ext.html (next: http://localhost:57124/tests/dromaeo/cssquery-jquery.html) 08:16:37 INFO - 2015-11-16 08:16:37,276 DEBUG : BROWSER_OUTPUT: RSS: Main: 364859392 08:16:37 INFO - 2015-11-16 08:16:37,277 DEBUG : BROWSER_OUTPUT: 08:19:39 INFO - 2015-11-16 08:19:39,469 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57124/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57124/tests/dromaeo/cssquery-mootools.html) 08:19:40 INFO - 2015-11-16 08:19:40,053 DEBUG : BROWSER_OUTPUT: RSS: Main: 326811648 08:19:40 INFO - 2015-11-16 08:19:40,053 DEBUG : BROWSER_OUTPUT: 08:22:41 INFO - 2015-11-16 08:22:41,994 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57124/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57124/tests/dromaeo/cssquery-prototype.html) 08:22:42 INFO - 2015-11-16 08:22:42,577 DEBUG : BROWSER_OUTPUT: RSS: Main: 319700992 08:22:42 INFO - 2015-11-16 08:22:42,577 DEBUG : BROWSER_OUTPUT: 08:25:45 INFO - 2015-11-16 08:25:45,565 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57124/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57124/tests/dromaeo/cssquery-yui.html) 08:25:46 INFO - 2015-11-16 08:25:46,183 DEBUG : BROWSER_OUTPUT: RSS: Main: 323174400 08:25:46 INFO - 2015-11-16 08:25:46,183 DEBUG : BROWSER_OUTPUT: 08:28:48 INFO - 2015-11-16 08:28:48,931 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57124/tests/dromaeo/cssquery-yui.html (next: http://localhost:57124/tests/dromaeo/cssquery-dojo.html) 08:28:49 INFO - 2015-11-16 08:28:49,189 DEBUG : BROWSER_OUTPUT: RSS: Main: 377192448 08:28:49 INFO - 2015-11-16 08:28:49,189 DEBUG : BROWSER_OUTPUT: 08:28:49 INFO - 2015-11-16 08:28:49,189 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:28:49 INFO - 2015-11-16 08:28:49,189 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:28:49 INFO - 2015-11-16 08:28:49,189 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:28:49 INFO - 2015-11-16 08:28:49,190 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:28:49 INFO - 2015-11-16 08:28:49,194 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3167.9841600791997;3225.725813305869;3225.9354812903744;3246.61040675119;3272.3946069977055;5272.710000949946;5333;5340.305760251167;5342.91985620216;5396.163594642837;5351.839444816662;5396.298481197439;5422.376426710929;5444.237806707064;5519.144532597444;4957.7769000395065;4986.850394488171;4999.175136102539;5043.470435604264;5081.390233172025;5027.698338099707;5044.545990860822;5058.645894787366;5059.569936555397;5072;4862.270659401082;4904.950950490485;4948.703077815343;5006.324146240266;5029.1953287473825;5067.138586440314;5085.949140508585;5101;5111.08000559899;5124.692518448905;5039.244113382985;5041.0422019816115;5047;5053.1157047516535;5055.469175736532;5269;5359.356877174725;5369.301990741218;5387.784488620489;5471.945280547184;5790.826275211708;5800.187973683687;5802.12968054791;5806.477417032487;5812.534997200214;5859.53123750099;5874.295084589834;5884.08796636522;5885.70571471429;5894.498967587718;5238.921416178722;5277.683338999673;5375.543078838343;5378.731063446851;5399.973000134974;5912.940870591325;5921.67430791302;5927.851803704942;5932.406759324033;6003.489703375175;5704.372519022904;5733.967885780517;5740.913886291709;5743.913841292384;5750.568707346882;5622.128570071645;5745.88508229833;5750.5112065474905;5779.537636989031;5912.17229587858;5713.428657134254;5716.657000579979;5719.828405147852;5729.169270455761;5732.426757324234;5728.283964504437;5735.311762588516;5742.684152371659;5744;5745.937001654707;4273.18809426208;4354.912901742011;4382.9342559861625;4383.60547550722;4390.341448782644;4075.3683179107284;4090.9386359204636;4103.630673239423;4123.154753275631;4133.607307305801;5453.072977593819;5493.972530137324;5497.8075767347955;5502.0371434998715;5554.805581804618;5642.605017648725;5775.451332123442;5779.826605201851;5832.066869300891;5891.351951285355;5509.779608815683;5524.281843360337;5532.2531458253425;5541.445855414427;5547;5130.9230361544605;5134.075866344094;5146.099432599281;5175.534201921845;5196.064708352533;5940.405959404025;6021.126936594257;6068.817935461943;6071.301800292935;6077.2099627049965;5895.4399332063385;5901.527877769854;5920.615160014585;5929;5935.525157987265;6091.8781624366375;6102.115193297036;6109.816705498843;6117.418845209698;6123.755049797958;5505.6696598204235;5588.692621905834;5627.240322556402;5647.915281270866;5783.392743761844;5872.207252020922;5879.059350503899;5890.410958904075;5910.556708246812;5919.644821310563;5738.512226460798;5758.769649213985;5759.395263497272;5764.913526297193;5778.248827652378;5509.256250406304;5555.055640541199;5596.748146333343;5613.635113717595;5727.8568035799435;5512.972435137799;5519.834404967857;5523.061079616556;5544.778208871761;5643.943560564506;5634.802781902614;5637;5647;5670.801521946877;5708.315002199763;5425.674459532441;5426.70153141581;5542.224088627515;5548.722563871871;5560.916586251128 08:28:49 INFO - 2015-11-16 08:28:49,194 DEBUG : BROWSER_OUTPUT: |1;ext.html;563.4759673503642;580.4775701868318;583.5244275915129;584.5469760935272;609.3723464831226;32016.519752203705;32720.509192362133;40328.798356008214;40935.59064409355;40974.79512602433;42549;43032.78483607578;43101.35347969783;43140.56859431405;43173.78413107938;8331.416800823945;9159.404638698497;9274.768130796716;9282.396644218137;9285.117913798213;8484.957575212145;11282.210245282833;11494.36780977046;11515.539378424895;11544.942275288611;11220.887791122066;11314.773704525904;11351.772964540703;11383.203175777699;11405.828912566276;8604.827903441896;8716.25911797498;11211.831822522669;11348.43257837109;11375.772484550263;11063;11175.552977880876;11198.104151667847;11203.271787333797;11230.719232019264;40894.79552602248;41349.79325103385;41425.79287103575;41449;41449.37825932583;2987.8207307561615;3040.559118927743;3373.5277061211204;3510.7015903647966;3528.435450327935;27148.592771108448;27250.45499090007;27817.304567385774;27820.582691259646;28122;2437.9756202437925;2458.8770561471856;2517.1064272183294;2621.7247189045065;2635.855027973461;284003;284488.9999999979;285054;285078;285975;57088.71455642695;57853.421465784806;60529.39470605326;60942.39057609367;67362.32637673659;62565.37434625596;63063.6846815763;63166.68416657979;63196.68401658054;63324.68337658282;15146.621334466507;15313.464028759163;15317.540473785804;15319;15323.46367877119;10491.737706557244;10492.26554141218;10495.842562361571;10511.684649460529;10533.631322903662;19981.700274495895;20111.19555217804;20156.596868062556;20176;20216.09027593762;8127.634256458474;8298.253157215879;8319;8343.95828020868;8392.874106888401;954.7231302922074;963.3545524498603;1085.625459216569;1117.972050698739;1122.7754449110212;26614;26627.600585991226;26887.193384198505;26980;27026.729732702814;1050.2595670052594;1070.384528895888;1172.695099274195;1178.3732676469924;1179.2924245452832;14375.843623456565;14430.639234019234;14449.711005779825;14476.276186190858;14596;334041;340857;340933;341622;343246;55747.16379254314;56057.71971140118;56125.87748245012;56156;56196.157057644166;1371.4377105386743;1380.2822532283358;1386.1960063163342;1387.2312801178578;1388.9305534723223;27585;28079.298017549725;28194.85902570474;29026.7097329024;29765.255868603457;47084.7645761769;47516.52483475121;47524.7623761879;47529;47554.52445475639;259041;261639;261712;262471;262702;31950.201244969063;33128.50307245345;33242.33515329728;33290.167745806546;33332.50001250031;42888.42669439719;43214.78392608017;43269.35095973626;43567.78216109026;44583.777081114386;36516.452253216754;36669.44995825118;37321.440178396806;37410.8129459351;37439.251214976095;36279.637203628685;36363.27273454569;38868;39248.30899519611;39979.60020399759;34808.65191348155;35531.28937421289;35704.28591428209;35738.8213058933;35762.8211858939;30435.695643043287;31861.6813831868;31887;31906.840465797522;31936;24199.395015124763;24669.62995555104;24848.627270590594;25078.24765257045;25182.74817251804 08:28:49 INFO - 2015-11-16 08:28:49,197 DEBUG : BROWSER_OUTPUT: |2;jquery.html;324.2881874285943;336.8147518864624;337.56198593989603;342.18730515026806;348.17656242985345;14031.158130512164;14388.568342949715;17555.385561505333;17872.463826085237;18456.538586535342;17894.821051789477;18535.258589656398;18593.442196734086;18919.243230270808;18923.432297031075;3989.820458079379;4121.9381709274385;5414.702191379472;5581.995240856644;5600.719964001804;5881;6042.425969532887;6084.452399284063;6096.878062438748;6115;5898.852528686774;6031.065184896348;6031.879362412749;6063.0905364195505;6073.665948372838;3911.3155197840406;4026.4765580474646;5753.338366087912;5935.109733540004;5991;5209.374875015023;5213.2701421800975;5213.6089793265655;5215.556677682363;5222.451642577551;21739.782602173935;22098.558028839492;22215.333539993826;22218;22432.775672243395;1983.8809671419617;2023.8077382648771;2157.8381621378458;2190.211523851412;2271.557046375941;13388.531401401002;13431.462741490328;13591.866534883582;13946.51187208453;13996.16023038621;1695.423555990969;1728.8398757862992;1735.7830271216098;1751.3782607174396;1756.7540544323676;58756.70621646864;59668.70165649144;60269.39730602682;60504;60735.69632151811;9427.575759090858;9614.375065620712;9783.315167938175;9795.755106122262;9880.258980576486;12110.970567501685;12112.333821639719;12119.878801212051;12120.151589388659;12124.151309408433;7468.21583733711;7517.849643007109;7530.058742657168;7579.393648508106;7579.848403031909;7288.453365997571;7315.597642129627;7324.121105467378;7332.706691732271;7375.483716139926;5850.882982340415;5910.852228694317;5917.763289468373;5924.14099955504;5976.193213916153;1665.4087798831483;1686.620510385178;1688.8311168883013;1693.0688121533108;1694.593297608565;917.3074328881785;950.0309684122295;957.0142752964458;982.9803403931882;1059.6026490066224;14583.92708036453;17598.472045838644;17852.821471785377;18102.45692629223;18275.63448731018;933.5518950903604;966.1980556138388;966.6954909203579;1049.2445439283704;1061.1722856172198;10411.94794026025;10598.0991615712;10622.46887655614;10627.946860265649;10665.466726663635;388082;389896;411577;426948;500723;64015.35984640187;65808.10302763699;69496.48272862248;70126;70785.64607177034;488.8875558621466;492.41648646354184;499.29848562769365;508.19451169895393;509.6330641937725;10758.784824303626;10863.78272434531;10909.454527273763;10910.181736369645;10956.178286628376;32170.67829321677;32295.51556726604;32343.191420214684;32598.34803303968;32810.67189328076;43395.783021084695;43751.343729843444;44528.10943781171;44718;46153;6068.8786224276155;6246.562740608114;6251.281102673251;6258.749650013949;6268.404501572526;11146.386948717898;11690.123240756808;11738.237014594024;11744;11836.289822610672;9872.85190722154;9894.06006429388;10083.495825208856;10186.03232692893;10201.693949181536;9801.950990245003;9890.406575605486;9955.562601247384;10268.691939241835;10334.276600637882;10210.846837297298;10478.423686697;10754;10759.3544387337;10813.891861081289;5918.822435326947;6204.5967012145875;6216.347283535164;6231.9688401557705;6313.305536391085;9935.850962235427;9978.351407158512;10180.287379883337;10300.124489418484;10301.9484902575 08:28:49 INFO - 2015-11-16 08:28:49,198 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1327.0644195841933;1384.937677804499;1447.5440236325558;1634.844689754473;1884.1709647754979;7340.889886651705;7765.417593680475;7829.334506566942;7837.8824317635135;7839.451238413313;7886;8115.0667673217595;8119.9188008120045;8136.877946830802;8137.552434616094;2320.8375413721046;2334.9299521014314;2338.4738433852417;2343.2618725101624;2348.7064116985375;2344.402177444749;2353.446939969106;2398.1846172301416;2402.9279121626378;2404.146527982567;2253.5830871288863;2258.8757618330983;2259.423846919033;2305.101010605865;2308.226744040748;2304.6197377432704;2317.0268487235317;2323.3610757041947;2329.9301020969397;2341.4497593065616;2329.5690297294886;2333.9299821005397;2334.8132149428006;2340.9297721068397;2343.4961483281177;7275.563466192046;7476.70093196277;8062.435629505937;8126.796830079236;8139;4965.453800081988;5127.7948882044675;5149.3305870237;5159.767810448501;5161.5870730341485;2809.101087651952;2905.026816016637;2917.6644685861183;2967.0208831085906;2967.762578993675;906.3338446242007;916.5600511754395;918.8667643191767;930.5440334236243;955.2787645327802;10735.94632026835;10800.243982921198;10800.51397687106;10811.621593244277;10825.13398928076;4277.529471758166;4361.978190109029;4368.716033457815;4442.644588432918;4591.862244132614;8763.737087887246;8772.517511536927;8780.429272097294;8797.736067917973;8802;5097.413797413345;5122.615803814729;5132.692038477703;5146.2280657900865;5149.176131818891;4730.763461826895;4740.7392593407;4744.478107408182;4744.5492678195515;4745.027269409763;3446.362422951762;3523.894283171509;3544.521489598871;3547.0954906498678;3557.288542291552;1028.0490546244844;1058.1640504001753;1059.4914441068331;1060.7825395793843;1069.3637285814928;1057.0328149743052;1058.7353161709573;1079.1151255970028;1079.7300674831292;1111.9833202501968;7608.087029556488;7656.310932016146;7717.498362606412;7725.884111738328;7753.263439973193;492.6526798607045;498.1556262135645;502.4949925325025;503.07434320849814;503.5342308364748;5538.723063846872;5636.210930469738;5699.544036477072;5734.827955161351;5744.770209191585;9305.720828375159;9425.717228483156;9520.428774273565;9525.333226674065;9545.52272386378;9248.549134479368;9343.813123737487;9456.716298511055;9466.810663786686;9519.762005949768;7646.082470103624;7726.536407815549;7731.613419329124;7731.690732370755;7752.3798096153305;7536.811579710551;7575.356094732009;7626.656800443882;7647.808804779925;7651.540907545343;8475.915240847758;8606.698765543177;8608.225259726654;8686.261667758312;8700.60847261862;8744.125587441205;8836.779080523038;8928.687495937611;9022.188003079755;9036.819263614823;6317.557770955989;6372.681365931592;6377.681115944091;6384.3934826191435;6386.361363863763;7658.8085297868;7775.377969762519;7792.259735325135;7793.64928578204;7795.805104872424;7290.1251849776245;7369.668364923698;7392.002079719384;7404.074490688664;7413.666385012795;7148.857022859618;7168.964155179191;7175.138983322035;7214.603196824015;7280.126384833854;7283.7450689225625;7328.560286382834;7366.889496657447;7373;7375.078115235596;6582.243042050225;6636.004599310142;6641.900371494528;6644.867102658017;6658.267590565131;6611.669416529058;6740.157480314961;6781.186257649114;6786.981952707133;6796.524243303119 08:28:49 INFO - 2015-11-16 08:28:49,202 DEBUG : BROWSER_OUTPUT: |4;prototype.html;315.87365053978414;326.5134948926101;328.68446291560093;332.9017939707787;334.54668923608523;6145.7541698332125;6269.592476489036;6309.463695585875;6349.7142628581705;6360.077788720633;6082.939170608292;6219.906701399483;6261.217347831521;6294.464970477504;6297.18136642237;4795.6163506919365;4796.83211087612;4805.6155507559315;4815.0610630926985;4819.951800481986;4637.814487420499;4719.43366795985;4722.079194557063;4808.086463571927;4814.66297359185;4728.692634978733;4734.4081989751285;4748.050389922012;4751.168545504523;4766.428028636568;4738.407699037621;4757.738324392157;4762.119007983534;4765.28520721891;4772.976135119302;4092.4884389451317;4101.097758493127;4107.507099148092;4108.281050816125;4111.6093971073;5895.882082358372;6057.151998720183;6077.058056001327;6115.113308570232;6131.754729810802;5372.167314066326;5376.784928602851;5385.703786291752;5390.407055223922;5391.892162156735;6545.312742162052;6564.212294524687;6565.441937435324;6565.507586930951;6570.63861487618;4193.35003074524;4340.414044104037;4458.464984201884;4460.977695111536;4469.620082293009;6551.410373066399;6722.49581281401;6760.661966901635;6901;6901.75843845468;4384.101259241912;4410.3825464435;4418.64650827933;4420.889477763018;4429;4478.552144785495;4498.617617502549;4505.301678239813;4508.594226519629;4517.073999830027;5113.667611605234;5245.26566280721;5262.973685131627;5264.341957255343;5267.130923397596;6526.28210896801;6529.934700653028;6532.150820393318;6540.149780528501;6540.215174179034;1567.3652170870816;1584.0970646731253;1584.595928038343;1586.4923224568026;1588.3725928258273;1011.1809434358194;1018.6434747838198;1024.3034736379334;1032.4785983078648;1034.043509753475;6344.080108384258;6377.075324078076;6390.073439351361;6402.231732192166;6406.103145559626;6825.180978282638;6840.726370945106;6856.965715171492;6865.862682746417;6882.8967565486555;6270.247570291503;6370.522210834206;6381.1704478417505;6399.424051835264;6406.903896441557;3688.575813781396;3722.4044152935944;3725.832337544817;3731.533558305212;3738.36447803874;7158.2841715828;7172.713091476387;7185.173705023884;7201.531900426456;7208.4593655475;6755.256921738604;6987.510874238755;6996.705609462266;7007;7030.543014704028;7144;7149.92850071503;7166.8924966124505;7176.318249766368;7180.066591343092;6858.074159988338;6875.89686154698;6877.484188685969;6881.277465866012;6883.27725588826;6461.386168314003;6515.2833188348295;6713.697883595348;6720.563163394364;6740.460763139035;7041.859162816818;7079.221285658677;7118.110236220473;7148.356647901714;7185.245549217466;4393.693311011617;4465.0623369092855;4469.865904022885;4472.932906006347;4473.194824931414;6666.26671066192;6855.725770969106;6865.622390768555;6886.10480637514;6899.068625735462;6683.966580167068;6685.63229022389;6694.096297000037;6695.665216739241;6709.329067093252;6672.799816005528;6678.165229346332;6679.398854102959;6698.22970358415;6711.127553418024;6335.746570137328;6505.967470162619;6544.280129185881;6547.9672601638595;6586.70359833799;6721.1598550181225;6731.528792984444;6739;6763.425108865801;6768.593884366954;6585.176852893388;6602.7689030883685;6604.471642268511;6605.14133162705;6624.8343791405605 08:28:49 INFO - 2015-11-16 08:28:49,202 DEBUG : BROWSER_OUTPUT: |5;yui.html;693.7918624412677;712.92514286;723.1286300008491;750.6171852355297;821.6466919224731;12949.546765863197;12972.935135324335;12984.156029858053;13698.52055178069;13911.373988170531;12028.69928251792;12125.818112728317;12141.757164856697;12147.392630368468;12154.39228038599;677.7119724117255;721.1850608812035;896.5875697179289;904.2494729374636;915.4736026784592;901.3555307954811;908.8636704494313;915.4324318922278;915.9771005724843;916.1205242966727;945.7257395355339;951.8477043673014;952.6665667016558;952.7475219066953;952.9857052144223;687.2268697715045;747.3386053342804;929.7954450020984;944;944.0182210501139;699.098163369253;699.9160100787938;700.7022015643382;700.8002719224996;701.0430762009871;14117.364718587689;14286.357113929898;14319.78520322196;14324.427022919072;14327.140371577738;11796.410179490991;11854;11869.287842729464;12088.395580221042;12356.073294502858;9103.08969103091;9515.857262141073;9586.568604412818;9610.231181505464;10195.133413659847;3026.3190782074075;3061.418330517217;3088.3977624363256;3195.5206718992335;3221.4845624699938;43683.563164368265;43897.34153987693;43908.560914390764;43957.340639890426;44071.33892991608;6739.090222819955;6917.792466226021;6949.30506949301;6976.965115174392;6995.335443132894;12329.753404932031;12335.876641233652;12336.136470446983;12337.383130843422;12350.691232719075;6024.578279520391;6069.447338910479;6080.300765411946;6106.908396374058;6296.811095667137;3624.257027309395;3672.081979505124;3789.6589306961955;3868.284367391985;4017.738846974937;2655.6016597510143;2681.6916054653575;2682.195341397573;2685.7179996100126;2686.140435060762;382.7416493866684;389.25069241709593;391.13363898963934;392.77219212856477;394.2981492942567;475.6266330930203;477.3579535524714;525.0915915466264;611.403881215811;615.4061330815784;8074;8229.79425514367;8360.623771930277;8414.3268538518;8472.406931514735;488.67747286790546;578.4446930946254;611.7461253579803;620.2804746494045;645.4803882874237;3827.9808600956817;3991.4832363701607;4105.322621767375;4205.201011807747;4208.516020657664;53403.46596534063;53458.46541534535;53627.46372536303;53683;53778;45935;47769.76115119472;50144.49855501471;50232.748836256316;50595;44787.32819007652;45283.547164528594;45337.77331113389;45581.31628025582;45891.54108458939;8353.122922093336;8386.287165590993;8457.57712114404;8505.914940850513;8704.303655707656;33305.500417494244;33849.661503385636;34025.149371265914;34061.65938340684;34118.48822267717;43566;43835.561644383146;44262;44296.11407771891;44522.3321650182;7736.961315193388;7746.728864489716;7779.649915753918;7841.921580784119;7871.33093687043;11054.447277635925;11312.6040588579;11699.122565807429;11781;12040.277583345027;10491.68524944253;10492.52783624754;10501;10791.082757965347;11137.55449782032;10475.319104258198;10730.356178629307;10824.512896919816;10918.617848375268;11051.72370690739;10387.428691422045;10457.790844183226;10477.68566942993;10813.837792432962;11276.436178190894;9074.137956894085;9265.629374824932;9283.210927071275;9393.107654772786;9642.758931026781;8591.570421479026;8598.226159645661;8928.776780580278;9350.719478415658;9527.523623818919 08:28:49 INFO - 2015-11-16 08:28:49,202 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:28:49 INFO - 2015-11-16 08:28:49,202 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:28:49 INFO - 2015-11-16 08:28:49,203 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,993 08:28:49 INFO - 2015-11-16 08:28:49,203 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:28:49 INFO - 2015-11-16 08:28:49,203 DEBUG : BROWSER_OUTPUT: __startTimestamp1447691329188__endTimestamp 08:28:49 INFO - 2015-11-16 08:28:49,203 DEBUG : BROWSER_OUTPUT: 08:28:49 INFO - 2015-11-16 08:28:49,203 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:28:49 INFO - 2015-11-16 08:28:49,203 DEBUG : BROWSER_OUTPUT: Number of tests: 6 08:28:49 INFO - 2015-11-16 08:28:49,204 DEBUG : BROWSER_OUTPUT: 08:28:49 INFO - 2015-11-16 08:28:49,204 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5409.98 Median:5547.00 stddev:588.58 (10.6%) stddev-sans-first:563.50 08:28:49 INFO - 2015-11-16 08:28:49,205 DEBUG : BROWSER_OUTPUT: Values: 3168.0 3225.7 3225.9 3246.6 3272.4 5272.7 5333.0 5340.3 5342.9 5396.2 5351.8 5396.3 5422.4 5444.2 5519.1 4957.8 4986.9 4999.2 5043.5 5081.4 5027.7 5044.5 5058.6 5059.6 5072.0 4862.3 4905.0 4948.7 5006.3 5029.2 5067.1 5085.9 5101.0 5111.1 5124.7 5039.2 5041.0 5047.0 5053.1 5055.5 5269.0 5359.4 5369.3 5387.8 5471.9 5790.8 5800.2 5802.1 5806.5 5812.5 5859.5 5874.3 5884.1 5885.7 5894.5 5238.9 5277.7 5375.5 5378.7 5400.0 5912.9 5921.7 5927.9 5932.4 6003.5 5704.4 5734.0 5740.9 5743.9 5750.6 5622.1 5745.9 5750.5 5779.5 5912.2 5713.4 5716.7 5719.8 5729.2 5732.4 5728.3 5735.3 5742.7 5744.0 5745.9 4273.2 4354.9 4382.9 4383.6 4390.3 4075.4 4090.9 4103.6 4123.2 4133.6 5453.1 5494.0 5497.8 5502.0 5554.8 5642.6 5775.5 5779.8 5832.1 5891.4 5509.8 5524.3 5532.3 5541.4 5547.0 5130.9 5134.1 5146.1 5175.5 5196.1 5940.4 6021.1 6068.8 6071.3 6077.2 5895.4 5901.5 5920.6 5929.0 5935.5 6091.9 6102.1 6109.8 6117.4 6123.8 5505.7 5588.7 5627.2 5647.9 5783.4 5872.2 5879.1 5890.4 5910.6 5919.6 5738.5 5758.8 5759.4 5764.9 5778.2 5509.3 5555.1 5596.7 5613.6 5727.9 5513.0 5519.8 5523.1 5544.8 5643.9 5634.8 5637.0 5647.0 5670.8 5708.3 5425.7 5426.7 5542.2 5548.7 5560.9 08:28:49 INFO - 2015-11-16 08:28:49,205 DEBUG : BROWSER_OUTPUT: 08:28:49 INFO - 2015-11-16 08:28:49,205 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:47043.07 Median:31921.42 stddev:77720.56 (243.5%) stddev-sans-first:77860.24 08:28:49 INFO - 2015-11-16 08:28:49,207 DEBUG : BROWSER_OUTPUT: Values: 563.5 580.5 583.5 584.5 609.4 32016.5 32720.5 40328.8 40935.6 40974.8 42549.0 43032.8 43101.4 43140.6 43173.8 8331.4 9159.4 9274.8 9282.4 9285.1 8485.0 11282.2 11494.4 11515.5 11544.9 11220.9 11314.8 11351.8 11383.2 11405.8 8604.8 8716.3 11211.8 11348.4 11375.8 11063.0 11175.6 11198.1 11203.3 11230.7 40894.8 41349.8 41425.8 41449.0 41449.4 2987.8 3040.6 3373.5 3510.7 3528.4 27148.6 27250.5 27817.3 27820.6 28122.0 2438.0 2458.9 2517.1 2621.7 2635.9 284003.0 284489.0 285054.0 285078.0 285975.0 57088.7 57853.4 60529.4 60942.4 67362.3 62565.4 63063.7 63166.7 63196.7 63324.7 15146.6 15313.5 15317.5 15319.0 15323.5 10491.7 10492.3 10495.8 10511.7 10533.6 19981.7 20111.2 20156.6 20176.0 20216.1 8127.6 8298.3 8319.0 8344.0 8392.9 954.7 963.4 1085.6 1118.0 1122.8 26614.0 26627.6 26887.2 26980.0 27026.7 1050.3 1070.4 1172.7 1178.4 1179.3 14375.8 14430.6 14449.7 14476.3 14596.0 334041.0 340857.0 340933.0 341622.0 343246.0 55747.2 56057.7 56125.9 56156.0 56196.2 1371.4 1380.3 1386.2 1387.2 1388.9 27585.0 28079.3 28194.9 29026.7 29765.3 47084.8 47516.5 47524.8 47529.0 47554.5 259041.0 261639.0 261712.0 262471.0 262702.0 31950.2 33128.5 33242.3 33290.2 33332.5 42888.4 43214.8 43269.4 43567.8 44583.8 36516.5 36669.4 37321.4 37410.8 37439.3 36279.6 36363.3 38868.0 39248.3 39979.6 34808.7 35531.3 35704.3 35738.8 35762.8 30435.7 31861.7 31887.0 31906.8 31936.0 24199.4 24669.6 24848.6 25078.2 25182.7 08:28:49 INFO - 2015-11-16 08:28:49,207 DEBUG : BROWSER_OUTPUT: 08:28:49 INFO - 2015-11-16 08:28:49,207 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24477.30 Median:207801.74 stddev:69659.28 (33.5%) stddev-sans-first:69831.08 08:28:49 INFO - 2015-11-16 08:28:49,208 DEBUG : BROWSER_OUTPUT: Values: 324.3 336.8 337.6 342.2 348.2 14031.2 14388.6 17555.4 17872.5 18456.5 17894.8 18535.3 18593.4 18919.2 18923.4 3989.8 4121.9 5414.7 5582.0 5600.7 5881.0 6042.4 6084.5 6096.9 6115.0 5898.9 6031.1 6031.9 6063.1 6073.7 3911.3 4026.5 5753.3 5935.1 5991.0 5209.4 5213.3 5213.6 5215.6 5222.5 21739.8 22098.6 22215.3 22218.0 22432.8 1983.9 2023.8 2157.8 2190.2 2271.6 13388.5 13431.5 13591.9 13946.5 13996.2 1695.4 1728.8 1735.8 1751.4 1756.8 58756.7 59668.7 60269.4 60504.0 60735.7 9427.6 9614.4 9783.3 9795.8 9880.3 12111.0 12112.3 12119.9 12120.2 12124.2 7468.2 7517.8 7530.1 7579.4 7579.8 7288.5 7315.6 7324.1 7332.7 7375.5 5850.9 5910.9 5917.8 5924.1 5976.2 1665.4 1686.6 1688.8 1693.1 1694.6 917.3 950.0 957.0 983.0 1059.6 14583.9 17598.5 17852.8 18102.5 18275.6 933.6 966.2 966.7 1049.2 1061.2 10411.9 10598.1 10622.5 10627.9 10665.5 388082.0 389896.0 411577.0 426948.0 500723.0 64015.4 65808.1 69496.5 70126.0 70785.6 488.9 492.4 499.3 508.2 509.6 10758.8 10863.8 10909.5 10910.2 10956.2 32170.7 32295.5 32343.2 32598.3 32810.7 43395.8 43751.3 44528.1 44718.0 46153.0 6068.9 6246.6 6251.3 6258.7 6268.4 11146.4 11690.1 11738.2 11744.0 11836.3 9872.9 9894.1 10083.5 10186.0 10201.7 9802.0 9890.4 9955.6 10268.7 10334.3 10210.8 10478.4 10754.0 10759.4 10813.9 5918.8 6204.6 6216.3 6232.0 6313.3 9935.9 9978.4 10180.3 10300.1 10301.9 08:28:49 INFO - 2015-11-16 08:28:49,208 DEBUG : BROWSER_OUTPUT: 08:28:49 INFO - 2015-11-16 08:28:49,208 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5563.51 Median:6596.96 stddev:2917.89 (44.2%) stddev-sans-first:2908.70 08:28:49 INFO - 2015-11-16 08:28:49,210 DEBUG : BROWSER_OUTPUT: Values: 1327.1 1384.9 1447.5 1634.8 1884.2 7340.9 7765.4 7829.3 7837.9 7839.5 7886.0 8115.1 8119.9 8136.9 8137.6 2320.8 2334.9 2338.5 2343.3 2348.7 2344.4 2353.4 2398.2 2402.9 2404.1 2253.6 2258.9 2259.4 2305.1 2308.2 2304.6 2317.0 2323.4 2329.9 2341.4 2329.6 2333.9 2334.8 2340.9 2343.5 7275.6 7476.7 8062.4 8126.8 8139.0 4965.5 5127.8 5149.3 5159.8 5161.6 2809.1 2905.0 2917.7 2967.0 2967.8 906.3 916.6 918.9 930.5 955.3 10735.9 10800.2 10800.5 10811.6 10825.1 4277.5 4362.0 4368.7 4442.6 4591.9 8763.7 8772.5 8780.4 8797.7 8802.0 5097.4 5122.6 5132.7 5146.2 5149.2 4730.8 4740.7 4744.5 4744.5 4745.0 3446.4 3523.9 3544.5 3547.1 3557.3 1028.0 1058.2 1059.5 1060.8 1069.4 1057.0 1058.7 1079.1 1079.7 1112.0 7608.1 7656.3 7717.5 7725.9 7753.3 492.7 498.2 502.5 503.1 503.5 5538.7 5636.2 5699.5 5734.8 5744.8 9305.7 9425.7 9520.4 9525.3 9545.5 9248.5 9343.8 9456.7 9466.8 9519.8 7646.1 7726.5 7731.6 7731.7 7752.4 7536.8 7575.4 7626.7 7647.8 7651.5 8475.9 8606.7 8608.2 8686.3 8700.6 8744.1 8836.8 8928.7 9022.2 9036.8 6317.6 6372.7 6377.7 6384.4 6386.4 7658.8 7775.4 7792.3 7793.6 7795.8 7290.1 7369.7 7392.0 7404.1 7413.7 7148.9 7169.0 7175.1 7214.6 7280.1 7283.7 7328.6 7366.9 7373.0 7375.1 6582.2 6636.0 6641.9 6644.9 6658.3 6611.7 6740.2 6781.2 6787.0 6796.5 08:28:49 INFO - 2015-11-16 08:28:49,210 DEBUG : BROWSER_OUTPUT: 08:28:49 INFO - 2015-11-16 08:28:49,210 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5505.94 Median:6346.90 stddev:1709.76 (26.9%) stddev-sans-first:1669.59 08:28:49 INFO - 2015-11-16 08:28:49,211 DEBUG : BROWSER_OUTPUT: Values: 315.9 326.5 328.7 332.9 334.5 6145.8 6269.6 6309.5 6349.7 6360.1 6082.9 6219.9 6261.2 6294.5 6297.2 4795.6 4796.8 4805.6 4815.1 4820.0 4637.8 4719.4 4722.1 4808.1 4814.7 4728.7 4734.4 4748.1 4751.2 4766.4 4738.4 4757.7 4762.1 4765.3 4773.0 4092.5 4101.1 4107.5 4108.3 4111.6 5895.9 6057.2 6077.1 6115.1 6131.8 5372.2 5376.8 5385.7 5390.4 5391.9 6545.3 6564.2 6565.4 6565.5 6570.6 4193.4 4340.4 4458.5 4461.0 4469.6 6551.4 6722.5 6760.7 6901.0 6901.8 4384.1 4410.4 4418.6 4420.9 4429.0 4478.6 4498.6 4505.3 4508.6 4517.1 5113.7 5245.3 5263.0 5264.3 5267.1 6526.3 6529.9 6532.2 6540.1 6540.2 1567.4 1584.1 1584.6 1586.5 1588.4 1011.2 1018.6 1024.3 1032.5 1034.0 6344.1 6377.1 6390.1 6402.2 6406.1 6825.2 6840.7 6857.0 6865.9 6882.9 6270.2 6370.5 6381.2 6399.4 6406.9 3688.6 3722.4 3725.8 3731.5 3738.4 7158.3 7172.7 7185.2 7201.5 7208.5 6755.3 6987.5 6996.7 7007.0 7030.5 7144.0 7149.9 7166.9 7176.3 7180.1 6858.1 6875.9 6877.5 6881.3 6883.3 6461.4 6515.3 6713.7 6720.6 6740.5 7041.9 7079.2 7118.1 7148.4 7185.2 4393.7 4465.1 4469.9 4472.9 4473.2 6666.3 6855.7 6865.6 6886.1 6899.1 6684.0 6685.6 6694.1 6695.7 6709.3 6672.8 6678.2 6679.4 6698.2 6711.1 6335.7 6506.0 6544.3 6548.0 6586.7 6721.2 6731.5 6739.0 6763.4 6768.6 6585.2 6602.8 6604.5 6605.1 6624.8 08:28:49 INFO - 2015-11-16 08:28:49,211 DEBUG : BROWSER_OUTPUT: 08:28:49 INFO - 2015-11-16 08:28:49,211 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12868.14 Median:45913.27 stddev:15218.17 (33.1%) stddev-sans-first:15233.40 08:28:49 INFO - 2015-11-16 08:28:49,213 DEBUG : BROWSER_OUTPUT: Values: 693.8 712.9 723.1 750.6 821.6 12949.5 12972.9 12984.2 13698.5 13911.4 12028.7 12125.8 12141.8 12147.4 12154.4 677.7 721.2 896.6 904.2 915.5 901.4 908.9 915.4 916.0 916.1 945.7 951.8 952.7 952.7 953.0 687.2 747.3 929.8 944.0 944.0 699.1 699.9 700.7 700.8 701.0 14117.4 14286.4 14319.8 14324.4 14327.1 11796.4 11854.0 11869.3 12088.4 12356.1 9103.1 9515.9 9586.6 9610.2 10195.1 3026.3 3061.4 3088.4 3195.5 3221.5 43683.6 43897.3 43908.6 43957.3 44071.3 6739.1 6917.8 6949.3 6977.0 6995.3 12329.8 12335.9 12336.1 12337.4 12350.7 6024.6 6069.4 6080.3 6106.9 6296.8 3624.3 3672.1 3789.7 3868.3 4017.7 2655.6 2681.7 2682.2 2685.7 2686.1 382.7 389.3 391.1 392.8 394.3 475.6 477.4 525.1 611.4 615.4 8074.0 8229.8 8360.6 8414.3 8472.4 488.7 578.4 611.7 620.3 645.5 3828.0 3991.5 4105.3 4205.2 4208.5 53403.5 53458.5 53627.5 53683.0 53778.0 45935.0 47769.8 50144.5 50232.7 50595.0 44787.3 45283.5 45337.8 45581.3 45891.5 8353.1 8386.3 8457.6 8505.9 8704.3 33305.5 33849.7 34025.1 34061.7 34118.5 43566.0 43835.6 44262.0 44296.1 44522.3 7737.0 7746.7 7779.6 7841.9 7871.3 11054.4 11312.6 11699.1 11781.0 12040.3 10491.7 10492.5 10501.0 10791.1 11137.6 10475.3 10730.4 10824.5 10918.6 11051.7 10387.4 10457.8 10477.7 10813.8 11276.4 9074.1 9265.6 9283.2 9393.1 9642.8 8591.6 8598.2 8928.8 9350.7 9527.5 08:28:49 INFO - 2015-11-16 08:28:49,213 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:28:49 INFO - 2015-11-16 08:28:49,213 DEBUG : BROWSER_OUTPUT: 08:28:49 INFO - 2015-11-16 08:28:49,904 INFO : Browser exited with error code: 0 08:28:49 INFO - 2015-11-16 08:28:49,931 INFO : Completed test dromaeo_css (00:18:33) 08:28:49 INFO - 2015-11-16 08:28:49,931 INFO : Starting test kraken 08:28:49 INFO - 2015-11-16 08:28:49,931 DEBUG : operating with platform_type : mac_ 08:28:49 INFO - 2015-11-16 08:28:49,932 INFO : Initialising browser for kraken test... 08:28:49 INFO - 2015-11-16 08:28:49,946 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/T/tmpBcIDbv/profile http://localhost:57124/getInfo.html 08:28:52 INFO - 2015-11-16 08:28:52,144 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:28:52 INFO - 2015-11-16 08:28:52,144 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:28:52 INFO - 2015-11-16 08:28:52,144 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 08:28:52 INFO - 2015-11-16 08:28:52,144 DEBUG : BROWSER_OUTPUT: __metrics 08:28:52 INFO - 2015-11-16 08:28:52,160 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:28:52 INFO - 2015-11-16 08:28:52,821 INFO : Browser initialized. 08:28:52 INFO - 2015-11-16 08:28:52,822 INFO : Running cycle 1/1 for kraken test... 08:28:52 INFO - 2015-11-16 08:28:52,822 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/T/tmpBcIDbv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:29:04 INFO - 2015-11-16 08:29:04,678 DEBUG : BROWSER_OUTPUT: RSS: Main: 230260736 08:29:04 INFO - 2015-11-16 08:29:04,678 DEBUG : BROWSER_OUTPUT: 08:29:07 INFO - 2015-11-16 08:29:07,187 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57124/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57124/tests/kraken/driver.html?testName=audio-beat-detection) 08:29:07 INFO - 2015-11-16 08:29:07,781 DEBUG : BROWSER_OUTPUT: RSS: Main: 286420992 08:29:07 INFO - 2015-11-16 08:29:07,781 DEBUG : BROWSER_OUTPUT: 08:29:10 INFO - 2015-11-16 08:29:10,419 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57124/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57124/tests/kraken/driver.html?testName=audio-dft) 08:29:11 INFO - 2015-11-16 08:29:11,000 DEBUG : BROWSER_OUTPUT: RSS: Main: 296259584 08:29:11 INFO - 2015-11-16 08:29:11,000 DEBUG : BROWSER_OUTPUT: 08:29:13 INFO - 2015-11-16 08:29:13,980 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57124/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57124/tests/kraken/driver.html?testName=audio-fft) 08:29:14 INFO - 2015-11-16 08:29:14,556 DEBUG : BROWSER_OUTPUT: RSS: Main: 278450176 08:29:14 INFO - 2015-11-16 08:29:14,556 DEBUG : BROWSER_OUTPUT: 08:29:16 INFO - 2015-11-16 08:29:16,560 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57124/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57124/tests/kraken/driver.html?testName=audio-oscillator) 08:29:17 INFO - 2015-11-16 08:29:17,137 DEBUG : BROWSER_OUTPUT: RSS: Main: 280092672 08:29:17 INFO - 2015-11-16 08:29:17,137 DEBUG : BROWSER_OUTPUT: 08:29:19 INFO - 2015-11-16 08:29:19,315 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57124/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57124/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:29:19 INFO - 2015-11-16 08:29:19,900 DEBUG : BROWSER_OUTPUT: RSS: Main: 281673728 08:29:19 INFO - 2015-11-16 08:29:19,900 DEBUG : BROWSER_OUTPUT: 08:29:22 INFO - 2015-11-16 08:29:22,924 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57124/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57124/tests/kraken/driver.html?testName=imaging-darkroom) 08:29:23 INFO - 2015-11-16 08:29:23,510 DEBUG : BROWSER_OUTPUT: RSS: Main: 280780800 08:29:23 INFO - 2015-11-16 08:29:23,511 DEBUG : BROWSER_OUTPUT: 08:29:26 INFO - 2015-11-16 08:29:26,636 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57124/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57124/tests/kraken/driver.html?testName=imaging-desaturate) 08:29:27 INFO - 2015-11-16 08:29:27,219 DEBUG : BROWSER_OUTPUT: RSS: Main: 281260032 08:29:27 INFO - 2015-11-16 08:29:27,219 DEBUG : BROWSER_OUTPUT: 08:29:30 INFO - 2015-11-16 08:29:30,035 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57124/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57124/tests/kraken/driver.html?testName=json-parse-financial) 08:29:30 INFO - 2015-11-16 08:29:30,623 DEBUG : BROWSER_OUTPUT: RSS: Main: 282353664 08:29:30 INFO - 2015-11-16 08:29:30,623 DEBUG : BROWSER_OUTPUT: 08:29:32 INFO - 2015-11-16 08:29:32,188 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57124/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57124/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:29:32 INFO - 2015-11-16 08:29:32,760 DEBUG : BROWSER_OUTPUT: RSS: Main: 318767104 08:29:32 INFO - 2015-11-16 08:29:32,760 DEBUG : BROWSER_OUTPUT: 08:29:34 INFO - 2015-11-16 08:29:34,606 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57124/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57124/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:29:35 INFO - 2015-11-16 08:29:35,225 DEBUG : BROWSER_OUTPUT: RSS: Main: 320036864 08:29:35 INFO - 2015-11-16 08:29:35,225 DEBUG : BROWSER_OUTPUT: 08:29:37 INFO - 2015-11-16 08:29:37,307 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57124/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57124/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:29:37 INFO - 2015-11-16 08:29:37,889 DEBUG : BROWSER_OUTPUT: RSS: Main: 326688768 08:29:37 INFO - 2015-11-16 08:29:37,889 DEBUG : BROWSER_OUTPUT: 08:29:40 INFO - 2015-11-16 08:29:40,462 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57124/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57124/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:29:41 INFO - 2015-11-16 08:29:41,051 DEBUG : BROWSER_OUTPUT: RSS: Main: 326832128 08:29:41 INFO - 2015-11-16 08:29:41,051 DEBUG : BROWSER_OUTPUT: 08:29:43 INFO - 2015-11-16 08:29:43,691 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57124/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57124/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:29:44 INFO - 2015-11-16 08:29:44,273 DEBUG : BROWSER_OUTPUT: RSS: Main: 327467008 08:29:44 INFO - 2015-11-16 08:29:44,273 DEBUG : BROWSER_OUTPUT: 08:29:46 INFO - 2015-11-16 08:29:46,005 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57124/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57124/tests/kraken/driver.html?testName=ai-astar) 08:29:46 INFO - 2015-11-16 08:29:46,263 DEBUG : BROWSER_OUTPUT: RSS: Main: 385822720 08:29:46 INFO - 2015-11-16 08:29:46,263 DEBUG : BROWSER_OUTPUT: 08:29:46 INFO - 2015-11-16 08:29:46,263 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:29:46 INFO - 2015-11-16 08:29:46,263 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:29:46 INFO - 2015-11-16 08:29:46,263 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:29:46 INFO - 2015-11-16 08:29:46,263 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:29:46 INFO - 2015-11-16 08:29:46,263 DEBUG : BROWSER_OUTPUT: |0;ai-astar;105;106;101;106;106;106;95;106;107;104 08:29:46 INFO - 2015-11-16 08:29:46,263 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;157;128;153;162;125;149;149;126;164;127 08:29:46 INFO - 2015-11-16 08:29:46,263 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;161;163;162;163;162;163;163;161 08:29:46 INFO - 2015-11-16 08:29:46,263 DEBUG : BROWSER_OUTPUT: |3;audio-fft;80;79;84;86;67;69;70;81;83;66 08:29:46 INFO - 2015-11-16 08:29:46,263 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;99;101;135;88;89;92;123;89;88;126 08:29:46 INFO - 2015-11-16 08:29:46,264 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;120;119;114;120;120;114;114;114;114;120 08:29:46 INFO - 2015-11-16 08:29:46,264 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;125;125;125;125;125;125;125;125;125;125 08:29:46 INFO - 2015-11-16 08:29:46,264 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;94;93;101;93;93;94;101;100;92;100 08:29:46 INFO - 2015-11-16 08:29:46,264 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;59;59;59;59;58;59;67;57;58 08:29:46 INFO - 2015-11-16 08:29:46,264 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;69;69;71;70;70;70;70;71 08:29:46 INFO - 2015-11-16 08:29:46,264 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;87;86;84;85;86;85;86;86;87;84 08:29:46 INFO - 2015-11-16 08:29:46,264 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;122;124;131;123;128;134;132;131;126;130 08:29:46 INFO - 2015-11-16 08:29:46,264 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;155;152;154;153;155;142;155;153;150;151 08:29:46 INFO - 2015-11-16 08:29:46,264 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;70;69;71;70;70;71;70;70;70 08:29:46 INFO - 2015-11-16 08:29:46,264 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:29:46 INFO - 2015-11-16 08:29:46,264 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:29:46 INFO - 2015-11-16 08:29:46,264 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,926 08:29:46 INFO - 2015-11-16 08:29:46,264 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:29:46 INFO - 2015-11-16 08:29:46,264 DEBUG : BROWSER_OUTPUT: __startTimestamp1447691386257__endTimestamp 08:29:46 INFO - 2015-11-16 08:29:46,265 DEBUG : BROWSER_OUTPUT: 08:29:46 INFO - 2015-11-16 08:29:46,265 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:29:46 INFO - 2015-11-16 08:29:46,265 DEBUG : BROWSER_OUTPUT: Number of tests: 14 08:29:46 INFO - 2015-11-16 08:29:46,265 DEBUG : BROWSER_OUTPUT: 08:29:46 INFO - 2015-11-16 08:29:46,265 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:104.20 Median:106.00 stddev:3.65 (3.4%) stddev-sans-first:3.86 08:29:46 INFO - 2015-11-16 08:29:46,265 DEBUG : BROWSER_OUTPUT: Values: 105.0 106.0 101.0 106.0 106.0 106.0 95.0 106.0 107.0 104.0 08:29:46 INFO - 2015-11-16 08:29:46,265 DEBUG : BROWSER_OUTPUT: 08:29:46 INFO - 2015-11-16 08:29:46,265 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.00 Median:151.00 stddev:15.83 (10.5%) stddev-sans-first:16.07 08:29:46 INFO - 2015-11-16 08:29:46,265 DEBUG : BROWSER_OUTPUT: Values: 157.0 128.0 153.0 162.0 125.0 149.0 149.0 126.0 164.0 127.0 08:29:46 INFO - 2015-11-16 08:29:46,265 DEBUG : BROWSER_OUTPUT: 08:29:46 INFO - 2015-11-16 08:29:46,265 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.00 Median:162.50 stddev:0.94 (0.6%) stddev-sans-first:0.93 08:29:46 INFO - 2015-11-16 08:29:46,265 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 161.0 163.0 162.0 163.0 162.0 163.0 163.0 161.0 08:29:46 INFO - 2015-11-16 08:29:46,265 DEBUG : BROWSER_OUTPUT: 08:29:46 INFO - 2015-11-16 08:29:46,265 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:76.50 Median:80.50 stddev:7.65 (9.5%) stddev-sans-first:8.01 08:29:46 INFO - 2015-11-16 08:29:46,266 DEBUG : BROWSER_OUTPUT: Values: 80.0 79.0 84.0 86.0 67.0 69.0 70.0 81.0 83.0 66.0 08:29:46 INFO - 2015-11-16 08:29:46,266 DEBUG : BROWSER_OUTPUT: 08:29:46 INFO - 2015-11-16 08:29:46,266 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.00 Median:88.50 stddev:18.06 (20.4%) stddev-sans-first:19.10 08:29:46 INFO - 2015-11-16 08:29:46,266 DEBUG : BROWSER_OUTPUT: Values: 99.0 101.0 135.0 88.0 89.0 92.0 123.0 89.0 88.0 126.0 08:29:46 INFO - 2015-11-16 08:29:46,266 DEBUG : BROWSER_OUTPUT: 08:29:46 INFO - 2015-11-16 08:29:46,266 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:119.50 stddev:3.07 (2.6%) stddev-sans-first:3.05 08:29:46 INFO - 2015-11-16 08:29:46,266 DEBUG : BROWSER_OUTPUT: Values: 120.0 119.0 114.0 120.0 120.0 114.0 114.0 114.0 114.0 120.0 08:29:46 INFO - 2015-11-16 08:29:46,266 DEBUG : BROWSER_OUTPUT: 08:29:46 INFO - 2015-11-16 08:29:46,266 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:125.00 Median:125.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 08:29:46 INFO - 2015-11-16 08:29:46,266 DEBUG : BROWSER_OUTPUT: Values: 125.0 125.0 125.0 125.0 125.0 125.0 125.0 125.0 125.0 125.0 08:29:46 INFO - 2015-11-16 08:29:46,266 DEBUG : BROWSER_OUTPUT: 08:29:46 INFO - 2015-11-16 08:29:46,266 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.10 Median:93.00 stddev:3.84 (4.1%) stddev-sans-first:4.00 08:29:46 INFO - 2015-11-16 08:29:46,266 DEBUG : BROWSER_OUTPUT: Values: 94.0 93.0 101.0 93.0 93.0 94.0 101.0 100.0 92.0 100.0 08:29:46 INFO - 2015-11-16 08:29:46,266 DEBUG : BROWSER_OUTPUT: 08:29:46 INFO - 2015-11-16 08:29:46,266 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.40 Median:59.00 stddev:2.76 (4.7%) stddev-sans-first:2.92 08:29:46 INFO - 2015-11-16 08:29:46,267 DEBUG : BROWSER_OUTPUT: Values: 59.0 59.0 59.0 59.0 59.0 58.0 59.0 67.0 57.0 58.0 08:29:46 INFO - 2015-11-16 08:29:46,267 DEBUG : BROWSER_OUTPUT: 08:29:46 INFO - 2015-11-16 08:29:46,267 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:70.00 stddev:1.07 (1.5%) stddev-sans-first:0.97 08:29:46 INFO - 2015-11-16 08:29:46,267 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 69.0 69.0 71.0 70.0 70.0 70.0 70.0 71.0 08:29:46 INFO - 2015-11-16 08:29:46,267 DEBUG : BROWSER_OUTPUT: 08:29:46 INFO - 2015-11-16 08:29:46,267 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:86.00 stddev:1.07 (1.2%) stddev-sans-first:1.01 08:29:46 INFO - 2015-11-16 08:29:46,267 DEBUG : BROWSER_OUTPUT: Values: 87.0 86.0 84.0 85.0 86.0 85.0 86.0 86.0 87.0 84.0 08:29:46 INFO - 2015-11-16 08:29:46,267 DEBUG : BROWSER_OUTPUT: 08:29:46 INFO - 2015-11-16 08:29:46,267 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:128.10 Median:130.50 stddev:4.15 (3.2%) stddev-sans-first:3.77 08:29:46 INFO - 2015-11-16 08:29:46,267 DEBUG : BROWSER_OUTPUT: Values: 122.0 124.0 131.0 123.0 128.0 134.0 132.0 131.0 126.0 130.0 08:29:46 INFO - 2015-11-16 08:29:46,267 DEBUG : BROWSER_OUTPUT: 08:29:46 INFO - 2015-11-16 08:29:46,267 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.00 Median:153.50 stddev:3.92 (2.6%) stddev-sans-first:4.00 08:29:46 INFO - 2015-11-16 08:29:46,267 DEBUG : BROWSER_OUTPUT: Values: 155.0 152.0 154.0 153.0 155.0 142.0 155.0 153.0 150.0 151.0 08:29:46 INFO - 2015-11-16 08:29:46,267 DEBUG : BROWSER_OUTPUT: 08:29:46 INFO - 2015-11-16 08:29:46,267 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:70.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 08:29:46 INFO - 2015-11-16 08:29:46,268 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 69.0 71.0 70.0 70.0 71.0 70.0 70.0 70.0 08:29:46 INFO - 2015-11-16 08:29:46,268 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:29:46 INFO - 2015-11-16 08:29:46,268 DEBUG : BROWSER_OUTPUT: 08:29:46 INFO - 2015-11-16 08:29:46,938 INFO : Browser exited with error code: 0 08:29:46 INFO - 2015-11-16 08:29:46,986 INFO : Completed test kraken (00:00:57) 08:29:46 INFO - 2015-11-16 08:29:46,986 INFO : Starting test v8_7 08:29:46 INFO - 2015-11-16 08:29:46,986 DEBUG : operating with platform_type : mac_ 08:29:46 INFO - 2015-11-16 08:29:46,986 INFO : Initialising browser for v8_7 test... 08:29:47 INFO - 2015-11-16 08:29:47,001 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/T/tmplhajnX/profile http://localhost:57124/getInfo.html 08:29:49 INFO - 2015-11-16 08:29:49,142 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:29:49 INFO - 2015-11-16 08:29:49,142 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:29:49 INFO - 2015-11-16 08:29:49,142 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 08:29:49 INFO - 2015-11-16 08:29:49,143 DEBUG : BROWSER_OUTPUT: __metrics 08:29:49 INFO - 2015-11-16 08:29:49,161 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:29:49 INFO - 2015-11-16 08:29:49,841 INFO : Browser initialized. 08:29:49 INFO - 2015-11-16 08:29:49,842 INFO : Running cycle 1/1 for v8_7 test... 08:29:49 INFO - 2015-11-16 08:29:49,842 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/T/tmplhajnX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:30:01 INFO - 2015-11-16 08:30:01,711 DEBUG : BROWSER_OUTPUT: RSS: Main: 228184064 08:30:01 INFO - 2015-11-16 08:30:01,711 DEBUG : BROWSER_OUTPUT: 08:30:23 INFO - 2015-11-16 08:30:23,182 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57124/tests/v8_7/run.html (next: http://localhost:57124/tests/v8_7/run.html) 08:30:23 INFO - 2015-11-16 08:30:23,431 DEBUG : BROWSER_OUTPUT: RSS: Main: 701177856 08:30:23 INFO - 2015-11-16 08:30:23,431 DEBUG : BROWSER_OUTPUT: 08:30:23 INFO - 2015-11-16 08:30:23,431 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:30:23 INFO - 2015-11-16 08:30:23,431 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:30:23 INFO - 2015-11-16 08:30:23,431 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:30:23 INFO - 2015-11-16 08:30:23,432 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:30:23 INFO - 2015-11-16 08:30:23,432 DEBUG : BROWSER_OUTPUT: |0;Richards;167.61649346295675 08:30:23 INFO - 2015-11-16 08:30:23,432 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.20458891013385 08:30:23 INFO - 2015-11-16 08:30:23,432 DEBUG : BROWSER_OUTPUT: |2;Encrypt;327.8688524590164 08:30:23 INFO - 2015-11-16 08:30:23,432 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5770.114942528736 08:30:23 INFO - 2015-11-16 08:30:23,432 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1890.359168241966 08:30:23 INFO - 2015-11-16 08:30:23,433 DEBUG : BROWSER_OUTPUT: |5;Earley;970.8737864077669 08:30:23 INFO - 2015-11-16 08:30:23,433 DEBUG : BROWSER_OUTPUT: |6;Boyer;12935.897435897436 08:30:23 INFO - 2015-11-16 08:30:23,433 DEBUG : BROWSER_OUTPUT: |7;RegExp;30235.29411764706 08:30:23 INFO - 2015-11-16 08:30:23,433 DEBUG : BROWSER_OUTPUT: |8;Splay;630 08:30:23 INFO - 2015-11-16 08:30:23,433 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;5797.687861271676 08:30:23 INFO - 2015-11-16 08:30:23,433 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:30:23 INFO - 2015-11-16 08:30:23,433 DEBUG : BROWSER_OUTPUT: __startTimestamp1447691423429__endTimestamp 08:30:23 INFO - 2015-11-16 08:30:23,434 DEBUG : BROWSER_OUTPUT: 08:30:23 INFO - 2015-11-16 08:30:23,434 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:30:23 INFO - 2015-11-16 08:30:23,434 DEBUG : BROWSER_OUTPUT: Number of tests: 10 08:30:23 INFO - 2015-11-16 08:30:23,434 DEBUG : BROWSER_OUTPUT: 08:30:23 INFO - 2015-11-16 08:30:23,434 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.62 Median:167.62 stddev:0.00 (0.0%) 08:30:23 INFO - 2015-11-16 08:30:23,435 DEBUG : BROWSER_OUTPUT: Values: 167.6 08:30:23 INFO - 2015-11-16 08:30:23,435 DEBUG : BROWSER_OUTPUT: 08:30:23 INFO - 2015-11-16 08:30:23,435 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.20 Median:191.20 stddev:0.00 (0.0%) 08:30:23 INFO - 2015-11-16 08:30:23,435 DEBUG : BROWSER_OUTPUT: Values: 191.2 08:30:23 INFO - 2015-11-16 08:30:23,435 DEBUG : BROWSER_OUTPUT: 08:30:23 INFO - 2015-11-16 08:30:23,436 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:327.87 Median:327.87 stddev:0.00 (0.0%) 08:30:23 INFO - 2015-11-16 08:30:23,436 DEBUG : BROWSER_OUTPUT: Values: 327.9 08:30:23 INFO - 2015-11-16 08:30:23,436 DEBUG : BROWSER_OUTPUT: 08:30:23 INFO - 2015-11-16 08:30:23,436 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5770.11 Median:5770.11 stddev:0.00 (0.0%) 08:30:23 INFO - 2015-11-16 08:30:23,436 DEBUG : BROWSER_OUTPUT: Values: 5770.1 08:30:23 INFO - 2015-11-16 08:30:23,437 DEBUG : BROWSER_OUTPUT: 08:30:23 INFO - 2015-11-16 08:30:23,437 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1890.36 Median:1890.36 stddev:0.00 (0.0%) 08:30:23 INFO - 2015-11-16 08:30:23,437 DEBUG : BROWSER_OUTPUT: Values: 1890.4 08:30:23 INFO - 2015-11-16 08:30:23,437 DEBUG : BROWSER_OUTPUT: 08:30:23 INFO - 2015-11-16 08:30:23,437 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:970.87 Median:970.87 stddev:0.00 (0.0%) 08:30:23 INFO - 2015-11-16 08:30:23,437 DEBUG : BROWSER_OUTPUT: Values: 970.9 08:30:23 INFO - 2015-11-16 08:30:23,437 DEBUG : BROWSER_OUTPUT: 08:30:23 INFO - 2015-11-16 08:30:23,438 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12935.90 Median:12935.90 stddev:0.00 (0.0%) 08:30:23 INFO - 2015-11-16 08:30:23,439 DEBUG : BROWSER_OUTPUT: Values: 12935.9 08:30:23 INFO - 2015-11-16 08:30:23,439 DEBUG : BROWSER_OUTPUT: 08:30:23 INFO - 2015-11-16 08:30:23,439 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:30235.29 Median:30235.29 stddev:0.00 (0.0%) 08:30:23 INFO - 2015-11-16 08:30:23,439 DEBUG : BROWSER_OUTPUT: Values: 30235.3 08:30:23 INFO - 2015-11-16 08:30:23,439 DEBUG : BROWSER_OUTPUT: 08:30:23 INFO - 2015-11-16 08:30:23,439 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:630.00 Median:630.00 stddev:0.00 (0.0%) 08:30:23 INFO - 2015-11-16 08:30:23,439 DEBUG : BROWSER_OUTPUT: Values: 630.0 08:30:23 INFO - 2015-11-16 08:30:23,440 DEBUG : BROWSER_OUTPUT: 08:30:23 INFO - 2015-11-16 08:30:23,440 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:5797.69 Median:5797.69 stddev:0.00 (0.0%) 08:30:23 INFO - 2015-11-16 08:30:23,440 DEBUG : BROWSER_OUTPUT: Values: 5797.7 08:30:23 INFO - 2015-11-16 08:30:23,440 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:30:23 INFO - 2015-11-16 08:30:23,440 DEBUG : BROWSER_OUTPUT: 08:30:24 INFO - 2015-11-16 08:30:24,073 INFO : Browser exited with error code: 0 08:30:24 INFO - 2015-11-16 08:30:24,093 INFO : Completed test v8_7 (00:00:37) 08:30:24 INFO - 2015-11-16 08:30:24,525 INFO : Completed test suite (00:20:08) 08:30:24 INFO - 2015-11-16 08:30:24,525 DEBUG : Working with test: dromaeo_css 08:30:24 INFO - 2015-11-16 08:30:24,526 DEBUG : Generating results file: dromaeo_css 08:30:24 INFO - 2015-11-16 08:30:24,527 DEBUG : Working with test: kraken 08:30:24 INFO - 2015-11-16 08:30:24,527 DEBUG : Generating results file: kraken 08:30:24 INFO - 2015-11-16 08:30:24,527 INFO : javascript benchmark 08:30:24 INFO - 2015-11-16 08:30:24,527 DEBUG : Working with test: v8_7 08:30:24 INFO - 2015-11-16 08:30:24,527 DEBUG : Generating results file: v8_7 08:30:24 INFO - 2015-11-16 08:30:24,527 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:30:24 INFO - 2015-11-16 08:30:24,679 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,55]] 08:30:24 INFO - 2015-11-16 08:30:24,679 DEBUG : process_Request line: dromaeo_css 6862.25 graph.html#tests=[[72,64,55]] 08:30:24 INFO - 2015-11-16 08:30:24,679 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:30:24 INFO - 2015-11-16 08:30:24,856 DEBUG : process_Request line: kraken 1492.50 graph.html#tests=[[232,64,55]] 08:30:24 INFO - 2015-11-16 08:30:24,856 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:30:24 INFO - 2015-11-16 08:30:24,895 DEBUG : process_Request line: v8_7 18174.52 graph.html#tests=[[230,64,55]] 08:30:24 INFO - 2015-11-16 08:30:24,896 INFO : javascript benchmark 08:30:24 INFO - 2015-11-16 08:30:24,898 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [324.2881874285943, 336.8147518864624, 337.56198593989603, 342.18730515026806, 348.17656242985345, 14031.158130512164, 14388.568342949715, 17555.385561505333, 17872.463826085237, 18456.538586535342, 17894.821051789477, 18535.258589656398, 18593.442196734086, 18919.243230270808, 18923.432297031075, 3989.820458079379, 4121.9381709274385, 5414.702191379472, 5581.995240856644, 5600.719964001804, 5881.0, 6042.425969532887, 6084.452399284063, 6096.878062438748, 6115.0, 5898.852528686774, 6031.065184896348, 6031.879362412749, 6063.0905364195505, 6073.665948372838, 3911.3155197840406, 4026.4765580474646, 5753.338366087912, 5935.109733540004, 5991.0, 5209.374875015023, 5213.2701421800975, 5213.6089793265655, 5215.556677682363, 5222.451642577551, 21739.782602173935, 22098.558028839492, 22215.333539993826, 22218.0, 22432.775672243395, 1983.8809671419617, 2023.8077382648771, 2157.8381621378458, 2190.211523851412, 2271.557046375941, 13388.531401401002, 13431.462741490328, 13591.866534883582, 13946.51187208453, 13996.16023038621, 1695.423555990969, 1728.8398757862992, 1735.7830271216098, 1751.3782607174396, 1756.7540544323676, 58756.70621646864, 59668.70165649144, 60269.39730602682, 60504.0, 60735.69632151811, 9427.575759090858, 9614.375065620712, 9783.315167938175, 9795.755106122262, 9880.258980576486, 12110.970567501685, 12112.333821639719, 12119.878801212051, 12120.151589388659, 12124.151309408433, 7468.21583733711, 7517.849643007109, 7530.058742657168, 7579.393648508106, 7579.848403031909, 7288.453365997571, 7315.597642129627, 7324.121105467378, 7332.706691732271, 7375.483716139926, 5850.882982340415, 5910.852228694317, 5917.763289468373, 5924.14099955504, 5976.193213916153, 1665.4087798831483, 1686.620510385178, 1688.8311168883013, 1693.0688121533108, 1694.593297608565, 917.3074328881785, 950.0309684122295, 957.0142752964458, 982.9803403931882, 1059.6026490066224, 14583.92708036453, 17598.472045838644, 17852.821471785377, 18102.45692629223, 18275.63448731018, 933.5518950903604, 966.1980556138388, 966.6954909203579, 1049.2445439283704, 1061.1722856172198, 10411.94794026025, 10598.0991615712, 10622.46887655614, 10627.946860265649, 10665.466726663635, 388082.0, 389896.0, 411577.0, 426948.0, 500723.0, 64015.35984640187, 65808.10302763699, 69496.48272862248, 70126.0, 70785.64607177034, 488.8875558621466, 492.41648646354184, 499.29848562769365, 508.19451169895393, 509.6330641937725, 10758.784824303626, 10863.78272434531, 10909.454527273763, 10910.181736369645, 10956.178286628376, 32170.67829321677, 32295.51556726604, 32343.191420214684, 32598.34803303968, 32810.67189328076, 43395.783021084695, 43751.343729843444, 44528.10943781171, 44718.0, 46153.0, 6068.8786224276155, 6246.562740608114, 6251.281102673251, 6258.749650013949, 6268.404501572526, 11146.386948717898, 11690.123240756808, 11738.237014594024, 11744.0, 11836.289822610672, 9872.85190722154, 9894.06006429388, 10083.495825208856, 10186.03232692893, 10201.693949181536, 9801.950990245003, 9890.406575605486, 9955.562601247384, 10268.691939241835, 10334.276600637882, 10210.846837297298, 10478.423686697, 10754.0, 10759.3544387337, 10813.891861081289, 5918.822435326947, 6204.5967012145875, 6216.347283535164, 6231.9688401557705, 6313.305536391085, 9935.850962235427, 9978.351407158512, 10180.287379883337, 10300.124489418484, 10301.9484902575], "dojo.html": [3167.9841600791997, 3225.725813305869, 3225.9354812903744, 3246.61040675119, 3272.3946069977055, 5272.710000949946, 5333.0, 5340.305760251167, 5342.91985620216, 5396.163594642837, 5351.839444816662, 5396.298481197439, 5422.376426710929, 5444.237806707064, 5519.144532597444, 4957.7769000395065, 4986.850394488171, 4999.175136102539, 5043.470435604264, 5081.390233172025, 5027.698338099707, 5044.545990860822, 5058.645894787366, 5059.569936555397, 5072.0, 4862.270659401082, 4904.950950490485, 4948.703077815343, 5006.324146240266, 5029.1953287473825, 5067.138586440314, 5085.949140508585, 5101.0, 5111.08000559899, 5124.692518448905, 5039.244113382985, 5041.0422019816115, 5047.0, 5053.1157047516535, 5055.469175736532, 5269.0, 5359.356877174725, 5369.301990741218, 5387.784488620489, 5471.945280547184, 5790.826275211708, 5800.187973683687, 5802.12968054791, 5806.477417032487, 5812.534997200214, 5859.53123750099, 5874.295084589834, 5884.08796636522, 5885.70571471429, 5894.498967587718, 5238.921416178722, 5277.683338999673, 5375.543078838343, 5378.731063446851, 5399.973000134974, 5912.940870591325, 5921.67430791302, 5927.851803704942, 5932.406759324033, 6003.489703375175, 5704.372519022904, 5733.967885780517, 5740.913886291709, 5743.913841292384, 5750.568707346882, 5622.128570071645, 5745.88508229833, 5750.5112065474905, 5779.537636989031, 5912.17229587858, 5713.428657134254, 5716.657000579979, 5719.828405147852, 5729.169270455761, 5732.426757324234, 5728.283964504437, 5735.311762588516, 5742.684152371659, 5744.0, 5745.937001654707, 4273.18809426208, 4354.912901742011, 4382.9342559861625, 4383.60547550722, 4390.341448782644, 4075.3683179107284, 4090.9386359204636, 4103.630673239423, 4123.154753275631, 4133.607307305801, 5453.072977593819, 5493.972530137324, 5497.8075767347955, 5502.0371434998715, 5554.805581804618, 5642.605017648725, 5775.451332123442, 5779.826605201851, 5832.066869300891, 5891.351951285355, 5509.779608815683, 5524.281843360337, 5532.2531458253425, 5541.445855414427, 5547.0, 5130.9230361544605, 5134.075866344094, 5146.099432599281, 5175.534201921845, 5196.064708352533, 5940.405959404025, 6021.126936594257, 6068.817935461943, 6071.301800292935, 6077.2099627049965, 5895.4399332063385, 5901.527877769854, 5920.615160014585, 5929.0, 5935.525157987265, 6091.8781624366375, 6102.115193297036, 6109.816705498843, 6117.418845209698, 6123.755049797958, 5505.6696598204235, 5588.692621905834, 5627.240322556402, 5647.915281270866, 5783.392743761844, 5872.207252020922, 5879.059350503899, 5890.410958904075, 5910.556708246812, 5919.644821310563, 5738.512226460798, 5758.769649213985, 5759.395263497272, 5764.913526297193, 5778.248827652378, 5509.256250406304, 5555.055640541199, 5596.748146333343, 5613.635113717595, 5727.8568035799435, 5512.972435137799, 5519.834404967857, 5523.061079616556, 5544.778208871761, 5643.943560564506, 5634.802781902614, 5637.0, 5647.0, 5670.801521946877, 5708.315002199763, 5425.674459532441, 5426.70153141581, 5542.224088627515, 5548.722563871871, 5560.916586251128], "mootools.html": [1327.0644195841933, 1384.937677804499, 1447.5440236325558, 1634.844689754473, 1884.1709647754979, 7340.889886651705, 7765.417593680475, 7829.334506566942, 7837.8824317635135, 7839.451238413313, 7886.0, 8115.0667673217595, 8119.9188008120045, 8136.877946830802, 8137.552434616094, 2320.8375413721046, 2334.9299521014314, 2338.4738433852417, 2343.2618725101624, 2348.7064116985375, 2344.402177444749, 2353.446939969106, 2398.1846172301416, 2402.9279121626378, 2404.146527982567, 2253.5830871288863, 2258.8757618330983, 2259.423846919033, 2305.101010605865, 2308.226744040748, 2304.6197377432704, 2317.0268487235317, 2323.3610757041947, 2329.9301020969397, 2341.4497593065616, 2329.5690297294886, 2333.9299821005397, 2334.8132149428006, 2340.9297721068397, 2343.4961483281177, 7275.563466192046, 7476.70093196277, 8062.435629505937, 8126.796830079236, 8139.0, 4965.453800081988, 5127.7948882044675, 5149.3305870237, 5159.767810448501, 5161.5870730341485, 2809.101087651952, 2905.026816016637, 2917.6644685861183, 2967.0208831085906, 2967.762578993675, 906.3338446242007, 916.5600511754395, 918.8667643191767, 930.5440334236243, 955.2787645327802, 10735.94632026835, 10800.243982921198, 10800.51397687106, 10811.621593244277, 10825.13398928076, 4277.529471758166, 4361.978190109029, 4368.716033457815, 4442.644588432918, 4591.862244132614, 8763.737087887246, 8772.517511536927, 8780.429272097294, 8797.736067917973, 8802.0, 5097.413797413345, 5122.615803814729, 5132.692038477703, 5146.2280657900865, 5149.176131818891, 4730.763461826895, 4740.7392593407, 4744.478107408182, 4744.5492678195515, 4745.027269409763, 3446.362422951762, 3523.894283171509, 3544.521489598871, 3547.0954906498678, 3557.288542291552, 1028.0490546244844, 1058.1640504001753, 1059.4914441068331, 1060.7825395793843, 1069.3637285814928, 1057.0328149743052, 1058.7353161709573, 1079.1151255970028, 1079.7300674831292, 1111.9833202501968, 7608.087029556488, 7656.310932016146, 7717.498362606412, 7725.884111738328, 7753.263439973193, 492.6526798607045, 498.1556262135645, 502.4949925325025, 503.07434320849814, 503.5342308364748, 5538.723063846872, 5636.210930469738, 5699.544036477072, 5734.827955161351, 5744.770209191585, 9305.720828375159, 9425.717228483156, 9520.428774273565, 9525.333226674065, 9545.52272386378, 9248.549134479368, 9343.813123737487, 9456.716298511055, 9466.810663786686, 9519.762005949768, 7646.082470103624, 7726.536407815549, 7731.613419329124, 7731.690732370755, 7752.3798096153305, 7536.811579710551, 7575.356094732009, 7626.656800443882, 7647.808804779925, 7651.540907545343, 8475.915240847758, 8606.698765543177, 8608.225259726654, 8686.261667758312, 8700.60847261862, 8744.125587441205, 8836.779080523038, 8928.687495937611, 9022.188003079755, 9036.819263614823, 6317.557770955989, 6372.681365931592, 6377.681115944091, 6384.3934826191435, 6386.361363863763, 7658.8085297868, 7775.377969762519, 7792.259735325135, 7793.64928578204, 7795.805104872424, 7290.1251849776245, 7369.668364923698, 7392.002079719384, 7404.074490688664, 7413.666385012795, 7148.857022859618, 7168.964155179191, 7175.138983322035, 7214.603196824015, 7280.126384833854, 7283.7450689225625, 7328.560286382834, 7366.889496657447, 7373.0, 7375.078115235596, 6582.243042050225, 6636.004599310142, 6641.900371494528, 6644.867102658017, 6658.267590565131, 6611.669416529058, 6740.157480314961, 6781.186257649114, 6786.981952707133, 6796.524243303119], "ext.html": [563.4759673503642, 580.4775701868318, 583.5244275915129, 584.5469760935272, 609.3723464831226, 32016.519752203705, 32720.509192362133, 40328.798356008214, 40935.59064409355, 40974.79512602433, 42549.0, 43032.78483607578, 43101.35347969783, 43140.56859431405, 43173.78413107938, 8331.416800823945, 9159.404638698497, 9274.768130796716, 9282.396644218137, 9285.117913798213, 8484.957575212145, 11282.210245282833, 11494.36780977046, 11515.539378424895, 11544.942275288611, 11220.887791122066, 11314.773704525904, 11351.772964540703, 11383.203175777699, 11405.828912566276, 8604.827903441896, 8716.25911797498, 11211.831822522669, 11348.43257837109, 11375.772484550263, 11063.0, 11175.552977880876, 11198.104151667847, 11203.271787333797, 11230.719232019264, 40894.79552602248, 41349.79325103385, 41425.79287103575, 41449.0, 41449.37825932583, 2987.8207307561615, 3040.559118927743, 3373.5277061211204, 3510.7015903647966, 3528.435450327935, 27148.592771108448, 27250.45499090007, 27817.304567385774, 27820.582691259646, 28122.0, 2437.9756202437925, 2458.8770561471856, 2517.1064272183294, 2621.7247189045065, 2635.855027973461, 284003.0, 284488.9999999979, 285054.0, 285078.0, 285975.0, 57088.71455642695, 57853.421465784806, 60529.39470605326, 60942.39057609367, 67362.32637673659, 62565.37434625596, 63063.6846815763, 63166.68416657979, 63196.68401658054, 63324.68337658282, 15146.621334466507, 15313.464028759163, 15317.540473785804, 15319.0, 15323.46367877119, 10491.737706557244, 10492.26554141218, 10495.842562361571, 10511.684649460529, 10533.631322903662, 19981.700274495895, 20111.19555217804, 20156.596868062556, 20176.0, 20216.09027593762, 8127.634256458474, 8298.253157215879, 8319.0, 8343.95828020868, 8392.874106888401, 954.7231302922074, 963.3545524498603, 1085.625459216569, 1117.972050698739, 1122.7754449110212, 26614.0, 26627.600585991226, 26887.193384198505, 26980.0, 27026.729732702814, 1050.2595670052594, 1070.384528895888, 1172.695099274195, 1178.3732676469924, 1179.2924245452832, 14375.843623456565, 14430.639234019234, 14449.711005779825, 14476.276186190858, 14596.0, 334041.0, 340857.0, 340933.0, 341622.0, 343246.0, 55747.16379254314, 56057.71971140118, 56125.87748245012, 56156.0, 56196.157057644166, 1371.4377105386743, 1380.2822532283358, 1386.1960063163342, 1387.2312801178578, 1388.9305534723223, 27585.0, 28079.298017549725, 28194.85902570474, 29026.7097329024, 29765.255868603457, 47084.7645761769, 47516.52483475121, 47524.7623761879, 47529.0, 47554.52445475639, 259041.0, 261639.0, 261712.0, 262471.0, 262702.0, 31950.201244969063, 33128.50307245345, 33242.33515329728, 33290.167745806546, 33332.50001250031, 42888.42669439719, 43214.78392608017, 43269.35095973626, 43567.78216109026, 44583.777081114386, 36516.452253216754, 36669.44995825118, 37321.440178396806, 37410.8129459351, 37439.251214976095, 36279.637203628685, 36363.27273454569, 38868.0, 39248.30899519611, 39979.60020399759, 34808.65191348155, 35531.28937421289, 35704.28591428209, 35738.8213058933, 35762.8211858939, 30435.695643043287, 31861.6813831868, 31887.0, 31906.840465797522, 31936.0, 24199.395015124763, 24669.62995555104, 24848.627270590594, 25078.24765257045, 25182.74817251804], "prototype.html": [315.87365053978414, 326.5134948926101, 328.68446291560093, 332.9017939707787, 334.54668923608523, 6145.7541698332125, 6269.592476489036, 6309.463695585875, 6349.7142628581705, 6360.077788720633, 6082.939170608292, 6219.906701399483, 6261.217347831521, 6294.464970477504, 6297.18136642237, 4795.6163506919365, 4796.83211087612, 4805.6155507559315, 4815.0610630926985, 4819.951800481986, 4637.814487420499, 4719.43366795985, 4722.079194557063, 4808.086463571927, 4814.66297359185, 4728.692634978733, 4734.4081989751285, 4748.050389922012, 4751.168545504523, 4766.428028636568, 4738.407699037621, 4757.738324392157, 4762.119007983534, 4765.28520721891, 4772.976135119302, 4092.4884389451317, 4101.097758493127, 4107.507099148092, 4108.281050816125, 4111.6093971073, 5895.882082358372, 6057.151998720183, 6077.058056001327, 6115.113308570232, 6131.754729810802, 5372.167314066326, 5376.784928602851, 5385.703786291752, 5390.407055223922, 5391.892162156735, 6545.312742162052, 6564.212294524687, 6565.441937435324, 6565.507586930951, 6570.63861487618, 4193.35003074524, 4340.414044104037, 4458.464984201884, 4460.977695111536, 4469.620082293009, 6551.410373066399, 6722.49581281401, 6760.661966901635, 6901.0, 6901.75843845468, 4384.101259241912, 4410.3825464435, 4418.64650827933, 4420.889477763018, 4429.0, 4478.552144785495, 4498.617617502549, 4505.301678239813, 4508.594226519629, 4517.073999830027, 5113.667611605234, 5245.26566280721, 5262.973685131627, 5264.341957255343, 5267.130923397596, 6526.28210896801, 6529.934700653028, 6532.150820393318, 6540.149780528501, 6540.215174179034, 1567.3652170870816, 1584.0970646731253, 1584.595928038343, 1586.4923224568026, 1588.3725928258273, 1011.1809434358194, 1018.6434747838198, 1024.3034736379334, 1032.4785983078648, 1034.043509753475, 6344.080108384258, 6377.075324078076, 6390.073439351361, 6402.231732192166, 6406.103145559626, 6825.180978282638, 6840.726370945106, 6856.965715171492, 6865.862682746417, 6882.8967565486555, 6270.247570291503, 6370.522210834206, 6381.1704478417505, 6399.424051835264, 6406.903896441557, 3688.575813781396, 3722.4044152935944, 3725.832337544817, 3731.533558305212, 3738.36447803874, 7158.2841715828, 7172.713091476387, 7185.173705023884, 7201.531900426456, 7208.4593655475, 6755.256921738604, 6987.510874238755, 6996.705609462266, 7007.0, 7030.543014704028, 7144.0, 7149.92850071503, 7166.8924966124505, 7176.318249766368, 7180.066591343092, 6858.074159988338, 6875.89686154698, 6877.484188685969, 6881.277465866012, 6883.27725588826, 6461.386168314003, 6515.2833188348295, 6713.697883595348, 6720.563163394364, 6740.460763139035, 7041.859162816818, 7079.221285658677, 7118.110236220473, 7148.356647901714, 7185.245549217466, 4393.693311011617, 4465.0623369092855, 4469.865904022885, 4472.932906006347, 4473.194824931414, 6666.26671066192, 6855.725770969106, 6865.622390768555, 6886.10480637514, 6899.068625735462, 6683.966580167068, 6685.63229022389, 6694.096297000037, 6695.665216739241, 6709.329067093252, 6672.799816005528, 6678.165229346332, 6679.398854102959, 6698.22970358415, 6711.127553418024, 6335.746570137328, 6505.967470162619, 6544.280129185881, 6547.9672601638595, 6586.70359833799, 6721.1598550181225, 6731.528792984444, 6739.0, 6763.425108865801, 6768.593884366954, 6585.176852893388, 6602.7689030883685, 6604.471642268511, 6605.14133162705, 6624.8343791405605], "yui.html": [693.7918624412677, 712.92514286, 723.1286300008491, 750.6171852355297, 821.6466919224731, 12949.546765863197, 12972.935135324335, 12984.156029858053, 13698.52055178069, 13911.373988170531, 12028.69928251792, 12125.818112728317, 12141.757164856697, 12147.392630368468, 12154.39228038599, 677.7119724117255, 721.1850608812035, 896.5875697179289, 904.2494729374636, 915.4736026784592, 901.3555307954811, 908.8636704494313, 915.4324318922278, 915.9771005724843, 916.1205242966727, 945.7257395355339, 951.8477043673014, 952.6665667016558, 952.7475219066953, 952.9857052144223, 687.2268697715045, 747.3386053342804, 929.7954450020984, 944.0, 944.0182210501139, 699.098163369253, 699.9160100787938, 700.7022015643382, 700.8002719224996, 701.0430762009871, 14117.364718587689, 14286.357113929898, 14319.78520322196, 14324.427022919072, 14327.140371577738, 11796.410179490991, 11854.0, 11869.287842729464, 12088.395580221042, 12356.073294502858, 9103.08969103091, 9515.857262141073, 9586.568604412818, 9610.231181505464, 10195.133413659847, 3026.3190782074075, 3061.418330517217, 3088.3977624363256, 3195.5206718992335, 3221.4845624699938, 43683.563164368265, 43897.34153987693, 43908.560914390764, 43957.340639890426, 44071.33892991608, 6739.090222819955, 6917.792466226021, 6949.30506949301, 6976.965115174392, 6995.335443132894, 12329.753404932031, 12335.876641233652, 12336.136470446983, 12337.383130843422, 12350.691232719075, 6024.578279520391, 6069.447338910479, 6080.300765411946, 6106.908396374058, 6296.811095667137, 3624.257027309395, 3672.081979505124, 3789.6589306961955, 3868.284367391985, 4017.738846974937, 2655.6016597510143, 2681.6916054653575, 2682.195341397573, 2685.7179996100126, 2686.140435060762, 382.7416493866684, 389.25069241709593, 391.13363898963934, 392.77219212856477, 394.2981492942567, 475.6266330930203, 477.3579535524714, 525.0915915466264, 611.403881215811, 615.4061330815784, 8074.0, 8229.79425514367, 8360.623771930277, 8414.3268538518, 8472.406931514735, 488.67747286790546, 578.4446930946254, 611.7461253579803, 620.2804746494045, 645.4803882874237, 3827.9808600956817, 3991.4832363701607, 4105.322621767375, 4205.201011807747, 4208.516020657664, 53403.46596534063, 53458.46541534535, 53627.46372536303, 53683.0, 53778.0, 45935.0, 47769.76115119472, 50144.49855501471, 50232.748836256316, 50595.0, 44787.32819007652, 45283.547164528594, 45337.77331113389, 45581.31628025582, 45891.54108458939, 8353.122922093336, 8386.287165590993, 8457.57712114404, 8505.914940850513, 8704.303655707656, 33305.500417494244, 33849.661503385636, 34025.149371265914, 34061.65938340684, 34118.48822267717, 43566.0, 43835.561644383146, 44262.0, 44296.11407771891, 44522.3321650182, 7736.961315193388, 7746.728864489716, 7779.649915753918, 7841.921580784119, 7871.33093687043, 11054.447277635925, 11312.6040588579, 11699.122565807429, 11781.0, 12040.277583345027, 10491.68524944253, 10492.52783624754, 10501.0, 10791.082757965347, 11137.55449782032, 10475.319104258198, 10730.356178629307, 10824.512896919816, 10918.617848375268, 11051.72370690739, 10387.428691422045, 10457.790844183226, 10477.68566942993, 10813.837792432962, 11276.436178190894, 9074.137956894085, 9265.629374824932, 9283.210927071275, 9393.107654772786, 9642.758931026781, 8591.570421479026, 8598.226159645661, 8928.776780580278, 9350.719478415658, 9527.523623818919]}, "summary": {"lowerIsBetter": false, "suite": 6862.247152843202, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 8057.917132317386, "unit": "ms", "value": 8057.917132317386}, "dojo.html": {"lowerIsBetter": false, "filtered": 5372.213756273104, "unit": "ms", "value": 5372.213756273104}, "mootools.html": {"lowerIsBetter": false, "filtered": 4449.86488859639, "unit": "ms", "value": 4449.86488859639}, "ext.html": {"lowerIsBetter": false, "filtered": 18849.906636670825, "unit": "ms", "value": 18849.906636670825}, "prototype.html": {"lowerIsBetter": false, "filtered": 4934.115833683313, "unit": "ms", "value": 4934.115833683313}, "yui.html": {"lowerIsBetter": false, "filtered": 5827.986096760231, "unit": "ms", "value": 5827.986096760231}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0094"}, "testrun": {"date": 1447690215, "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": "20151116072434", "branch": "Fx-Team", "revision": "8e2b7001ebc461585bb003794e31e3f203a394c5"}}, {"talos_counters": {}, "results": {"audio-dft": [161.0, 161.0, 161.0, 163.0, 162.0, 163.0, 162.0, 163.0, 163.0, 161.0], "ai-astar": [105.0, 106.0, 101.0, 106.0, 106.0, 106.0, 95.0, 106.0, 107.0, 104.0], "imaging-gaussian-blur": [120.0, 119.0, 114.0, 120.0, 120.0, 114.0, 114.0, 114.0, 114.0, 120.0], "audio-beat-detection": [157.0, 128.0, 153.0, 162.0, 125.0, 149.0, 149.0, 126.0, 164.0, 127.0], "json-stringify-tinderbox": [68.0, 68.0, 69.0, 69.0, 71.0, 70.0, 70.0, 70.0, 70.0, 71.0], "stanford-crypto-pbkdf2": [155.0, 152.0, 154.0, 153.0, 155.0, 142.0, 155.0, 153.0, 150.0, 151.0], "json-parse-financial": [59.0, 59.0, 59.0, 59.0, 59.0, 58.0, 59.0, 67.0, 57.0, 58.0], "stanford-crypto-sha256-iterative": [70.0, 70.0, 69.0, 71.0, 70.0, 70.0, 71.0, 70.0, 70.0, 70.0], "audio-fft": [80.0, 79.0, 84.0, 86.0, 67.0, 69.0, 70.0, 81.0, 83.0, 66.0], "imaging-darkroom": [125.0, 125.0, 125.0, 125.0, 125.0, 125.0, 125.0, 125.0, 125.0, 125.0], "stanford-crypto-ccm": [122.0, 124.0, 131.0, 123.0, 128.0, 134.0, 132.0, 131.0, 126.0, 130.0], "audio-oscillator": [99.0, 101.0, 135.0, 88.0, 89.0, 92.0, 123.0, 89.0, 88.0, 126.0], "stanford-crypto-aes": [87.0, 86.0, 84.0, 85.0, 86.0, 85.0, 86.0, 86.0, 87.0, 84.0], "imaging-desaturate": [94.0, 93.0, 101.0, 93.0, 93.0, 94.0, 101.0, 100.0, 92.0, 100.0]}, "summary": {"lowerIsBetter": true, "suite": 1492.4999999999998, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 76.5, "unit": "ms", "value": 76.5}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 152.0, "unit": "ms", "value": 152.0}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 144.0, "unit": "ms", "value": 144.0}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 128.1, "unit": "ms", "value": 128.1}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 125.0, "unit": "ms", "value": 125.0}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 59.4, "unit": "ms", "value": 59.4}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 103.0, "unit": "ms", "value": 103.0}, "ai-astar": {"lowerIsBetter": true, "filtered": 104.2, "unit": "ms", "value": 104.2}, "audio-dft": {"lowerIsBetter": true, "filtered": 162.0, "unit": "ms", "value": 162.0}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 70.1, "unit": "ms", "value": 70.1}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 69.6, "unit": "ms", "value": 69.6}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 116.9, "unit": "ms", "value": 116.9}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 85.6, "unit": "ms", "value": 85.6}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 96.1, "unit": "ms", "value": 96.1}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0094"}, "testrun": {"date": 1447690215, "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": "20151116072434", "branch": "Fx-Team", "revision": "8e2b7001ebc461585bb003794e31e3f203a394c5"}}, {"talos_counters": {}, "results": {"DeltaBlue": [191.20458891013385], "Encrypt": [327.8688524590164], "NavierStokes": [5797.687861271676], "Decrypt": [5770.114942528736], "Splay": [630.0], "Richards": [167.61649346295675], "RegExp": [30235.29411764706], "Earley": [970.8737864077669], "Boyer": [12935.897435897436], "RayTrace": [1890.359168241966]}, "summary": {"lowerIsBetter": false, "suite": 18174.516979152948, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 345.79713999999984, "unit": "score", "value": 345.79713999999984}, "Encrypt": {"lowerIsBetter": false, "filtered": 811.8520500000001, "unit": "score", "value": 811.8520500000001}, "NavierStokes": {"lowerIsBetter": false, "filtered": 255.96410767696923, "unit": "score", "value": 255.96410767696923}, "Decrypt": {"lowerIsBetter": false, "filtered": 46.130970119521876, "unit": "score", "value": 46.130970119521876}, "Splay": {"lowerIsBetter": false, "filtered": 129.3507936507937, "unit": "score", "value": 129.3507936507937}, "RegExp": {"lowerIsBetter": false, "filtered": 30.12985408560309, "unit": "score", "value": 30.12985408560309}, "Richards": {"lowerIsBetter": false, "filtered": 210.61173199999993, "unit": "score", "value": 210.61173199999993}, "Earley": {"lowerIsBetter": false, "filtered": 686.45689, "unit": "score", "value": 686.45689}, "Boyer": {"lowerIsBetter": false, "filtered": 51.52043012884043, "unit": "score", "value": 51.52043012884043}, "RayTrace": {"lowerIsBetter": false, "filtered": 391.45418100000006, "unit": "score", "value": 391.45418100000006}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0094"}, "testrun": {"date": 1447690215, "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": "20151116072434", "branch": "Fx-Team", "revision": "8e2b7001ebc461585bb003794e31e3f203a394c5"}}] 08:30:24 INFO - RETURN: dromaeo_css: 6862.25 08:30:24 INFO - RETURN: kraken: 1492.50 08:30:24 INFO - RETURN: v8_7: 18174.52 08:30:24 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,55]]", "result": "18174.52"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,55]]", "result": "1492.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,55]]", "result": "6862.25"}}} 08:30:24 INFO - Return code: 0 08:30:24 INFO - # TBPL SUCCESS # 08:30:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:30:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:30:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:30:24 INFO - 2015-11-16 08:30:24.997 screenresolution[1939:21191] starting screenresolution argv=screenresolution get 08:30:25 INFO - 2015-11-16 08:30:25.000 screenresolution[1939:21191] Display 0: 1600x1200x32@60 08:30:25 INFO - 2015-11-16 08:30:25.006 screenresolution[1940:21194] starting screenresolution argv=screenresolution list 08:30:25 INFO - Available Modes on Display 0 08:30:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:30:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:30:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:30:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:30:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:30:25 INFO - Intel HD Graphics 3000: 08:30:25 INFO - Chipset Model: Intel HD Graphics 3000 08:30:25 INFO - Type: GPU 08:30:25 INFO - Bus: Built-In 08:30:25 INFO - VRAM (Total): 512 MB 08:30:25 INFO - VRAM (Dynamic, Max): 10 08:30:25 INFO - Vendor: Intel (0x8086) 08:30:25 INFO - Device ID: 0x0116 08:30:25 INFO - Revision ID: 0x0009 08:30:25 INFO - Displays: 08:30:25 INFO - Display: 08:30:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:30:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:30:25 INFO - Display Serial Number: 1600x1200 60 08:30:25 INFO - Main Display: Yes 08:30:25 INFO - Mirror: Off 08:30:25 INFO - Online: Yes 08:30:25 INFO - Rotation: Supported 08:30:25 INFO - Return code: 0 08:30:25 INFO - Running post-action listener: _resource_record_post_action 08:30:25 INFO - Running post-run listener: _resource_record_post_run 08:30:26 INFO - Total resource usage - Wall time: 1247s; CPU: 30.0%; Read bytes: 8192; Write bytes: 685362176; Read time: 14; Write time: 59461 08:30:26 INFO - install - Wall time: 38s; CPU: 30.0%; Read bytes: 334412288; Write bytes: 335902720; Read time: 31945; Write time: 7313 08:30:26 INFO - run-tests - Wall time: 1210s; CPU: 30.0%; Read bytes: 8192; Write bytes: 339096576; Read time: 14; Write time: 50572 08:30:26 INFO - Running post-run listener: _upload_blobber_files 08:30:26 INFO - Blob upload gear active. 08:30:26 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 08:30:26 INFO - Copying logs to upload dir... 08:30:26 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1317.766637 ========= master_lag: 11.17 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 8 secs) (at 2015-11-16 08:30:37.537037) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-16 08:30:37.541073) ========= 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.ryp4ZXMmmS/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.XDg6x8wVLa/Listeners TMPDIR=/var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/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/jzW4DwGySfOar5Op6FZX7A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010113 build_url: 'https://queue.taskcluster.net/v1/task/jzW4DwGySfOar5Op6FZX7A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-16 08:30:37.589158) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 08:30:37.589475) ========= 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.ryp4ZXMmmS/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.XDg6x8wVLa/Listeners TMPDIR=/var/folders/gf/x91z9mwj36j8kgk6j260mth000000w/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.005325 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 08:30:37.640494) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 08:30:37.640862) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 08:30:37.641388) ========= ========= Total master_lag: 11.70 =========