builder: fx-team_yosemite_test-dromaeojs slave: t-yosemite-r5-0019 starttime: 1446828655.65 results: success (0) buildid: 20151106065436 builduid: bc69dbbf77de464683e4ba70152b3912 revision: c921afa9fc3e164ab52dc4564349a92e16663317 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-06 08:50:55.650848) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-06 08:50:55.651394) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-06 08:50:55.651770) ========= 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.GFLiz1S8m2/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.EavsOyrJHV/Listeners TMPDIR=/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/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.006692 basedir: '/builds/slave/test' ========= master_lag: 0.38 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-06 08:50:56.036106) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-06 08:50:56.036487) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-06 08:50:56.053032) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-06 08:50:56.053722) ========= 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.GFLiz1S8m2/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.EavsOyrJHV/Listeners TMPDIR=/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/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.005657 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-06 08:50:56.107086) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-06 08:50:56.107744) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-06 08:50:56.108613) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-06 08:50:56.109328) ========= 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.GFLiz1S8m2/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.EavsOyrJHV/Listeners TMPDIR=/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/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-06 08:50:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 8.96M=0.001s 2015-11-06 08:50:56 (8.96 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.112934 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-06 08:50:56.239335) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-06 08:50:56.239754) ========= 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.GFLiz1S8m2/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.EavsOyrJHV/Listeners TMPDIR=/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/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.020596 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-06 08:50:56.289550) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-06 08:50:56.289934) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c921afa9fc3e164ab52dc4564349a92e16663317 --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 c921afa9fc3e164ab52dc4564349a92e16663317 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.GFLiz1S8m2/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.EavsOyrJHV/Listeners TMPDIR=/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/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-06 08:50:56,374 truncating revision to first 12 chars 2015-11-06 08:50:56,374 Setting DEBUG logging. 2015-11-06 08:50:56,374 attempt 1/10 2015-11-06 08:50:56,374 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c921afa9fc3e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-06 08:50:57,319 unpacking tar archive at: fx-team-c921afa9fc3e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.211753 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-06 08:50:57.519654) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-06 08:50:57.520026) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-06 08:50:57.534852) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-06 08:50:57.535671) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-06 08:50:57.536698) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 1 secs) (at 2015-11-06 08:50:57.537533) ========= /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.GFLiz1S8m2/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.EavsOyrJHV/Listeners TMPDIR=/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/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:50:57 INFO - MultiFileLogger online at 20151106 08:50:57 in /builds/slave/test 08:50:57 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:50:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:50:57 INFO - {'append_to_log': False, 08:50:57 INFO - 'base_work_dir': '/builds/slave/test', 08:50:57 INFO - 'blob_upload_branch': 'Fx-Team', 08:50:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:50:57 INFO - 'branch': 'Fx-Team', 08:50:57 INFO - 'buildbot_json_path': 'buildprops.json', 08:50:57 INFO - 'config_files': ('talos/mac_config.py',), 08:50:57 INFO - 'default_actions': ('clobber', 08:50:57 INFO - 'read-buildbot-config', 08:50:57 INFO - 'download-and-extract', 08:50:57 INFO - 'populate-webroot', 08:50:57 INFO - 'create-virtualenv', 08:50:57 INFO - 'install', 08:50:57 INFO - 'run-tests'), 08:50:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:50:57 INFO - 'download_minidump_stackwalk': True, 08:50:57 INFO - 'download_symbols': 'ondemand', 08:50:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:50:57 INFO - 'tooltool.py': '/tools/tooltool.py', 08:50:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:50:57 INFO - '/tools/misc-python/virtualenv.py')}, 08:50:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:50:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:50:57 INFO - 'installer_path': 'installer.exe', 08:50:57 INFO - 'log_level': 'info', 08:50:57 INFO - 'log_name': 'talos', 08:50:57 INFO - 'log_to_console': True, 08:50:57 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:50:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:50:57 INFO - 'opt_config_files': (), 08:50:57 INFO - 'pip_index': False, 08:50:57 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:50:57 INFO - 'cmd': ('bash', 08:50:57 INFO - '-c', 08:50:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:50:57 INFO - 'enabled': True, 08:50:57 INFO - 'halt_on_failure': False, 08:50:57 INFO - 'name': 'check_screen_resolution'},), 08:50:57 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:50:57 INFO - 'cmd': ('bash', 08:50:57 INFO - '-c', 08:50:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:50:57 INFO - 'enabled': True, 08:50:57 INFO - 'halt_on_failure': False, 08:50:57 INFO - 'name': 'check_screen_resolution'},), 08:50:57 INFO - 'run_cmd_checks_enabled': True, 08:50:57 INFO - 'sps_profile': False, 08:50:57 INFO - 'sps_profile_interval': 0, 08:50:57 INFO - 'suite': 'dromaeojs', 08:50:57 INFO - 'system_bits': '64', 08:50:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:50:57 INFO - 'title': 't-yosemite-r5-0019', 08:50:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:50:57 INFO - 'use_talos_json': True, 08:50:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:50:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:50:57 INFO - 'work_dir': 'build'} 08:50:57 INFO - ##### 08:50:57 INFO - ##### Running clobber step. 08:50:57 INFO - ##### 08:50:57 INFO - Running pre-action listener: _resource_record_pre_action 08:50:57 INFO - Running main action method: clobber 08:50:57 INFO - rmtree: /builds/slave/test/build 08:50:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:50:59 INFO - Running post-action listener: _resource_record_post_action 08:50:59 INFO - ##### 08:50:59 INFO - ##### Running read-buildbot-config step. 08:50:59 INFO - ##### 08:50:59 INFO - Running pre-action listener: _resource_record_pre_action 08:50:59 INFO - Running main action method: read_buildbot_config 08:50:59 INFO - Using buildbot properties: 08:50:59 INFO - { 08:50:59 INFO - "properties": { 08:50:59 INFO - "buildnumber": 1197, 08:50:59 INFO - "product": "firefox", 08:50:59 INFO - "script_repo_revision": "production", 08:50:59 INFO - "builddir": "fx-team_yosemite_test-dromaeojs", 08:50:59 INFO - "repository": "", 08:50:59 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 fx-team talos dromaeojs", 08:50:59 INFO - "buildid": "20151106065436", 08:50:59 INFO - "slavename": "t-yosemite-r5-0019", 08:50:59 INFO - "pgo_build": "False", 08:50:59 INFO - "basedir": "/builds/slave/test", 08:50:59 INFO - "project": "", 08:50:59 INFO - "platform": "yosemite", 08:50:59 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 08:50:59 INFO - "slavebuilddir": "test", 08:50:59 INFO - "scheduler": "tests-fx-team-macosx64-talos", 08:50:59 INFO - "branch": "fx-team", 08:50:59 INFO - "repo_path": "integration/fx-team", 08:50:59 INFO - "stage_platform": "macosx64", 08:50:59 INFO - "builduid": "bc69dbbf77de464683e4ba70152b3912", 08:50:59 INFO - "revision": "c921afa9fc3e164ab52dc4564349a92e16663317" 08:50:59 INFO - }, 08:50:59 INFO - "sourcestamp": { 08:50:59 INFO - "repository": "", 08:50:59 INFO - "hasPatch": false, 08:50:59 INFO - "project": "", 08:50:59 INFO - "branch": "fx-team-macosx64-talos", 08:50:59 INFO - "changes": [ 08:50:59 INFO - { 08:50:59 INFO - "category": null, 08:50:59 INFO - "files": [ 08:50:59 INFO - { 08:50:59 INFO - "url": null, 08:50:59 INFO - "name": "https://queue.taskcluster.net/v1/task/g9GRn1xsT2mzbkhAqjNBSg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 08:50:59 INFO - } 08:50:59 INFO - ], 08:50:59 INFO - "repository": "", 08:50:59 INFO - "rev": "c921afa9fc3e164ab52dc4564349a92e16663317", 08:50:59 INFO - "who": "florian@queze.net", 08:50:59 INFO - "when": 1446827696, 08:50:59 INFO - "number": 6631092, 08:50:59 INFO - "comments": "Bug 1220246 - fix test_geodefaults.js to avoid failing when the http server takes more than 1000ms to reply, r=Gijs.", 08:50:59 INFO - "project": "", 08:50:59 INFO - "at": "Fri 06 Nov 2015 08:34:56", 08:50:59 INFO - "branch": "fx-team-macosx64-talos", 08:50:59 INFO - "revlink": "", 08:50:59 INFO - "properties": [ 08:50:59 INFO - [ 08:50:59 INFO - "buildid", 08:50:59 INFO - "20151106065436", 08:50:59 INFO - "Change" 08:50:59 INFO - ], 08:50:59 INFO - [ 08:50:59 INFO - "builduid", 08:50:59 INFO - "bc69dbbf77de464683e4ba70152b3912", 08:50:59 INFO - "Change" 08:50:59 INFO - ], 08:50:59 INFO - [ 08:50:59 INFO - "pgo_build", 08:50:59 INFO - "False", 08:50:59 INFO - "Change" 08:50:59 INFO - ] 08:50:59 INFO - ], 08:50:59 INFO - "revision": "c921afa9fc3e164ab52dc4564349a92e16663317" 08:50:59 INFO - } 08:50:59 INFO - ], 08:50:59 INFO - "revision": "c921afa9fc3e164ab52dc4564349a92e16663317" 08:50:59 INFO - } 08:50:59 INFO - } 08:50:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/g9GRn1xsT2mzbkhAqjNBSg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 08:50:59 INFO - Running post-action listener: _resource_record_post_action 08:50:59 INFO - ##### 08:50:59 INFO - ##### Running download-and-extract step. 08:50:59 INFO - ##### 08:50:59 INFO - Running pre-action listener: _resource_record_pre_action 08:50:59 INFO - Running main action method: download_and_extract 08:50:59 INFO - mkdir: /builds/slave/test/build/tests 08:50:59 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:50:59 INFO - https://queue.taskcluster.net/v1/task/g9GRn1xsT2mzbkhAqjNBSg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:50:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/g9GRn1xsT2mzbkhAqjNBSg/artifacts/public/build/test_packages.json 08:50:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/g9GRn1xsT2mzbkhAqjNBSg/artifacts/public/build/test_packages.json 08:50:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/g9GRn1xsT2mzbkhAqjNBSg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 08:50:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/g9GRn1xsT2mzbkhAqjNBSg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 08:51:00 INFO - Downloaded 1149 bytes. 08:51:00 INFO - Reading from file /builds/slave/test/build/test_packages.json 08:51:00 INFO - Using the following test package requirements: 08:51:00 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 08:51:00 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 08:51:00 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 08:51:00 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 08:51:00 INFO - u'jsshell-mac.zip'], 08:51:00 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 08:51:00 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 08:51:00 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 08:51:00 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 08:51:00 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 08:51:00 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 08:51:00 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 08:51:00 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 08:51:00 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 08:51:00 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 08:51:00 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 08:51:00 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 08:51:00 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:51:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:51:00 INFO - https://queue.taskcluster.net/v1/task/g9GRn1xsT2mzbkhAqjNBSg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:51:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/g9GRn1xsT2mzbkhAqjNBSg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 08:51:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/g9GRn1xsT2mzbkhAqjNBSg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 08:51:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/g9GRn1xsT2mzbkhAqjNBSg/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:51:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/g9GRn1xsT2mzbkhAqjNBSg/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:51:01 INFO - Downloaded 17429445 bytes. 08:51:01 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:51:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 08:51:01 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 08:51:06 INFO - Return code: 0 08:51:06 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:51: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:51:06 INFO - https://queue.taskcluster.net/v1/task/g9GRn1xsT2mzbkhAqjNBSg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:51:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/g9GRn1xsT2mzbkhAqjNBSg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 08:51:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/g9GRn1xsT2mzbkhAqjNBSg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 08:51:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/g9GRn1xsT2mzbkhAqjNBSg/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:51:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/g9GRn1xsT2mzbkhAqjNBSg/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:51:07 INFO - Downloaded 17429445 bytes. 08:51:07 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:51:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 08:51:07 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 08:51:13 INFO - Return code: 0 08:51:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:51:13 INFO - https://queue.taskcluster.net/v1/task/g9GRn1xsT2mzbkhAqjNBSg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 08:51:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/g9GRn1xsT2mzbkhAqjNBSg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 08:51:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/g9GRn1xsT2mzbkhAqjNBSg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 08:51:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/g9GRn1xsT2mzbkhAqjNBSg/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:51:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/g9GRn1xsT2mzbkhAqjNBSg/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:51:14 INFO - Downloaded 11131623 bytes. 08:51:14 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:51:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 08:51:14 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 08:51:15 INFO - Return code: 0 08:51: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:51:15 INFO - https://queue.taskcluster.net/v1/task/g9GRn1xsT2mzbkhAqjNBSg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 08:51:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/g9GRn1xsT2mzbkhAqjNBSg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 08:51:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/g9GRn1xsT2mzbkhAqjNBSg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 08:51:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/g9GRn1xsT2mzbkhAqjNBSg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 08:51:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/g9GRn1xsT2mzbkhAqjNBSg/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:51:18 INFO - Downloaded 108676616 bytes. 08:51:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/g9GRn1xsT2mzbkhAqjNBSg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 08:51:18 INFO - mkdir: /builds/slave/test/properties 08:51:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:51:18 INFO - Writing to file /builds/slave/test/properties/build_url 08:51:18 INFO - Contents: 08:51:18 INFO - build_url:https://queue.taskcluster.net/v1/task/g9GRn1xsT2mzbkhAqjNBSg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 08:51:18 INFO - Running post-action listener: _resource_record_post_action 08:51:18 INFO - Running post-action listener: set_extra_try_arguments 08:51:18 INFO - ##### 08:51:18 INFO - ##### Running populate-webroot step. 08:51:18 INFO - ##### 08:51:18 INFO - Running pre-action listener: _resource_record_pre_action 08:51:18 INFO - Running main action method: populate_webroot 08:51:18 INFO - Guessing talos json url... 08:51: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:51:18 INFO - https://queue.taskcluster.net/v1/task/g9GRn1xsT2mzbkhAqjNBSg/artifacts/public/build/firefox-45.0a1.en-US.mac.txt matches https://queue.taskcluster.net 08:51:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/g9GRn1xsT2mzbkhAqjNBSg/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 08:51:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/g9GRn1xsT2mzbkhAqjNBSg/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 08:51:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/g9GRn1xsT2mzbkhAqjNBSg/artifacts/public/build/firefox-45.0a1.en-US.mac.txt to /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 08:51:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/g9GRn1xsT2mzbkhAqjNBSg/artifacts/public/build/firefox-45.0a1.en-US.mac.txt', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.txt'}, attempt #1 08:51:19 INFO - Downloaded 103 bytes. 08:51:19 INFO - Reading from file /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 08:51:19 INFO - Contents: 08:51:19 INFO - 20151106065436 08:51:19 INFO - https://hg.mozilla.org/integration/fx-team/rev/c921afa9fc3e164ab52dc4564349a92e16663317 08:51:19 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:51:19 INFO - trying https://hg.mozilla.org/integration/fx-team/raw-file/c921afa9fc/testing/talos/talos.json 08:51:19 INFO - Downloading https://hg.mozilla.org/integration/fx-team/raw-file/c921afa9fc/testing/talos/talos.json to /builds/slave/test/build/talos.json 08:51:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/integration/fx-team/raw-file/c921afa9fc/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 08:51:19 INFO - Downloaded 4264 bytes. 08:51:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:51:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:51:19 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 08:51:19 INFO - '../fennec_ids.txt'], 08:51:19 INFO - 'tests': ['tcheck2']}, 08:51:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:51:19 INFO - '--tppagecycles', 08:51:19 INFO - '7'], 08:51:19 INFO - 'tests': ['tsvgm']}}, 08:51:19 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:51:19 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:51:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:51:19 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:51:19 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:51:19 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:51:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:51:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:19 INFO - 'talos_options': ['--e10s'], 08:51:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:51:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:19 INFO - 'tests': ['damp', 'tps']}, 08:51:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:19 INFO - 'talos_options': ['--e10s'], 08:51:19 INFO - 'tests': ['damp', 'tps']}, 08:51:19 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:51:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:51:19 INFO - 'other': {'tests': ['a11yr', 08:51:19 INFO - 'ts_paint', 08:51:19 INFO - 'tpaint', 08:51:19 INFO - 'sessionrestore', 08:51:19 INFO - 'sessionrestore_no_auto_restore']}, 08:51:19 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:51:19 INFO - 'tests': ['a11yr', 08:51:19 INFO - 'ts_paint', 08:51:19 INFO - 'tpaint', 08:51:19 INFO - 'sessionrestore', 08:51:19 INFO - 'sessionrestore_no_auto_restore']}, 08:51:19 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:51:19 INFO - 'tests': ['a11yr', 08:51:19 INFO - 'ts_paint', 08:51:19 INFO - 'tpaint', 08:51:19 INFO - 'sessionrestore', 08:51:19 INFO - 'sessionrestore_no_auto_restore']}, 08:51:19 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:51:19 INFO - 'tests': ['a11yr', 08:51:19 INFO - 'ts_paint', 08:51:19 INFO - 'tpaint', 08:51:19 INFO - 'sessionrestore', 08:51:19 INFO - 'sessionrestore_no_auto_restore']}, 08:51:19 INFO - 'other_l64': {'tests': ['a11yr', 08:51:19 INFO - 'ts_paint', 08:51:19 INFO - 'tpaint', 08:51:19 INFO - 'sessionrestore', 08:51:19 INFO - 'sessionrestore_no_auto_restore']}, 08:51:19 INFO - 'other_nol64': {'tests': ['a11yr', 08:51:19 INFO - 'ts_paint', 08:51:19 INFO - 'tpaint', 08:51:19 INFO - 'sessionrestore', 08:51:19 INFO - 'sessionrestore_no_auto_restore']}, 08:51:19 INFO - 'svgr': {'tests': ['tsvgx', 08:51:19 INFO - 'tsvgr_opacity', 08:51:19 INFO - 'tart', 08:51:19 INFO - 'tscrollx', 08:51:19 INFO - 'cart']}, 08:51:19 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:51:19 INFO - 'tests': ['tsvgx', 08:51:19 INFO - 'tsvgr_opacity', 08:51:19 INFO - 'tart', 08:51:19 INFO - 'tscrollx', 08:51:19 INFO - 'cart']}, 08:51:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:19 INFO - 'tests': ['tp5o']}, 08:51:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:19 INFO - 'talos_options': ['--e10s'], 08:51:19 INFO - 'tests': ['tp5o']}, 08:51:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:19 INFO - 'talos_options': ['--xperf_path', 08:51:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:51:19 INFO - 'tests': ['tp5n']}, 08:51:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:19 INFO - 'talos_options': ['--e10s', 08:51:19 INFO - '--xperf_path', 08:51:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 08:51:19 INFO - 'C:/slave/talos-data/talos/xperf.config'], 08:51:19 INFO - 'tests': ['tp5n']}}, 08:51:19 INFO - 'talos.zip': {'path': '', 08:51:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:51:19 INFO - Running post-action listener: _resource_record_post_action 08:51:19 INFO - ##### 08:51:19 INFO - ##### Running create-virtualenv step. 08:51:19 INFO - ##### 08:51:19 INFO - Running pre-action listener: _resource_record_pre_action 08:51:19 INFO - Running main action method: create_virtualenv 08:51:19 INFO - Creating virtualenv /builds/slave/test/build/venv 08:51:19 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:51:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:51:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:51:20 INFO - Using real prefix '/tools/python27' 08:51:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:51:20 INFO - Installing distribute.............................................................................................................................................................................................done. 08:51:25 INFO - Installing pip.................done. 08:51:25 INFO - Return code: 0 08:51:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:51:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:51:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x10cb6aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbd7228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83e9cbc0a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb1f9f0>, '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 0x10c87ecd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cae9990>, '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.GFLiz1S8m2/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.EavsOyrJHV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/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:51:25 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:51:25 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:51:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GFLiz1S8m2/Render', 08:51:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:25 INFO - 'HOME': '/Users/cltbld', 08:51:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:25 INFO - 'LOGNAME': 'cltbld', 08:51:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:25 INFO - 'MOZ_NO_REMOTE': '1', 08:51:25 INFO - 'NO_EM_RESTART': '1', 08:51:25 INFO - 'PAGER': '/bin/cat', 08:51:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:25 INFO - 'PWD': '/builds/slave/test', 08:51:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:25 INFO - 'SHELL': '/bin/bash', 08:51:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EavsOyrJHV/Listeners', 08:51:25 INFO - 'TMPDIR': '/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/', 08:51:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:25 INFO - 'USER': 'cltbld', 08:51:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:25 INFO - 'XPC_FLAGS': '0x0', 08:51:25 INFO - 'XPC_SERVICE_NAME': '0', 08:51:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:51:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:25 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:51:25 INFO - Cleaning up... 08:51:26 INFO - Return code: 0 08:51:26 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:51: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:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51: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:51:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:26 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 0x10cb6aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbd7228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83e9cbc0a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb1f9f0>, '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 0x10c87ecd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cae9990>, '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.GFLiz1S8m2/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.EavsOyrJHV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/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:51:26 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:51:26 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:51:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GFLiz1S8m2/Render', 08:51:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:26 INFO - 'HOME': '/Users/cltbld', 08:51:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:26 INFO - 'LOGNAME': 'cltbld', 08:51:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:26 INFO - 'MOZ_NO_REMOTE': '1', 08:51:26 INFO - 'NO_EM_RESTART': '1', 08:51:26 INFO - 'PAGER': '/bin/cat', 08:51:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:26 INFO - 'PWD': '/builds/slave/test', 08:51:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:26 INFO - 'SHELL': '/bin/bash', 08:51:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EavsOyrJHV/Listeners', 08:51:26 INFO - 'TMPDIR': '/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/', 08:51:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:26 INFO - 'USER': 'cltbld', 08:51:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:26 INFO - 'XPC_FLAGS': '0x0', 08:51:26 INFO - 'XPC_SERVICE_NAME': '0', 08:51:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:51:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:26 INFO - Downloading/unpacking psutil>=0.7.1 08:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:28 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 08:51:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:51:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:51:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:51:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:51:29 INFO - Installing collected packages: psutil 08:51:29 INFO - Running setup.py install for psutil 08:51:29 INFO - building 'psutil._psutil_osx' extension 08:51:29 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:51:29 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:51:29 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:51:29 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:51:29 INFO - building 'psutil._psutil_posix' extension 08:51:29 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:51:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:51:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:51:30 INFO - ^ 08:51:30 INFO - 1 warning generated. 08:51:30 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:51:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:51:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:51:30 INFO - Successfully installed psutil 08:51:30 INFO - Cleaning up... 08:51:30 INFO - Return code: 0 08:51:30 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:51:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:51:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x10cb6aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbd7228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83e9cbc0a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb1f9f0>, '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 0x10c87ecd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cae9990>, '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.GFLiz1S8m2/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.EavsOyrJHV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/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:51:30 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:51:30 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:51:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GFLiz1S8m2/Render', 08:51:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:30 INFO - 'HOME': '/Users/cltbld', 08:51:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:30 INFO - 'LOGNAME': 'cltbld', 08:51:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:30 INFO - 'MOZ_NO_REMOTE': '1', 08:51:30 INFO - 'NO_EM_RESTART': '1', 08:51:30 INFO - 'PAGER': '/bin/cat', 08:51:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:30 INFO - 'PWD': '/builds/slave/test', 08:51:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:30 INFO - 'SHELL': '/bin/bash', 08:51:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EavsOyrJHV/Listeners', 08:51:30 INFO - 'TMPDIR': '/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/', 08:51:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:30 INFO - 'USER': 'cltbld', 08:51:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:30 INFO - 'XPC_FLAGS': '0x0', 08:51:30 INFO - 'XPC_SERVICE_NAME': '0', 08:51:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:51:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:30 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:51:30 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:51:30 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:51:30 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:51:30 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:51:30 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:51:30 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:51:33 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:51:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:51:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:51:33 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:51:33 INFO - Installing collected packages: mozsystemmonitor 08:51:33 INFO - Running setup.py install for mozsystemmonitor 08:51:33 INFO - Successfully installed mozsystemmonitor 08:51:33 INFO - Cleaning up... 08:51:33 INFO - Return code: 0 08:51:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:51: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:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51: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:51:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x10cb6aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbd7228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83e9cbc0a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb1f9f0>, '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 0x10c87ecd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cae9990>, '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.GFLiz1S8m2/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.EavsOyrJHV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/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:51:33 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:51:33 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:51:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GFLiz1S8m2/Render', 08:51:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:33 INFO - 'HOME': '/Users/cltbld', 08:51:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:33 INFO - 'LOGNAME': 'cltbld', 08:51:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:33 INFO - 'MOZ_NO_REMOTE': '1', 08:51:33 INFO - 'NO_EM_RESTART': '1', 08:51:33 INFO - 'PAGER': '/bin/cat', 08:51:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:33 INFO - 'PWD': '/builds/slave/test', 08:51:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:33 INFO - 'SHELL': '/bin/bash', 08:51:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EavsOyrJHV/Listeners', 08:51:33 INFO - 'TMPDIR': '/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/', 08:51:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:33 INFO - 'USER': 'cltbld', 08:51:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:33 INFO - 'XPC_FLAGS': '0x0', 08:51:33 INFO - 'XPC_SERVICE_NAME': '0', 08:51:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:51:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:34 INFO - Downloading/unpacking blobuploader==1.2.4 08:51: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:51: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:51: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:51: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:51: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:51: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:51:36 INFO - Downloading blobuploader-1.2.4.tar.gz 08:51:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:51:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:51:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:51:36 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:51:36 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:51:36 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:51:36 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:51:36 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:51:36 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:51:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:51:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:51:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:51:37 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:51:37 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:51:37 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:51:37 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:51:37 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:51:37 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:51:38 INFO - Downloading docopt-0.6.1.tar.gz 08:51:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:51:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:51:38 INFO - Installing collected packages: blobuploader, requests, docopt 08:51:38 INFO - Running setup.py install for blobuploader 08:51:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:51:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:51:38 INFO - Running setup.py install for requests 08:51:38 INFO - Running setup.py install for docopt 08:51:39 INFO - Successfully installed blobuploader requests docopt 08:51:39 INFO - Cleaning up... 08:51:39 INFO - Return code: 0 08:51:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:51: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:51:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51: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:51:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:39 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 0x10cb6aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbd7228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83e9cbc0a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb1f9f0>, '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 0x10c87ecd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cae9990>, '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.GFLiz1S8m2/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.EavsOyrJHV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/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:51:39 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:51:39 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:51:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GFLiz1S8m2/Render', 08:51:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:39 INFO - 'HOME': '/Users/cltbld', 08:51:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:39 INFO - 'LOGNAME': 'cltbld', 08:51:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:39 INFO - 'MOZ_NO_REMOTE': '1', 08:51:39 INFO - 'NO_EM_RESTART': '1', 08:51:39 INFO - 'PAGER': '/bin/cat', 08:51:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:39 INFO - 'PWD': '/builds/slave/test', 08:51:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:39 INFO - 'SHELL': '/bin/bash', 08:51:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EavsOyrJHV/Listeners', 08:51:39 INFO - 'TMPDIR': '/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/', 08:51:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:39 INFO - 'USER': 'cltbld', 08:51:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:39 INFO - 'XPC_FLAGS': '0x0', 08:51:39 INFO - 'XPC_SERVICE_NAME': '0', 08:51:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:51:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:51:39 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-JnFsqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:51:39 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-C5TteZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:51:39 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-ryPxr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:51:39 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-sR2v2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:51:40 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-WxhDJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:51:40 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-AUZmxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:51:40 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-34ZCZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:51:40 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-sBOiED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:51:40 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-tio6DY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:51:40 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-k1gnmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:51:40 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-iJVWXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:51:41 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-fZFpIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:51:41 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-euuFXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:51:41 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-8DUOGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:51:41 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-mjKark-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:51:41 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-jwvAwy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:51:41 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-u_8lSv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:51:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:51:41 INFO - Running setup.py install for manifestparser 08:51:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:51:42 INFO - Running setup.py install for mozcrash 08:51:42 INFO - Running setup.py install for mozdebug 08:51:42 INFO - Running setup.py install for mozdevice 08:51:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:51:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:51:42 INFO - Running setup.py install for mozfile 08:51:42 INFO - Running setup.py install for mozhttpd 08:51:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:51:43 INFO - Running setup.py install for mozinfo 08:51:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:51:43 INFO - Running setup.py install for mozInstall 08:51:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:51:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:51:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:51:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:51:43 INFO - Running setup.py install for mozleak 08:51:43 INFO - Running setup.py install for mozlog 08:51:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:51:43 INFO - Running setup.py install for moznetwork 08:51:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:51:43 INFO - Running setup.py install for mozprocess 08:51:44 INFO - Running setup.py install for mozprofile 08:51:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:51:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:51:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:51:44 INFO - Running setup.py install for mozrunner 08:51:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:51:44 INFO - Running setup.py install for mozscreenshot 08:51:44 INFO - Running setup.py install for moztest 08:51:44 INFO - Running setup.py install for mozversion 08:51:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:51:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:51:45 INFO - Cleaning up... 08:51:45 INFO - Return code: 0 08:51:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:51:45 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:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:45 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:51:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:45 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 0x10cb6aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbd7228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83e9cbc0a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb1f9f0>, '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 0x10c87ecd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cae9990>, '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.GFLiz1S8m2/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.EavsOyrJHV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/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:51:45 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:51:45 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:51:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GFLiz1S8m2/Render', 08:51:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:45 INFO - 'HOME': '/Users/cltbld', 08:51:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:45 INFO - 'LOGNAME': 'cltbld', 08:51:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:45 INFO - 'MOZ_NO_REMOTE': '1', 08:51:45 INFO - 'NO_EM_RESTART': '1', 08:51:45 INFO - 'PAGER': '/bin/cat', 08:51:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:45 INFO - 'PWD': '/builds/slave/test', 08:51:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:45 INFO - 'SHELL': '/bin/bash', 08:51:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EavsOyrJHV/Listeners', 08:51:45 INFO - 'TMPDIR': '/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/', 08:51:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:45 INFO - 'USER': 'cltbld', 08:51:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:45 INFO - 'XPC_FLAGS': '0x0', 08:51:45 INFO - 'XPC_SERVICE_NAME': '0', 08:51:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:51:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:51:45 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-h9HDJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:51:45 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:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:51:45 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-hMMrAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:51:45 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:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:51:45 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-Cvc1Ah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:51:45 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:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:51:45 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-C7k1WE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:51:46 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:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:51:46 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-04IypZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:51:46 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:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:51:46 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-j5E17B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:51:46 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:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:51:46 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-BUX8rX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:51:46 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:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:51:46 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-c0wabf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:51:46 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:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:51:46 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-Vznq1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:51:46 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:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:51:46 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-38E2wd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:51:46 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:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:51:46 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-Z4bSgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:51:47 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:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:51:47 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-7f2MFN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:51:47 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:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:51:47 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-jRQsyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:51:47 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:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:51:47 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-qk68oX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:51:47 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:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:51:47 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-XSPgqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:51:47 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:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:51:47 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-fUBjbo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:51:47 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:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:51:47 INFO - Running setup.py (path:/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/pip-h8HtHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:51:47 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:51:47 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:51:47 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:51:47 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:51:47 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:51:47 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:51:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:50 INFO - Downloading blessings-1.5.1.tar.gz 08:51:50 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:51:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:51:50 INFO - Installing collected packages: blessings 08:51:50 INFO - Running setup.py install for blessings 08:51:50 INFO - Successfully installed blessings 08:51:50 INFO - Cleaning up... 08:51:51 INFO - Return code: 0 08:51:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:51:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:51:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:51:51 INFO - Reading from file tmpfile_stdout 08:51:51 INFO - Current package versions: 08:51:51 INFO - blessings == 1.5.1 08:51:51 INFO - blobuploader == 1.2.4 08:51:51 INFO - docopt == 0.6.1 08:51:51 INFO - manifestparser == 1.1 08:51:51 INFO - mozInstall == 1.12 08:51:51 INFO - mozcrash == 0.16 08:51:51 INFO - mozdebug == 0.1 08:51:51 INFO - mozdevice == 0.47 08:51:51 INFO - mozfile == 1.2 08:51:51 INFO - mozhttpd == 0.7 08:51:51 INFO - mozinfo == 0.9 08:51:51 INFO - mozleak == 0.1 08:51:51 INFO - mozlog == 3.0 08:51:51 INFO - moznetwork == 0.27 08:51:51 INFO - mozprocess == 0.22 08:51:51 INFO - mozprofile == 0.27 08:51:51 INFO - mozrunner == 6.11 08:51:51 INFO - mozscreenshot == 0.1 08:51:51 INFO - mozsystemmonitor == 0.0 08:51:51 INFO - moztest == 0.7 08:51:51 INFO - mozversion == 1.4 08:51:51 INFO - psutil == 3.1.1 08:51:51 INFO - requests == 1.2.3 08:51:51 INFO - wsgiref == 0.1.2 08:51:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:51:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:51:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x10cb6aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbd7228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83e9cbc0a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb1f9f0>, '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 0x10c87ecd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cae9990>, '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.GFLiz1S8m2/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.EavsOyrJHV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/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:51:51 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:51:51 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:51:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GFLiz1S8m2/Render', 08:51:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:51 INFO - 'HOME': '/Users/cltbld', 08:51:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:51 INFO - 'LOGNAME': 'cltbld', 08:51:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:51 INFO - 'MOZ_NO_REMOTE': '1', 08:51:51 INFO - 'NO_EM_RESTART': '1', 08:51:51 INFO - 'PAGER': '/bin/cat', 08:51:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:51 INFO - 'PWD': '/builds/slave/test', 08:51:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:51 INFO - 'SHELL': '/bin/bash', 08:51:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EavsOyrJHV/Listeners', 08:51:51 INFO - 'TMPDIR': '/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/', 08:51:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:51 INFO - 'USER': 'cltbld', 08:51:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:51 INFO - 'XPC_FLAGS': '0x0', 08:51:51 INFO - 'XPC_SERVICE_NAME': '0', 08:51:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:51:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:51 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:51:51 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:51:51 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:51:51 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:51:51 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:51:51 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:51:51 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:51:51 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:51:51 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:51:51 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:51:51 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:51:51 INFO - Cleaning up... 08:51:51 INFO - Return code: 0 08:51:51 INFO - Running post-action listener: _resource_record_post_action 08:51:51 INFO - Running post-action listener: _start_resource_monitoring 08:51:51 INFO - Starting resource monitoring. 08:51:51 INFO - ##### 08:51:51 INFO - ##### Running install step. 08:51:51 INFO - ##### 08:51:51 INFO - Running pre-action listener: _resource_record_pre_action 08:51:51 INFO - Running main action method: install 08:51:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:51:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:51:52 INFO - Reading from file tmpfile_stdout 08:51:52 INFO - Detecting whether we're running mozinstall >=1.0... 08:51:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:51:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:51:52 INFO - Reading from file tmpfile_stdout 08:51:52 INFO - Output received: 08:51:52 INFO - Usage: mozinstall [options] installer 08:51:52 INFO - Options: 08:51:52 INFO - -h, --help show this help message and exit 08:51:52 INFO - -d DEST, --destination=DEST 08:51:52 INFO - Directory to install application into. [default: 08:51:52 INFO - "/builds/slave/test"] 08:51:52 INFO - --app=APP Application being installed. [default: firefox] 08:51:52 INFO - mkdir: /builds/slave/test/build/application 08:51:52 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:51:52 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:52:33 INFO - Reading from file tmpfile_stdout 08:52:33 INFO - Output received: 08:52:33 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:52:33 INFO - Running post-action listener: _resource_record_post_action 08:52:33 INFO - ##### 08:52:33 INFO - ##### Running run-tests step. 08:52:33 INFO - ##### 08:52:33 INFO - Running pre-action listener: _resource_record_pre_action 08:52:33 INFO - Running main action method: run_tests 08:52:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:52:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:52:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:52:33 INFO - 2015-11-06 08:52:33.745 screenresolution[2262:17360] starting screenresolution argv=screenresolution get 08:52:33 INFO - 2015-11-06 08:52:33.749 screenresolution[2262:17360] Display 0: 1600x1200x32@60 08:52:33 INFO - 2015-11-06 08:52:33.756 screenresolution[2263:17363] starting screenresolution argv=screenresolution list 08:52:33 INFO - Available Modes on Display 0 08:52:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:52:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:52:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:52:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:52:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:52:34 INFO - Intel HD Graphics 3000: 08:52:34 INFO - Chipset Model: Intel HD Graphics 3000 08:52:34 INFO - Type: GPU 08:52:34 INFO - Bus: Built-In 08:52:34 INFO - VRAM (Total): 512 MB 08:52:34 INFO - VRAM (Dynamic, Max): 10 08:52:34 INFO - Vendor: Intel (0x8086) 08:52:34 INFO - Device ID: 0x0116 08:52:34 INFO - Revision ID: 0x0009 08:52:34 INFO - Displays: 08:52:34 INFO - Display: 08:52:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:52:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:52:34 INFO - Display Serial Number: 1600x1200 60 08:52:34 INFO - Main Display: Yes 08:52:34 INFO - Mirror: Off 08:52:34 INFO - Online: Yes 08:52:34 INFO - Rotation: Supported 08:52:34 INFO - Return code: 0 08:52:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:52:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:52:34 INFO - Python 2.7.3 08:52:34 INFO - Return code: 0 08:52:34 INFO - grabbing minidump binary from tooltool 08:52:34 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:52:34 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 0x10cb1f9f0>, '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 0x10c87ecd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cae9990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:52:34 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:52:34 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:52:34 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:52:34 INFO - Return code: 0 08:52:34 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:52:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:52:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:52:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:52:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:52:34 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/g9GRn1xsT2mzbkhAqjNBSg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0019', '--webServer', 'localhost'] in /builds/slave/test/build 08:52:34 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/g9GRn1xsT2mzbkhAqjNBSg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0019 --webServer localhost 08:52:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GFLiz1S8m2/Render', 08:52:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:52:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:52:34 INFO - 'HOME': '/Users/cltbld', 08:52:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:52:34 INFO - 'LOGNAME': 'cltbld', 08:52:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:52:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:52:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:34 INFO - 'MOZ_NO_REMOTE': '1', 08:52:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:52:34 INFO - 'NO_EM_RESTART': '1', 08:52:34 INFO - 'PAGER': '/bin/cat', 08:52:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:52:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:34 INFO - 'PWD': '/builds/slave/test', 08:52:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:52:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:52:34 INFO - 'SHELL': '/bin/bash', 08:52:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EavsOyrJHV/Listeners', 08:52:34 INFO - 'TMPDIR': '/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/', 08:52:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:52:34 INFO - 'USER': 'cltbld', 08:52:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:52:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:52:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:34 INFO - 'XPC_FLAGS': '0x0', 08:52:34 INFO - 'XPC_SERVICE_NAME': '0', 08:52:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:52:34 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/g9GRn1xsT2mzbkhAqjNBSg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0019', '--webServer', 'localhost'] with output_timeout 3600 08:52:34 INFO - mozversion INFO | application_buildid: 20151106065436 08:52:34 INFO - mozversion INFO | application_changeset: c921afa9fc3e164ab52dc4564349a92e16663317 08:52:34 INFO - mozversion INFO | application_display_name: Nightly 08:52:34 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:52:34 INFO - mozversion INFO | application_name: Firefox 08:52:34 INFO - mozversion INFO | application_remotingname: firefox 08:52:34 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 08:52:34 INFO - mozversion INFO | application_vendor: Mozilla 08:52:34 INFO - mozversion INFO | application_version: 45.0a1 08:52:34 INFO - mozversion INFO | platform_buildid: 20151106065436 08:52:34 INFO - mozversion INFO | platform_changeset: c921afa9fc3e164ab52dc4564349a92e16663317 08:52:34 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 08:52:34 INFO - mozversion INFO | platform_version: 45.0a1 08:52:34 INFO - 2015-11-06 08:52:34,431 DEBUG : using testdate: 1446828754 08:52:34 INFO - 2015-11-06 08:52:34,431 DEBUG : actual date: 1446828754 08:52:34 INFO - 2015-11-06 08:52:34,440 INFO : starting webserver on 'localhost:51407' 08:52:34 INFO - 2015-11-06 08:52:34,442 INFO : Starting test suite t-yosemite-r5-0019 08:52:34 INFO - 2015-11-06 08:52:34,442 INFO : Starting test dromaeo_css 08:52:34 INFO - 2015-11-06 08:52:34,442 DEBUG : operating with platform_type : mac_ 08:52:34 INFO - 2015-11-06 08:52:34,443 INFO : Initialising browser for dromaeo_css test... 08:52:34 INFO - 2015-11-06 08:52:34,476 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/tmp1M5VTy/profile http://localhost:51407/getInfo.html 08:52:36 INFO - 2015-11-06 08:52:36,951 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:52:36 INFO - 2015-11-06 08:52:36,952 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:52:36 INFO - 2015-11-06 08:52:36,952 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 08:52:36 INFO - 2015-11-06 08:52:36,952 DEBUG : BROWSER_OUTPUT: __metrics 08:52:36 INFO - 2015-11-06 08:52:36,969 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:52:37 INFO - 2015-11-06 08:52:37,722 INFO : Browser initialized. 08:52:37 INFO - 2015-11-06 08:52:37,723 INFO : Running cycle 1/1 for dromaeo_css test... 08:52:37 INFO - 2015-11-06 08:52:37,723 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/tmp1M5VTy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:52:49 INFO - 2015-11-06 08:52:49,807 DEBUG : BROWSER_OUTPUT: RSS: Main: 222560256 08:52:49 INFO - 2015-11-06 08:52:49,807 DEBUG : BROWSER_OUTPUT: 08:53:40 INFO - 2015-11-06 08:53:40,778 DEBUG : BROWSER_OUTPUT: 1446828820772 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:55:51 INFO - 2015-11-06 08:55:51,952 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51407/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51407/tests/dromaeo/cssquery-ext.html) 08:55:53 INFO - 2015-11-06 08:55:53,182 DEBUG : BROWSER_OUTPUT: RSS: Main: 325877760 08:55:53 INFO - 2015-11-06 08:55:53,182 DEBUG : BROWSER_OUTPUT: 08:58:56 INFO - 2015-11-06 08:58:56,051 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51407/tests/dromaeo/cssquery-ext.html (next: http://localhost:51407/tests/dromaeo/cssquery-jquery.html) 08:58:56 INFO - 2015-11-06 08:58:56,620 DEBUG : BROWSER_OUTPUT: RSS: Main: 352149504 08:58:56 INFO - 2015-11-06 08:58:56,620 DEBUG : BROWSER_OUTPUT: 09:01:58 INFO - 2015-11-06 09:01:58,816 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51407/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51407/tests/dromaeo/cssquery-mootools.html) 09:01:59 INFO - 2015-11-06 09:01:59,397 DEBUG : BROWSER_OUTPUT: RSS: Main: 314515456 09:01:59 INFO - 2015-11-06 09:01:59,397 DEBUG : BROWSER_OUTPUT: 09:05:01 INFO - 2015-11-06 09:05:01,635 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51407/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51407/tests/dromaeo/cssquery-prototype.html) 09:05:02 INFO - 2015-11-06 09:05:02,226 DEBUG : BROWSER_OUTPUT: RSS: Main: 310607872 09:05:02 INFO - 2015-11-06 09:05:02,227 DEBUG : BROWSER_OUTPUT: 09:08:05 INFO - 2015-11-06 09:08:05,479 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51407/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51407/tests/dromaeo/cssquery-yui.html) 09:08:06 INFO - 2015-11-06 09:08:06,067 DEBUG : BROWSER_OUTPUT: RSS: Main: 312242176 09:08:06 INFO - 2015-11-06 09:08:06,067 DEBUG : BROWSER_OUTPUT: 09:11:08 INFO - 2015-11-06 09:11:08,981 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51407/tests/dromaeo/cssquery-yui.html (next: http://localhost:51407/tests/dromaeo/cssquery-dojo.html) 09:11:09 INFO - 2015-11-06 09:11:09,243 DEBUG : BROWSER_OUTPUT: RSS: Main: 358207488 09:11:09 INFO - 2015-11-06 09:11:09,243 DEBUG : BROWSER_OUTPUT: 09:11:09 INFO - 2015-11-06 09:11:09,243 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:11:09 INFO - 2015-11-06 09:11:09,243 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:11:09 INFO - 2015-11-06 09:11:09,244 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:11:09 INFO - 2015-11-06 09:11:09,244 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:11:09 INFO - 2015-11-06 09:11:09,244 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2629.658144441223;2702.1893431970416;2714.687810901747;2719.9048033318836;2773.3898542320694;4436;4570.1316749817515;4592.265237561995;4611.492735799059;4642.907141857161;4540.160070386989;4542.636589072875;4659.277811939146;4660.883477913054;4733.621310295177;4200.495940487131;4252.766097864616;4259.212045771526;4266.679999000072;4346.76092814895;4267.679924005696;4327.935080973788;4331.981984233718;4384.079343337903;4424.269995450747;4038.0510580013674;4129.070959034223;4182.56083111275;4233.407322974786;4297.676262200872;4159.480064991876;4240.321548552217;4278.657707383433;4337.501187363462;4349.282368409209;4233.745975241495;4275.40144379787;4309.6336811371075;4320.395144679747;4345.217860785057;4339.240632889232;4531.297648864432;4646.303054541812;4685.461171965199;4754.049190161982;4718.3158442025715;4830.758462076882;4885.926711099336;4906.852794416173;4911.140550403665;4967.379077615298;4983.551480366785;5007.874803129915;5032.446430892599;5069.290299358093;4430.246858034142;4487.528809475023;4645.907081858378;4674.766261686902;4679.157751604744;4977.626677999165;5021.347224860745;5031.22016087507;5099.668521546162;5151.124308867502;4833.05755377705;4884.3161957326;4890.828820991248;4905.484924082992;4951.5048495150195;4865.56209941107;4951.331570238044;4963.404391473046;5037.395512538519;5037.571806396424;4847.612191024709;4868.269759536098;4901.779419926112;4916.164252077156;4945;4862.975685121552;4956.801727930842;4957.603391728653;4964.329815474937;5000.149974504343;3724.9068773280883;3819.312523745697;3821.006538300062;3856.9228615427533;3911.765294082364;3356.815375154341;3374.0552645259368;3396.5924089109467;3406.761526693157;3415.299863527971;4652.883677908079;4692.507286734912;4701.459332176843;4703.7883295251795;4720.95279047212;4784.091022705745;4908.680935739166;5015.17249653803;5033.0688822567945;5041.563962597462;4548.704334218265;4559.156556037144;4565.634749220055;4611.446626404853;4669.229577119737;4366.432363792686;4423.579759922803;4427.512973572904;4431.7340959542535;4472.0832229393545;4960.950390496048;5042.697438153723;5202.063628546823;5211.921821172609;5218.165093585084;4878.902421951612;4933.55597996182;4973.45292017885;5001.874953126201;5002.849914502571;5071.518205770446;5115.488451154854;5158.742062896915;5160.509751573594;5203.713795741271;4796.112719146969;4854.19905715553;4919.950800492093;4925.753712314298;4937.407511098691;4838.806447742191;4880.90238195227;4927.384076990376;4938.111139994836;4939.728314942713;4787.8563643090765;4801.447833499193;4863.076015557032;4869.147899117711;4897.3878265216845;4586.289125185602;4713.363695901009;4834.564889159992;4855.781489832895;4921.311016457627;4625.884352891205;4648.744319062349;4675.532446755297;4689.132510485571;4696.412948381452;4881.438634557071;4895.241237608177;4903.289023091703;4914.70511769295;4950.653454258168;4598.448186217675;4708.764561771829;4751.667383283137;4813.4945830687275;4886.364772579542 09:11:09 INFO - 2015-11-06 09:11:09,244 DEBUG : BROWSER_OUTPUT: |1;ext.html;470.9929351059734;483.9419269687638;494.1475953979385;496.98260560880374;499.8100721725746;26657.466850662975;27945.860270698668;33128.834355828214;34132.31735365297;34571.65428345716;37204.25591488169;37312.44031339525;37388.252234955355;37512;37896;7012.649367531629;7886;8046.074701409325;8170.836583268331;8194.959025204866;7171.784846454615;9528.475933823636;9766.121049105579;9782.413055216673;9932.304738668296;9615.375000624972;9628.566714497865;9635.036496350343;9682.12860842524;9747.610095596203;7171.89242161368;7325.706971721178;9523.857142142873;9661.565229564687;9700.951495242514;9343.159115679622;9442.055794420572;9515.333926625139;9530.714078577654;9592.424454532751;34583.82708086444;35014.47478287828;35016.12459688528;35054.82472587646;35069.47395789065;2419.6249581314923;2698.3928616061426;2712.308361367858;2842.1473557932536;3072.6005619269577;23796.524069518688;24251.272461826175;24451.755482445125;24696.753032469624;25082.498350032896;2013.0840467587213;2046.887421191834;2047.9385618431322;2062.804033616804;2085.0304608357187;263105;264222;265904.6704766483;266286;267641;50959.745201273756;51226.23160652593;51334.74332628313;51351.48648513467;51767.22349164765;46010.539894600624;46645.30032049522;52044.739776301634;52794.94410111776;53504;14594.927025365017;14663.48677796272;14817.33322000491;14825.184614846286;14837.480688175861;10988.230823842414;11051;11114.388708620942;11328.830067548994;11330.263532870336;16171.757423638655;16366;16369.345226190819;16376.181190940644;16400.75398869018;7181.533200341961;7362.300581444754;7379.409647228209;7407.85184296311;7423.591702456309;829.9626516806758;883.5361435246418;911.937592704505;958.7890664053897;964.9758756031156;24547;24967;25101.24696259115;25353.492930141663;25361.61957570638;883.765802062454;907.6233363154217;952.1002652493328;1000.7398076500017;1009.6415772400692;13004.21974681522;13004.934975325063;13029.869701303056;13163.407646655924;13182.472701092041;379488;386423;392282;393082.03458983096;393136;45774.77112614416;46250.53749462462;46607;46804.297935530994;46984;1158.6350299655583;1200.0339726520235;1207.6316723399273;1208.238809549978;1210.7154818617794;24119.397015074763;24490.632640510765;24650.506989859743;24858.25425237246;24935.625965610892;39426.40860387154;39885.40171897482;40198.79900600478;40250.39624405577;40327.1934561313;229139;231840;234211;234755;235627;22760;23027.07891684314;25238.49523009566;26409;26578;31822.840885795424;31935.201619959687;32317.35365292728;32842.343153136324;33024.66975330312;27759;28007.439851202453;28074.719252807212;30261.394772104875;30643.2339191522;23154.768452315937;28189.154325370273;28747.42505149927;28832.279193020342;29450.558241626823;25028.124015660094;27459.862700686368;28888.855555722086;29350.266243344086;29994;26298.605520917583;27274.45451091007;27400;27476;27839.164825055283;20066.79933200708;20462.693059604415;20466.795332046488;20731.4817129573;20781.68827467559 09:11:09 INFO - 2015-11-06 09:11:09,248 DEBUG : BROWSER_OUTPUT: |2;jquery.html;282.77801925488495;289.8854952293843;290.6250936292183;290.87492378277335;292.3320213312581;8338.70814521492;9061.048589898064;14534.127952322868;15258.694826103485;15301.081935083888;9124.635014599407;10142.54358553865;10176.287659863812;10395.168386529078;10435;3691.427828686551;3803.0872590578338;3822.503074600298;3825.08198032473;3870.7290489665734;2866.641669791276;2965.2142182321704;2974.1226338230167;3769.8303576338994;3866.1881004988986;3966.900827479322;4047.7773722445254;4078.653314468274;4097.549269580344;4115.053537686319;4072.1855628874046;4085.1829634073156;4092.263392589333;4096.160287141129;4102.077032667656;3433.759636825423;3512.8067956262394;3516.1209697575605;3517.3844577199143;3555.982220088883;11463.140264480115;11713.121515886258;11716.53133874644;11726.589569365116;11870.881291187065;1556.750919852818;1603.1102737980416;1613.4433620400944;1634.8446897544713;1652.8016638003517;8025.678972841138;8396.83206335876;8452.83094338116;8466.74599762008;8496.575171241413;1322.1207896748651;1332.8867046301077;1357.4095268558208;1359.4154513559165;1365.49476693623;40420.393694094615;46107.30839037417;46230.537694623294;47441.5255847444;48558.27162592564;5542.445755424425;5586.078297081018;5589.916151257735;5609.074502707008;5674.2339784129435;6356.809295721136;6372.171617689671;6474.805755827333;6475.514336424787;6479.416852483299;4771.212749896297;4805.639577031667;4853.733044682576;4855.635827312965;4864.489228631013;5209.557187639018;5248.868778280497;5250.264962905197;5272.051030814414;5293.894122117536;2555.399481121935;2573.189445324717;2576.4460640962284;2587.8835452404687;2593.0664960614163;880.3837313880309;893.1957445959126;898.4384759525296;903.3676426501476;958.7075941837667;302.86825231024574;343.51564294344854;373.6170425314075;388.3844107090237;390.26435169704746;9880.258980576342;9972.202223822076;10002.349847259904;10164.695059148238;10618.36289822613;316.34043020302465;386.2313995149632;389.43726315474436;394.6389054015601;404.1008755519006;5235.476452354734;5385.192221166856;5486.423925487767;5509.449055094458;5511.669299842022;494933;502371;509777;518763;543438.2421318417;62165;64537;64964.350356496776;65147.34852651413;65165.764225325205;416.3504932305613;427.56815616227215;427.7989345007841;428.3296640757205;433.06674117277316;9371.531423428938;9469.905300946903;9528.809423811623;9571.664991725256;9706.70879873605;30210.46397627124;31080.067597972098;31557.52663710092;31583.36833263368;31610.209744756565;42030.36954445625;42717.78641106775;42912.35631465468;43060.35409468923;43163;5170.741462926914;5222.686638801684;5225.764840582259;5305.893882122413;5324.627276090637;9869.802603948025;10013.048760367754;10152.086312231935;10192.235582331503;10209.489525523843;8662.740117796477;8751.649934002824;8775.868361974448;8858.512781797062;8878.378513503993;8326.62530186131;8417.242448179693;8464.195901389357;8520.61657225414;8688.26149777276;8721.127887211482;8806.691765788166;8855.955720221358;9001.054889236797;9007.729768106967;4788.377510923558;4938.43208031081;5270.657407268515;5271.341082364705;5273.472652734696;8275.048369437593;8457.746267611981;8553;8623.137686231326;8635.352348573757 09:11:09 INFO - 2015-11-06 09:11:09,250 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1345.6972181259212;1435.885129189665;1520.429838810446;1522.7182971150335;1563.6638122803588;6036;6244.157038799766;6344.39728225819;6415.679216039202;6430.260520040197;6428;6557.803265902018;6559.47524198063;6602.504812139085;6624.635645039521;1637.6397192617605;1673.7071012572812;1893.9715904261448;1921.8174273444001;1923.0096500302357;1728.1704781704789;1881.5766452548135;1939.5442071113278;1940.3984764722911;1940.980590194094;1792.4264235444598;1832.303724584656;1850.6206227723285;1865.822746839048;1866.5986812835238;1885.6605810954022;1897.231621193405;1902.6860568006261;1903.1150515010447;1904.7999960004277;1820.8998505082216;1832.4411054628333;1842.6498965196704;1858.2659849359563;1859.5258209156714;6547.770828021044;6608.339166083401;6621.106150669646;6624.072629831828;6683.298253683391;4032.1330913853367;4108.6918481114035;4112.629863312316;4118.75287482752;4159.750414975111;2302.401375642345;2380.6548050532574;2384.1059602649007;2415.7946574541184;2452.6934133233344;720.8990741296222;729.616951100671;1247.6381849263703;1279.3475327583;1337.3848029906255;8520.275776559;8625.870611940825;8652.956735216347;8657.26413254874;8761.386702930797;3576.2847430514003;3648.325059863934;3710.3692372296773;3713.1088538750505;3763.9435408468894;7672.539647621049;7672.616369181518;7685.769426917202;7695.23047695226;7779.066512018594;4165.042040330741;4172.019575399779;4172.374143878443;4212.262854000538;4223.556526564728;3804.8097595120134;3806.71449641278;3808.6572208501366;3842.404427313715;3862.1310205203604;2841.957370639442;2924.0789151417234;3048.84755762211;3051.054173206313;3061.479548476764;937.4890684576922;969.6896992962326;998.1565577087349;1003.2826529031777;1025.6974192613197;894.8612964990307;910.4127837544879;910.6311943662827;912.2838571721167;1095.7041598768287;6248.562600618004;6260.686965651699;6278.277998030194;6279.843003924847;6337.493000559944;573.4237091722792;578.5747475605426;579.878225572626;582.1297160744629;714.9678264478111;4734.360861283752;4825.227963525819;4829.444613869379;4832.033593281358;4923.704577725348;7367.484276100621;7534.510256833289;7614.505057171377;7659.387249020177;7740.342070923922;7647.847043059219;7707.036620422447;7720.382369410434;7725.343345815556;7738.61306934651;6201.782937597162;6242.188515493048;6251.6561589113035;6255.812325630147;6271.05934109878;6130.816075517741;6174.783882564088;6184.783532576338;6190.133381326528;6251.937480625135;6907;7038.894416583653;7043.36609705129;7079.716811327489;7087.184973728087;6977.825554361181;7142.0001199833105;7240.131184257712;7254.056972593529;7255.891161632685;5844.831033793173;5918.704064796657;5919.052951527735;5932.673702946379;5986.2217911671205;5146.382434107931;6298.149749783904;6316.336784637547;6383.96808015957;6384.705384481379;5115.5396014358885;5158.845234642967;5557.469972782046;5950.702464876652;5993.550483713651;5647.435256474319;5757.366689664217;5824.223611798273;5841.737121829443;5950.285965684146;5862.208601838697;5910.497607703393;5913.940860591339;5926.555508336978;5996.370381110095;5414.0254754144635;5416.079266524779;5429.918551221814;5459.727013649381;5511.173324001432;5141.434442211428;5174.637775355689;5195.298634684269;5223.347081614798;5241.6068794839775 09:11:09 INFO - 2015-11-06 09:11:09,253 DEBUG : BROWSER_OUTPUT: |4;prototype.html;262.9355807827082;266.91858983010184;267.2756828993429;271.9360950176708;273.19135359336366;5226.92159617606;5233.528982391584;5263.815766448175;5278.524932756051;5288.973555132228;5077.441481437039;5120.206368012955;5134.794608215667;5135.589152867771;5224.216367544861;3831.252905683393;3880.611938806125;3902.414637804324;3924.0189952511873;4051.392291156321;3986.4817573715377;3986.940195897064;4001.339778936472;4036.4348991141264;4061.776602286873;3932.74437161585;3948;3991.7804520751347;4005.339119045354;4006.2187873364705;3841.0397400649836;3884.184321292532;3908.2965066288057;3918.4122381642696;4024.9195016099807;3429.6741809528053;3432.7940323580665;3437.7077948374417;3477.8608855645743;3482.112061424346;5034.370703662043;5087.8982420351385;5093.974530127326;5100.744962751847;5117.181250999822;4457.821687132511;4475.552444755498;4484.461864576272;4535.591796738309;4540.250858608326;5371.597130215249;5471.671699698031;5494.148406996922;5569.081101618228;5578.079616863212;3777.6033516480925;3786.8295926683363;3833.7124715646437;3840.884773456773;3842.3852183650483;5748.080307150877;5775.422457754191;5778.653280803123;5807.709614519299;5888.705564721789;3834.1564855732254;3862.7102967277565;3864.3237433449035;3909.4135879618284;3910.1397692507603;3475.061733332037;3681.245344704329;3893.065664240562;3908.1988192420486;3939.665128464055;4349.217140914666;4362.083962367875;4378.518362980133;4417.668674849399;4542.250528662799;5311.17676760095;5415.458454154553;5431.701256430934;5484.2047903053835;5489.066858634042;1400.7478653842202;1409.7885317202501;1412.5691664042565;1415.985840141606;1432.7421064208543;909.7316291693834;914.3279689428265;927.2350310993322;936.0312077000408;940.2806852757645;5243.68537887728;5269.420363759983;5291.656042357235;5330.147176451749;5356.116240820221;5730.656160630376;5735.340435849847;5739.081746920473;5747.396523364986;5749.942500574941;5294.179402192666;5295.232191332312;5320.760565774472;5336.092864213016;5336.653117547347;2899.0722968650252;3003.6996300370224;3124.218945263684;3147.4964005759425;3183.840807959593;5790.044642633919;5832.737526811304;5834.649921004753;5869.266341707286;5892.1161825726485;5749.281339832437;5768.307803063575;5851.151583020438;5874;5876.529877609781;5783.971080144573;5788;5868.061110222344;5870.6771127587535;5876.7355469004;5519.558435325084;5764.625299355528;5788.913166302593;5799.797007104731;5839.883202336015;5595.384507704068;5638.943610564006;5665.20687103814;5708.200851880657;5715.399883012224;5862.736176871966;5896.64620122794;5964.433378829004;5989.131575921554;5992.610480318765;3738.1962877981364;3757.4176002719623;3826.521684789401;3827.1771569112775;3854.5567259764366;5634.6337488063145;5640.71796410186;5659.405762394889;5661.46216109469;5716.828495144986;5485.204645326485;5489.39616642177;5502.477264659851;5530.142827861688;5571.804986825442;5482.479164479368;5496.6701997880255;5499.835004949858;5541.2796336476;5557.3331200256225;5189.4032186299055;5344.679319240702;5372;5375.462453754593;5446.373667028184;5463.644863083887;5482.890342193054;5545.584081193846;5549.250851135206;5555.0278701227935;5170.3278573785165;5270.393904701008;5271.156614941591;5402.621816472809;5432.103702888979 09:11:09 INFO - 2015-11-06 09:11:09,253 DEBUG : BROWSER_OUTPUT: |5;yui.html;646.4440581100253;648.0240214095265;659.0838734159519;666.0841343153164;673.383853773797;11939.820902686455;12342.382880855956;12459.563915262968;12464.252144871314;12485.563005294805;11326.150538709588;11476.827847582294;11555.768884622323;11633.650990470278;11668.82496762547;581.6451964301773;628.1174949196386;628.7516431009749;756.5800980455858;761.9885701714479;770.5030255485209;771.9459637825355;772.1043589436255;782.8982232309792;790.3677058353323;830.2901019628222;830.48509923847;830.9252167304942;832.2218725491655;839.3872473094644;572.0132770970085;638.9648569328708;762.1578156137443;815.657423881971;817.9141190175066;603.6136872401667;604.7853012180657;604.8548348396397;605.9545534084962;606.4057223920538;11733.941330293294;11920.046396288277;11939.40302984856;11943.880561194364;11963.042956563455;9948.104670579683;9975.551100200508;10551.366917984946;10594.523246453928;10730;7806.648700808477;8169.591520423955;8181.100078991306;8223;8368.079511253818;2434.172381390336;2519.0553542421594;2544.70735865376;2852.9223056148157;2934.9119526414243;42007.159856802995;42554;42596.99999999969;42665;42755.57244427547;5959.344472108065;6137.9079313810325;6139.447449729546;6151.3541078187045;6327.082573026885;10488.160947124212;10550.208734344955;10657.094146997591;10683.893161068445;10698.304610200312;5307.65500242483;5317.760700768475;5487.478689524489;5491.560675145979;5500.202470641734;3265;3351.0952042948265;3365.3269346130874;3443.2941247044296;3475.600305964796;2245.214175038756;2262.773722627724;2293.9197128100436;2294.0250393582996;2299.7470278269375;328.9144822346207;331.1539017809472;345.7441493294994;345.92735525539916;346.7053004945776;464.21315869600704;501.45341577680506;520.5757307794136;532.5420138680731;533.9225812257201;6596.406323430819;6753.527253092335;6864.176298844171;6882.346177113166;7042.436605071582;387.45175576558853;410.7720215280548;487.373724763677;495.9603231741524;502.3318985748945;3135.764817638686;3135.8275294858545;3170.5719727836445;3177.9364412711616;3188.3145123798495;54418.45581544134;55087;55168;55795.44204557984;56433.71783141058;45754.882060614706;47069;47101.76449117801;47218;47304;43136.352954705704;43604.56395436005;43918.780406098405;44063.55936440595;44133;6859.416949559343;6946.8610627788175;7085.787426377217;7158.141023077264;7220.638968051681;32111.67888321087;32463.513047303837;32526.512102318957;32675.509867351535;32904.177395565304;42107.789461053726;42141.57858421376;42840.35739463973;43055.7847210762;43444.56555434405;6557.540972131905;6570.277269500447;6623.503237257129;6792.150981127359;6861.142357205349;9505.572249248939;9752.171065459515;9825.754356141153;9939;10415.895841041493;9033.187013168847;9045.90954090477;9061.954690226507;9077.909220907706;9089.091090890857;9048.457092574467;9112.179903808425;9157.130072643089;9168.908310916806;9191.494467804336;8903.465792052497;8993.190612844875;9027.097290271184;9100.31747618918;9549.140577348073;7562.0925488941675;7734.098127612637;7871.606419678878;8216.497881239737;8238.340932725248;7591.544507329357;7891.487053341514;7986.321162701235;8093.35253179756;8198.38512111606 09:11:09 INFO - 2015-11-06 09:11:09,255 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:11:09 INFO - 2015-11-06 09:11:09,255 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:11:09 INFO - 2015-11-06 09:11:09,255 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,965 09:11:09 INFO - 2015-11-06 09:11:09,256 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:11:09 INFO - 2015-11-06 09:11:09,256 DEBUG : BROWSER_OUTPUT: __startTimestamp1446829869239__endTimestamp 09:11:09 INFO - 2015-11-06 09:11:09,256 DEBUG : BROWSER_OUTPUT: 09:11:09 INFO - 2015-11-06 09:11:09,256 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:11:09 INFO - 2015-11-06 09:11:09,256 DEBUG : BROWSER_OUTPUT: Number of tests: 6 09:11:09 INFO - 2015-11-06 09:11:09,256 DEBUG : BROWSER_OUTPUT: 09:11:09 INFO - 2015-11-06 09:11:09,256 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4603.69 Median:4720.95 stddev:508.34 (10.8%) stddev-sans-first:485.74 09:11:09 INFO - 2015-11-06 09:11:09,257 DEBUG : BROWSER_OUTPUT: Values: 2629.7 2702.2 2714.7 2719.9 2773.4 4436.0 4570.1 4592.3 4611.5 4642.9 4540.2 4542.6 4659.3 4660.9 4733.6 4200.5 4252.8 4259.2 4266.7 4346.8 4267.7 4327.9 4332.0 4384.1 4424.3 4038.1 4129.1 4182.6 4233.4 4297.7 4159.5 4240.3 4278.7 4337.5 4349.3 4233.7 4275.4 4309.6 4320.4 4345.2 4339.2 4531.3 4646.3 4685.5 4754.0 4718.3 4830.8 4885.9 4906.9 4911.1 4967.4 4983.6 5007.9 5032.4 5069.3 4430.2 4487.5 4645.9 4674.8 4679.2 4977.6 5021.3 5031.2 5099.7 5151.1 4833.1 4884.3 4890.8 4905.5 4951.5 4865.6 4951.3 4963.4 5037.4 5037.6 4847.6 4868.3 4901.8 4916.2 4945.0 4863.0 4956.8 4957.6 4964.3 5000.1 3724.9 3819.3 3821.0 3856.9 3911.8 3356.8 3374.1 3396.6 3406.8 3415.3 4652.9 4692.5 4701.5 4703.8 4721.0 4784.1 4908.7 5015.2 5033.1 5041.6 4548.7 4559.2 4565.6 4611.4 4669.2 4366.4 4423.6 4427.5 4431.7 4472.1 4961.0 5042.7 5202.1 5211.9 5218.2 4878.9 4933.6 4973.5 5001.9 5002.8 5071.5 5115.5 5158.7 5160.5 5203.7 4796.1 4854.2 4920.0 4925.8 4937.4 4838.8 4880.9 4927.4 4938.1 4939.7 4787.9 4801.4 4863.1 4869.1 4897.4 4586.3 4713.4 4834.6 4855.8 4921.3 4625.9 4648.7 4675.5 4689.1 4696.4 4881.4 4895.2 4903.3 4914.7 4950.7 4598.4 4708.8 4751.7 4813.5 4886.4 09:11:09 INFO - 2015-11-06 09:11:09,257 DEBUG : BROWSER_OUTPUT: 09:11:09 INFO - 2015-11-06 09:11:09,257 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:43304.18 Median:30127.70 stddev:80052.69 (265.7%) stddev-sans-first:80212.66 09:11:09 INFO - 2015-11-06 09:11:09,259 DEBUG : BROWSER_OUTPUT: Values: 471.0 483.9 494.1 497.0 499.8 26657.5 27945.9 33128.8 34132.3 34571.7 37204.3 37312.4 37388.3 37512.0 37896.0 7012.6 7886.0 8046.1 8170.8 8195.0 7171.8 9528.5 9766.1 9782.4 9932.3 9615.4 9628.6 9635.0 9682.1 9747.6 7171.9 7325.7 9523.9 9661.6 9701.0 9343.2 9442.1 9515.3 9530.7 9592.4 34583.8 35014.5 35016.1 35054.8 35069.5 2419.6 2698.4 2712.3 2842.1 3072.6 23796.5 24251.3 24451.8 24696.8 25082.5 2013.1 2046.9 2047.9 2062.8 2085.0 263105.0 264222.0 265904.7 266286.0 267641.0 50959.7 51226.2 51334.7 51351.5 51767.2 46010.5 46645.3 52044.7 52794.9 53504.0 14594.9 14663.5 14817.3 14825.2 14837.5 10988.2 11051.0 11114.4 11328.8 11330.3 16171.8 16366.0 16369.3 16376.2 16400.8 7181.5 7362.3 7379.4 7407.9 7423.6 830.0 883.5 911.9 958.8 965.0 24547.0 24967.0 25101.2 25353.5 25361.6 883.8 907.6 952.1 1000.7 1009.6 13004.2 13004.9 13029.9 13163.4 13182.5 379488.0 386423.0 392282.0 393082.0 393136.0 45774.8 46250.5 46607.0 46804.3 46984.0 1158.6 1200.0 1207.6 1208.2 1210.7 24119.4 24490.6 24650.5 24858.3 24935.6 39426.4 39885.4 40198.8 40250.4 40327.2 229139.0 231840.0 234211.0 234755.0 235627.0 22760.0 23027.1 25238.5 26409.0 26578.0 31822.8 31935.2 32317.4 32842.3 33024.7 27759.0 28007.4 28074.7 30261.4 30643.2 23154.8 28189.2 28747.4 28832.3 29450.6 25028.1 27459.9 28888.9 29350.3 29994.0 26298.6 27274.5 27400.0 27476.0 27839.2 20066.8 20462.7 20466.8 20731.5 20781.7 09:11:09 INFO - 2015-11-06 09:11:09,259 DEBUG : BROWSER_OUTPUT: 09:11:09 INFO - 2015-11-06 09:11:09,259 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24154.35 Median:46168.92 stddev:84188.48 (182.3%) stddev-sans-first:84405.56 09:11:09 INFO - 2015-11-06 09:11:09,260 DEBUG : BROWSER_OUTPUT: Values: 282.8 289.9 290.6 290.9 292.3 8338.7 9061.0 14534.1 15258.7 15301.1 9124.6 10142.5 10176.3 10395.2 10435.0 3691.4 3803.1 3822.5 3825.1 3870.7 2866.6 2965.2 2974.1 3769.8 3866.2 3966.9 4047.8 4078.7 4097.5 4115.1 4072.2 4085.2 4092.3 4096.2 4102.1 3433.8 3512.8 3516.1 3517.4 3556.0 11463.1 11713.1 11716.5 11726.6 11870.9 1556.8 1603.1 1613.4 1634.8 1652.8 8025.7 8396.8 8452.8 8466.7 8496.6 1322.1 1332.9 1357.4 1359.4 1365.5 40420.4 46107.3 46230.5 47441.5 48558.3 5542.4 5586.1 5589.9 5609.1 5674.2 6356.8 6372.2 6474.8 6475.5 6479.4 4771.2 4805.6 4853.7 4855.6 4864.5 5209.6 5248.9 5250.3 5272.1 5293.9 2555.4 2573.2 2576.4 2587.9 2593.1 880.4 893.2 898.4 903.4 958.7 302.9 343.5 373.6 388.4 390.3 9880.3 9972.2 10002.3 10164.7 10618.4 316.3 386.2 389.4 394.6 404.1 5235.5 5385.2 5486.4 5509.4 5511.7 494933.0 502371.0 509777.0 518763.0 543438.2 62165.0 64537.0 64964.4 65147.3 65165.8 416.4 427.6 427.8 428.3 433.1 9371.5 9469.9 9528.8 9571.7 9706.7 30210.5 31080.1 31557.5 31583.4 31610.2 42030.4 42717.8 42912.4 43060.4 43163.0 5170.7 5222.7 5225.8 5305.9 5324.6 9869.8 10013.0 10152.1 10192.2 10209.5 8662.7 8751.6 8775.9 8858.5 8878.4 8326.6 8417.2 8464.2 8520.6 8688.3 8721.1 8806.7 8856.0 9001.1 9007.7 4788.4 4938.4 5270.7 5271.3 5273.5 8275.0 8457.7 8553.0 8623.1 8635.4 09:11:09 INFO - 2015-11-06 09:11:09,260 DEBUG : BROWSER_OUTPUT: 09:11:09 INFO - 2015-11-06 09:11:09,260 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4564.69 Median:3203.18 stddev:2347.62 (73.3%) stddev-sans-first:2341.74 09:11:09 INFO - 2015-11-06 09:11:09,262 DEBUG : BROWSER_OUTPUT: Values: 1345.7 1435.9 1520.4 1522.7 1563.7 6036.0 6244.2 6344.4 6415.7 6430.3 6428.0 6557.8 6559.5 6602.5 6624.6 1637.6 1673.7 1894.0 1921.8 1923.0 1728.2 1881.6 1939.5 1940.4 1941.0 1792.4 1832.3 1850.6 1865.8 1866.6 1885.7 1897.2 1902.7 1903.1 1904.8 1820.9 1832.4 1842.6 1858.3 1859.5 6547.8 6608.3 6621.1 6624.1 6683.3 4032.1 4108.7 4112.6 4118.8 4159.8 2302.4 2380.7 2384.1 2415.8 2452.7 720.9 729.6 1247.6 1279.3 1337.4 8520.3 8625.9 8653.0 8657.3 8761.4 3576.3 3648.3 3710.4 3713.1 3763.9 7672.5 7672.6 7685.8 7695.2 7779.1 4165.0 4172.0 4172.4 4212.3 4223.6 3804.8 3806.7 3808.7 3842.4 3862.1 2842.0 2924.1 3048.8 3051.1 3061.5 937.5 969.7 998.2 1003.3 1025.7 894.9 910.4 910.6 912.3 1095.7 6248.6 6260.7 6278.3 6279.8 6337.5 573.4 578.6 579.9 582.1 715.0 4734.4 4825.2 4829.4 4832.0 4923.7 7367.5 7534.5 7614.5 7659.4 7740.3 7647.8 7707.0 7720.4 7725.3 7738.6 6201.8 6242.2 6251.7 6255.8 6271.1 6130.8 6174.8 6184.8 6190.1 6251.9 6907.0 7038.9 7043.4 7079.7 7087.2 6977.8 7142.0 7240.1 7254.1 7255.9 5844.8 5918.7 5919.1 5932.7 5986.2 5146.4 6298.1 6316.3 6384.0 6384.7 5115.5 5158.8 5557.5 5950.7 5993.6 5647.4 5757.4 5824.2 5841.7 5950.3 5862.2 5910.5 5913.9 5926.6 5996.4 5414.0 5416.1 5429.9 5459.7 5511.2 5141.4 5174.6 5195.3 5223.3 5241.6 09:11:09 INFO - 2015-11-06 09:11:09,262 DEBUG : BROWSER_OUTPUT: 09:11:09 INFO - 2015-11-06 09:11:09,262 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4595.04 Median:5290.31 stddev:1398.97 (26.4%) stddev-sans-first:1364.59 09:11:09 INFO - 2015-11-06 09:11:09,263 DEBUG : BROWSER_OUTPUT: Values: 262.9 266.9 267.3 271.9 273.2 5226.9 5233.5 5263.8 5278.5 5289.0 5077.4 5120.2 5134.8 5135.6 5224.2 3831.3 3880.6 3902.4 3924.0 4051.4 3986.5 3986.9 4001.3 4036.4 4061.8 3932.7 3948.0 3991.8 4005.3 4006.2 3841.0 3884.2 3908.3 3918.4 4024.9 3429.7 3432.8 3437.7 3477.9 3482.1 5034.4 5087.9 5094.0 5100.7 5117.2 4457.8 4475.6 4484.5 4535.6 4540.3 5371.6 5471.7 5494.1 5569.1 5578.1 3777.6 3786.8 3833.7 3840.9 3842.4 5748.1 5775.4 5778.7 5807.7 5888.7 3834.2 3862.7 3864.3 3909.4 3910.1 3475.1 3681.2 3893.1 3908.2 3939.7 4349.2 4362.1 4378.5 4417.7 4542.3 5311.2 5415.5 5431.7 5484.2 5489.1 1400.7 1409.8 1412.6 1416.0 1432.7 909.7 914.3 927.2 936.0 940.3 5243.7 5269.4 5291.7 5330.1 5356.1 5730.7 5735.3 5739.1 5747.4 5749.9 5294.2 5295.2 5320.8 5336.1 5336.7 2899.1 3003.7 3124.2 3147.5 3183.8 5790.0 5832.7 5834.6 5869.3 5892.1 5749.3 5768.3 5851.2 5874.0 5876.5 5784.0 5788.0 5868.1 5870.7 5876.7 5519.6 5764.6 5788.9 5799.8 5839.9 5595.4 5638.9 5665.2 5708.2 5715.4 5862.7 5896.6 5964.4 5989.1 5992.6 3738.2 3757.4 3826.5 3827.2 3854.6 5634.6 5640.7 5659.4 5661.5 5716.8 5485.2 5489.4 5502.5 5530.1 5571.8 5482.5 5496.7 5499.8 5541.3 5557.3 5189.4 5344.7 5372.0 5375.5 5446.4 5463.6 5482.9 5545.6 5549.3 5555.0 5170.3 5270.4 5271.2 5402.6 5432.1 09:11:09 INFO - 2015-11-06 09:11:09,263 DEBUG : BROWSER_OUTPUT: 09:11:09 INFO - 2015-11-06 09:11:09,263 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11971.17 Median:55127.50 stddev:15085.05 (27.4%) stddev-sans-first:15103.40 09:11:09 INFO - 2015-11-06 09:11:09,264 DEBUG : BROWSER_OUTPUT: Values: 646.4 648.0 659.1 666.1 673.4 11939.8 12342.4 12459.6 12464.3 12485.6 11326.2 11476.8 11555.8 11633.7 11668.8 581.6 628.1 628.8 756.6 762.0 770.5 771.9 772.1 782.9 790.4 830.3 830.5 830.9 832.2 839.4 572.0 639.0 762.2 815.7 817.9 603.6 604.8 604.9 606.0 606.4 11733.9 11920.0 11939.4 11943.9 11963.0 9948.1 9975.6 10551.4 10594.5 10730.0 7806.6 8169.6 8181.1 8223.0 8368.1 2434.2 2519.1 2544.7 2852.9 2934.9 42007.2 42554.0 42597.0 42665.0 42755.6 5959.3 6137.9 6139.4 6151.4 6327.1 10488.2 10550.2 10657.1 10683.9 10698.3 5307.7 5317.8 5487.5 5491.6 5500.2 3265.0 3351.1 3365.3 3443.3 3475.6 2245.2 2262.8 2293.9 2294.0 2299.7 328.9 331.2 345.7 345.9 346.7 464.2 501.5 520.6 532.5 533.9 6596.4 6753.5 6864.2 6882.3 7042.4 387.5 410.8 487.4 496.0 502.3 3135.8 3135.8 3170.6 3177.9 3188.3 54418.5 55087.0 55168.0 55795.4 56433.7 45754.9 47069.0 47101.8 47218.0 47304.0 43136.4 43604.6 43918.8 44063.6 44133.0 6859.4 6946.9 7085.8 7158.1 7220.6 32111.7 32463.5 32526.5 32675.5 32904.2 42107.8 42141.6 42840.4 43055.8 43444.6 6557.5 6570.3 6623.5 6792.2 6861.1 9505.6 9752.2 9825.8 9939.0 10415.9 9033.2 9045.9 9062.0 9077.9 9089.1 9048.5 9112.2 9157.1 9168.9 9191.5 8903.5 8993.2 9027.1 9100.3 9549.1 7562.1 7734.1 7871.6 8216.5 8238.3 7591.5 7891.5 7986.3 8093.4 8198.4 09:11:09 INFO - 2015-11-06 09:11:09,264 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:11:09 INFO - 2015-11-06 09:11:09,264 DEBUG : BROWSER_OUTPUT: 09:11:09 INFO - 2015-11-06 09:11:09,940 INFO : Browser exited with error code: 0 09:11:09 INFO - 2015-11-06 09:11:09,972 INFO : Completed test dromaeo_css (00:18:35) 09:11:09 INFO - 2015-11-06 09:11:09,972 INFO : Starting test kraken 09:11:09 INFO - 2015-11-06 09:11:09,972 DEBUG : operating with platform_type : mac_ 09:11:09 INFO - 2015-11-06 09:11:09,973 INFO : Initialising browser for kraken test... 09:11:09 INFO - 2015-11-06 09:11:09,988 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/tmpmy0cne/profile http://localhost:51407/getInfo.html 09:11:12 INFO - 2015-11-06 09:11:12,462 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:11:12 INFO - 2015-11-06 09:11:12,462 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:11:12 INFO - 2015-11-06 09:11:12,463 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 09:11:12 INFO - 2015-11-06 09:11:12,463 DEBUG : BROWSER_OUTPUT: __metrics 09:11:12 INFO - 2015-11-06 09:11:12,480 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:11:13 INFO - 2015-11-06 09:11:13,227 INFO : Browser initialized. 09:11:13 INFO - 2015-11-06 09:11:13,228 INFO : Running cycle 1/1 for kraken test... 09:11:13 INFO - 2015-11-06 09:11:13,228 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/tmpmy0cne/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:11:25 INFO - 2015-11-06 09:11:25,286 DEBUG : BROWSER_OUTPUT: RSS: Main: 221782016 09:11:25 INFO - 2015-11-06 09:11:25,287 DEBUG : BROWSER_OUTPUT: 09:11:28 INFO - 2015-11-06 09:11:28,110 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51407/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51407/tests/kraken/driver.html?testName=audio-beat-detection) 09:11:28 INFO - 2015-11-06 09:11:28,702 DEBUG : BROWSER_OUTPUT: RSS: Main: 278573056 09:11:28 INFO - 2015-11-06 09:11:28,702 DEBUG : BROWSER_OUTPUT: 09:11:31 INFO - 2015-11-06 09:11:31,682 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51407/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51407/tests/kraken/driver.html?testName=audio-dft) 09:11:32 INFO - 2015-11-06 09:11:32,278 DEBUG : BROWSER_OUTPUT: RSS: Main: 292003840 09:11:32 INFO - 2015-11-06 09:11:32,278 DEBUG : BROWSER_OUTPUT: 09:11:35 INFO - 2015-11-06 09:11:35,575 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51407/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51407/tests/kraken/driver.html?testName=audio-fft) 09:11:36 INFO - 2015-11-06 09:11:36,161 DEBUG : BROWSER_OUTPUT: RSS: Main: 277614592 09:11:36 INFO - 2015-11-06 09:11:36,162 DEBUG : BROWSER_OUTPUT: 09:11:38 INFO - 2015-11-06 09:11:38,378 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51407/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51407/tests/kraken/driver.html?testName=audio-oscillator) 09:11:38 INFO - 2015-11-06 09:11:38,971 DEBUG : BROWSER_OUTPUT: RSS: Main: 278867968 09:11:38 INFO - 2015-11-06 09:11:38,971 DEBUG : BROWSER_OUTPUT: 09:11:41 INFO - 2015-11-06 09:11:41,386 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51407/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51407/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:11:41 INFO - 2015-11-06 09:11:41,957 DEBUG : BROWSER_OUTPUT: RSS: Main: 279687168 09:11:41 INFO - 2015-11-06 09:11:41,957 DEBUG : BROWSER_OUTPUT: 09:11:45 INFO - 2015-11-06 09:11:45,401 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51407/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51407/tests/kraken/driver.html?testName=imaging-darkroom) 09:11:45 INFO - 2015-11-06 09:11:45,980 DEBUG : BROWSER_OUTPUT: RSS: Main: 280137728 09:11:45 INFO - 2015-11-06 09:11:45,980 DEBUG : BROWSER_OUTPUT: 09:11:49 INFO - 2015-11-06 09:11:49,529 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51407/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51407/tests/kraken/driver.html?testName=imaging-desaturate) 09:11:50 INFO - 2015-11-06 09:11:50,116 DEBUG : BROWSER_OUTPUT: RSS: Main: 277712896 09:11:50 INFO - 2015-11-06 09:11:50,116 DEBUG : BROWSER_OUTPUT: 09:11:53 INFO - 2015-11-06 09:11:53,385 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51407/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51407/tests/kraken/driver.html?testName=json-parse-financial) 09:11:53 INFO - 2015-11-06 09:11:53,975 DEBUG : BROWSER_OUTPUT: RSS: Main: 278208512 09:11:53 INFO - 2015-11-06 09:11:53,975 DEBUG : BROWSER_OUTPUT: 09:11:55 INFO - 2015-11-06 09:11:55,663 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51407/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51407/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:11:56 INFO - 2015-11-06 09:11:56,247 DEBUG : BROWSER_OUTPUT: RSS: Main: 312135680 09:11:56 INFO - 2015-11-06 09:11:56,247 DEBUG : BROWSER_OUTPUT: 09:11:58 INFO - 2015-11-06 09:11:58,237 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51407/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51407/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:11:58 INFO - 2015-11-06 09:11:58,850 DEBUG : BROWSER_OUTPUT: RSS: Main: 313544704 09:11:58 INFO - 2015-11-06 09:11:58,851 DEBUG : BROWSER_OUTPUT: 09:12:01 INFO - 2015-11-06 09:12:01,168 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51407/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51407/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:12:01 INFO - 2015-11-06 09:12:01,757 DEBUG : BROWSER_OUTPUT: RSS: Main: 320258048 09:12:01 INFO - 2015-11-06 09:12:01,757 DEBUG : BROWSER_OUTPUT: 09:12:04 INFO - 2015-11-06 09:12:04,663 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51407/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51407/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:12:05 INFO - 2015-11-06 09:12:05,256 DEBUG : BROWSER_OUTPUT: RSS: Main: 320888832 09:12:05 INFO - 2015-11-06 09:12:05,256 DEBUG : BROWSER_OUTPUT: 09:12:08 INFO - 2015-11-06 09:12:08,177 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51407/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51407/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:12:08 INFO - 2015-11-06 09:12:08,770 DEBUG : BROWSER_OUTPUT: RSS: Main: 322170880 09:12:08 INFO - 2015-11-06 09:12:08,770 DEBUG : BROWSER_OUTPUT: 09:12:10 INFO - 2015-11-06 09:12:10,670 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51407/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51407/tests/kraken/driver.html?testName=ai-astar) 09:12:10 INFO - 2015-11-06 09:12:10,926 DEBUG : BROWSER_OUTPUT: RSS: Main: 380862464 09:12:10 INFO - 2015-11-06 09:12:10,926 DEBUG : BROWSER_OUTPUT: 09:12:10 INFO - 2015-11-06 09:12:10,926 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:12:10 INFO - 2015-11-06 09:12:10,926 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:12:10 INFO - 2015-11-06 09:12:10,926 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:12:10 INFO - 2015-11-06 09:12:10,926 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:12:10 INFO - 2015-11-06 09:12:10,926 DEBUG : BROWSER_OUTPUT: |0;ai-astar;122;125;117;125;126;128;125;127;125;133 09:12:10 INFO - 2015-11-06 09:12:10,926 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;183;150;182;196;153;173;172;148;195;155 09:12:10 INFO - 2015-11-06 09:12:10,927 DEBUG : BROWSER_OUTPUT: |2;audio-dft;185;189;188;188;190;189;189;188;187;191 09:12:10 INFO - 2015-11-06 09:12:10,927 DEBUG : BROWSER_OUTPUT: |3;audio-fft;88;90;103;100;82;84;85;99;98;77 09:12:10 INFO - 2015-11-06 09:12:10,927 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;109;111;161;103;105;104;151;103;103;156 09:12:10 INFO - 2015-11-06 09:12:10,927 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;135;136;135;136;135;142;135;142;144;135 09:12:10 INFO - 2015-11-06 09:12:10,927 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;147;148;147;147;147;154;148;147 09:12:10 INFO - 2015-11-06 09:12:10,927 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;119;123;123;118;121;124;124;119;119;119 09:12:10 INFO - 2015-11-06 09:12:10,927 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;61;64;68;66;67;68;67;79;65;68 09:12:10 INFO - 2015-11-06 09:12:10,927 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;72;75;79;80;79;79;79;79;80;80 09:12:10 INFO - 2015-11-06 09:12:10,928 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;97;102;100;104;105;108;100;101;101;102 09:12:10 INFO - 2015-11-06 09:12:10,928 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;147;151;152;145;162;144;154;158;151;151 09:12:10 INFO - 2015-11-06 09:12:10,928 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;163;165;176;180;176;179;177;179;187;173 09:12:10 INFO - 2015-11-06 09:12:10,928 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;81;82;81;82;82;84;83;83;83;82 09:12:10 INFO - 2015-11-06 09:12:10,928 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:12:10 INFO - 2015-11-06 09:12:10,928 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:12:10 INFO - 2015-11-06 09:12:10,929 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,949 09:12:10 INFO - 2015-11-06 09:12:10,929 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:12:10 INFO - 2015-11-06 09:12:10,929 DEBUG : BROWSER_OUTPUT: __startTimestamp1446829930924__endTimestamp 09:12:10 INFO - 2015-11-06 09:12:10,929 DEBUG : BROWSER_OUTPUT: 09:12:10 INFO - 2015-11-06 09:12:10,929 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:12:10 INFO - 2015-11-06 09:12:10,931 DEBUG : BROWSER_OUTPUT: Number of tests: 14 09:12:10 INFO - 2015-11-06 09:12:10,931 DEBUG : BROWSER_OUTPUT: 09:12:10 INFO - 2015-11-06 09:12:10,931 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:125.30 Median:125.50 stddev:4.08 (3.3%) stddev-sans-first:4.15 09:12:10 INFO - 2015-11-06 09:12:10,931 DEBUG : BROWSER_OUTPUT: Values: 122.0 125.0 117.0 125.0 126.0 128.0 125.0 127.0 125.0 133.0 09:12:10 INFO - 2015-11-06 09:12:10,931 DEBUG : BROWSER_OUTPUT: 09:12:10 INFO - 2015-11-06 09:12:10,931 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:170.70 Median:177.50 stddev:18.32 (10.3%) stddev-sans-first:18.88 09:12:10 INFO - 2015-11-06 09:12:10,931 DEBUG : BROWSER_OUTPUT: Values: 183.0 150.0 182.0 196.0 153.0 173.0 172.0 148.0 195.0 155.0 09:12:10 INFO - 2015-11-06 09:12:10,932 DEBUG : BROWSER_OUTPUT: 09:12:10 INFO - 2015-11-06 09:12:10,932 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:188.40 Median:189.00 stddev:1.65 (0.9%) stddev-sans-first:1.20 09:12:10 INFO - 2015-11-06 09:12:10,932 DEBUG : BROWSER_OUTPUT: Values: 185.0 189.0 188.0 188.0 190.0 189.0 189.0 188.0 187.0 191.0 09:12:10 INFO - 2015-11-06 09:12:10,932 DEBUG : BROWSER_OUTPUT: 09:12:10 INFO - 2015-11-06 09:12:10,932 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:90.60 Median:86.50 stddev:8.87 (10.3%) stddev-sans-first:9.36 09:12:10 INFO - 2015-11-06 09:12:10,932 DEBUG : BROWSER_OUTPUT: Values: 88.0 90.0 103.0 100.0 82.0 84.0 85.0 99.0 98.0 77.0 09:12:10 INFO - 2015-11-06 09:12:10,933 DEBUG : BROWSER_OUTPUT: 09:12:10 INFO - 2015-11-06 09:12:10,933 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:120.60 Median:110.00 stddev:24.69 (22.4%) stddev-sans-first:25.82 09:12:10 INFO - 2015-11-06 09:12:10,933 DEBUG : BROWSER_OUTPUT: Values: 109.0 111.0 161.0 103.0 105.0 104.0 151.0 103.0 103.0 156.0 09:12:10 INFO - 2015-11-06 09:12:10,933 DEBUG : BROWSER_OUTPUT: 09:12:10 INFO - 2015-11-06 09:12:10,933 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:137.50 Median:136.00 stddev:3.63 (2.7%) stddev-sans-first:3.73 09:12:10 INFO - 2015-11-06 09:12:10,934 DEBUG : BROWSER_OUTPUT: Values: 135.0 136.0 135.0 136.0 135.0 142.0 135.0 142.0 144.0 135.0 09:12:10 INFO - 2015-11-06 09:12:10,934 DEBUG : BROWSER_OUTPUT: 09:12:10 INFO - 2015-11-06 09:12:10,934 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.00 Median:147.50 stddev:2.16 (1.5%) stddev-sans-first:2.29 09:12:10 INFO - 2015-11-06 09:12:10,934 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 147.0 148.0 147.0 147.0 147.0 154.0 148.0 147.0 09:12:10 INFO - 2015-11-06 09:12:10,934 DEBUG : BROWSER_OUTPUT: 09:12:10 INFO - 2015-11-06 09:12:10,935 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:120.90 Median:122.00 stddev:2.38 (1.9%) stddev-sans-first:2.42 09:12:10 INFO - 2015-11-06 09:12:10,936 DEBUG : BROWSER_OUTPUT: Values: 119.0 123.0 123.0 118.0 121.0 124.0 124.0 119.0 119.0 119.0 09:12:10 INFO - 2015-11-06 09:12:10,936 DEBUG : BROWSER_OUTPUT: 09:12:10 INFO - 2015-11-06 09:12:10,936 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:67.30 Median:67.50 stddev:4.67 (6.9%) stddev-sans-first:4.36 09:12:10 INFO - 2015-11-06 09:12:10,936 DEBUG : BROWSER_OUTPUT: Values: 61.0 64.0 68.0 66.0 67.0 68.0 67.0 79.0 65.0 68.0 09:12:10 INFO - 2015-11-06 09:12:10,936 DEBUG : BROWSER_OUTPUT: 09:12:10 INFO - 2015-11-06 09:12:10,936 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:78.20 Median:79.00 stddev:2.62 (3.3%) stddev-sans-first:1.54 09:12:10 INFO - 2015-11-06 09:12:10,936 DEBUG : BROWSER_OUTPUT: Values: 72.0 75.0 79.0 80.0 79.0 79.0 79.0 79.0 80.0 80.0 09:12:10 INFO - 2015-11-06 09:12:10,936 DEBUG : BROWSER_OUTPUT: 09:12:10 INFO - 2015-11-06 09:12:10,936 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:102.00 Median:103.00 stddev:3.06 (3.0%) stddev-sans-first:2.65 09:12:10 INFO - 2015-11-06 09:12:10,936 DEBUG : BROWSER_OUTPUT: Values: 97.0 102.0 100.0 104.0 105.0 108.0 100.0 101.0 101.0 102.0 09:12:10 INFO - 2015-11-06 09:12:10,936 DEBUG : BROWSER_OUTPUT: 09:12:10 INFO - 2015-11-06 09:12:10,936 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:151.50 Median:151.50 stddev:5.56 (3.7%) stddev-sans-first:5.66 09:12:10 INFO - 2015-11-06 09:12:10,936 DEBUG : BROWSER_OUTPUT: Values: 147.0 151.0 152.0 145.0 162.0 144.0 154.0 158.0 151.0 151.0 09:12:10 INFO - 2015-11-06 09:12:10,937 DEBUG : BROWSER_OUTPUT: 09:12:10 INFO - 2015-11-06 09:12:10,937 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.50 Median:178.00 stddev:7.09 (4.0%) stddev-sans-first:5.90 09:12:10 INFO - 2015-11-06 09:12:10,937 DEBUG : BROWSER_OUTPUT: Values: 163.0 165.0 176.0 180.0 176.0 179.0 177.0 179.0 187.0 173.0 09:12:10 INFO - 2015-11-06 09:12:10,937 DEBUG : BROWSER_OUTPUT: 09:12:10 INFO - 2015-11-06 09:12:10,937 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:82.30 Median:82.50 stddev:0.95 (1.1%) stddev-sans-first:0.88 09:12:10 INFO - 2015-11-06 09:12:10,937 DEBUG : BROWSER_OUTPUT: Values: 81.0 82.0 81.0 82.0 82.0 84.0 83.0 83.0 83.0 82.0 09:12:10 INFO - 2015-11-06 09:12:10,937 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:12:10 INFO - 2015-11-06 09:12:10,937 DEBUG : BROWSER_OUTPUT: 09:12:11 INFO - 2015-11-06 09:12:11,674 INFO : Browser exited with error code: 0 09:12:11 INFO - 2015-11-06 09:12:11,731 INFO : Completed test kraken (00:01:01) 09:12:11 INFO - 2015-11-06 09:12:11,731 INFO : Starting test v8_7 09:12:11 INFO - 2015-11-06 09:12:11,731 DEBUG : operating with platform_type : mac_ 09:12:11 INFO - 2015-11-06 09:12:11,731 INFO : Initialising browser for v8_7 test... 09:12:11 INFO - 2015-11-06 09:12:11,747 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/tmpnnlhk7/profile http://localhost:51407/getInfo.html 09:12:14 INFO - 2015-11-06 09:12:14,127 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:12:14 INFO - 2015-11-06 09:12:14,127 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:12:14 INFO - 2015-11-06 09:12:14,127 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 09:12:14 INFO - 2015-11-06 09:12:14,128 DEBUG : BROWSER_OUTPUT: __metrics 09:12:14 INFO - 2015-11-06 09:12:14,148 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:12:14 INFO - 2015-11-06 09:12:14,881 INFO : Browser initialized. 09:12:14 INFO - 2015-11-06 09:12:14,881 INFO : Running cycle 1/1 for v8_7 test... 09:12:14 INFO - 2015-11-06 09:12:14,882 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8w/xy9v5xw56415wls9095pr92m00000w/T/tmpnnlhk7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:12:26 INFO - 2015-11-06 09:12:26,950 DEBUG : BROWSER_OUTPUT: RSS: Main: 222511104 09:12:26 INFO - 2015-11-06 09:12:26,950 DEBUG : BROWSER_OUTPUT: 09:12:49 INFO - 2015-11-06 09:12:49,840 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51407/tests/v8_7/run.html (next: http://localhost:51407/tests/v8_7/run.html) 09:12:50 INFO - 2015-11-06 09:12:50,098 DEBUG : BROWSER_OUTPUT: RSS: Main: 601341952 09:12:50 INFO - 2015-11-06 09:12:50,098 DEBUG : BROWSER_OUTPUT: 09:12:50 INFO - 2015-11-06 09:12:50,098 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:12:50 INFO - 2015-11-06 09:12:50,098 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:12:50 INFO - 2015-11-06 09:12:50,099 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:12:50 INFO - 2015-11-06 09:12:50,099 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:12:50 INFO - 2015-11-06 09:12:50,099 DEBUG : BROWSER_OUTPUT: |0;Richards;192.19680953296177 09:12:50 INFO - 2015-11-06 09:12:50,099 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;222.3210315695865 09:12:50 INFO - 2015-11-06 09:12:50,099 DEBUG : BROWSER_OUTPUT: |2;Encrypt;369.2762186115214 09:12:50 INFO - 2015-11-06 09:12:50,099 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6856.164383561644 09:12:50 INFO - 2015-11-06 09:12:50,099 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2391.4081145584723 09:12:50 INFO - 2015-11-06 09:12:50,099 DEBUG : BROWSER_OUTPUT: |5;Earley;1053.740779768177 09:12:50 INFO - 2015-11-06 09:12:50,099 DEBUG : BROWSER_OUTPUT: |6;Boyer;14550.72463768116 09:12:50 INFO - 2015-11-06 09:12:50,099 DEBUG : BROWSER_OUTPUT: |7;RegExp;34627.1186440678 09:12:50 INFO - 2015-11-06 09:12:50,099 DEBUG : BROWSER_OUTPUT: |8;Splay;720.4610951008646 09:12:50 INFO - 2015-11-06 09:12:50,099 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6700 09:12:50 INFO - 2015-11-06 09:12:50,100 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:12:50 INFO - 2015-11-06 09:12:50,100 DEBUG : BROWSER_OUTPUT: __startTimestamp1446829970093__endTimestamp 09:12:50 INFO - 2015-11-06 09:12:50,100 DEBUG : BROWSER_OUTPUT: 09:12:50 INFO - 2015-11-06 09:12:50,100 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:12:50 INFO - 2015-11-06 09:12:50,100 DEBUG : BROWSER_OUTPUT: Number of tests: 10 09:12:50 INFO - 2015-11-06 09:12:50,100 DEBUG : BROWSER_OUTPUT: 09:12:50 INFO - 2015-11-06 09:12:50,100 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:192.20 Median:192.20 stddev:0.00 (0.0%) 09:12:50 INFO - 2015-11-06 09:12:50,100 DEBUG : BROWSER_OUTPUT: Values: 192.2 09:12:50 INFO - 2015-11-06 09:12:50,100 DEBUG : BROWSER_OUTPUT: 09:12:50 INFO - 2015-11-06 09:12:50,100 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:222.32 Median:222.32 stddev:0.00 (0.0%) 09:12:50 INFO - 2015-11-06 09:12:50,100 DEBUG : BROWSER_OUTPUT: Values: 222.3 09:12:50 INFO - 2015-11-06 09:12:50,100 DEBUG : BROWSER_OUTPUT: 09:12:50 INFO - 2015-11-06 09:12:50,100 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:369.28 Median:369.28 stddev:0.00 (0.0%) 09:12:50 INFO - 2015-11-06 09:12:50,101 DEBUG : BROWSER_OUTPUT: Values: 369.3 09:12:50 INFO - 2015-11-06 09:12:50,101 DEBUG : BROWSER_OUTPUT: 09:12:50 INFO - 2015-11-06 09:12:50,101 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6856.16 Median:6856.16 stddev:0.00 (0.0%) 09:12:50 INFO - 2015-11-06 09:12:50,101 DEBUG : BROWSER_OUTPUT: Values: 6856.2 09:12:50 INFO - 2015-11-06 09:12:50,101 DEBUG : BROWSER_OUTPUT: 09:12:50 INFO - 2015-11-06 09:12:50,101 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2391.41 Median:2391.41 stddev:0.00 (0.0%) 09:12:50 INFO - 2015-11-06 09:12:50,101 DEBUG : BROWSER_OUTPUT: Values: 2391.4 09:12:50 INFO - 2015-11-06 09:12:50,101 DEBUG : BROWSER_OUTPUT: 09:12:50 INFO - 2015-11-06 09:12:50,101 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:1053.74 Median:1053.74 stddev:0.00 (0.0%) 09:12:50 INFO - 2015-11-06 09:12:50,101 DEBUG : BROWSER_OUTPUT: Values: 1053.7 09:12:50 INFO - 2015-11-06 09:12:50,101 DEBUG : BROWSER_OUTPUT: 09:12:50 INFO - 2015-11-06 09:12:50,101 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:14550.72 Median:14550.72 stddev:0.00 (0.0%) 09:12:50 INFO - 2015-11-06 09:12:50,101 DEBUG : BROWSER_OUTPUT: Values: 14550.7 09:12:50 INFO - 2015-11-06 09:12:50,102 DEBUG : BROWSER_OUTPUT: 09:12:50 INFO - 2015-11-06 09:12:50,102 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:34627.12 Median:34627.12 stddev:0.00 (0.0%) 09:12:50 INFO - 2015-11-06 09:12:50,102 DEBUG : BROWSER_OUTPUT: Values: 34627.1 09:12:50 INFO - 2015-11-06 09:12:50,102 DEBUG : BROWSER_OUTPUT: 09:12:50 INFO - 2015-11-06 09:12:50,102 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:720.46 Median:720.46 stddev:0.00 (0.0%) 09:12:50 INFO - 2015-11-06 09:12:50,102 DEBUG : BROWSER_OUTPUT: Values: 720.5 09:12:50 INFO - 2015-11-06 09:12:50,102 DEBUG : BROWSER_OUTPUT: 09:12:50 INFO - 2015-11-06 09:12:50,102 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6700.00 Median:6700.00 stddev:0.00 (0.0%) 09:12:50 INFO - 2015-11-06 09:12:50,102 DEBUG : BROWSER_OUTPUT: Values: 6700.0 09:12:50 INFO - 2015-11-06 09:12:50,102 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:12:50 INFO - 2015-11-06 09:12:50,102 DEBUG : BROWSER_OUTPUT: 09:12:50 INFO - 2015-11-06 09:12:50,810 INFO : Browser exited with error code: 0 09:12:50 INFO - 2015-11-06 09:12:50,834 INFO : Completed test v8_7 (00:00:39) 09:12:51 INFO - 2015-11-06 09:12:51,327 INFO : Completed test suite (00:20:16) 09:12:51 INFO - 2015-11-06 09:12:51,327 DEBUG : Working with test: dromaeo_css 09:12:51 INFO - 2015-11-06 09:12:51,327 DEBUG : Generating results file: dromaeo_css 09:12:51 INFO - 2015-11-06 09:12:51,327 DEBUG : Working with test: kraken 09:12:51 INFO - 2015-11-06 09:12:51,328 DEBUG : Generating results file: kraken 09:12:51 INFO - 2015-11-06 09:12:51,328 INFO : javascript benchmark 09:12:51 INFO - 2015-11-06 09:12:51,328 DEBUG : Working with test: v8_7 09:12:51 INFO - 2015-11-06 09:12:51,328 DEBUG : Generating results file: v8_7 09:12:51 INFO - 2015-11-06 09:12:51,328 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:12:51 INFO - 2015-11-06 09:12:51,384 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,55]] 09:12:51 INFO - 2015-11-06 09:12:51,384 DEBUG : process_Request line: dromaeo_css 5661.57 graph.html#tests=[[72,64,55]] 09:12:51 INFO - 2015-11-06 09:12:51,384 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:12:51 INFO - 2015-11-06 09:12:51,414 DEBUG : process_Request line: kraken 1758.80 graph.html#tests=[[232,64,55]] 09:12:51 INFO - 2015-11-06 09:12:51,414 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:12:51 INFO - 2015-11-06 09:12:51,448 DEBUG : process_Request line: v8_7 15766.03 graph.html#tests=[[230,64,55]] 09:12:51 INFO - 2015-11-06 09:12:51,449 INFO : javascript benchmark 09:12:51 INFO - 2015-11-06 09:12:51,451 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [282.77801925488495, 289.8854952293843, 290.6250936292183, 290.87492378277335, 292.3320213312581, 8338.70814521492, 9061.048589898064, 14534.127952322868, 15258.694826103485, 15301.081935083888, 9124.635014599407, 10142.54358553865, 10176.287659863812, 10395.168386529078, 10435.0, 3691.427828686551, 3803.0872590578338, 3822.503074600298, 3825.08198032473, 3870.7290489665734, 2866.641669791276, 2965.2142182321704, 2974.1226338230167, 3769.8303576338994, 3866.1881004988986, 3966.900827479322, 4047.7773722445254, 4078.653314468274, 4097.549269580344, 4115.053537686319, 4072.1855628874046, 4085.1829634073156, 4092.263392589333, 4096.160287141129, 4102.077032667656, 3433.759636825423, 3512.8067956262394, 3516.1209697575605, 3517.3844577199143, 3555.982220088883, 11463.140264480115, 11713.121515886258, 11716.53133874644, 11726.589569365116, 11870.881291187065, 1556.750919852818, 1603.1102737980416, 1613.4433620400944, 1634.8446897544713, 1652.8016638003517, 8025.678972841138, 8396.83206335876, 8452.83094338116, 8466.74599762008, 8496.575171241413, 1322.1207896748651, 1332.8867046301077, 1357.4095268558208, 1359.4154513559165, 1365.49476693623, 40420.393694094615, 46107.30839037417, 46230.537694623294, 47441.5255847444, 48558.27162592564, 5542.445755424425, 5586.078297081018, 5589.916151257735, 5609.074502707008, 5674.2339784129435, 6356.809295721136, 6372.171617689671, 6474.805755827333, 6475.514336424787, 6479.416852483299, 4771.212749896297, 4805.639577031667, 4853.733044682576, 4855.635827312965, 4864.489228631013, 5209.557187639018, 5248.868778280497, 5250.264962905197, 5272.051030814414, 5293.894122117536, 2555.399481121935, 2573.189445324717, 2576.4460640962284, 2587.8835452404687, 2593.0664960614163, 880.3837313880309, 893.1957445959126, 898.4384759525296, 903.3676426501476, 958.7075941837667, 302.86825231024574, 343.51564294344854, 373.6170425314075, 388.3844107090237, 390.26435169704746, 9880.258980576342, 9972.202223822076, 10002.349847259904, 10164.695059148238, 10618.36289822613, 316.34043020302465, 386.2313995149632, 389.43726315474436, 394.6389054015601, 404.1008755519006, 5235.476452354734, 5385.192221166856, 5486.423925487767, 5509.449055094458, 5511.669299842022, 494933.0, 502371.0, 509777.0, 518763.0, 543438.2421318417, 62165.0, 64537.0, 64964.350356496776, 65147.34852651413, 65165.764225325205, 416.3504932305613, 427.56815616227215, 427.7989345007841, 428.3296640757205, 433.06674117277316, 9371.531423428938, 9469.905300946903, 9528.809423811623, 9571.664991725256, 9706.70879873605, 30210.46397627124, 31080.067597972098, 31557.52663710092, 31583.36833263368, 31610.209744756565, 42030.36954445625, 42717.78641106775, 42912.35631465468, 43060.35409468923, 43163.0, 5170.741462926914, 5222.686638801684, 5225.764840582259, 5305.893882122413, 5324.627276090637, 9869.802603948025, 10013.048760367754, 10152.086312231935, 10192.235582331503, 10209.489525523843, 8662.740117796477, 8751.649934002824, 8775.868361974448, 8858.512781797062, 8878.378513503993, 8326.62530186131, 8417.242448179693, 8464.195901389357, 8520.61657225414, 8688.26149777276, 8721.127887211482, 8806.691765788166, 8855.955720221358, 9001.054889236797, 9007.729768106967, 4788.377510923558, 4938.43208031081, 5270.657407268515, 5271.341082364705, 5273.472652734696, 8275.048369437593, 8457.746267611981, 8553.0, 8623.137686231326, 8635.352348573757], "dojo.html": [2629.658144441223, 2702.1893431970416, 2714.687810901747, 2719.9048033318836, 2773.3898542320694, 4436.0, 4570.1316749817515, 4592.265237561995, 4611.492735799059, 4642.907141857161, 4540.160070386989, 4542.636589072875, 4659.277811939146, 4660.883477913054, 4733.621310295177, 4200.495940487131, 4252.766097864616, 4259.212045771526, 4266.679999000072, 4346.76092814895, 4267.679924005696, 4327.935080973788, 4331.981984233718, 4384.079343337903, 4424.269995450747, 4038.0510580013674, 4129.070959034223, 4182.56083111275, 4233.407322974786, 4297.676262200872, 4159.480064991876, 4240.321548552217, 4278.657707383433, 4337.501187363462, 4349.282368409209, 4233.745975241495, 4275.40144379787, 4309.6336811371075, 4320.395144679747, 4345.217860785057, 4339.240632889232, 4531.297648864432, 4646.303054541812, 4685.461171965199, 4754.049190161982, 4718.3158442025715, 4830.758462076882, 4885.926711099336, 4906.852794416173, 4911.140550403665, 4967.379077615298, 4983.551480366785, 5007.874803129915, 5032.446430892599, 5069.290299358093, 4430.246858034142, 4487.528809475023, 4645.907081858378, 4674.766261686902, 4679.157751604744, 4977.626677999165, 5021.347224860745, 5031.22016087507, 5099.668521546162, 5151.124308867502, 4833.05755377705, 4884.3161957326, 4890.828820991248, 4905.484924082992, 4951.5048495150195, 4865.56209941107, 4951.331570238044, 4963.404391473046, 5037.395512538519, 5037.571806396424, 4847.612191024709, 4868.269759536098, 4901.779419926112, 4916.164252077156, 4945.0, 4862.975685121552, 4956.801727930842, 4957.603391728653, 4964.329815474937, 5000.149974504343, 3724.9068773280883, 3819.312523745697, 3821.006538300062, 3856.9228615427533, 3911.765294082364, 3356.815375154341, 3374.0552645259368, 3396.5924089109467, 3406.761526693157, 3415.299863527971, 4652.883677908079, 4692.507286734912, 4701.459332176843, 4703.7883295251795, 4720.95279047212, 4784.091022705745, 4908.680935739166, 5015.17249653803, 5033.0688822567945, 5041.563962597462, 4548.704334218265, 4559.156556037144, 4565.634749220055, 4611.446626404853, 4669.229577119737, 4366.432363792686, 4423.579759922803, 4427.512973572904, 4431.7340959542535, 4472.0832229393545, 4960.950390496048, 5042.697438153723, 5202.063628546823, 5211.921821172609, 5218.165093585084, 4878.902421951612, 4933.55597996182, 4973.45292017885, 5001.874953126201, 5002.849914502571, 5071.518205770446, 5115.488451154854, 5158.742062896915, 5160.509751573594, 5203.713795741271, 4796.112719146969, 4854.19905715553, 4919.950800492093, 4925.753712314298, 4937.407511098691, 4838.806447742191, 4880.90238195227, 4927.384076990376, 4938.111139994836, 4939.728314942713, 4787.8563643090765, 4801.447833499193, 4863.076015557032, 4869.147899117711, 4897.3878265216845, 4586.289125185602, 4713.363695901009, 4834.564889159992, 4855.781489832895, 4921.311016457627, 4625.884352891205, 4648.744319062349, 4675.532446755297, 4689.132510485571, 4696.412948381452, 4881.438634557071, 4895.241237608177, 4903.289023091703, 4914.70511769295, 4950.653454258168, 4598.448186217675, 4708.764561771829, 4751.667383283137, 4813.4945830687275, 4886.364772579542], "mootools.html": [1345.6972181259212, 1435.885129189665, 1520.429838810446, 1522.7182971150335, 1563.6638122803588, 6036.0, 6244.157038799766, 6344.39728225819, 6415.679216039202, 6430.260520040197, 6428.0, 6557.803265902018, 6559.47524198063, 6602.504812139085, 6624.635645039521, 1637.6397192617605, 1673.7071012572812, 1893.9715904261448, 1921.8174273444001, 1923.0096500302357, 1728.1704781704789, 1881.5766452548135, 1939.5442071113278, 1940.3984764722911, 1940.980590194094, 1792.4264235444598, 1832.303724584656, 1850.6206227723285, 1865.822746839048, 1866.5986812835238, 1885.6605810954022, 1897.231621193405, 1902.6860568006261, 1903.1150515010447, 1904.7999960004277, 1820.8998505082216, 1832.4411054628333, 1842.6498965196704, 1858.2659849359563, 1859.5258209156714, 6547.770828021044, 6608.339166083401, 6621.106150669646, 6624.072629831828, 6683.298253683391, 4032.1330913853367, 4108.6918481114035, 4112.629863312316, 4118.75287482752, 4159.750414975111, 2302.401375642345, 2380.6548050532574, 2384.1059602649007, 2415.7946574541184, 2452.6934133233344, 720.8990741296222, 729.616951100671, 1247.6381849263703, 1279.3475327583, 1337.3848029906255, 8520.275776559, 8625.870611940825, 8652.956735216347, 8657.26413254874, 8761.386702930797, 3576.2847430514003, 3648.325059863934, 3710.3692372296773, 3713.1088538750505, 3763.9435408468894, 7672.539647621049, 7672.616369181518, 7685.769426917202, 7695.23047695226, 7779.066512018594, 4165.042040330741, 4172.019575399779, 4172.374143878443, 4212.262854000538, 4223.556526564728, 3804.8097595120134, 3806.71449641278, 3808.6572208501366, 3842.404427313715, 3862.1310205203604, 2841.957370639442, 2924.0789151417234, 3048.84755762211, 3051.054173206313, 3061.479548476764, 937.4890684576922, 969.6896992962326, 998.1565577087349, 1003.2826529031777, 1025.6974192613197, 894.8612964990307, 910.4127837544879, 910.6311943662827, 912.2838571721167, 1095.7041598768287, 6248.562600618004, 6260.686965651699, 6278.277998030194, 6279.843003924847, 6337.493000559944, 573.4237091722792, 578.5747475605426, 579.878225572626, 582.1297160744629, 714.9678264478111, 4734.360861283752, 4825.227963525819, 4829.444613869379, 4832.033593281358, 4923.704577725348, 7367.484276100621, 7534.510256833289, 7614.505057171377, 7659.387249020177, 7740.342070923922, 7647.847043059219, 7707.036620422447, 7720.382369410434, 7725.343345815556, 7738.61306934651, 6201.782937597162, 6242.188515493048, 6251.6561589113035, 6255.812325630147, 6271.05934109878, 6130.816075517741, 6174.783882564088, 6184.783532576338, 6190.133381326528, 6251.937480625135, 6907.0, 7038.894416583653, 7043.36609705129, 7079.716811327489, 7087.184973728087, 6977.825554361181, 7142.0001199833105, 7240.131184257712, 7254.056972593529, 7255.891161632685, 5844.831033793173, 5918.704064796657, 5919.052951527735, 5932.673702946379, 5986.2217911671205, 5146.382434107931, 6298.149749783904, 6316.336784637547, 6383.96808015957, 6384.705384481379, 5115.5396014358885, 5158.845234642967, 5557.469972782046, 5950.702464876652, 5993.550483713651, 5647.435256474319, 5757.366689664217, 5824.223611798273, 5841.737121829443, 5950.285965684146, 5862.208601838697, 5910.497607703393, 5913.940860591339, 5926.555508336978, 5996.370381110095, 5414.0254754144635, 5416.079266524779, 5429.918551221814, 5459.727013649381, 5511.173324001432, 5141.434442211428, 5174.637775355689, 5195.298634684269, 5223.347081614798, 5241.6068794839775], "ext.html": [470.9929351059734, 483.9419269687638, 494.1475953979385, 496.98260560880374, 499.8100721725746, 26657.466850662975, 27945.860270698668, 33128.834355828214, 34132.31735365297, 34571.65428345716, 37204.25591488169, 37312.44031339525, 37388.252234955355, 37512.0, 37896.0, 7012.649367531629, 7886.0, 8046.074701409325, 8170.836583268331, 8194.959025204866, 7171.784846454615, 9528.475933823636, 9766.121049105579, 9782.413055216673, 9932.304738668296, 9615.375000624972, 9628.566714497865, 9635.036496350343, 9682.12860842524, 9747.610095596203, 7171.89242161368, 7325.706971721178, 9523.857142142873, 9661.565229564687, 9700.951495242514, 9343.159115679622, 9442.055794420572, 9515.333926625139, 9530.714078577654, 9592.424454532751, 34583.82708086444, 35014.47478287828, 35016.12459688528, 35054.82472587646, 35069.47395789065, 2419.6249581314923, 2698.3928616061426, 2712.308361367858, 2842.1473557932536, 3072.6005619269577, 23796.524069518688, 24251.272461826175, 24451.755482445125, 24696.753032469624, 25082.498350032896, 2013.0840467587213, 2046.887421191834, 2047.9385618431322, 2062.804033616804, 2085.0304608357187, 263105.0, 264222.0, 265904.6704766483, 266286.0, 267641.0, 50959.745201273756, 51226.23160652593, 51334.74332628313, 51351.48648513467, 51767.22349164765, 46010.539894600624, 46645.30032049522, 52044.739776301634, 52794.94410111776, 53504.0, 14594.927025365017, 14663.48677796272, 14817.33322000491, 14825.184614846286, 14837.480688175861, 10988.230823842414, 11051.0, 11114.388708620942, 11328.830067548994, 11330.263532870336, 16171.757423638655, 16366.0, 16369.345226190819, 16376.181190940644, 16400.75398869018, 7181.533200341961, 7362.300581444754, 7379.409647228209, 7407.85184296311, 7423.591702456309, 829.9626516806758, 883.5361435246418, 911.937592704505, 958.7890664053897, 964.9758756031156, 24547.0, 24967.0, 25101.24696259115, 25353.492930141663, 25361.61957570638, 883.765802062454, 907.6233363154217, 952.1002652493328, 1000.7398076500017, 1009.6415772400692, 13004.21974681522, 13004.934975325063, 13029.869701303056, 13163.407646655924, 13182.472701092041, 379488.0, 386423.0, 392282.0, 393082.03458983096, 393136.0, 45774.77112614416, 46250.53749462462, 46607.0, 46804.297935530994, 46984.0, 1158.6350299655583, 1200.0339726520235, 1207.6316723399273, 1208.238809549978, 1210.7154818617794, 24119.397015074763, 24490.632640510765, 24650.506989859743, 24858.25425237246, 24935.625965610892, 39426.40860387154, 39885.40171897482, 40198.79900600478, 40250.39624405577, 40327.1934561313, 229139.0, 231840.0, 234211.0, 234755.0, 235627.0, 22760.0, 23027.07891684314, 25238.49523009566, 26409.0, 26578.0, 31822.840885795424, 31935.201619959687, 32317.35365292728, 32842.343153136324, 33024.66975330312, 27759.0, 28007.439851202453, 28074.719252807212, 30261.394772104875, 30643.2339191522, 23154.768452315937, 28189.154325370273, 28747.42505149927, 28832.279193020342, 29450.558241626823, 25028.124015660094, 27459.862700686368, 28888.855555722086, 29350.266243344086, 29994.0, 26298.605520917583, 27274.45451091007, 27400.0, 27476.0, 27839.164825055283, 20066.79933200708, 20462.693059604415, 20466.795332046488, 20731.4817129573, 20781.68827467559], "prototype.html": [262.9355807827082, 266.91858983010184, 267.2756828993429, 271.9360950176708, 273.19135359336366, 5226.92159617606, 5233.528982391584, 5263.815766448175, 5278.524932756051, 5288.973555132228, 5077.441481437039, 5120.206368012955, 5134.794608215667, 5135.589152867771, 5224.216367544861, 3831.252905683393, 3880.611938806125, 3902.414637804324, 3924.0189952511873, 4051.392291156321, 3986.4817573715377, 3986.940195897064, 4001.339778936472, 4036.4348991141264, 4061.776602286873, 3932.74437161585, 3948.0, 3991.7804520751347, 4005.339119045354, 4006.2187873364705, 3841.0397400649836, 3884.184321292532, 3908.2965066288057, 3918.4122381642696, 4024.9195016099807, 3429.6741809528053, 3432.7940323580665, 3437.7077948374417, 3477.8608855645743, 3482.112061424346, 5034.370703662043, 5087.8982420351385, 5093.974530127326, 5100.744962751847, 5117.181250999822, 4457.821687132511, 4475.552444755498, 4484.461864576272, 4535.591796738309, 4540.250858608326, 5371.597130215249, 5471.671699698031, 5494.148406996922, 5569.081101618228, 5578.079616863212, 3777.6033516480925, 3786.8295926683363, 3833.7124715646437, 3840.884773456773, 3842.3852183650483, 5748.080307150877, 5775.422457754191, 5778.653280803123, 5807.709614519299, 5888.705564721789, 3834.1564855732254, 3862.7102967277565, 3864.3237433449035, 3909.4135879618284, 3910.1397692507603, 3475.061733332037, 3681.245344704329, 3893.065664240562, 3908.1988192420486, 3939.665128464055, 4349.217140914666, 4362.083962367875, 4378.518362980133, 4417.668674849399, 4542.250528662799, 5311.17676760095, 5415.458454154553, 5431.701256430934, 5484.2047903053835, 5489.066858634042, 1400.7478653842202, 1409.7885317202501, 1412.5691664042565, 1415.985840141606, 1432.7421064208543, 909.7316291693834, 914.3279689428265, 927.2350310993322, 936.0312077000408, 940.2806852757645, 5243.68537887728, 5269.420363759983, 5291.656042357235, 5330.147176451749, 5356.116240820221, 5730.656160630376, 5735.340435849847, 5739.081746920473, 5747.396523364986, 5749.942500574941, 5294.179402192666, 5295.232191332312, 5320.760565774472, 5336.092864213016, 5336.653117547347, 2899.0722968650252, 3003.6996300370224, 3124.218945263684, 3147.4964005759425, 3183.840807959593, 5790.044642633919, 5832.737526811304, 5834.649921004753, 5869.266341707286, 5892.1161825726485, 5749.281339832437, 5768.307803063575, 5851.151583020438, 5874.0, 5876.529877609781, 5783.971080144573, 5788.0, 5868.061110222344, 5870.6771127587535, 5876.7355469004, 5519.558435325084, 5764.625299355528, 5788.913166302593, 5799.797007104731, 5839.883202336015, 5595.384507704068, 5638.943610564006, 5665.20687103814, 5708.200851880657, 5715.399883012224, 5862.736176871966, 5896.64620122794, 5964.433378829004, 5989.131575921554, 5992.610480318765, 3738.1962877981364, 3757.4176002719623, 3826.521684789401, 3827.1771569112775, 3854.5567259764366, 5634.6337488063145, 5640.71796410186, 5659.405762394889, 5661.46216109469, 5716.828495144986, 5485.204645326485, 5489.39616642177, 5502.477264659851, 5530.142827861688, 5571.804986825442, 5482.479164479368, 5496.6701997880255, 5499.835004949858, 5541.2796336476, 5557.3331200256225, 5189.4032186299055, 5344.679319240702, 5372.0, 5375.462453754593, 5446.373667028184, 5463.644863083887, 5482.890342193054, 5545.584081193846, 5549.250851135206, 5555.0278701227935, 5170.3278573785165, 5270.393904701008, 5271.156614941591, 5402.621816472809, 5432.103702888979], "yui.html": [646.4440581100253, 648.0240214095265, 659.0838734159519, 666.0841343153164, 673.383853773797, 11939.820902686455, 12342.382880855956, 12459.563915262968, 12464.252144871314, 12485.563005294805, 11326.150538709588, 11476.827847582294, 11555.768884622323, 11633.650990470278, 11668.82496762547, 581.6451964301773, 628.1174949196386, 628.7516431009749, 756.5800980455858, 761.9885701714479, 770.5030255485209, 771.9459637825355, 772.1043589436255, 782.8982232309792, 790.3677058353323, 830.2901019628222, 830.48509923847, 830.9252167304942, 832.2218725491655, 839.3872473094644, 572.0132770970085, 638.9648569328708, 762.1578156137443, 815.657423881971, 817.9141190175066, 603.6136872401667, 604.7853012180657, 604.8548348396397, 605.9545534084962, 606.4057223920538, 11733.941330293294, 11920.046396288277, 11939.40302984856, 11943.880561194364, 11963.042956563455, 9948.104670579683, 9975.551100200508, 10551.366917984946, 10594.523246453928, 10730.0, 7806.648700808477, 8169.591520423955, 8181.100078991306, 8223.0, 8368.079511253818, 2434.172381390336, 2519.0553542421594, 2544.70735865376, 2852.9223056148157, 2934.9119526414243, 42007.159856802995, 42554.0, 42596.99999999969, 42665.0, 42755.57244427547, 5959.344472108065, 6137.9079313810325, 6139.447449729546, 6151.3541078187045, 6327.082573026885, 10488.160947124212, 10550.208734344955, 10657.094146997591, 10683.893161068445, 10698.304610200312, 5307.65500242483, 5317.760700768475, 5487.478689524489, 5491.560675145979, 5500.202470641734, 3265.0, 3351.0952042948265, 3365.3269346130874, 3443.2941247044296, 3475.600305964796, 2245.214175038756, 2262.773722627724, 2293.9197128100436, 2294.0250393582996, 2299.7470278269375, 328.9144822346207, 331.1539017809472, 345.7441493294994, 345.92735525539916, 346.7053004945776, 464.21315869600704, 501.45341577680506, 520.5757307794136, 532.5420138680731, 533.9225812257201, 6596.406323430819, 6753.527253092335, 6864.176298844171, 6882.346177113166, 7042.436605071582, 387.45175576558853, 410.7720215280548, 487.373724763677, 495.9603231741524, 502.3318985748945, 3135.764817638686, 3135.8275294858545, 3170.5719727836445, 3177.9364412711616, 3188.3145123798495, 54418.45581544134, 55087.0, 55168.0, 55795.44204557984, 56433.71783141058, 45754.882060614706, 47069.0, 47101.76449117801, 47218.0, 47304.0, 43136.352954705704, 43604.56395436005, 43918.780406098405, 44063.55936440595, 44133.0, 6859.416949559343, 6946.8610627788175, 7085.787426377217, 7158.141023077264, 7220.638968051681, 32111.67888321087, 32463.513047303837, 32526.512102318957, 32675.509867351535, 32904.177395565304, 42107.789461053726, 42141.57858421376, 42840.35739463973, 43055.7847210762, 43444.56555434405, 6557.540972131905, 6570.277269500447, 6623.503237257129, 6792.150981127359, 6861.142357205349, 9505.572249248939, 9752.171065459515, 9825.754356141153, 9939.0, 10415.895841041493, 9033.187013168847, 9045.90954090477, 9061.954690226507, 9077.909220907706, 9089.091090890857, 9048.457092574467, 9112.179903808425, 9157.130072643089, 9168.908310916806, 9191.494467804336, 8903.465792052497, 8993.190612844875, 9027.097290271184, 9100.31747618918, 9549.140577348073, 7562.0925488941675, 7734.098127612637, 7871.606419678878, 8216.497881239737, 8238.340932725248, 7591.544507329357, 7891.487053341514, 7986.321162701235, 8093.35253179756, 8198.38512111606]}, "summary": {"lowerIsBetter": false, "suite": 5661.567356716209, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 5643.745521374475, "unit": "ms", "value": 5643.745521374475}, "dojo.html": {"lowerIsBetter": false, "filtered": 4570.584728182777, "unit": "ms", "value": 4570.584728182777}, "mootools.html": {"lowerIsBetter": false, "filtered": 3738.6013355206746, "unit": "ms", "value": 3738.6013355206746}, "ext.html": {"lowerIsBetter": false, "filtered": 16145.901309352645, "unit": "ms", "value": 16145.901309352645}, "prototype.html": {"lowerIsBetter": false, "filtered": 4133.388187611369, "unit": "ms", "value": 4133.388187611369}, "yui.html": {"lowerIsBetter": false, "filtered": 5116.329680445749, "unit": "ms", "value": 5116.329680445749}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0019"}, "testrun": {"date": 1446828754, "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": "20151106065436", "branch": "Fx-Team", "revision": "c921afa9fc3e164ab52dc4564349a92e16663317"}}, {"talos_counters": {}, "results": {"audio-dft": [185.0, 189.0, 188.0, 188.0, 190.0, 189.0, 189.0, 188.0, 187.0, 191.0], "ai-astar": [122.0, 125.0, 117.0, 125.0, 126.0, 128.0, 125.0, 127.0, 125.0, 133.0], "imaging-gaussian-blur": [135.0, 136.0, 135.0, 136.0, 135.0, 142.0, 135.0, 142.0, 144.0, 135.0], "audio-beat-detection": [183.0, 150.0, 182.0, 196.0, 153.0, 173.0, 172.0, 148.0, 195.0, 155.0], "json-stringify-tinderbox": [72.0, 75.0, 79.0, 80.0, 79.0, 79.0, 79.0, 79.0, 80.0, 80.0], "stanford-crypto-pbkdf2": [163.0, 165.0, 176.0, 180.0, 176.0, 179.0, 177.0, 179.0, 187.0, 173.0], "json-parse-financial": [61.0, 64.0, 68.0, 66.0, 67.0, 68.0, 67.0, 79.0, 65.0, 68.0], "stanford-crypto-sha256-iterative": [81.0, 82.0, 81.0, 82.0, 82.0, 84.0, 83.0, 83.0, 83.0, 82.0], "audio-fft": [88.0, 90.0, 103.0, 100.0, 82.0, 84.0, 85.0, 99.0, 98.0, 77.0], "imaging-darkroom": [148.0, 147.0, 147.0, 148.0, 147.0, 147.0, 147.0, 154.0, 148.0, 147.0], "stanford-crypto-ccm": [147.0, 151.0, 152.0, 145.0, 162.0, 144.0, 154.0, 158.0, 151.0, 151.0], "audio-oscillator": [109.0, 111.0, 161.0, 103.0, 105.0, 104.0, 151.0, 103.0, 103.0, 156.0], "stanford-crypto-aes": [97.0, 102.0, 100.0, 104.0, 105.0, 108.0, 100.0, 101.0, 101.0, 102.0], "imaging-desaturate": [119.0, 123.0, 123.0, 118.0, 121.0, 124.0, 124.0, 119.0, 119.0, 119.0]}, "summary": {"lowerIsBetter": true, "suite": 1758.8, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 90.6, "unit": "ms", "value": 90.6}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 175.5, "unit": "ms", "value": 175.5}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 170.7, "unit": "ms", "value": 170.7}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 151.5, "unit": "ms", "value": 151.5}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 148.0, "unit": "ms", "value": 148.0}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 67.3, "unit": "ms", "value": 67.3}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 120.6, "unit": "ms", "value": 120.6}, "ai-astar": {"lowerIsBetter": true, "filtered": 125.3, "unit": "ms", "value": 125.3}, "audio-dft": {"lowerIsBetter": true, "filtered": 188.4, "unit": "ms", "value": 188.4}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 82.3, "unit": "ms", "value": 82.3}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 78.2, "unit": "ms", "value": 78.2}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 137.5, "unit": "ms", "value": 137.5}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 102.0, "unit": "ms", "value": 102.0}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 120.9, "unit": "ms", "value": 120.9}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0019"}, "testrun": {"date": 1446828754, "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": "20151106065436", "branch": "Fx-Team", "revision": "c921afa9fc3e164ab52dc4564349a92e16663317"}}, {"talos_counters": {}, "results": {"DeltaBlue": [222.3210315695865], "Encrypt": [369.2762186115214], "NavierStokes": [6700.0], "Decrypt": [6856.164383561644], "Splay": [720.4610951008646], "Richards": [192.19680953296177], "RegExp": [34627.1186440678], "Earley": [1053.740779768177], "Boyer": [14550.72463768116], "RayTrace": [2391.4081145584723]}, "summary": {"lowerIsBetter": false, "suite": 15766.030745059279, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 297.39876399999997, "unit": "score", "value": 297.39876399999997}, "Encrypt": {"lowerIsBetter": false, "filtered": 720.818148, "unit": "score", "value": 720.818148}, "NavierStokes": {"lowerIsBetter": false, "filtered": 221.49253731343285, "unit": "score", "value": 221.49253731343285}, "Decrypt": {"lowerIsBetter": false, "filtered": 38.823602397602365, "unit": "score", "value": 38.823602397602365}, "Splay": {"lowerIsBetter": false, "filtered": 113.109508, "unit": "score", "value": 113.109508}, "RegExp": {"lowerIsBetter": false, "filtered": 26.308426333822812, "unit": "score", "value": 26.308426333822812}, "Richards": {"lowerIsBetter": false, "filtered": 183.6763059999999, "unit": "score", "value": 183.6763059999999}, "Earley": {"lowerIsBetter": false, "filtered": 632.473387, "unit": "score", "value": 632.473387}, "Boyer": {"lowerIsBetter": false, "filtered": 45.80273605577688, "unit": "score", "value": 45.80273605577688}, "RayTrace": {"lowerIsBetter": false, "filtered": 309.43651796407187, "unit": "score", "value": 309.43651796407187}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0019"}, "testrun": {"date": 1446828754, "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": "20151106065436", "branch": "Fx-Team", "revision": "c921afa9fc3e164ab52dc4564349a92e16663317"}}] 09:12:51 INFO - RETURN: dromaeo_css: 5661.57 09:12:51 INFO - RETURN: kraken: 1758.80 09:12:51 INFO - RETURN: v8_7: 15766.03 09:12:51 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,55]]", "result": "15766.03"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,55]]", "result": "1758.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,55]]", "result": "5661.57"}}} 09:12:51 INFO - Return code: 0 09:12:51 INFO - # TBPL SUCCESS # 09:12:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:12:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:12:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:12:51 INFO - 2015-11-06 09:12:51.591 screenresolution[2289:19517] starting screenresolution argv=screenresolution get 09:12:51 INFO - 2015-11-06 09:12:51.594 screenresolution[2289:19517] Display 0: 1600x1200x32@60 09:12:51 INFO - 2015-11-06 09:12:51.600 screenresolution[2290:19520] starting screenresolution argv=screenresolution list 09:12:51 INFO - Available Modes on Display 0 09:12:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:12:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:12:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:12:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:12:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:12:51 INFO - Intel HD Graphics 3000: 09:12:51 INFO - Chipset Model: Intel HD Graphics 3000 09:12:51 INFO - Type: GPU 09:12:51 INFO - Bus: Built-In 09:12:51 INFO - VRAM (Total): 512 MB 09:12:51 INFO - VRAM (Dynamic, Max): 10 09:12:51 INFO - Vendor: Intel (0x8086) 09:12:51 INFO - Device ID: 0x0116 09:12:51 INFO - Revision ID: 0x0009 09:12:51 INFO - Displays: 09:12:51 INFO - Display: 09:12:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:12:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:12:51 INFO - Display Serial Number: 1600x1200 60 09:12:51 INFO - Main Display: Yes 09:12:51 INFO - Mirror: Off 09:12:51 INFO - Online: Yes 09:12:51 INFO - Rotation: Supported 09:12:51 INFO - Return code: 0 09:12:51 INFO - Running post-action listener: _resource_record_post_action 09:12:51 INFO - Running post-run listener: _resource_record_post_run 09:12:52 INFO - Total resource usage - Wall time: 1260s; CPU: 30.0%; Read bytes: 602112; Write bytes: 686621696; Read time: 356; Write time: 44709 09:12:52 INFO - install - Wall time: 42s; CPU: 30.0%; Read bytes: 334371328; Write bytes: 333346816; Read time: 36259; Write time: 3086 09:12:52 INFO - run-tests - Wall time: 1218s; CPU: 30.0%; Read bytes: 585728; Write bytes: 338625536; Read time: 325; Write time: 37276 09:12:52 INFO - Running post-run listener: _upload_blobber_files 09:12:52 INFO - Blob upload gear active. 09:12:52 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 09:12:52 INFO - Copying logs to upload dir... 09:12:52 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1315.450270 ========= master_lag: 6.33 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 1 secs) (at 2015-11-06 09:12:59.319214) ========= ========= Started set props: build_url (results: 0, elapsed: 3 secs) (at 2015-11-06 09:12:59.330649) ========= 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.GFLiz1S8m2/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.EavsOyrJHV/Listeners TMPDIR=/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/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/g9GRn1xsT2mzbkhAqjNBSg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010125 build_url: 'https://queue.taskcluster.net/v1/task/g9GRn1xsT2mzbkhAqjNBSg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 3.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 3 secs) (at 2015-11-06 09:13:02.394804) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-06 09:13:02.395132) ========= 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.GFLiz1S8m2/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.EavsOyrJHV/Listeners TMPDIR=/var/folders/8w/xy9v5xw56415wls9095pr92m00000w/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.005313 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-06 09:13:02.422201) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-06 09:13:02.422646) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-06 09:13:02.424414) ========= ========= Total master_lag: 9.90 =========