builder: fx-team_yosemite_test-dromaeojs slave: t-yosemite-r5-0090 starttime: 1447650751.58 results: success (0) buildid: 20151115191934 builduid: c20a87a03ec44d88be4f4c4a773e5b58 revision: 04fb61e343addd47b88ac694041c0bce5a98cfc0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-15 21:12:31.582868) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-15 21:12:31.583367) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-15 21:12:31.583735) ========= 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.wczxMZNuOj/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.qjWURUTijg/Listeners TMPDIR=/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/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.005886 basedir: '/builds/slave/test' ========= master_lag: 0.30 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-15 21:12:31.891638) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-15 21:12:31.891978) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-15 21:12:31.932348) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 21:12:31.933015) ========= 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.wczxMZNuOj/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.qjWURUTijg/Listeners TMPDIR=/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/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.015947 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 21:12:31.984403) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-15 21:12:31.984765) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-15 21:12:31.985191) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 21:12:31.985479) ========= 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.wczxMZNuOj/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.qjWURUTijg/Listeners TMPDIR=/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False --2015-11-15 21:12:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.25, 63.245.215.102, ... Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 9.07M=0.001s 2015-11-15 21:12:32 (9.07 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.186004 ========= master_lag: 0.41 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 21:12:32.583295) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 21:12:32.583667) ========= 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.wczxMZNuOj/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.qjWURUTijg/Listeners TMPDIR=/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/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.123069 ========= master_lag: 0.36 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 21:12:33.063555) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 21:12:33.063941) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 04fb61e343addd47b88ac694041c0bce5a98cfc0 --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 04fb61e343addd47b88ac694041c0bce5a98cfc0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wczxMZNuOj/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.qjWURUTijg/Listeners TMPDIR=/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 2015-11-15 21:12:33,179 truncating revision to first 12 chars 2015-11-15 21:12:33,179 Setting DEBUG logging. 2015-11-15 21:12:33,179 attempt 1/10 2015-11-15 21:12:33,179 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/04fb61e343ad?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-15 21:12:33,430 unpacking tar archive at: fx-team-04fb61e343ad/testing/mozharness/ program finished with exit code 0 elapsedTime=0.558454 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 21:12:33.644510) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-15 21:12:33.644881) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-15 21:12:33.660004) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-15 21:12:33.660418) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-15 21:12:33.660983) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 9 secs) (at 2015-11-15 21:12:33.661292) ========= /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.wczxMZNuOj/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.qjWURUTijg/Listeners TMPDIR=/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/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 21:12:33 INFO - MultiFileLogger online at 20151115 21:12:33 in /builds/slave/test 21:12:33 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 21:12:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:12:34 INFO - {'append_to_log': False, 21:12:34 INFO - 'base_work_dir': '/builds/slave/test', 21:12:34 INFO - 'blob_upload_branch': 'Fx-Team', 21:12:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:12:34 INFO - 'branch': 'Fx-Team', 21:12:34 INFO - 'buildbot_json_path': 'buildprops.json', 21:12:34 INFO - 'config_files': ('talos/mac_config.py',), 21:12:34 INFO - 'default_actions': ('clobber', 21:12:34 INFO - 'read-buildbot-config', 21:12:34 INFO - 'download-and-extract', 21:12:34 INFO - 'populate-webroot', 21:12:34 INFO - 'create-virtualenv', 21:12:34 INFO - 'install', 21:12:34 INFO - 'run-tests'), 21:12:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:12:34 INFO - 'download_minidump_stackwalk': True, 21:12:34 INFO - 'download_symbols': 'ondemand', 21:12:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:12:34 INFO - 'tooltool.py': '/tools/tooltool.py', 21:12:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:12:34 INFO - '/tools/misc-python/virtualenv.py')}, 21:12:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:12:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:12:34 INFO - 'installer_path': 'installer.exe', 21:12:34 INFO - 'log_level': 'info', 21:12:34 INFO - 'log_name': 'talos', 21:12:34 INFO - 'log_to_console': True, 21:12:34 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:12:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:12:34 INFO - 'opt_config_files': (), 21:12:34 INFO - 'pip_index': False, 21:12:34 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:12:34 INFO - 'cmd': ('bash', 21:12:34 INFO - '-c', 21:12:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:12:34 INFO - 'enabled': True, 21:12:34 INFO - 'halt_on_failure': False, 21:12:34 INFO - 'name': 'check_screen_resolution'},), 21:12:34 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:12:34 INFO - 'cmd': ('bash', 21:12:34 INFO - '-c', 21:12:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:12:34 INFO - 'enabled': True, 21:12:34 INFO - 'halt_on_failure': False, 21:12:34 INFO - 'name': 'check_screen_resolution'},), 21:12:34 INFO - 'run_cmd_checks_enabled': True, 21:12:34 INFO - 'sps_profile': False, 21:12:34 INFO - 'sps_profile_interval': 0, 21:12:34 INFO - 'suite': 'dromaeojs', 21:12:34 INFO - 'system_bits': '64', 21:12:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:12:34 INFO - 'title': 't-yosemite-r5-0090', 21:12:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:12:34 INFO - 'use_talos_json': True, 21:12:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:12:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:12:34 INFO - 'work_dir': 'build'} 21:12:34 INFO - ##### 21:12:34 INFO - ##### Running clobber step. 21:12:34 INFO - ##### 21:12:34 INFO - Running pre-action listener: _resource_record_pre_action 21:12:34 INFO - Running main action method: clobber 21:12:34 INFO - rmtree: /builds/slave/test/build 21:12:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:12:37 INFO - Running post-action listener: _resource_record_post_action 21:12:37 INFO - ##### 21:12:37 INFO - ##### Running read-buildbot-config step. 21:12:37 INFO - ##### 21:12:37 INFO - Running pre-action listener: _resource_record_pre_action 21:12:37 INFO - Running main action method: read_buildbot_config 21:12:37 INFO - Using buildbot properties: 21:12:37 INFO - { 21:12:37 INFO - "properties": { 21:12:37 INFO - "buildnumber": 1232, 21:12:37 INFO - "product": "firefox", 21:12:37 INFO - "script_repo_revision": "production", 21:12:37 INFO - "builddir": "fx-team_yosemite_test-dromaeojs", 21:12:37 INFO - "repository": "", 21:12:37 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 fx-team talos dromaeojs", 21:12:37 INFO - "buildid": "20151115191934", 21:12:37 INFO - "slavename": "t-yosemite-r5-0090", 21:12:37 INFO - "pgo_build": "False", 21:12:37 INFO - "basedir": "/builds/slave/test", 21:12:37 INFO - "project": "", 21:12:37 INFO - "platform": "yosemite", 21:12:37 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 21:12:37 INFO - "slavebuilddir": "test", 21:12:37 INFO - "scheduler": "tests-fx-team-macosx64-talos", 21:12:37 INFO - "branch": "fx-team", 21:12:37 INFO - "repo_path": "integration/fx-team", 21:12:37 INFO - "stage_platform": "macosx64", 21:12:37 INFO - "builduid": "c20a87a03ec44d88be4f4c4a773e5b58", 21:12:37 INFO - "revision": "04fb61e343addd47b88ac694041c0bce5a98cfc0" 21:12:37 INFO - }, 21:12:37 INFO - "sourcestamp": { 21:12:37 INFO - "repository": "", 21:12:37 INFO - "hasPatch": false, 21:12:37 INFO - "project": "", 21:12:37 INFO - "branch": "fx-team-macosx64-talos", 21:12:37 INFO - "changes": [ 21:12:37 INFO - { 21:12:37 INFO - "category": null, 21:12:37 INFO - "files": [ 21:12:37 INFO - { 21:12:37 INFO - "url": null, 21:12:37 INFO - "name": "https://queue.taskcluster.net/v1/task/ZjTbuTY2RkSkT863-Sdzjw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 21:12:37 INFO - } 21:12:37 INFO - ], 21:12:37 INFO - "repository": "", 21:12:37 INFO - "rev": "04fb61e343addd47b88ac694041c0bce5a98cfc0", 21:12:37 INFO - "who": "philringnalda@gmail.com", 21:12:37 INFO - "when": 1447650704, 21:12:37 INFO - "number": 6664819, 21:12:37 INFO - "comments": "Merge m-c to f-t", 21:12:37 INFO - "project": "", 21:12:37 INFO - "at": "Sun 15 Nov 2015 21:11:44", 21:12:37 INFO - "branch": "fx-team-macosx64-talos", 21:12:37 INFO - "revlink": "", 21:12:37 INFO - "properties": [ 21:12:37 INFO - [ 21:12:37 INFO - "buildid", 21:12:37 INFO - "20151115191934", 21:12:37 INFO - "Change" 21:12:37 INFO - ], 21:12:37 INFO - [ 21:12:37 INFO - "builduid", 21:12:37 INFO - "c20a87a03ec44d88be4f4c4a773e5b58", 21:12:37 INFO - "Change" 21:12:37 INFO - ], 21:12:37 INFO - [ 21:12:37 INFO - "pgo_build", 21:12:37 INFO - "False", 21:12:37 INFO - "Change" 21:12:37 INFO - ] 21:12:37 INFO - ], 21:12:37 INFO - "revision": "04fb61e343addd47b88ac694041c0bce5a98cfc0" 21:12:37 INFO - } 21:12:37 INFO - ], 21:12:37 INFO - "revision": "04fb61e343addd47b88ac694041c0bce5a98cfc0" 21:12:37 INFO - } 21:12:37 INFO - } 21:12:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZjTbuTY2RkSkT863-Sdzjw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 21:12:37 INFO - Running post-action listener: _resource_record_post_action 21:12:37 INFO - ##### 21:12:37 INFO - ##### Running download-and-extract step. 21:12:37 INFO - ##### 21:12:37 INFO - Running pre-action listener: _resource_record_pre_action 21:12:37 INFO - Running main action method: download_and_extract 21:12:37 INFO - mkdir: /builds/slave/test/build/tests 21:12:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:12:37 INFO - https://queue.taskcluster.net/v1/task/ZjTbuTY2RkSkT863-Sdzjw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 21:12:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjTbuTY2RkSkT863-Sdzjw/artifacts/public/build/test_packages.json 21:12:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjTbuTY2RkSkT863-Sdzjw/artifacts/public/build/test_packages.json 21:12:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjTbuTY2RkSkT863-Sdzjw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 21:12:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjTbuTY2RkSkT863-Sdzjw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 21:12:41 INFO - Downloaded 1149 bytes. 21:12:41 INFO - Reading from file /builds/slave/test/build/test_packages.json 21:12:41 INFO - Using the following test package requirements: 21:12:41 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 21:12:41 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 21:12:41 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 21:12:41 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 21:12:41 INFO - u'jsshell-mac.zip'], 21:12:41 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 21:12:41 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 21:12:41 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 21:12:41 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 21:12:41 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 21:12:41 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 21:12:41 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 21:12:41 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 21:12:41 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 21:12:41 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 21:12:41 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 21:12:41 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 21:12:41 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 21:12:41 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')]} 21:12:41 INFO - https://queue.taskcluster.net/v1/task/ZjTbuTY2RkSkT863-Sdzjw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 21:12:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjTbuTY2RkSkT863-Sdzjw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 21:12:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjTbuTY2RkSkT863-Sdzjw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 21:12:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjTbuTY2RkSkT863-Sdzjw/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 21:12:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjTbuTY2RkSkT863-Sdzjw/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 21:12:44 INFO - Downloaded 17464151 bytes. 21:12:44 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 21:12:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 21:12:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 21:12:50 INFO - Return code: 0 21:12:50 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 21:12:50 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')]} 21:12:50 INFO - https://queue.taskcluster.net/v1/task/ZjTbuTY2RkSkT863-Sdzjw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 21:12:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjTbuTY2RkSkT863-Sdzjw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 21:12:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjTbuTY2RkSkT863-Sdzjw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 21:12:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjTbuTY2RkSkT863-Sdzjw/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 21:12:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjTbuTY2RkSkT863-Sdzjw/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 21:12:51 INFO - Downloaded 17464151 bytes. 21:12:51 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 21:12:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 21:12:51 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 21:12:57 INFO - Return code: 0 21:12:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:12:57 INFO - https://queue.taskcluster.net/v1/task/ZjTbuTY2RkSkT863-Sdzjw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 21:12:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjTbuTY2RkSkT863-Sdzjw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 21:12:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjTbuTY2RkSkT863-Sdzjw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 21:12:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjTbuTY2RkSkT863-Sdzjw/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 21:12:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjTbuTY2RkSkT863-Sdzjw/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 21:12:58 INFO - Downloaded 11131693 bytes. 21:12:58 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 21:12:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 21:12:58 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 21:12:58 INFO - Return code: 0 21:12:58 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')]} 21:12:58 INFO - https://queue.taskcluster.net/v1/task/ZjTbuTY2RkSkT863-Sdzjw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 21:12:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjTbuTY2RkSkT863-Sdzjw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 21:12:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjTbuTY2RkSkT863-Sdzjw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 21:12:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjTbuTY2RkSkT863-Sdzjw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 21:12:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjTbuTY2RkSkT863-Sdzjw/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 21:13:02 INFO - Downloaded 108681065 bytes. 21:13:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZjTbuTY2RkSkT863-Sdzjw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 21:13:02 INFO - mkdir: /builds/slave/test/properties 21:13:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:13:02 INFO - Writing to file /builds/slave/test/properties/build_url 21:13:02 INFO - Contents: 21:13:02 INFO - build_url:https://queue.taskcluster.net/v1/task/ZjTbuTY2RkSkT863-Sdzjw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 21:13:02 INFO - Running post-action listener: _resource_record_post_action 21:13:02 INFO - Running post-action listener: set_extra_try_arguments 21:13:02 INFO - ##### 21:13:02 INFO - ##### Running populate-webroot step. 21:13:02 INFO - ##### 21:13:02 INFO - Running pre-action listener: _resource_record_pre_action 21:13:02 INFO - Running main action method: populate_webroot 21:13:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:13:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:13:02 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 21:13:02 INFO - '../fennec_ids.txt'], 21:13:02 INFO - 'tests': ['tcheck2']}, 21:13:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:13:02 INFO - '--tppagecycles', 21:13:02 INFO - '7'], 21:13:02 INFO - 'tests': ['tsvgm']}}, 21:13:02 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:13:02 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:13:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:13:02 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:13:02 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:13:02 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:13:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:13:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:13:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:13:02 INFO - 'talos_options': ['--e10s'], 21:13:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:13:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:13:02 INFO - 'tests': ['damp', 'tps']}, 21:13:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:13:02 INFO - 'talos_options': ['--e10s'], 21:13:02 INFO - 'tests': ['damp', 'tps']}, 21:13:02 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:13:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:13:02 INFO - 'other': {'tests': ['a11yr', 21:13:02 INFO - 'ts_paint', 21:13:02 INFO - 'tpaint', 21:13:02 INFO - 'sessionrestore', 21:13:02 INFO - 'sessionrestore_no_auto_restore']}, 21:13:02 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:13:02 INFO - 'tests': ['a11yr', 21:13:02 INFO - 'ts_paint', 21:13:02 INFO - 'tpaint', 21:13:02 INFO - 'sessionrestore', 21:13:02 INFO - 'sessionrestore_no_auto_restore']}, 21:13:02 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:13:02 INFO - 'tests': ['a11yr', 21:13:02 INFO - 'ts_paint', 21:13:02 INFO - 'tpaint', 21:13:02 INFO - 'sessionrestore', 21:13:02 INFO - 'sessionrestore_no_auto_restore']}, 21:13:02 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:13:02 INFO - 'tests': ['a11yr', 21:13:02 INFO - 'ts_paint', 21:13:02 INFO - 'tpaint', 21:13:02 INFO - 'sessionrestore', 21:13:02 INFO - 'sessionrestore_no_auto_restore']}, 21:13:02 INFO - 'other_l64': {'tests': ['a11yr', 21:13:02 INFO - 'ts_paint', 21:13:02 INFO - 'tpaint', 21:13:02 INFO - 'sessionrestore', 21:13:02 INFO - 'sessionrestore_no_auto_restore']}, 21:13:02 INFO - 'other_nol64': {'tests': ['a11yr', 21:13:02 INFO - 'ts_paint', 21:13:02 INFO - 'tpaint', 21:13:02 INFO - 'sessionrestore', 21:13:02 INFO - 'sessionrestore_no_auto_restore']}, 21:13:02 INFO - 'svgr': {'tests': ['tsvgx', 21:13:02 INFO - 'tsvgr_opacity', 21:13:02 INFO - 'tart', 21:13:02 INFO - 'tscrollx', 21:13:02 INFO - 'cart']}, 21:13:02 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:13:02 INFO - 'tests': ['tsvgx', 21:13:02 INFO - 'tsvgr_opacity', 21:13:02 INFO - 'tart', 21:13:02 INFO - 'tscrollx', 21:13:02 INFO - 'cart']}, 21:13:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:13:02 INFO - 'tests': ['tp5o']}, 21:13:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:13:02 INFO - 'talos_options': ['--e10s'], 21:13:02 INFO - 'tests': ['tp5o']}, 21:13:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:13:02 INFO - 'talos_options': ['--xperf_path', 21:13:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:13:02 INFO - 'tests': ['tp5n']}, 21:13:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:13:02 INFO - 'talos_options': ['--e10s', 21:13:02 INFO - '--xperf_path', 21:13:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:13:02 INFO - 'tests': ['tp5n']}}, 21:13:02 INFO - 'talos.zip': {'path': '', 21:13:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:13:02 INFO - Running post-action listener: _resource_record_post_action 21:13:02 INFO - ##### 21:13:02 INFO - ##### Running create-virtualenv step. 21:13:02 INFO - ##### 21:13:02 INFO - Running pre-action listener: _resource_record_pre_action 21:13:02 INFO - Running main action method: create_virtualenv 21:13:02 INFO - Creating virtualenv /builds/slave/test/build/venv 21:13:02 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 21:13:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:13:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:13:02 INFO - Using real prefix '/tools/python27' 21:13:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:13:03 INFO - Installing distribute.............................................................................................................................................................................................done. 21:13:08 INFO - Installing pip.................done. 21:13:08 INFO - Return code: 0 21:13:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:13:08 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')]} 21:13:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:13:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:08 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')]} 21:13:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:13:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:08 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 0x104eff490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104edc228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9309f27430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e229f0>, '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 0x104b82db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104e168c8>, '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.wczxMZNuOj/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.qjWURUTijg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/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 21:13:08 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 21:13:08 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 21:13:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wczxMZNuOj/Render', 21:13:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:13:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:13:08 INFO - 'HOME': '/Users/cltbld', 21:13:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:13:08 INFO - 'LOGNAME': 'cltbld', 21:13:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:08 INFO - 'MOZ_NO_REMOTE': '1', 21:13:08 INFO - 'NO_EM_RESTART': '1', 21:13:08 INFO - 'PAGER': '/bin/cat', 21:13:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:13:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:08 INFO - 'PWD': '/builds/slave/test', 21:13:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:13:08 INFO - 'SHELL': '/bin/bash', 21:13:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qjWURUTijg/Listeners', 21:13:08 INFO - 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/', 21:13:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:13:08 INFO - 'USER': 'cltbld', 21:13:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:13:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:13:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:08 INFO - 'XPC_FLAGS': '0x0', 21:13:08 INFO - 'XPC_SERVICE_NAME': '0', 21:13:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 21:13:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:13:08 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 21:13:08 INFO - Cleaning up... 21:13:08 INFO - Return code: 0 21:13:08 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 21:13:08 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')]} 21:13:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:13:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:08 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')]} 21:13:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:13:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:08 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 0x104eff490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104edc228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9309f27430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e229f0>, '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 0x104b82db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104e168c8>, '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.wczxMZNuOj/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.qjWURUTijg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/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 21:13:08 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 21:13:08 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 21:13:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wczxMZNuOj/Render', 21:13:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:13:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:13:08 INFO - 'HOME': '/Users/cltbld', 21:13:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:13:08 INFO - 'LOGNAME': 'cltbld', 21:13:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:08 INFO - 'MOZ_NO_REMOTE': '1', 21:13:08 INFO - 'NO_EM_RESTART': '1', 21:13:08 INFO - 'PAGER': '/bin/cat', 21:13:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:13:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:08 INFO - 'PWD': '/builds/slave/test', 21:13:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:13:08 INFO - 'SHELL': '/bin/bash', 21:13:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qjWURUTijg/Listeners', 21:13:08 INFO - 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/', 21:13:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:13:08 INFO - 'USER': 'cltbld', 21:13:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:13:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:13:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:08 INFO - 'XPC_FLAGS': '0x0', 21:13:08 INFO - 'XPC_SERVICE_NAME': '0', 21:13:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 21:13:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:13:09 INFO - Downloading/unpacking psutil>=0.7.1 21:13:09 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 21:13:09 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 21:13:09 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 21:13:09 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 21:13:09 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 21:13:09 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 21:13:11 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 21:13:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 21:13:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:13:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:13:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:13:11 INFO - Installing collected packages: psutil 21:13:11 INFO - Running setup.py install for psutil 21:13:11 INFO - building 'psutil._psutil_osx' extension 21:13:11 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 21:13:13 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 21:13:13 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 21:13:14 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 21:13:14 INFO - building 'psutil._psutil_posix' extension 21:13:14 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 21:13:14 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:13:14 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:13:14 INFO - ^ 21:13:14 INFO - 1 warning generated. 21:13:14 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 21:13:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:13:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:13:14 INFO - Successfully installed psutil 21:13:14 INFO - Cleaning up... 21:13:14 INFO - Return code: 0 21:13:14 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 21:13:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:13:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:13:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:13:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104eff490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104edc228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9309f27430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e229f0>, '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 0x104b82db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104e168c8>, '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.wczxMZNuOj/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.qjWURUTijg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/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 21:13:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 21:13:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 21:13:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wczxMZNuOj/Render', 21:13:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:13:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:13:14 INFO - 'HOME': '/Users/cltbld', 21:13:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:13:14 INFO - 'LOGNAME': 'cltbld', 21:13:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:14 INFO - 'MOZ_NO_REMOTE': '1', 21:13:14 INFO - 'NO_EM_RESTART': '1', 21:13:14 INFO - 'PAGER': '/bin/cat', 21:13:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:13:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:14 INFO - 'PWD': '/builds/slave/test', 21:13:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:13:14 INFO - 'SHELL': '/bin/bash', 21:13:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qjWURUTijg/Listeners', 21:13:14 INFO - 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/', 21:13:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:13:14 INFO - 'USER': 'cltbld', 21:13:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:13:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:13:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:14 INFO - 'XPC_FLAGS': '0x0', 21:13:14 INFO - 'XPC_SERVICE_NAME': '0', 21:13:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 21:13:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:13:15 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:17 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:13:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 21:13:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:13:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:13:17 INFO - Installing collected packages: mozsystemmonitor 21:13:17 INFO - Running setup.py install for mozsystemmonitor 21:13:17 INFO - Successfully installed mozsystemmonitor 21:13:17 INFO - Cleaning up... 21:13:18 INFO - Return code: 0 21:13:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:13: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')]} 21:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:13:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13: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')]} 21:13:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:13:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104eff490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104edc228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9309f27430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e229f0>, '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 0x104b82db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104e168c8>, '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.wczxMZNuOj/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.qjWURUTijg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/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 21:13:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:13:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:13:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wczxMZNuOj/Render', 21:13:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:13:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:13:18 INFO - 'HOME': '/Users/cltbld', 21:13:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:13:18 INFO - 'LOGNAME': 'cltbld', 21:13:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:18 INFO - 'MOZ_NO_REMOTE': '1', 21:13:18 INFO - 'NO_EM_RESTART': '1', 21:13:18 INFO - 'PAGER': '/bin/cat', 21:13:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:13:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:18 INFO - 'PWD': '/builds/slave/test', 21:13:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:13:18 INFO - 'SHELL': '/bin/bash', 21:13:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qjWURUTijg/Listeners', 21:13:18 INFO - 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/', 21:13:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:13:18 INFO - 'USER': 'cltbld', 21:13:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:13:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:13:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:18 INFO - 'XPC_FLAGS': '0x0', 21:13:18 INFO - 'XPC_SERVICE_NAME': '0', 21:13:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 21:13:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:13:18 INFO - Downloading/unpacking blobuploader==1.2.4 21:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:21 INFO - Downloading blobuploader-1.2.4.tar.gz 21:13:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 21:13:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:13:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:13:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 21:13:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:13:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:13:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:22 INFO - Downloading docopt-0.6.1.tar.gz 21:13:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 21:13:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:13:22 INFO - Installing collected packages: blobuploader, requests, docopt 21:13:22 INFO - Running setup.py install for blobuploader 21:13:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:13:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:13:22 INFO - Running setup.py install for requests 21:13:23 INFO - Running setup.py install for docopt 21:13:23 INFO - Successfully installed blobuploader requests docopt 21:13:23 INFO - Cleaning up... 21:13:23 INFO - Return code: 0 21:13:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:13:23 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')]} 21:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:13:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:23 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')]} 21:13:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:13:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:23 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 0x104eff490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104edc228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9309f27430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e229f0>, '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 0x104b82db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104e168c8>, '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.wczxMZNuOj/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.qjWURUTijg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/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 21:13:23 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 21:13:23 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 21:13:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wczxMZNuOj/Render', 21:13:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:13:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:13:23 INFO - 'HOME': '/Users/cltbld', 21:13:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:13:23 INFO - 'LOGNAME': 'cltbld', 21:13:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:23 INFO - 'MOZ_NO_REMOTE': '1', 21:13:23 INFO - 'NO_EM_RESTART': '1', 21:13:23 INFO - 'PAGER': '/bin/cat', 21:13:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:13:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:23 INFO - 'PWD': '/builds/slave/test', 21:13:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:13:23 INFO - 'SHELL': '/bin/bash', 21:13:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qjWURUTijg/Listeners', 21:13:23 INFO - 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/', 21:13:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:13:23 INFO - 'USER': 'cltbld', 21:13:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:13:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:13:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:23 INFO - 'XPC_FLAGS': '0x0', 21:13:23 INFO - 'XPC_SERVICE_NAME': '0', 21:13:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 21:13:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:13:24 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-4duaLU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:13:24 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-xW_lJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:13:24 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-1phjw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:13:24 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-kn4RP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:13:24 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-V7HDGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:13:24 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-HEXs1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:13:24 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-W4DY8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:13:25 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-BPUIvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:13:25 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-FchA8r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:13:25 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-L05IVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:13:25 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-YESZra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:13:25 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-Hw7Hao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:13:25 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-e0wT1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:13:25 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-64IjtY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:13:26 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-QkW1mq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:13:26 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-_n9Nji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:13:26 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-6prkBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:13:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:13:26 INFO - Running setup.py install for manifestparser 21:13:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:13:26 INFO - Running setup.py install for mozcrash 21:13:26 INFO - Running setup.py install for mozdebug 21:13:26 INFO - Running setup.py install for mozdevice 21:13:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:13:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:13:27 INFO - Running setup.py install for mozfile 21:13:27 INFO - Running setup.py install for mozhttpd 21:13:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:13:27 INFO - Running setup.py install for mozinfo 21:13:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:13:27 INFO - Running setup.py install for mozInstall 21:13:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:13:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:13:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:13:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:13:27 INFO - Running setup.py install for mozleak 21:13:28 INFO - Running setup.py install for mozlog 21:13:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:13:28 INFO - Running setup.py install for moznetwork 21:13:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:13:28 INFO - Running setup.py install for mozprocess 21:13:28 INFO - Running setup.py install for mozprofile 21:13:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:13:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:13:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:13:28 INFO - Running setup.py install for mozrunner 21:13:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:13:29 INFO - Running setup.py install for mozscreenshot 21:13:29 INFO - Running setup.py install for moztest 21:13:29 INFO - Running setup.py install for mozversion 21:13:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:13:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:13:29 INFO - Cleaning up... 21:13:29 INFO - Return code: 0 21:13:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:13:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:13:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:13:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:13:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:13:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:29 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 0x104eff490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104edc228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9309f27430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e229f0>, '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 0x104b82db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104e168c8>, '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.wczxMZNuOj/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.qjWURUTijg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/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 21:13:29 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 21:13:29 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 21:13:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wczxMZNuOj/Render', 21:13:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:13:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:13:29 INFO - 'HOME': '/Users/cltbld', 21:13:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:13:29 INFO - 'LOGNAME': 'cltbld', 21:13:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:29 INFO - 'MOZ_NO_REMOTE': '1', 21:13:29 INFO - 'NO_EM_RESTART': '1', 21:13:29 INFO - 'PAGER': '/bin/cat', 21:13:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:13:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:29 INFO - 'PWD': '/builds/slave/test', 21:13:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:13:29 INFO - 'SHELL': '/bin/bash', 21:13:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qjWURUTijg/Listeners', 21:13:29 INFO - 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/', 21:13:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:13:29 INFO - 'USER': 'cltbld', 21:13:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:13:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:13:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:29 INFO - 'XPC_FLAGS': '0x0', 21:13:29 INFO - 'XPC_SERVICE_NAME': '0', 21:13:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 21:13:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:13:30 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-m8ETG7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:13:30 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)) 21:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:13:30 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-iK4BV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:13:30 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)) 21:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:13:30 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-Z8iCCB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:13:30 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)) 21:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:13:30 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-ExRppQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:13:30 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)) 21:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:13:30 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-eEnhJO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:13:30 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)) 21:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:13:30 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-DBv66E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:13:30 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)) 21:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:13:30 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-Wt23gZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:13:30 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)) 21:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:13:30 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-bT3Uvp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:13:31 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)) 21:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:13:31 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-W1UqS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:13:31 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)) 21:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:13:31 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-bOIsFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:13:31 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)) 21:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:13:31 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-IMtvEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:13:31 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)) 21:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:13:31 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-Vh1fOw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:13:31 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)) 21:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:13:31 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-DLynOq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:13:31 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)) 21:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:13:31 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-q9clo6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:13:31 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)) 21:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:13:31 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-IqA3PL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:13:32 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)) 21:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:13:32 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-23NQSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:13:32 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)) 21:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:13:32 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-5SAmhf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:13:32 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)) 21:13:32 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)) 21:13:32 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)) 21:13:32 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)) 21:13:32 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)) 21:13:32 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)) 21:13:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:13:32 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 21:13:32 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 21:13:32 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 21:13:32 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 21:13:32 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 21:13:32 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 21:13:35 INFO - Downloading blessings-1.5.1.tar.gz 21:13:35 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 21:13:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:13:35 INFO - Installing collected packages: blessings 21:13:35 INFO - Running setup.py install for blessings 21:13:35 INFO - Successfully installed blessings 21:13:35 INFO - Cleaning up... 21:13:35 INFO - Return code: 0 21:13:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:13:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:13:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:13:35 INFO - Reading from file tmpfile_stdout 21:13:35 INFO - Current package versions: 21:13:35 INFO - blessings == 1.5.1 21:13:35 INFO - blobuploader == 1.2.4 21:13:35 INFO - docopt == 0.6.1 21:13:35 INFO - manifestparser == 1.1 21:13:35 INFO - mozInstall == 1.12 21:13:35 INFO - mozcrash == 0.16 21:13:35 INFO - mozdebug == 0.1 21:13:35 INFO - mozdevice == 0.47 21:13:35 INFO - mozfile == 1.2 21:13:35 INFO - mozhttpd == 0.7 21:13:35 INFO - mozinfo == 0.9 21:13:35 INFO - mozleak == 0.1 21:13:35 INFO - mozlog == 3.0 21:13:35 INFO - moznetwork == 0.27 21:13:35 INFO - mozprocess == 0.22 21:13:35 INFO - mozprofile == 0.27 21:13:35 INFO - mozrunner == 6.11 21:13:35 INFO - mozscreenshot == 0.1 21:13:35 INFO - mozsystemmonitor == 0.0 21:13:35 INFO - moztest == 0.7 21:13:35 INFO - mozversion == 1.4 21:13:35 INFO - psutil == 3.1.1 21:13:35 INFO - requests == 1.2.3 21:13:35 INFO - wsgiref == 0.1.2 21:13:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:13:35 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')]} 21:13:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:13:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:35 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')]} 21:13:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:13:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:35 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 0x104eff490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104edc228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9309f27430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e229f0>, '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 0x104b82db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104e168c8>, '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.wczxMZNuOj/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.qjWURUTijg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/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 21:13:35 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 21:13:35 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 21:13:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wczxMZNuOj/Render', 21:13:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:13:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:13:35 INFO - 'HOME': '/Users/cltbld', 21:13:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:13:35 INFO - 'LOGNAME': 'cltbld', 21:13:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:35 INFO - 'MOZ_NO_REMOTE': '1', 21:13:35 INFO - 'NO_EM_RESTART': '1', 21:13:35 INFO - 'PAGER': '/bin/cat', 21:13:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:13:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:35 INFO - 'PWD': '/builds/slave/test', 21:13:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:13:35 INFO - 'SHELL': '/bin/bash', 21:13:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qjWURUTijg/Listeners', 21:13:35 INFO - 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/', 21:13:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:13:35 INFO - 'USER': 'cltbld', 21:13:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:13:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:13:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:35 INFO - 'XPC_FLAGS': '0x0', 21:13:35 INFO - 'XPC_SERVICE_NAME': '0', 21:13:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 21:13:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:13:36 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)) 21:13:36 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)) 21:13:36 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)) 21:13:36 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)) 21:13:36 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)) 21:13:36 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)) 21:13:36 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)) 21:13:36 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)) 21:13:36 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)) 21:13:36 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)) 21:13:36 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)) 21:13:36 INFO - Cleaning up... 21:13:36 INFO - Return code: 0 21:13:36 INFO - Running post-action listener: _resource_record_post_action 21:13:36 INFO - Running post-action listener: _start_resource_monitoring 21:13:36 INFO - Starting resource monitoring. 21:13:36 INFO - ##### 21:13:36 INFO - ##### Running install step. 21:13:36 INFO - ##### 21:13:36 INFO - Running pre-action listener: _resource_record_pre_action 21:13:36 INFO - Running main action method: install 21:13:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:13:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:13:36 INFO - Reading from file tmpfile_stdout 21:13:36 INFO - Detecting whether we're running mozinstall >=1.0... 21:13:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:13:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:13:36 INFO - Reading from file tmpfile_stdout 21:13:36 INFO - Output received: 21:13:36 INFO - Usage: mozinstall [options] installer 21:13:36 INFO - Options: 21:13:36 INFO - -h, --help show this help message and exit 21:13:36 INFO - -d DEST, --destination=DEST 21:13:36 INFO - Directory to install application into. [default: 21:13:36 INFO - "/builds/slave/test"] 21:13:36 INFO - --app=APP Application being installed. [default: firefox] 21:13:36 INFO - mkdir: /builds/slave/test/build/application 21:13:36 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'] 21:13:36 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 21:14:18 INFO - Reading from file tmpfile_stdout 21:14:18 INFO - Output received: 21:14:18 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 21:14:18 INFO - Running post-action listener: _resource_record_post_action 21:14:18 INFO - ##### 21:14:18 INFO - ##### Running run-tests step. 21:14:18 INFO - ##### 21:14:18 INFO - Running pre-action listener: _resource_record_pre_action 21:14:18 INFO - Running main action method: run_tests 21:14:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:14:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:14:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:14:18 INFO - 2015-11-15 21:14:18.381 screenresolution[1644:9213] starting screenresolution argv=screenresolution get 21:14:18 INFO - 2015-11-15 21:14:18.385 screenresolution[1644:9213] Display 0: 1600x1200x32@60 21:14:18 INFO - 2015-11-15 21:14:18.392 screenresolution[1645:9215] starting screenresolution argv=screenresolution list 21:14:18 INFO - Available Modes on Display 0 21:14:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:14:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:14:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:14:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:14:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:14:18 INFO - Intel HD Graphics 3000: 21:14:18 INFO - Chipset Model: Intel HD Graphics 3000 21:14:18 INFO - Type: GPU 21:14:18 INFO - Bus: Built-In 21:14:18 INFO - VRAM (Total): 512 MB 21:14:18 INFO - VRAM (Dynamic, Max): 10 21:14:18 INFO - Vendor: Intel (0x8086) 21:14:18 INFO - Device ID: 0x0116 21:14:18 INFO - Revision ID: 0x0009 21:14:18 INFO - Displays: 21:14:18 INFO - Display: 21:14:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:14:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:14:18 INFO - Display Serial Number: 1600x1200 60 21:14:18 INFO - Main Display: Yes 21:14:18 INFO - Mirror: Off 21:14:18 INFO - Online: Yes 21:14:18 INFO - Rotation: Supported 21:14:18 INFO - Return code: 0 21:14:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:14:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:14:18 INFO - Python 2.7.3 21:14:18 INFO - Return code: 0 21:14:18 INFO - grabbing minidump binary from tooltool 21:14: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')]} 21:14:18 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 0x104e229f0>, '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 0x104b82db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104e168c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:14:18 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 21:14:18 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 21:14:18 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:14:18 INFO - Return code: 0 21:14:18 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:14:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:14:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:14:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:14:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:14:18 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/ZjTbuTY2RkSkT863-Sdzjw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0090', '--webServer', 'localhost'] in /builds/slave/test/build 21:14:18 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/ZjTbuTY2RkSkT863-Sdzjw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0090 --webServer localhost 21:14:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wczxMZNuOj/Render', 21:14:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:14:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:14:18 INFO - 'HOME': '/Users/cltbld', 21:14:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:14:18 INFO - 'LOGNAME': 'cltbld', 21:14:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:14:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:14:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:18 INFO - 'MOZ_NO_REMOTE': '1', 21:14:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:14:18 INFO - 'NO_EM_RESTART': '1', 21:14:18 INFO - 'PAGER': '/bin/cat', 21:14:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:14:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:18 INFO - 'PWD': '/builds/slave/test', 21:14:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:14:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:14:18 INFO - 'SHELL': '/bin/bash', 21:14:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qjWURUTijg/Listeners', 21:14:18 INFO - 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/', 21:14:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:14:18 INFO - 'USER': 'cltbld', 21:14:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:14:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:14:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:18 INFO - 'XPC_FLAGS': '0x0', 21:14:18 INFO - 'XPC_SERVICE_NAME': '0', 21:14:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 21:14:18 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/ZjTbuTY2RkSkT863-Sdzjw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0090', '--webServer', 'localhost'] with output_timeout 3600 21:14:19 INFO - mozversion INFO | application_buildid: 20151115191934 21:14:19 INFO - mozversion INFO | application_changeset: 04fb61e343addd47b88ac694041c0bce5a98cfc0 21:14:19 INFO - mozversion INFO | application_display_name: Nightly 21:14:19 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:14:19 INFO - mozversion INFO | application_name: Firefox 21:14:19 INFO - mozversion INFO | application_remotingname: firefox 21:14:19 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 21:14:19 INFO - mozversion INFO | application_vendor: Mozilla 21:14:19 INFO - mozversion INFO | application_version: 45.0a1 21:14:19 INFO - mozversion INFO | platform_buildid: 20151115191934 21:14:19 INFO - mozversion INFO | platform_changeset: 04fb61e343addd47b88ac694041c0bce5a98cfc0 21:14:19 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 21:14:19 INFO - mozversion INFO | platform_version: 45.0a1 21:14:19 INFO - 2015-11-15 21:14:19,113 DEBUG : using testdate: 1447650859 21:14:19 INFO - 2015-11-15 21:14:19,113 DEBUG : actual date: 1447650859 21:14:19 INFO - 2015-11-15 21:14:19,164 INFO : starting webserver on 'localhost:49262' 21:14:19 INFO - 2015-11-15 21:14:19,165 INFO : Starting test suite t-yosemite-r5-0090 21:14:19 INFO - 2015-11-15 21:14:19,165 INFO : Starting test dromaeo_css 21:14:19 INFO - 2015-11-15 21:14:19,165 DEBUG : operating with platform_type : mac_ 21:14:19 INFO - 2015-11-15 21:14:19,166 INFO : Initialising browser for dromaeo_css test... 21:14:19 INFO - 2015-11-15 21:14:19,192 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/tmpVMIEz0/profile http://localhost:49262/getInfo.html 21:14:22 INFO - 2015-11-15 21:14:22,832 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:14:22 INFO - 2015-11-15 21:14:22,832 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:14:22 INFO - 2015-11-15 21:14:22,832 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 21:14:22 INFO - 2015-11-15 21:14:22,832 DEBUG : BROWSER_OUTPUT: __metrics 21:14:22 INFO - 2015-11-15 21:14:22,853 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:14:23 INFO - 2015-11-15 21:14:23,650 INFO : Browser initialized. 21:14:23 INFO - 2015-11-15 21:14:23,651 INFO : Running cycle 1/1 for dromaeo_css test... 21:14:23 INFO - 2015-11-15 21:14:23,651 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/tmpVMIEz0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:14:35 INFO - 2015-11-15 21:14:35,802 DEBUG : BROWSER_OUTPUT: RSS: Main: 232345600 21:14:35 INFO - 2015-11-15 21:14:35,803 DEBUG : BROWSER_OUTPUT: 21:15:27 INFO - 2015-11-15 21:15:27,749 DEBUG : BROWSER_OUTPUT: 1447650927745 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] 21:17:37 INFO - 2015-11-15 21:17:37,843 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49262/tests/dromaeo/cssquery-ext.html) 21:17:39 INFO - 2015-11-15 21:17:39,069 DEBUG : BROWSER_OUTPUT: RSS: Main: 330125312 21:17:39 INFO - 2015-11-15 21:17:39,070 DEBUG : BROWSER_OUTPUT: 21:20:41 INFO - 2015-11-15 21:20:41,972 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-ext.html (next: http://localhost:49262/tests/dromaeo/cssquery-jquery.html) 21:20:42 INFO - 2015-11-15 21:20:42,557 DEBUG : BROWSER_OUTPUT: RSS: Main: 359297024 21:20:42 INFO - 2015-11-15 21:20:42,557 DEBUG : BROWSER_OUTPUT: 21:23:45 INFO - 2015-11-15 21:23:45,029 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49262/tests/dromaeo/cssquery-mootools.html) 21:23:45 INFO - 2015-11-15 21:23:45,604 DEBUG : BROWSER_OUTPUT: RSS: Main: 362815488 21:23:45 INFO - 2015-11-15 21:23:45,604 DEBUG : BROWSER_OUTPUT: 21:26:47 INFO - 2015-11-15 21:26:47,657 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49262/tests/dromaeo/cssquery-prototype.html) 21:26:48 INFO - 2015-11-15 21:26:48,261 DEBUG : BROWSER_OUTPUT: RSS: Main: 315871232 21:26:48 INFO - 2015-11-15 21:26:48,261 DEBUG : BROWSER_OUTPUT: 21:29:51 INFO - 2015-11-15 21:29:51,613 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49262/tests/dromaeo/cssquery-yui.html) 21:29:52 INFO - 2015-11-15 21:29:52,207 DEBUG : BROWSER_OUTPUT: RSS: Main: 320634880 21:29:52 INFO - 2015-11-15 21:29:52,207 DEBUG : BROWSER_OUTPUT: 21:32:54 INFO - 2015-11-15 21:32:54,737 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-yui.html (next: http://localhost:49262/tests/dromaeo/cssquery-dojo.html) 21:32:54 INFO - 2015-11-15 21:32:54,993 DEBUG : BROWSER_OUTPUT: RSS: Main: 366993408 21:32:54 INFO - 2015-11-15 21:32:54,993 DEBUG : BROWSER_OUTPUT: 21:32:54 INFO - 2015-11-15 21:32:54,994 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:32:54 INFO - 2015-11-15 21:32:54,994 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:32:54 INFO - 2015-11-15 21:32:54,995 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:32:54 INFO - 2015-11-15 21:32:54,995 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:32:54 INFO - 2015-11-15 21:32:54,998 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2623.59334303183;2728.7271272872727;2739.342557786131;2744.1081648464256;2768.584712293157;4343.913121737563;4538.319252112181;4538.364628951941;4550.0899820036;4600.792964316605;4378.1900348435565;4482.036362182138;4578.519255478169;4611.608013318863;4627.606653434462;4097.549269580344;4178.707490475668;4185.79071046448;4189.539150693437;4195.139996300751;4185.309423945046;4309.396684464177;4342.630876375511;4376.912461750763;4379.671524635649;4041.838326466938;4088.0597462583473;4162.521310049353;4252.808623611945;4350.303951367766;4054.209429161315;4108.609682080198;4156.334986402191;4253.319468884994;4277.550857159985;4183.686223533247;4220.409142719991;4225.957740422587;4262.062346283813;4274.038341373166;4366.061296821199;4490.820367185309;4559.247724125516;4570.291604801261;4579.816807327703;4764.595009424203;4776.522347765195;4831;4839.637027222972;4993.925091123636;4903.289023091667;4934.6792458490445;4940.901181976376;4944;5014.473480284554;4362.912741745147;4540.79566419512;4547.340635607851;4550.089982003613;4681.344611754357;4906.386701662293;4931.802727890916;4974.552290293818;5009.423916249678;5062;4813.229883218738;4840.782164802592;4847.587955023862;4873.293372461044;4887.877803054952;4746.4541577719;4919.163742163841;4982;4984.526469985346;5025.221090730943;4666.090112428112;4739.739314337676;4773.37946067009;4883.58489528387;4898.657094003385;4802.73584952831;4803.207470767354;4813.663043586916;4882.658213925062;4930.285108659296;3665.3585622515952;3706.0734816295926;3710.276496083292;3743.5882052974152;3751.5873253942045;3351.111955331839;3374.746893982961;3396.5414669019365;3403.8808641697424;3414.778039427429;4447.399601053881;4517.706349087364;4526.434195725535;4540.318952157203;4573.062522182944;4828.927566086511;4847.418309802776;4865.6107511399005;4883.3651625288485;4924.039812236651;4437.090396468716;4509.120721459284;4549.385832912581;4576.496585375606;4581.083783243364;4275.230458517497;4313.784310784511;4323.783810809447;4323.870283891489;4334.9783251083545;4882.2432522959;5035.521625445577;5060.746962651779;5089.211172268304;5149.253358263031;4880.194767863263;4908.92636610444;4924.704517728947;4975.751212439436;5007.824726134568;5029.29589857413;5042.974785126051;5043.571296439697;5053.393592768891;5089.8727531812;4724.244120940633;4782;4797.064572408347;4839.274108883696;4871.926921096116;4692.812287508462;4881.829135980366;4882.487338829372;4897.608191344612;4983.277424773315;4753.168195565831;4769.61843052548;4813.422389313305;4860.173770459101;4925.014997000542;4660.510646382081;4725.267583524559;4740.5733483986605;4789.233722604506;4817.084753896748;4476.26141686618;4589.311603259404;4602.056578401487;4602.102589994919;4738.620910327097;4746.121967436035;4771.141194585008;4774.785134669018;4853.005133947603;4868.9756551217015;4577.313402989445;4690.671652984258;4741.407324084489;4750.619950404029;4777.3072904429355 21:32:55 INFO - 2015-11-15 21:32:54,998 DEBUG : BROWSER_OUTPUT: |1;ext.html;468.917939360612;468.93200485929543;478.5429914431716;482.38736804258593;498.9077020751159;25884.741152588493;26851;32505.51241731376;32618.18454538638;33392.16519587012;34635.65364346356;34750;34838.12904677384;35180.824095879485;35362.823185884095;6790.3549162829695;7502.5873576953245;7519.962400187991;7535.434842386816;7636.579988100652;6849.657517124148;7005.649717514129;9032.45805251687;9040.412373195753;9143.771405714844;8933.46399216046;8952.060033696465;9003.639854405848;9049.321300902426;9050.86423703645;6941.757038503679;7002.964985175093;8927.821443571158;9030.638774449015;9074.274058075338;6842.726290948356;9165;9183.219426348769;9226.677066302647;9304.441733495943;32009.51985720216;32252.193695157574;32486.83756581202;32552.6744732552;32927.377988421256;2320.396696858812;2332.1604222479896;2409.4337830609793;2425.478522117753;2476.306634142443;22083.227087051877;22495.55008899829;22522.436939076655;22794.77205227943;22957.08171673131;2060.5054786851047;2080.1887263967064;2083.4166433398523;2099.863508871934;2120.130746393971;235254;235312;235900;236287;236332;47118.5288147121;47567.52432475631;47879.76060119677;47960.7601961988;47977.28034079492;44625;44655.55344446579;45513.77243113763;49992.50007499951;56255.156172657444;11875.287482751062;11992.880071199352;12046.457909394097;12173.756524869454;12241.69395765113;9314.301427392973;9317.953410233042;9318.021607731227;9419.670311539063;9492.857607135898;15479.5356139316;15499.5350139496;15784.68430631381;15810.209489525707;15853.762193567105;6933.653317334113;7121.394681452135;7200.315969982843;7234.819129521804;7279.235680253497;783.6943591999011;811.2820154163608;835.5488036460365;909.0318810466831;957.0381766324799;23309.300720978397;23352.065917363456;23396.18113366024;23410.64884026741;23466.17868374633;901.783571942729;904.6381447421085;925.3304217332908;928.4939707859232;970.5486948568949;12222.327771972627;12378.319192444502;12632.74734505323;13133.474661013644;13138.146020508637;200411;204989;206439;206796;208384;37101.25797484035;37115.44326835046;37145.25709485849;37210;37542;1127.0589058136547;1128.864536255638;1133.6032388664066;1141.6061458796703;1148.2995372822572;23391.53216935686;23400.531989360457;23764.762352376256;27338.532293540975;27874.30314242079;36555.45166822553;37707.245855083296;41774;43227;43274.35088473612;185860;187064;189008;190618;190643;31755.52366714455;32045.198870028435;36405.45391819072;37257.44113838349;37469.43795843119;31590.210244743146;35099.82450087733;38102.42846357251;38719.225615488096;39133.217335653695;32420.675793241764;32532;32786.67213327836;32911.835440822644;33533.83233083916;31621.209469762518;32074.518882216318;32100.83949580237;32283.51574726334;32402.625645538494;29384.706152938197;29757.851210744673;30015.399692006475;30290;30308;27067.533856914175;28386.43227135487;28499.43001140007;28502.85748571244;29066.12801615955;21268.893655532243;21649.783502164777;21724.45688857791;21813.563728725017;21905.890470547547 21:32:55 INFO - 2015-11-15 21:32:55,003 DEBUG : BROWSER_OUTPUT: |2;jquery.html;277.5268167773946;281.9069706996691;285.05930429582384;292.9964870319157;294.5346352762635;9437.433753974767;9922.355046921944;14250.786238206421;14775.335109920052;14779.18714470705;15060.54818355451;15139.848601513982;15150.393984240618;15297.464588739396;15702.37190512381;3984.2230765000836;4590.40324757781;4619.722816630996;4691.132140554008;4692.671512994075;4649.302604609302;4679.578837904588;4706.388169537972;4728.338032675429;4766.094442056015;3329.6004479462376;3423.400904841655;3500.492428597852;4648;4734.218853889121;4875.9756201219125;5055.393352797688;5075.923861142049;5120.769565369549;5124.359455068116;4377.299632058887;4396.868093957187;4417.138657961698;4440.222960981815;4505.121501307246;18258.817411825843;18803.24787008518;18983.145758440904;19012.33456829018;19014.90492547542;1687.7890263717036;1699.923503442348;1705.9488215353558;1743.4943866278763;1790.4897104325205;10997.505112269968;11755.823662645067;11854.110941679408;11948.522059117711;12079.456424460832;1427.4718354208906;1432.9283535823272;1476.8153980752406;1486.8513148685154;1489.4489039055618;49128.26307605389;50733.74633126848;51762;51762.7411862942;52409.47590524084;8799.384043117048;8799.912000880036;9059.728208153765;9076.8638470423;9111.68109116191;11190.94404527972;11192.104631629612;11213.831792523119;11383;11384.316940983568;6279.215098112736;6281.214848143982;6321.620702757849;6342.175517182736;6344.206974128234;5909.911351329733;5917.5857689961285;5944.167816505693;5974.3726908674835;6021.939780602225;5189.792408303701;5238.135707608279;5321.787128514893;5329.493698098674;5375.059364611177;1501.594569466238;1550.0931954806565;1551.4724993502264;1575.558843523815;1610.9850793999706;348.31034551588;357.672729452548;363.5945920298848;368.34434706222964;370.66454858353234;8261.215184557457;8544.53005084714;9387.15515603599;9635.22918166545;9889.851652225223;380.3344147741453;381.0663873509912;386.92841824262604;395.84759867451237;402.54713447371705;4772.3557319762085;4778.713277203379;5010.473900240495;5140.203268493389;5482.835514934558;311914;316414;317016;318800;318835;55185.72407138019;57450.425495745345;58934.41065589289;60186.699066504385;60192.09711854326;403.159412624675;410.1735003967009;413.2705774308348;420.1240413737392;427.5574780102579;9017.684381046633;9073.183413492554;9173.54132293396;9199.908000919904;9253.491057991874;27891.302717432227;27997.720022800328;28431;28643.14070577886;28744.568831467128;39271.80364098161;39482.60517394789;39525.80237098796;39890.60109398985;40160.59839401569;4983.9003219934675;5218.634695571273;5246.055709972242;5268.051750684914;5313.149896016619;9923.206143508647;9947;9990.850137247802;10022.849657255292;10093.69718908434;8403.789905252173;8446.45098068648;8536.70121545743;8567.614457349559;8715.95408550978;6540.313267106885;7222.566646001257;7228.31331023552;8211.671533138608;8495.660173592987;8361.790955226168;8570.35722320841;8732;8752.256058234867;8812.559372031244;5132.3327967364;5214.243934629533;5223.268742376146;5318.069337865935;5334.75993580282;8448.112948140602;8557.743267701979;8603.870941936002;8701.47791132534;8803.779905502413 21:32:55 INFO - 2015-11-15 21:32:55,003 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1188.6968822950146;1196.096946805162;1222.0223820943245;1321.7488677151334;1558.7272227360202;6027.487663548598;6491.318411566783;6623.437007854326;6837.418819400345;6955.374016338528;6577.57245779024;6714.529982901199;6813.3186681331845;6850.897236541444;6871.965640171805;1660.1533218058755;1732.6015016546203;1885.50976746046;1916.434651777729;1938.7479627648456;1727.4990252826665;1904.3430016644236;1971.8126777956072;2001.8898960557165;2011.5272910865936;1895.5924476237606;1932.1015727686622;1947.9902600487048;1951.7072439134172;1969.5863868587614;1892.139076720096;1896.943091707251;1902.0869982408383;1910.5701217226083;1926.6243082598899;1892.7728672559244;1920.5870737791302;1925.124068548821;1930.9903450482798;1939.0692467615625;6662.5003124765835;6672.199336079701;6685.431738302202;6831.077804496429;6843.589384636938;4193.496780386343;4265.509466411371;4271.957280427218;4277.764722940268;4363.323684828857;2485.515324511721;2565;2565.191964531167;2587.430765231646;2607.2308668942705;640.8942524483455;741.218014994181;789.3211837819471;802.277949845144;820.0774129104757;8919.687810926587;8954.552272386354;8976.41653292534;9075.591598378089;9096.044915283866;3904.472896159039;4007.458993035961;4012.518497780285;4017.6584990276156;4053.412255222976;7744.380449564022;7792.220777922275;7799.649015794303;7809.531428114331;7846.372290216769;4340.348947657877;4341.567282796669;4358.150160718693;4421.53573874745;4441.267190913528;3933.704972127102;3934.272159650474;3946.1515774108702;4012.518497780227;4013.538443079083;3133.1540484069174;3185.5062465317915;3221.2430078931434;3226.161198088514;3264.8204348760573;1015.669907280137;1044.556063672936;1049.994750026245;1056.8309070548676;1071.2233630617895;1106.253279036647;1133.7222380516662;1149.5689116581282;1155.9017483513996;1161.5702190189684;6346.30190679025;6350;6352.460040896483;6398.712057957403;6427.710753016126;409.1550947293888;411.23305036107445;411.75500577156544;414.5936981757834;420.05278097889067;4886.682365646222;4949.232868905326;4954.455009948902;4971.279164521125;4986.077575648516;7856.214378562098;7943.920560794318;8010;8018.438709290411;8080.515169089874;7874.251946065229;7937.087234968052;7978.242067003625;8034.076081250731;8082.676692932335;6254.061890716429;6279.623222606659;6317.241930968221;6365.618062916147;6390.904136437957;5877.588568800143;6084.78703245402;6132.5707200495535;6222.16000839899;6227.221597300338;6974.197967233833;7033.648317584202;7103.786886393416;7116.359527642537;7150.249223831423;7151.32062454066;7230.530015548972;7306.707731690885;7367.152777430664;7370.262973702587;5923.519120219945;5930.940690593039;5975.014122669711;5990.161377407254;6068.51451883857;6381.234251889803;6440.581362211441;6477.125588045554;6514.185726784152;6556;5986.371430999682;6024.457798798129;6024.608400453956;6071.726772295169;6165.537584681257;5576.079946808731;5612.382637909745;5655.7172141393585;5713;5801.36185019639;6064.3935606439;6093.786717464867;6124.724387402666;6138.07928810682;6144.907826382697;5441.347038355264;5462.6995515247045;5515.062439385234;5574.191742197439;5580.720963951868;5512.862178445411;5562.082256427644;5572.526335261548;5595.748191331319;5675.489205971482 21:32:55 INFO - 2015-11-15 21:32:55,007 DEBUG : BROWSER_OUTPUT: |4;prototype.html;262.1336482923936;273.63879678823946;275.3735252301016;276.0435092404817;279.1458138097421;5268.894622107565;5281.49825766552;5306.867328316789;5330.840074797758;5370.194470829378;5244.737763111848;5269.3676758789;5277.70972596507;5279.366476022883;5367.892642147164;3848.9037774055664;3871.477350557681;3912;3966.10762578419;4045.029192993675;4004.819783109767;4011;4040.636342729154;4045.1505183911413;4075.7758323292355;3824.388097904336;3979.4826672532677;3980.7213495055357;4031.677465802729;4039.7172197946156;3897.123147291865;3916.490856188706;3977.2642061218767;3985.0834308109006;3987.9003024924464;3435.707964822993;3445.3109378124223;3489.5638045244345;3498.9475157872653;3509.7543171977973;5076.340075790161;5170.638055336128;5174.120399532088;5189.558887494568;5192.792288308463;4498.955010449919;4521.186186486431;4584.862454126382;4587.839425620121;4594.425696787902;5325.20121981702;5496.560275177976;5583;5605.215269862222;5608.298962629671;3744.3821769408014;3746.269477451898;3807.58116607173;3814;3816.637419445148;5780.9710951445395;5798.884022319572;5895.970520147372;5902.2622172228475;5906.616069955439;3810.8094595270127;3815.5993620669983;3826.7895265760094;3883.572806991229;3890.630390112935;3452.913677158091;3633.16437219441;3806.638369354907;3817.4273858921383;3929.646331830149;4396.494403143615;4423.867283981485;4493.5281795411665;4535.841245556389;4591.95408045922;5434.836954891281;5447.482489163603;5529.474699903502;5632.7746890123935;5635.6618602883955;1363.0731102850157;1375.642332993429;1380.6065271397604;1396.9930150349387;1400.8389035261075;889.7820034091689;898.2723993565234;909.3180114913814;910.904355042711;918.6830543462495;5316.6544174628525;5338.065838478251;5376.462353764592;5418.512333889968;5420.186971954159;5444.292242008513;5741.45456181662;5773.538116950634;5823.30120385548;5858.853528661817;5282.52457278839;5312.096943519611;5340.412554618989;5372.570194384518;5416.566674666017;2908.2147820088458;3025.848707564613;3050.7864449488325;3064.7088526589937;3111.7510599152465;5850.853728656818;5957.672328021914;5967.403259673998;6065.909011364833;6088.543359248074;5916.645001299936;5943.286805583358;5980.192673988956;6044.637321760709;6045.425684559959;5875.911861322169;5946.078357854453;5988.04191329394;6038.335783063947;6051.213342265565;5780.884382312414;5792.333881603501;5798.275215598051;5860.706964651665;5919.348871624204;5681.0910254359105;5686.601937864475;5790.594658373873;5791.420857914343;5795.188673585617;5964.582479226413;5969.611975221596;5973.193618861398;6053.334133245251;6066.848328791639;3692.5753538343433;3850.9807450962567;3856.7878766668105;3879.0302424393903;3890.513685789276;5810.273715785527;5816.70916454184;5853.326867410132;5882.176495290748;5921.940780592139;5622.353429355677;5663.2071509989455;5666.603337766317;5722.055860783091;5727.7422515986045;5554.611177217717;5624.690642014729;5695.088785794253;5701.344345400332;5714.828555143353;5496.945030549803;5499.257600223918;5582.49757521825;5589.189567512769;5593.972030139823;5606.467385598362;5679;5706.172604972173;5710.257666503494;5738.713064346849;5371.892562148813;5377.327834020747;5503.889922201613;5516.310461192351;5545.611807173459 21:32:55 INFO - 2015-11-15 21:32:55,008 DEBUG : BROWSER_OUTPUT: |5;yui.html;549.1981706708206;586.6685322792622;601.386585682604;602.4638072115818;651.0624700431381;11213.271137376076;11490.540378384865;11676.532938682463;11911.880881191186;11940.164188506786;9536.666216682417;12120.69698257544;12149.392530373469;12208.45061972211;12351.876481235186;572.8109723791139;577.4081566394458;715.9725793486364;722.3101937649545;729.7555318968152;560.6383882395852;743.3941337809667;751.7481643649356;752.838139799943;754.8678981178299;770.1528318849277;784.0787075186662;786.9803254918615;796.2037962037962;799.5722288575613;618.2704408797595;628.3779058731823;790.8102055506695;793.654760179318;803.0844836885925;582.8280657206134;584.3776378157249;585.7569108819835;591.60658162322;595.502755199409;11521.711957201052;11685.2404593702;11704.356260405675;11752.764944701059;11782.882171178264;9674;9716.12554870058;9865.80268394628;9903.801923961553;10343.89656103437;7560.810979725496;7893.368530517545;7953.284204421572;8056.1541038190735;8139.389545784031;2839.261791934112;2851.9714802851913;2861.241770930705;2873.6551613806478;2942.0732469272325;42426;42791;43104.3534346985;43378.783106084586;43619.12761744748;7896.565688887052;7905.288524032865;7944.165862584346;7947.205279472122;8024.438289319808;16373.91813040951;16436.506904792874;16605.6678866422;16643.33426662944;16663.33346666144;5958.612690175125;5973.731182096816;5983.820485385445;6079.422454866781;6095.390460953958;2921.3134913295357;2922.547005214195;3052.9542056869163;3088.104449709604;3104.98447507761;2595.779358754527;2613.333599932005;2615.1239334822667;2617.293330800673;2636.8286061405947;365.3241503219024;376.1592840002592;377.59408635716716;382.21645626465636;388.09573693294556;452.7215762306158;484.58810011489953;493.46212628235395;514.1644827155872;521.713057818206;6536.281009088996;6875.724971001104;7066.646667666699;7167;7487.1389790173735;391.09266501715746;392.65250253525835;496.9353983982059;518.2873548870303;545.9563234941195;3136.8274744888795;3187.2031992002;3219.532093342536;3275.295811400513;3386.49202619609;50322;50793.746031269606;50821.49178508241;50915.74542127266;51341.22988155181;42870.78564607157;43317.133657326674;43637.345439818426;44017;44420.55579444164;39105.80447097746;39520.60479395227;39799.80100099481;40071;40595.59404405977;6576.2766095728475;6642.269350371359;6733.091032710718;6752.291009443938;6886.173659160932;27126.864365678834;27245.86377068181;27773.166804995883;28542;28916.855415722788;33560.1609959753;37697.43453848139;38960.80519597497;39665;40254.39618405668;5850.297964244318;5946;5963.731632076654;5966.224390829165;6045.939540604538;8587.656493740431;8723.389362744547;8757.824843503222;8762.868556971524;8818.470891746516;8129.75610731679;8218.342532597497;8252.257296843312;8310.584470776557;8419.579021048801;8118.107008229208;8240.752777416687;8283.50298982063;8350.665973360998;8439.578021099043;8145.185481451807;8177.100518943031;8236.794080148044;8311.459755115899;8401.663933442594;7181.82045448847;7253.310935461122;7434.888476672746;7484.925150748423;7620.8475830484185;7242.710291588278;7484.035887424949;7516.285952834472;7567.091948966159;7606.733764318223 21:32:55 INFO - 2015-11-15 21:32:55,008 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:32:55 INFO - 2015-11-15 21:32:55,008 DEBUG : BROWSER_OUTPUT: __start_cc_report 21:32:55 INFO - 2015-11-15 21:32:55,008 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,928 21:32:55 INFO - 2015-11-15 21:32:55,008 DEBUG : BROWSER_OUTPUT: __end_cc_report 21:32:55 INFO - 2015-11-15 21:32:55,009 DEBUG : BROWSER_OUTPUT: __startTimestamp1447651974993__endTimestamp 21:32:55 INFO - 2015-11-15 21:32:55,009 DEBUG : BROWSER_OUTPUT: 21:32:55 INFO - 2015-11-15 21:32:55,009 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:32:55 INFO - 2015-11-15 21:32:55,009 DEBUG : BROWSER_OUTPUT: Number of tests: 6 21:32:55 INFO - 2015-11-15 21:32:55,009 DEBUG : BROWSER_OUTPUT: 21:32:55 INFO - 2015-11-15 21:32:55,009 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4539.59 Median:4690.67 stddev:497.01 (10.6%) stddev-sans-first:475.27 21:32:55 INFO - 2015-11-15 21:32:55,011 DEBUG : BROWSER_OUTPUT: Values: 2623.6 2728.7 2739.3 2744.1 2768.6 4343.9 4538.3 4538.4 4550.1 4600.8 4378.2 4482.0 4578.5 4611.6 4627.6 4097.5 4178.7 4185.8 4189.5 4195.1 4185.3 4309.4 4342.6 4376.9 4379.7 4041.8 4088.1 4162.5 4252.8 4350.3 4054.2 4108.6 4156.3 4253.3 4277.6 4183.7 4220.4 4226.0 4262.1 4274.0 4366.1 4490.8 4559.2 4570.3 4579.8 4764.6 4776.5 4831.0 4839.6 4993.9 4903.3 4934.7 4940.9 4944.0 5014.5 4362.9 4540.8 4547.3 4550.1 4681.3 4906.4 4931.8 4974.6 5009.4 5062.0 4813.2 4840.8 4847.6 4873.3 4887.9 4746.5 4919.2 4982.0 4984.5 5025.2 4666.1 4739.7 4773.4 4883.6 4898.7 4802.7 4803.2 4813.7 4882.7 4930.3 3665.4 3706.1 3710.3 3743.6 3751.6 3351.1 3374.7 3396.5 3403.9 3414.8 4447.4 4517.7 4526.4 4540.3 4573.1 4828.9 4847.4 4865.6 4883.4 4924.0 4437.1 4509.1 4549.4 4576.5 4581.1 4275.2 4313.8 4323.8 4323.9 4335.0 4882.2 5035.5 5060.7 5089.2 5149.3 4880.2 4908.9 4924.7 4975.8 5007.8 5029.3 5043.0 5043.6 5053.4 5089.9 4724.2 4782.0 4797.1 4839.3 4871.9 4692.8 4881.8 4882.5 4897.6 4983.3 4753.2 4769.6 4813.4 4860.2 4925.0 4660.5 4725.3 4740.6 4789.2 4817.1 4476.3 4589.3 4602.1 4602.1 4738.6 4746.1 4771.1 4774.8 4853.0 4869.0 4577.3 4690.7 4741.4 4750.6 4777.3 21:32:55 INFO - 2015-11-15 21:32:55,011 DEBUG : BROWSER_OUTPUT: 21:32:55 INFO - 2015-11-15 21:32:55,011 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:35973.55 Median:32542.34 stddev:54736.93 (168.2%) stddev-sans-first:54825.56 21:32:55 INFO - 2015-11-15 21:32:55,015 DEBUG : BROWSER_OUTPUT: Values: 468.9 468.9 478.5 482.4 498.9 25884.7 26851.0 32505.5 32618.2 33392.2 34635.7 34750.0 34838.1 35180.8 35362.8 6790.4 7502.6 7520.0 7535.4 7636.6 6849.7 7005.6 9032.5 9040.4 9143.8 8933.5 8952.1 9003.6 9049.3 9050.9 6941.8 7003.0 8927.8 9030.6 9074.3 6842.7 9165.0 9183.2 9226.7 9304.4 32009.5 32252.2 32486.8 32552.7 32927.4 2320.4 2332.2 2409.4 2425.5 2476.3 22083.2 22495.6 22522.4 22794.8 22957.1 2060.5 2080.2 2083.4 2099.9 2120.1 235254.0 235312.0 235900.0 236287.0 236332.0 47118.5 47567.5 47879.8 47960.8 47977.3 44625.0 44655.6 45513.8 49992.5 56255.2 11875.3 11992.9 12046.5 12173.8 12241.7 9314.3 9318.0 9318.0 9419.7 9492.9 15479.5 15499.5 15784.7 15810.2 15853.8 6933.7 7121.4 7200.3 7234.8 7279.2 783.7 811.3 835.5 909.0 957.0 23309.3 23352.1 23396.2 23410.6 23466.2 901.8 904.6 925.3 928.5 970.5 12222.3 12378.3 12632.7 13133.5 13138.1 200411.0 204989.0 206439.0 206796.0 208384.0 37101.3 37115.4 37145.3 37210.0 37542.0 1127.1 1128.9 1133.6 1141.6 1148.3 23391.5 23400.5 23764.8 27338.5 27874.3 36555.5 37707.2 41774.0 43227.0 43274.4 185860.0 187064.0 189008.0 190618.0 190643.0 31755.5 32045.2 36405.5 37257.4 37469.4 31590.2 35099.8 38102.4 38719.2 39133.2 32420.7 32532.0 32786.7 32911.8 33533.8 31621.2 32074.5 32100.8 32283.5 32402.6 29384.7 29757.9 30015.4 30290.0 30308.0 27067.5 28386.4 28499.4 28502.9 29066.1 21268.9 21649.8 21724.5 21813.6 21905.9 21:32:55 INFO - 2015-11-15 21:32:55,015 DEBUG : BROWSER_OUTPUT: 21:32:55 INFO - 2015-11-15 21:32:55,015 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:19342.66 Median:4699.53 stddev:52084.65 (1108.3%) stddev-sans-first:52211.09 21:32:55 INFO - 2015-11-15 21:32:55,015 DEBUG : BROWSER_OUTPUT: Values: 277.5 281.9 285.1 293.0 294.5 9437.4 9922.4 14250.8 14775.3 14779.2 15060.5 15139.8 15150.4 15297.5 15702.4 3984.2 4590.4 4619.7 4691.1 4692.7 4649.3 4679.6 4706.4 4728.3 4766.1 3329.6 3423.4 3500.5 4648.0 4734.2 4876.0 5055.4 5075.9 5120.8 5124.4 4377.3 4396.9 4417.1 4440.2 4505.1 18258.8 18803.2 18983.1 19012.3 19014.9 1687.8 1699.9 1705.9 1743.5 1790.5 10997.5 11755.8 11854.1 11948.5 12079.5 1427.5 1432.9 1476.8 1486.9 1489.4 49128.3 50733.7 51762.0 51762.7 52409.5 8799.4 8799.9 9059.7 9076.9 9111.7 11190.9 11192.1 11213.8 11383.0 11384.3 6279.2 6281.2 6321.6 6342.2 6344.2 5909.9 5917.6 5944.2 5974.4 6021.9 5189.8 5238.1 5321.8 5329.5 5375.1 1501.6 1550.1 1551.5 1575.6 1611.0 348.3 357.7 363.6 368.3 370.7 8261.2 8544.5 9387.2 9635.2 9889.9 380.3 381.1 386.9 395.8 402.5 4772.4 4778.7 5010.5 5140.2 5482.8 311914.0 316414.0 317016.0 318800.0 318835.0 55185.7 57450.4 58934.4 60186.7 60192.1 403.2 410.2 413.3 420.1 427.6 9017.7 9073.2 9173.5 9199.9 9253.5 27891.3 27997.7 28431.0 28643.1 28744.6 39271.8 39482.6 39525.8 39890.6 40160.6 4983.9 5218.6 5246.1 5268.1 5313.1 9923.2 9947.0 9990.9 10022.8 10093.7 8403.8 8446.5 8536.7 8567.6 8716.0 6540.3 7222.6 7228.3 8211.7 8495.7 8361.8 8570.4 8732.0 8752.3 8812.6 5132.3 5214.2 5223.3 5318.1 5334.8 8448.1 8557.7 8603.9 8701.5 8803.8 21:32:55 INFO - 2015-11-15 21:32:55,015 DEBUG : BROWSER_OUTPUT: 21:32:55 INFO - 2015-11-15 21:32:55,016 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4692.46 Median:5634.05 stddev:2430.19 (43.1%) stddev-sans-first:2422.74 21:32:55 INFO - 2015-11-15 21:32:55,016 DEBUG : BROWSER_OUTPUT: Values: 1188.7 1196.1 1222.0 1321.7 1558.7 6027.5 6491.3 6623.4 6837.4 6955.4 6577.6 6714.5 6813.3 6850.9 6872.0 1660.2 1732.6 1885.5 1916.4 1938.7 1727.5 1904.3 1971.8 2001.9 2011.5 1895.6 1932.1 1948.0 1951.7 1969.6 1892.1 1896.9 1902.1 1910.6 1926.6 1892.8 1920.6 1925.1 1931.0 1939.1 6662.5 6672.2 6685.4 6831.1 6843.6 4193.5 4265.5 4272.0 4277.8 4363.3 2485.5 2565.0 2565.2 2587.4 2607.2 640.9 741.2 789.3 802.3 820.1 8919.7 8954.6 8976.4 9075.6 9096.0 3904.5 4007.5 4012.5 4017.7 4053.4 7744.4 7792.2 7799.6 7809.5 7846.4 4340.3 4341.6 4358.2 4421.5 4441.3 3933.7 3934.3 3946.2 4012.5 4013.5 3133.2 3185.5 3221.2 3226.2 3264.8 1015.7 1044.6 1050.0 1056.8 1071.2 1106.3 1133.7 1149.6 1155.9 1161.6 6346.3 6350.0 6352.5 6398.7 6427.7 409.2 411.2 411.8 414.6 420.1 4886.7 4949.2 4954.5 4971.3 4986.1 7856.2 7943.9 8010.0 8018.4 8080.5 7874.3 7937.1 7978.2 8034.1 8082.7 6254.1 6279.6 6317.2 6365.6 6390.9 5877.6 6084.8 6132.6 6222.2 6227.2 6974.2 7033.6 7103.8 7116.4 7150.2 7151.3 7230.5 7306.7 7367.2 7370.3 5923.5 5930.9 5975.0 5990.2 6068.5 6381.2 6440.6 6477.1 6514.2 6556.0 5986.4 6024.5 6024.6 6071.7 6165.5 5576.1 5612.4 5655.7 5713.0 5801.4 6064.4 6093.8 6124.7 6138.1 6144.9 5441.3 5462.7 5515.1 5574.2 5580.7 5512.9 5562.1 5572.5 5595.7 5675.5 21:32:55 INFO - 2015-11-15 21:32:55,016 DEBUG : BROWSER_OUTPUT: 21:32:55 INFO - 2015-11-15 21:32:55,016 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4659.92 Median:5371.04 stddev:1446.69 (26.9%) stddev-sans-first:1412.59 21:32:55 INFO - 2015-11-15 21:32:55,018 DEBUG : BROWSER_OUTPUT: Values: 262.1 273.6 275.4 276.0 279.1 5268.9 5281.5 5306.9 5330.8 5370.2 5244.7 5269.4 5277.7 5279.4 5367.9 3848.9 3871.5 3912.0 3966.1 4045.0 4004.8 4011.0 4040.6 4045.2 4075.8 3824.4 3979.5 3980.7 4031.7 4039.7 3897.1 3916.5 3977.3 3985.1 3987.9 3435.7 3445.3 3489.6 3498.9 3509.8 5076.3 5170.6 5174.1 5189.6 5192.8 4499.0 4521.2 4584.9 4587.8 4594.4 5325.2 5496.6 5583.0 5605.2 5608.3 3744.4 3746.3 3807.6 3814.0 3816.6 5781.0 5798.9 5896.0 5902.3 5906.6 3810.8 3815.6 3826.8 3883.6 3890.6 3452.9 3633.2 3806.6 3817.4 3929.6 4396.5 4423.9 4493.5 4535.8 4592.0 5434.8 5447.5 5529.5 5632.8 5635.7 1363.1 1375.6 1380.6 1397.0 1400.8 889.8 898.3 909.3 910.9 918.7 5316.7 5338.1 5376.5 5418.5 5420.2 5444.3 5741.5 5773.5 5823.3 5858.9 5282.5 5312.1 5340.4 5372.6 5416.6 2908.2 3025.8 3050.8 3064.7 3111.8 5850.9 5957.7 5967.4 6065.9 6088.5 5916.6 5943.3 5980.2 6044.6 6045.4 5875.9 5946.1 5988.0 6038.3 6051.2 5780.9 5792.3 5798.3 5860.7 5919.3 5681.1 5686.6 5790.6 5791.4 5795.2 5964.6 5969.6 5973.2 6053.3 6066.8 3692.6 3851.0 3856.8 3879.0 3890.5 5810.3 5816.7 5853.3 5882.2 5921.9 5622.4 5663.2 5666.6 5722.1 5727.7 5554.6 5624.7 5695.1 5701.3 5714.8 5496.9 5499.3 5582.5 5589.2 5594.0 5606.5 5679.0 5706.2 5710.3 5738.7 5371.9 5377.3 5503.9 5516.3 5545.6 21:32:55 INFO - 2015-11-15 21:32:55,018 DEBUG : BROWSER_OUTPUT: 21:32:55 INFO - 2015-11-15 21:32:55,018 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11442.76 Median:585.07 stddev:13936.39 (2382.0%) stddev-sans-first:13951.48 21:32:55 INFO - 2015-11-15 21:32:55,019 DEBUG : BROWSER_OUTPUT: Values: 549.2 586.7 601.4 602.5 651.1 11213.3 11490.5 11676.5 11911.9 11940.2 9536.7 12120.7 12149.4 12208.5 12351.9 572.8 577.4 716.0 722.3 729.8 560.6 743.4 751.7 752.8 754.9 770.2 784.1 787.0 796.2 799.6 618.3 628.4 790.8 793.7 803.1 582.8 584.4 585.8 591.6 595.5 11521.7 11685.2 11704.4 11752.8 11782.9 9674.0 9716.1 9865.8 9903.8 10343.9 7560.8 7893.4 7953.3 8056.2 8139.4 2839.3 2852.0 2861.2 2873.7 2942.1 42426.0 42791.0 43104.4 43378.8 43619.1 7896.6 7905.3 7944.2 7947.2 8024.4 16373.9 16436.5 16605.7 16643.3 16663.3 5958.6 5973.7 5983.8 6079.4 6095.4 2921.3 2922.5 3053.0 3088.1 3105.0 2595.8 2613.3 2615.1 2617.3 2636.8 365.3 376.2 377.6 382.2 388.1 452.7 484.6 493.5 514.2 521.7 6536.3 6875.7 7066.6 7167.0 7487.1 391.1 392.7 496.9 518.3 546.0 3136.8 3187.2 3219.5 3275.3 3386.5 50322.0 50793.7 50821.5 50915.7 51341.2 42870.8 43317.1 43637.3 44017.0 44420.6 39105.8 39520.6 39799.8 40071.0 40595.6 6576.3 6642.3 6733.1 6752.3 6886.2 27126.9 27245.9 27773.2 28542.0 28916.9 33560.2 37697.4 38960.8 39665.0 40254.4 5850.3 5946.0 5963.7 5966.2 6045.9 8587.7 8723.4 8757.8 8762.9 8818.5 8129.8 8218.3 8252.3 8310.6 8419.6 8118.1 8240.8 8283.5 8350.7 8439.6 8145.2 8177.1 8236.8 8311.5 8401.7 7181.8 7253.3 7434.9 7484.9 7620.8 7242.7 7484.0 7516.3 7567.1 7606.7 21:32:55 INFO - 2015-11-15 21:32:55,019 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:32:55 INFO - 2015-11-15 21:32:55,019 DEBUG : BROWSER_OUTPUT: 21:32:55 INFO - 2015-11-15 21:32:55,700 INFO : Browser exited with error code: 0 21:32:55 INFO - 2015-11-15 21:32:55,732 INFO : Completed test dromaeo_css (00:18:36) 21:32:55 INFO - 2015-11-15 21:32:55,733 INFO : Starting test kraken 21:32:55 INFO - 2015-11-15 21:32:55,733 DEBUG : operating with platform_type : mac_ 21:32:55 INFO - 2015-11-15 21:32:55,733 INFO : Initialising browser for kraken test... 21:32:55 INFO - 2015-11-15 21:32:55,748 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/tmpcfPmXk/profile http://localhost:49262/getInfo.html 21:32:58 INFO - 2015-11-15 21:32:58,235 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:32:58 INFO - 2015-11-15 21:32:58,235 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:32:58 INFO - 2015-11-15 21:32:58,235 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 21:32:58 INFO - 2015-11-15 21:32:58,236 DEBUG : BROWSER_OUTPUT: __metrics 21:32:58 INFO - 2015-11-15 21:32:58,251 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:32:59 INFO - 2015-11-15 21:32:59,049 INFO : Browser initialized. 21:32:59 INFO - 2015-11-15 21:32:59,050 INFO : Running cycle 1/1 for kraken test... 21:32:59 INFO - 2015-11-15 21:32:59,050 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/tmpcfPmXk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:33:11 INFO - 2015-11-15 21:33:11,190 DEBUG : BROWSER_OUTPUT: RSS: Main: 229937152 21:33:11 INFO - 2015-11-15 21:33:11,190 DEBUG : BROWSER_OUTPUT: 21:33:14 INFO - 2015-11-15 21:33:14,108 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-beat-detection) 21:33:14 INFO - 2015-11-15 21:33:14,700 DEBUG : BROWSER_OUTPUT: RSS: Main: 285204480 21:33:14 INFO - 2015-11-15 21:33:14,701 DEBUG : BROWSER_OUTPUT: 21:33:17 INFO - 2015-11-15 21:33:17,755 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-dft) 21:33:18 INFO - 2015-11-15 21:33:18,351 DEBUG : BROWSER_OUTPUT: RSS: Main: 298430464 21:33:18 INFO - 2015-11-15 21:33:18,352 DEBUG : BROWSER_OUTPUT: 21:33:21 INFO - 2015-11-15 21:33:21,731 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-fft) 21:33:22 INFO - 2015-11-15 21:33:22,316 DEBUG : BROWSER_OUTPUT: RSS: Main: 280768512 21:33:22 INFO - 2015-11-15 21:33:22,316 DEBUG : BROWSER_OUTPUT: 21:33:24 INFO - 2015-11-15 21:33:24,614 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-oscillator) 21:33:25 INFO - 2015-11-15 21:33:25,205 DEBUG : BROWSER_OUTPUT: RSS: Main: 283254784 21:33:25 INFO - 2015-11-15 21:33:25,205 DEBUG : BROWSER_OUTPUT: 21:33:27 INFO - 2015-11-15 21:33:27,681 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49262/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:33:28 INFO - 2015-11-15 21:33:28,263 DEBUG : BROWSER_OUTPUT: RSS: Main: 284237824 21:33:28 INFO - 2015-11-15 21:33:28,263 DEBUG : BROWSER_OUTPUT: 21:33:31 INFO - 2015-11-15 21:33:31,768 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49262/tests/kraken/driver.html?testName=imaging-darkroom) 21:33:32 INFO - 2015-11-15 21:33:32,358 DEBUG : BROWSER_OUTPUT: RSS: Main: 280051712 21:33:32 INFO - 2015-11-15 21:33:32,359 DEBUG : BROWSER_OUTPUT: 21:33:35 INFO - 2015-11-15 21:33:35,981 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49262/tests/kraken/driver.html?testName=imaging-desaturate) 21:33:36 INFO - 2015-11-15 21:33:36,576 DEBUG : BROWSER_OUTPUT: RSS: Main: 280715264 21:33:36 INFO - 2015-11-15 21:33:36,576 DEBUG : BROWSER_OUTPUT: 21:33:39 INFO - 2015-11-15 21:33:39,827 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49262/tests/kraken/driver.html?testName=json-parse-financial) 21:33:40 INFO - 2015-11-15 21:33:40,411 DEBUG : BROWSER_OUTPUT: RSS: Main: 282673152 21:33:40 INFO - 2015-11-15 21:33:40,412 DEBUG : BROWSER_OUTPUT: 21:33:42 INFO - 2015-11-15 21:33:42,161 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49262/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:33:42 INFO - 2015-11-15 21:33:42,738 DEBUG : BROWSER_OUTPUT: RSS: Main: 316923904 21:33:42 INFO - 2015-11-15 21:33:42,738 DEBUG : BROWSER_OUTPUT: 21:33:44 INFO - 2015-11-15 21:33:44,797 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:33:45 INFO - 2015-11-15 21:33:45,424 DEBUG : BROWSER_OUTPUT: RSS: Main: 317804544 21:33:45 INFO - 2015-11-15 21:33:45,424 DEBUG : BROWSER_OUTPUT: 21:33:47 INFO - 2015-11-15 21:33:47,797 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:33:48 INFO - 2015-11-15 21:33:48,385 DEBUG : BROWSER_OUTPUT: RSS: Main: 325451776 21:33:48 INFO - 2015-11-15 21:33:48,385 DEBUG : BROWSER_OUTPUT: 21:33:51 INFO - 2015-11-15 21:33:51,369 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:33:51 INFO - 2015-11-15 21:33:51,972 DEBUG : BROWSER_OUTPUT: RSS: Main: 326987776 21:33:51 INFO - 2015-11-15 21:33:51,972 DEBUG : BROWSER_OUTPUT: 21:33:54 INFO - 2015-11-15 21:33:54,965 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:33:55 INFO - 2015-11-15 21:33:55,550 DEBUG : BROWSER_OUTPUT: RSS: Main: 326860800 21:33:55 INFO - 2015-11-15 21:33:55,550 DEBUG : BROWSER_OUTPUT: 21:33:57 INFO - 2015-11-15 21:33:57,525 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49262/tests/kraken/driver.html?testName=ai-astar) 21:33:57 INFO - 2015-11-15 21:33:57,786 DEBUG : BROWSER_OUTPUT: RSS: Main: 386498560 21:33:57 INFO - 2015-11-15 21:33:57,786 DEBUG : BROWSER_OUTPUT: 21:33:57 INFO - 2015-11-15 21:33:57,786 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:33:57 INFO - 2015-11-15 21:33:57,786 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:33:57 INFO - 2015-11-15 21:33:57,786 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:33:57 INFO - 2015-11-15 21:33:57,786 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:33:57 INFO - 2015-11-15 21:33:57,786 DEBUG : BROWSER_OUTPUT: |0;ai-astar;123;132;124;131;129;125;113;137;136;117 21:33:57 INFO - 2015-11-15 21:33:57,787 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;185;160;185;198;155;182;180;155;197;156 21:33:57 INFO - 2015-11-15 21:33:57,787 DEBUG : BROWSER_OUTPUT: |2;audio-dft;187;192;196;195;186;189;197;197;191;188 21:33:57 INFO - 2015-11-15 21:33:57,787 DEBUG : BROWSER_OUTPUT: |3;audio-fft;85;95;109;103;85;85;92;99;103;83 21:33:57 INFO - 2015-11-15 21:33:57,787 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;114;114;165;110;110;110;155;107;105;152 21:33:57 INFO - 2015-11-15 21:33:57,787 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;142;148;148;140;142;141;141;145;134;148 21:33:57 INFO - 2015-11-15 21:33:57,787 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;156;155;152;148;154;155;154;148;147;154 21:33:57 INFO - 2015-11-15 21:33:57,787 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;110;124;115;115;115;124;114;124;114;124 21:33:57 INFO - 2015-11-15 21:33:57,787 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;64;66;70;69;72;72;73;83;72;72 21:33:57 INFO - 2015-11-15 21:33:57,787 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;77;82;82;85;87;85;86;84;81;82 21:33:57 INFO - 2015-11-15 21:33:57,787 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;99;103;106;104;104;105;103;105;107;106 21:33:57 INFO - 2015-11-15 21:33:57,788 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;154;156;158;152;159;152;149;157;162;154 21:33:57 INFO - 2015-11-15 21:33:57,788 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;166;170;189;191;179;166;187;191;188;179 21:33:57 INFO - 2015-11-15 21:33:57,788 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;80;82;83;88;91;91;87;88;87;87 21:33:57 INFO - 2015-11-15 21:33:57,788 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:33:57 INFO - 2015-11-15 21:33:57,788 DEBUG : BROWSER_OUTPUT: __start_cc_report 21:33:57 INFO - 2015-11-15 21:33:57,788 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,982 21:33:57 INFO - 2015-11-15 21:33:57,788 DEBUG : BROWSER_OUTPUT: __end_cc_report 21:33:57 INFO - 2015-11-15 21:33:57,789 DEBUG : BROWSER_OUTPUT: __startTimestamp1447652037779__endTimestamp 21:33:57 INFO - 2015-11-15 21:33:57,789 DEBUG : BROWSER_OUTPUT: 21:33:57 INFO - 2015-11-15 21:33:57,789 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:33:57 INFO - 2015-11-15 21:33:57,789 DEBUG : BROWSER_OUTPUT: Number of tests: 14 21:33:57 INFO - 2015-11-15 21:33:57,789 DEBUG : BROWSER_OUTPUT: 21:33:57 INFO - 2015-11-15 21:33:57,789 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:126.70 Median:130.00 stddev:7.82 (6.0%) stddev-sans-first:8.18 21:33:57 INFO - 2015-11-15 21:33:57,789 DEBUG : BROWSER_OUTPUT: Values: 123.0 132.0 124.0 131.0 129.0 125.0 113.0 137.0 136.0 117.0 21:33:57 INFO - 2015-11-15 21:33:57,789 DEBUG : BROWSER_OUTPUT: 21:33:57 INFO - 2015-11-15 21:33:57,790 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:175.30 Median:183.50 stddev:17.23 (9.4%) stddev-sans-first:17.91 21:33:57 INFO - 2015-11-15 21:33:57,790 DEBUG : BROWSER_OUTPUT: Values: 185.0 160.0 185.0 198.0 155.0 182.0 180.0 155.0 197.0 156.0 21:33:57 INFO - 2015-11-15 21:33:57,790 DEBUG : BROWSER_OUTPUT: 21:33:57 INFO - 2015-11-15 21:33:57,790 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:191.80 Median:193.50 stddev:4.24 (2.2%) stddev-sans-first:4.12 21:33:57 INFO - 2015-11-15 21:33:57,790 DEBUG : BROWSER_OUTPUT: Values: 187.0 192.0 196.0 195.0 186.0 189.0 197.0 197.0 191.0 188.0 21:33:57 INFO - 2015-11-15 21:33:57,790 DEBUG : BROWSER_OUTPUT: 21:33:57 INFO - 2015-11-15 21:33:57,790 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:93.90 Median:85.00 stddev:9.31 (11.0%) stddev-sans-first:9.31 21:33:57 INFO - 2015-11-15 21:33:57,790 DEBUG : BROWSER_OUTPUT: Values: 85.0 95.0 109.0 103.0 85.0 85.0 92.0 99.0 103.0 83.0 21:33:57 INFO - 2015-11-15 21:33:57,790 DEBUG : BROWSER_OUTPUT: 21:33:57 INFO - 2015-11-15 21:33:57,791 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:124.20 Median:114.00 stddev:23.25 (20.4%) stddev-sans-first:24.36 21:33:57 INFO - 2015-11-15 21:33:57,791 DEBUG : BROWSER_OUTPUT: Values: 114.0 114.0 165.0 110.0 110.0 110.0 155.0 107.0 105.0 152.0 21:33:57 INFO - 2015-11-15 21:33:57,791 DEBUG : BROWSER_OUTPUT: 21:33:57 INFO - 2015-11-15 21:33:57,791 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:142.90 Median:143.50 stddev:4.46 (3.1%) stddev-sans-first:4.72 21:33:57 INFO - 2015-11-15 21:33:57,791 DEBUG : BROWSER_OUTPUT: Values: 142.0 148.0 148.0 140.0 142.0 141.0 141.0 145.0 134.0 148.0 21:33:57 INFO - 2015-11-15 21:33:57,791 DEBUG : BROWSER_OUTPUT: 21:33:57 INFO - 2015-11-15 21:33:57,791 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:152.30 Median:154.00 stddev:3.37 (2.2%) stddev-sans-first:3.30 21:33:57 INFO - 2015-11-15 21:33:57,791 DEBUG : BROWSER_OUTPUT: Values: 156.0 155.0 152.0 148.0 154.0 155.0 154.0 148.0 147.0 154.0 21:33:57 INFO - 2015-11-15 21:33:57,791 DEBUG : BROWSER_OUTPUT: 21:33:57 INFO - 2015-11-15 21:33:57,791 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:117.90 Median:119.50 stddev:5.45 (4.6%) stddev-sans-first:4.97 21:33:57 INFO - 2015-11-15 21:33:57,792 DEBUG : BROWSER_OUTPUT: Values: 110.0 124.0 115.0 115.0 115.0 124.0 114.0 124.0 114.0 124.0 21:33:57 INFO - 2015-11-15 21:33:57,792 DEBUG : BROWSER_OUTPUT: 21:33:57 INFO - 2015-11-15 21:33:57,792 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.30 Median:72.00 stddev:5.06 (7.0%) stddev-sans-first:4.62 21:33:57 INFO - 2015-11-15 21:33:57,792 DEBUG : BROWSER_OUTPUT: Values: 64.0 66.0 70.0 69.0 72.0 72.0 73.0 83.0 72.0 72.0 21:33:57 INFO - 2015-11-15 21:33:57,792 DEBUG : BROWSER_OUTPUT: 21:33:57 INFO - 2015-11-15 21:33:57,792 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:83.10 Median:84.50 stddev:2.92 (3.5%) stddev-sans-first:2.11 21:33:57 INFO - 2015-11-15 21:33:57,792 DEBUG : BROWSER_OUTPUT: Values: 77.0 82.0 82.0 85.0 87.0 85.0 86.0 84.0 81.0 82.0 21:33:57 INFO - 2015-11-15 21:33:57,792 DEBUG : BROWSER_OUTPUT: 21:33:57 INFO - 2015-11-15 21:33:57,792 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:104.20 Median:105.50 stddev:2.25 (2.1%) stddev-sans-first:1.39 21:33:57 INFO - 2015-11-15 21:33:57,793 DEBUG : BROWSER_OUTPUT: Values: 99.0 103.0 106.0 104.0 104.0 105.0 103.0 105.0 107.0 106.0 21:33:57 INFO - 2015-11-15 21:33:57,793 DEBUG : BROWSER_OUTPUT: 21:33:57 INFO - 2015-11-15 21:33:57,793 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:155.30 Median:156.50 stddev:3.86 (2.5%) stddev-sans-first:4.07 21:33:57 INFO - 2015-11-15 21:33:57,793 DEBUG : BROWSER_OUTPUT: Values: 154.0 156.0 158.0 152.0 159.0 152.0 149.0 157.0 162.0 154.0 21:33:57 INFO - 2015-11-15 21:33:57,793 DEBUG : BROWSER_OUTPUT: 21:33:57 INFO - 2015-11-15 21:33:57,793 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.60 Median:187.50 stddev:10.15 (5.4%) stddev-sans-first:9.28 21:33:57 INFO - 2015-11-15 21:33:57,793 DEBUG : BROWSER_OUTPUT: Values: 166.0 170.0 189.0 191.0 179.0 166.0 187.0 191.0 188.0 179.0 21:33:57 INFO - 2015-11-15 21:33:57,794 DEBUG : BROWSER_OUTPUT: 21:33:57 INFO - 2015-11-15 21:33:57,794 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:86.40 Median:87.50 stddev:3.66 (4.2%) stddev-sans-first:3.06 21:33:57 INFO - 2015-11-15 21:33:57,794 DEBUG : BROWSER_OUTPUT: Values: 80.0 82.0 83.0 88.0 91.0 91.0 87.0 88.0 87.0 87.0 21:33:57 INFO - 2015-11-15 21:33:57,794 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:33:57 INFO - 2015-11-15 21:33:57,794 DEBUG : BROWSER_OUTPUT: 21:33:58 INFO - 2015-11-15 21:33:58,519 INFO : Browser exited with error code: 0 21:33:58 INFO - 2015-11-15 21:33:58,575 INFO : Completed test kraken (00:01:02) 21:33:58 INFO - 2015-11-15 21:33:58,575 INFO : Starting test v8_7 21:33:58 INFO - 2015-11-15 21:33:58,575 DEBUG : operating with platform_type : mac_ 21:33:58 INFO - 2015-11-15 21:33:58,575 INFO : Initialising browser for v8_7 test... 21:33:58 INFO - 2015-11-15 21:33:58,590 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/tmpDvWXi6/profile http://localhost:49262/getInfo.html 21:34:01 INFO - 2015-11-15 21:34:01,100 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:34:01 INFO - 2015-11-15 21:34:01,101 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:34:01 INFO - 2015-11-15 21:34:01,101 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 21:34:01 INFO - 2015-11-15 21:34:01,101 DEBUG : BROWSER_OUTPUT: __metrics 21:34:01 INFO - 2015-11-15 21:34:01,117 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:34:01 INFO - 2015-11-15 21:34:01,900 INFO : Browser initialized. 21:34:01 INFO - 2015-11-15 21:34:01,901 INFO : Running cycle 1/1 for v8_7 test... 21:34:01 INFO - 2015-11-15 21:34:01,901 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/tmpDvWXi6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:34:14 INFO - 2015-11-15 21:34:14,015 DEBUG : BROWSER_OUTPUT: RSS: Main: 228745216 21:34:14 INFO - 2015-11-15 21:34:14,015 DEBUG : BROWSER_OUTPUT: 21:34:36 INFO - 2015-11-15 21:34:36,919 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/v8_7/run.html (next: http://localhost:49262/tests/v8_7/run.html) 21:34:37 INFO - 2015-11-15 21:34:37,178 DEBUG : BROWSER_OUTPUT: RSS: Main: 701263872 21:34:37 INFO - 2015-11-15 21:34:37,178 DEBUG : BROWSER_OUTPUT: 21:34:37 INFO - 2015-11-15 21:34:37,178 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:34:37 INFO - 2015-11-15 21:34:37,178 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:34:37 INFO - 2015-11-15 21:34:37,178 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:34:37 INFO - 2015-11-15 21:34:37,178 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:34:37 INFO - 2015-11-15 21:34:37,179 DEBUG : BROWSER_OUTPUT: |0;Richards;199.0842126219391 21:34:37 INFO - 2015-11-15 21:34:37,179 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;229.77941176470588 21:34:37 INFO - 2015-11-15 21:34:37,179 DEBUG : BROWSER_OUTPUT: |2;Encrypt;376.6478342749529 21:34:37 INFO - 2015-11-15 21:34:37,179 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6724.832214765101 21:34:37 INFO - 2015-11-15 21:34:37,179 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2306.451612903226 21:34:37 INFO - 2015-11-15 21:34:37,179 DEBUG : BROWSER_OUTPUT: |5;Earley;954.2421353670162 21:34:37 INFO - 2015-11-15 21:34:37,179 DEBUG : BROWSER_OUTPUT: |6;Boyer;15212.121212121212 21:34:37 INFO - 2015-11-15 21:34:37,179 DEBUG : BROWSER_OUTPUT: |7;RegExp;35344.8275862069 21:34:37 INFO - 2015-11-15 21:34:37,179 DEBUG : BROWSER_OUTPUT: |8;Splay;748.6950037285608 21:34:37 INFO - 2015-11-15 21:34:37,179 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6849.315068493151 21:34:37 INFO - 2015-11-15 21:34:37,179 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:34:37 INFO - 2015-11-15 21:34:37,179 DEBUG : BROWSER_OUTPUT: __startTimestamp1447652077170__endTimestamp 21:34:37 INFO - 2015-11-15 21:34:37,179 DEBUG : BROWSER_OUTPUT: 21:34:37 INFO - 2015-11-15 21:34:37,180 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:34:37 INFO - 2015-11-15 21:34:37,180 DEBUG : BROWSER_OUTPUT: Number of tests: 10 21:34:37 INFO - 2015-11-15 21:34:37,180 DEBUG : BROWSER_OUTPUT: 21:34:37 INFO - 2015-11-15 21:34:37,180 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:199.08 Median:199.08 stddev:0.00 (0.0%) 21:34:37 INFO - 2015-11-15 21:34:37,180 DEBUG : BROWSER_OUTPUT: Values: 199.1 21:34:37 INFO - 2015-11-15 21:34:37,180 DEBUG : BROWSER_OUTPUT: 21:34:37 INFO - 2015-11-15 21:34:37,180 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:229.78 Median:229.78 stddev:0.00 (0.0%) 21:34:37 INFO - 2015-11-15 21:34:37,180 DEBUG : BROWSER_OUTPUT: Values: 229.8 21:34:37 INFO - 2015-11-15 21:34:37,180 DEBUG : BROWSER_OUTPUT: 21:34:37 INFO - 2015-11-15 21:34:37,180 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:376.65 Median:376.65 stddev:0.00 (0.0%) 21:34:37 INFO - 2015-11-15 21:34:37,180 DEBUG : BROWSER_OUTPUT: Values: 376.6 21:34:37 INFO - 2015-11-15 21:34:37,180 DEBUG : BROWSER_OUTPUT: 21:34:37 INFO - 2015-11-15 21:34:37,180 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6724.83 Median:6724.83 stddev:0.00 (0.0%) 21:34:37 INFO - 2015-11-15 21:34:37,181 DEBUG : BROWSER_OUTPUT: Values: 6724.8 21:34:37 INFO - 2015-11-15 21:34:37,181 DEBUG : BROWSER_OUTPUT: 21:34:37 INFO - 2015-11-15 21:34:37,181 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2306.45 Median:2306.45 stddev:0.00 (0.0%) 21:34:37 INFO - 2015-11-15 21:34:37,181 DEBUG : BROWSER_OUTPUT: Values: 2306.5 21:34:37 INFO - 2015-11-15 21:34:37,181 DEBUG : BROWSER_OUTPUT: 21:34:37 INFO - 2015-11-15 21:34:37,181 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:954.24 Median:954.24 stddev:0.00 (0.0%) 21:34:37 INFO - 2015-11-15 21:34:37,181 DEBUG : BROWSER_OUTPUT: Values: 954.2 21:34:37 INFO - 2015-11-15 21:34:37,181 DEBUG : BROWSER_OUTPUT: 21:34:37 INFO - 2015-11-15 21:34:37,181 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:15212.12 Median:15212.12 stddev:0.00 (0.0%) 21:34:37 INFO - 2015-11-15 21:34:37,181 DEBUG : BROWSER_OUTPUT: Values: 15212.1 21:34:37 INFO - 2015-11-15 21:34:37,181 DEBUG : BROWSER_OUTPUT: 21:34:37 INFO - 2015-11-15 21:34:37,181 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:35344.83 Median:35344.83 stddev:0.00 (0.0%) 21:34:37 INFO - 2015-11-15 21:34:37,181 DEBUG : BROWSER_OUTPUT: Values: 35344.8 21:34:37 INFO - 2015-11-15 21:34:37,182 DEBUG : BROWSER_OUTPUT: 21:34:37 INFO - 2015-11-15 21:34:37,182 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:748.70 Median:748.70 stddev:0.00 (0.0%) 21:34:37 INFO - 2015-11-15 21:34:37,182 DEBUG : BROWSER_OUTPUT: Values: 748.7 21:34:37 INFO - 2015-11-15 21:34:37,182 DEBUG : BROWSER_OUTPUT: 21:34:37 INFO - 2015-11-15 21:34:37,182 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6849.32 Median:6849.32 stddev:0.00 (0.0%) 21:34:37 INFO - 2015-11-15 21:34:37,182 DEBUG : BROWSER_OUTPUT: Values: 6849.3 21:34:37 INFO - 2015-11-15 21:34:37,182 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:34:37 INFO - 2015-11-15 21:34:37,182 DEBUG : BROWSER_OUTPUT: 21:34:37 INFO - 2015-11-15 21:34:37,941 INFO : Browser exited with error code: 0 21:34:37 INFO - 2015-11-15 21:34:37,965 INFO : Completed test v8_7 (00:00:39) 21:34:38 INFO - 2015-11-15 21:34:38,414 INFO : Completed test suite (00:20:19) 21:34:38 INFO - 2015-11-15 21:34:38,414 DEBUG : Working with test: dromaeo_css 21:34:38 INFO - 2015-11-15 21:34:38,414 DEBUG : Generating results file: dromaeo_css 21:34:38 INFO - 2015-11-15 21:34:38,415 DEBUG : Working with test: kraken 21:34:38 INFO - 2015-11-15 21:34:38,415 DEBUG : Generating results file: kraken 21:34:38 INFO - 2015-11-15 21:34:38,416 INFO : javascript benchmark 21:34:38 INFO - 2015-11-15 21:34:38,416 DEBUG : Working with test: v8_7 21:34:38 INFO - 2015-11-15 21:34:38,416 DEBUG : Generating results file: v8_7 21:34:38 INFO - 2015-11-15 21:34:38,416 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:34:38 INFO - 2015-11-15 21:34:38,466 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,55]] 21:34:38 INFO - 2015-11-15 21:34:38,466 DEBUG : process_Request line: dromaeo_css 5712.03 graph.html#tests=[[72,64,55]] 21:34:38 INFO - 2015-11-15 21:34:38,466 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:34:38 INFO - 2015-11-15 21:34:38,503 DEBUG : process_Request line: kraken 1805.90 graph.html#tests=[[232,64,55]] 21:34:38 INFO - 2015-11-15 21:34:38,503 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:34:38 INFO - 2015-11-15 21:34:38,530 DEBUG : process_Request line: v8_7 15675.92 graph.html#tests=[[230,64,55]] 21:34:38 INFO - 2015-11-15 21:34:38,531 INFO : javascript benchmark 21:34:38 INFO - 2015-11-15 21:34:38,533 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [277.5268167773946, 281.9069706996691, 285.05930429582384, 292.9964870319157, 294.5346352762635, 9437.433753974767, 9922.355046921944, 14250.786238206421, 14775.335109920052, 14779.18714470705, 15060.54818355451, 15139.848601513982, 15150.393984240618, 15297.464588739396, 15702.37190512381, 3984.2230765000836, 4590.40324757781, 4619.722816630996, 4691.132140554008, 4692.671512994075, 4649.302604609302, 4679.578837904588, 4706.388169537972, 4728.338032675429, 4766.094442056015, 3329.6004479462376, 3423.400904841655, 3500.492428597852, 4648.0, 4734.218853889121, 4875.9756201219125, 5055.393352797688, 5075.923861142049, 5120.769565369549, 5124.359455068116, 4377.299632058887, 4396.868093957187, 4417.138657961698, 4440.222960981815, 4505.121501307246, 18258.817411825843, 18803.24787008518, 18983.145758440904, 19012.33456829018, 19014.90492547542, 1687.7890263717036, 1699.923503442348, 1705.9488215353558, 1743.4943866278763, 1790.4897104325205, 10997.505112269968, 11755.823662645067, 11854.110941679408, 11948.522059117711, 12079.456424460832, 1427.4718354208906, 1432.9283535823272, 1476.8153980752406, 1486.8513148685154, 1489.4489039055618, 49128.26307605389, 50733.74633126848, 51762.0, 51762.7411862942, 52409.47590524084, 8799.384043117048, 8799.912000880036, 9059.728208153765, 9076.8638470423, 9111.68109116191, 11190.94404527972, 11192.104631629612, 11213.831792523119, 11383.0, 11384.316940983568, 6279.215098112736, 6281.214848143982, 6321.620702757849, 6342.175517182736, 6344.206974128234, 5909.911351329733, 5917.5857689961285, 5944.167816505693, 5974.3726908674835, 6021.939780602225, 5189.792408303701, 5238.135707608279, 5321.787128514893, 5329.493698098674, 5375.059364611177, 1501.594569466238, 1550.0931954806565, 1551.4724993502264, 1575.558843523815, 1610.9850793999706, 348.31034551588, 357.672729452548, 363.5945920298848, 368.34434706222964, 370.66454858353234, 8261.215184557457, 8544.53005084714, 9387.15515603599, 9635.22918166545, 9889.851652225223, 380.3344147741453, 381.0663873509912, 386.92841824262604, 395.84759867451237, 402.54713447371705, 4772.3557319762085, 4778.713277203379, 5010.473900240495, 5140.203268493389, 5482.835514934558, 311914.0, 316414.0, 317016.0, 318800.0, 318835.0, 55185.72407138019, 57450.425495745345, 58934.41065589289, 60186.699066504385, 60192.09711854326, 403.159412624675, 410.1735003967009, 413.2705774308348, 420.1240413737392, 427.5574780102579, 9017.684381046633, 9073.183413492554, 9173.54132293396, 9199.908000919904, 9253.491057991874, 27891.302717432227, 27997.720022800328, 28431.0, 28643.14070577886, 28744.568831467128, 39271.80364098161, 39482.60517394789, 39525.80237098796, 39890.60109398985, 40160.59839401569, 4983.9003219934675, 5218.634695571273, 5246.055709972242, 5268.051750684914, 5313.149896016619, 9923.206143508647, 9947.0, 9990.850137247802, 10022.849657255292, 10093.69718908434, 8403.789905252173, 8446.45098068648, 8536.70121545743, 8567.614457349559, 8715.95408550978, 6540.313267106885, 7222.566646001257, 7228.31331023552, 8211.671533138608, 8495.660173592987, 8361.790955226168, 8570.35722320841, 8732.0, 8752.256058234867, 8812.559372031244, 5132.3327967364, 5214.243934629533, 5223.268742376146, 5318.069337865935, 5334.75993580282, 8448.112948140602, 8557.743267701979, 8603.870941936002, 8701.47791132534, 8803.779905502413], "dojo.html": [2623.59334303183, 2728.7271272872727, 2739.342557786131, 2744.1081648464256, 2768.584712293157, 4343.913121737563, 4538.319252112181, 4538.364628951941, 4550.0899820036, 4600.792964316605, 4378.1900348435565, 4482.036362182138, 4578.519255478169, 4611.608013318863, 4627.606653434462, 4097.549269580344, 4178.707490475668, 4185.79071046448, 4189.539150693437, 4195.139996300751, 4185.309423945046, 4309.396684464177, 4342.630876375511, 4376.912461750763, 4379.671524635649, 4041.838326466938, 4088.0597462583473, 4162.521310049353, 4252.808623611945, 4350.303951367766, 4054.209429161315, 4108.609682080198, 4156.334986402191, 4253.319468884994, 4277.550857159985, 4183.686223533247, 4220.409142719991, 4225.957740422587, 4262.062346283813, 4274.038341373166, 4366.061296821199, 4490.820367185309, 4559.247724125516, 4570.291604801261, 4579.816807327703, 4764.595009424203, 4776.522347765195, 4831.0, 4839.637027222972, 4993.925091123636, 4903.289023091667, 4934.6792458490445, 4940.901181976376, 4944.0, 5014.473480284554, 4362.912741745147, 4540.79566419512, 4547.340635607851, 4550.089982003613, 4681.344611754357, 4906.386701662293, 4931.802727890916, 4974.552290293818, 5009.423916249678, 5062.0, 4813.229883218738, 4840.782164802592, 4847.587955023862, 4873.293372461044, 4887.877803054952, 4746.4541577719, 4919.163742163841, 4982.0, 4984.526469985346, 5025.221090730943, 4666.090112428112, 4739.739314337676, 4773.37946067009, 4883.58489528387, 4898.657094003385, 4802.73584952831, 4803.207470767354, 4813.663043586916, 4882.658213925062, 4930.285108659296, 3665.3585622515952, 3706.0734816295926, 3710.276496083292, 3743.5882052974152, 3751.5873253942045, 3351.111955331839, 3374.746893982961, 3396.5414669019365, 3403.8808641697424, 3414.778039427429, 4447.399601053881, 4517.706349087364, 4526.434195725535, 4540.318952157203, 4573.062522182944, 4828.927566086511, 4847.418309802776, 4865.6107511399005, 4883.3651625288485, 4924.039812236651, 4437.090396468716, 4509.120721459284, 4549.385832912581, 4576.496585375606, 4581.083783243364, 4275.230458517497, 4313.784310784511, 4323.783810809447, 4323.870283891489, 4334.9783251083545, 4882.2432522959, 5035.521625445577, 5060.746962651779, 5089.211172268304, 5149.253358263031, 4880.194767863263, 4908.92636610444, 4924.704517728947, 4975.751212439436, 5007.824726134568, 5029.29589857413, 5042.974785126051, 5043.571296439697, 5053.393592768891, 5089.8727531812, 4724.244120940633, 4782.0, 4797.064572408347, 4839.274108883696, 4871.926921096116, 4692.812287508462, 4881.829135980366, 4882.487338829372, 4897.608191344612, 4983.277424773315, 4753.168195565831, 4769.61843052548, 4813.422389313305, 4860.173770459101, 4925.014997000542, 4660.510646382081, 4725.267583524559, 4740.5733483986605, 4789.233722604506, 4817.084753896748, 4476.26141686618, 4589.311603259404, 4602.056578401487, 4602.102589994919, 4738.620910327097, 4746.121967436035, 4771.141194585008, 4774.785134669018, 4853.005133947603, 4868.9756551217015, 4577.313402989445, 4690.671652984258, 4741.407324084489, 4750.619950404029, 4777.3072904429355], "mootools.html": [1188.6968822950146, 1196.096946805162, 1222.0223820943245, 1321.7488677151334, 1558.7272227360202, 6027.487663548598, 6491.318411566783, 6623.437007854326, 6837.418819400345, 6955.374016338528, 6577.57245779024, 6714.529982901199, 6813.3186681331845, 6850.897236541444, 6871.965640171805, 1660.1533218058755, 1732.6015016546203, 1885.50976746046, 1916.434651777729, 1938.7479627648456, 1727.4990252826665, 1904.3430016644236, 1971.8126777956072, 2001.8898960557165, 2011.5272910865936, 1895.5924476237606, 1932.1015727686622, 1947.9902600487048, 1951.7072439134172, 1969.5863868587614, 1892.139076720096, 1896.943091707251, 1902.0869982408383, 1910.5701217226083, 1926.6243082598899, 1892.7728672559244, 1920.5870737791302, 1925.124068548821, 1930.9903450482798, 1939.0692467615625, 6662.5003124765835, 6672.199336079701, 6685.431738302202, 6831.077804496429, 6843.589384636938, 4193.496780386343, 4265.509466411371, 4271.957280427218, 4277.764722940268, 4363.323684828857, 2485.515324511721, 2565.0, 2565.191964531167, 2587.430765231646, 2607.2308668942705, 640.8942524483455, 741.218014994181, 789.3211837819471, 802.277949845144, 820.0774129104757, 8919.687810926587, 8954.552272386354, 8976.41653292534, 9075.591598378089, 9096.044915283866, 3904.472896159039, 4007.458993035961, 4012.518497780285, 4017.6584990276156, 4053.412255222976, 7744.380449564022, 7792.220777922275, 7799.649015794303, 7809.531428114331, 7846.372290216769, 4340.348947657877, 4341.567282796669, 4358.150160718693, 4421.53573874745, 4441.267190913528, 3933.704972127102, 3934.272159650474, 3946.1515774108702, 4012.518497780227, 4013.538443079083, 3133.1540484069174, 3185.5062465317915, 3221.2430078931434, 3226.161198088514, 3264.8204348760573, 1015.669907280137, 1044.556063672936, 1049.994750026245, 1056.8309070548676, 1071.2233630617895, 1106.253279036647, 1133.7222380516662, 1149.5689116581282, 1155.9017483513996, 1161.5702190189684, 6346.30190679025, 6350.0, 6352.460040896483, 6398.712057957403, 6427.710753016126, 409.1550947293888, 411.23305036107445, 411.75500577156544, 414.5936981757834, 420.05278097889067, 4886.682365646222, 4949.232868905326, 4954.455009948902, 4971.279164521125, 4986.077575648516, 7856.214378562098, 7943.920560794318, 8010.0, 8018.438709290411, 8080.515169089874, 7874.251946065229, 7937.087234968052, 7978.242067003625, 8034.076081250731, 8082.676692932335, 6254.061890716429, 6279.623222606659, 6317.241930968221, 6365.618062916147, 6390.904136437957, 5877.588568800143, 6084.78703245402, 6132.5707200495535, 6222.16000839899, 6227.221597300338, 6974.197967233833, 7033.648317584202, 7103.786886393416, 7116.359527642537, 7150.249223831423, 7151.32062454066, 7230.530015548972, 7306.707731690885, 7367.152777430664, 7370.262973702587, 5923.519120219945, 5930.940690593039, 5975.014122669711, 5990.161377407254, 6068.51451883857, 6381.234251889803, 6440.581362211441, 6477.125588045554, 6514.185726784152, 6556.0, 5986.371430999682, 6024.457798798129, 6024.608400453956, 6071.726772295169, 6165.537584681257, 5576.079946808731, 5612.382637909745, 5655.7172141393585, 5713.0, 5801.36185019639, 6064.3935606439, 6093.786717464867, 6124.724387402666, 6138.07928810682, 6144.907826382697, 5441.347038355264, 5462.6995515247045, 5515.062439385234, 5574.191742197439, 5580.720963951868, 5512.862178445411, 5562.082256427644, 5572.526335261548, 5595.748191331319, 5675.489205971482], "ext.html": [468.917939360612, 468.93200485929543, 478.5429914431716, 482.38736804258593, 498.9077020751159, 25884.741152588493, 26851.0, 32505.51241731376, 32618.18454538638, 33392.16519587012, 34635.65364346356, 34750.0, 34838.12904677384, 35180.824095879485, 35362.823185884095, 6790.3549162829695, 7502.5873576953245, 7519.962400187991, 7535.434842386816, 7636.579988100652, 6849.657517124148, 7005.649717514129, 9032.45805251687, 9040.412373195753, 9143.771405714844, 8933.46399216046, 8952.060033696465, 9003.639854405848, 9049.321300902426, 9050.86423703645, 6941.757038503679, 7002.964985175093, 8927.821443571158, 9030.638774449015, 9074.274058075338, 6842.726290948356, 9165.0, 9183.219426348769, 9226.677066302647, 9304.441733495943, 32009.51985720216, 32252.193695157574, 32486.83756581202, 32552.6744732552, 32927.377988421256, 2320.396696858812, 2332.1604222479896, 2409.4337830609793, 2425.478522117753, 2476.306634142443, 22083.227087051877, 22495.55008899829, 22522.436939076655, 22794.77205227943, 22957.08171673131, 2060.5054786851047, 2080.1887263967064, 2083.4166433398523, 2099.863508871934, 2120.130746393971, 235254.0, 235312.0, 235900.0, 236287.0, 236332.0, 47118.5288147121, 47567.52432475631, 47879.76060119677, 47960.7601961988, 47977.28034079492, 44625.0, 44655.55344446579, 45513.77243113763, 49992.50007499951, 56255.156172657444, 11875.287482751062, 11992.880071199352, 12046.457909394097, 12173.756524869454, 12241.69395765113, 9314.301427392973, 9317.953410233042, 9318.021607731227, 9419.670311539063, 9492.857607135898, 15479.5356139316, 15499.5350139496, 15784.68430631381, 15810.209489525707, 15853.762193567105, 6933.653317334113, 7121.394681452135, 7200.315969982843, 7234.819129521804, 7279.235680253497, 783.6943591999011, 811.2820154163608, 835.5488036460365, 909.0318810466831, 957.0381766324799, 23309.300720978397, 23352.065917363456, 23396.18113366024, 23410.64884026741, 23466.17868374633, 901.783571942729, 904.6381447421085, 925.3304217332908, 928.4939707859232, 970.5486948568949, 12222.327771972627, 12378.319192444502, 12632.74734505323, 13133.474661013644, 13138.146020508637, 200411.0, 204989.0, 206439.0, 206796.0, 208384.0, 37101.25797484035, 37115.44326835046, 37145.25709485849, 37210.0, 37542.0, 1127.0589058136547, 1128.864536255638, 1133.6032388664066, 1141.6061458796703, 1148.2995372822572, 23391.53216935686, 23400.531989360457, 23764.762352376256, 27338.532293540975, 27874.30314242079, 36555.45166822553, 37707.245855083296, 41774.0, 43227.0, 43274.35088473612, 185860.0, 187064.0, 189008.0, 190618.0, 190643.0, 31755.52366714455, 32045.198870028435, 36405.45391819072, 37257.44113838349, 37469.43795843119, 31590.210244743146, 35099.82450087733, 38102.42846357251, 38719.225615488096, 39133.217335653695, 32420.675793241764, 32532.0, 32786.67213327836, 32911.835440822644, 33533.83233083916, 31621.209469762518, 32074.518882216318, 32100.83949580237, 32283.51574726334, 32402.625645538494, 29384.706152938197, 29757.851210744673, 30015.399692006475, 30290.0, 30308.0, 27067.533856914175, 28386.43227135487, 28499.43001140007, 28502.85748571244, 29066.12801615955, 21268.893655532243, 21649.783502164777, 21724.45688857791, 21813.563728725017, 21905.890470547547], "prototype.html": [262.1336482923936, 273.63879678823946, 275.3735252301016, 276.0435092404817, 279.1458138097421, 5268.894622107565, 5281.49825766552, 5306.867328316789, 5330.840074797758, 5370.194470829378, 5244.737763111848, 5269.3676758789, 5277.70972596507, 5279.366476022883, 5367.892642147164, 3848.9037774055664, 3871.477350557681, 3912.0, 3966.10762578419, 4045.029192993675, 4004.819783109767, 4011.0, 4040.636342729154, 4045.1505183911413, 4075.7758323292355, 3824.388097904336, 3979.4826672532677, 3980.7213495055357, 4031.677465802729, 4039.7172197946156, 3897.123147291865, 3916.490856188706, 3977.2642061218767, 3985.0834308109006, 3987.9003024924464, 3435.707964822993, 3445.3109378124223, 3489.5638045244345, 3498.9475157872653, 3509.7543171977973, 5076.340075790161, 5170.638055336128, 5174.120399532088, 5189.558887494568, 5192.792288308463, 4498.955010449919, 4521.186186486431, 4584.862454126382, 4587.839425620121, 4594.425696787902, 5325.20121981702, 5496.560275177976, 5583.0, 5605.215269862222, 5608.298962629671, 3744.3821769408014, 3746.269477451898, 3807.58116607173, 3814.0, 3816.637419445148, 5780.9710951445395, 5798.884022319572, 5895.970520147372, 5902.2622172228475, 5906.616069955439, 3810.8094595270127, 3815.5993620669983, 3826.7895265760094, 3883.572806991229, 3890.630390112935, 3452.913677158091, 3633.16437219441, 3806.638369354907, 3817.4273858921383, 3929.646331830149, 4396.494403143615, 4423.867283981485, 4493.5281795411665, 4535.841245556389, 4591.95408045922, 5434.836954891281, 5447.482489163603, 5529.474699903502, 5632.7746890123935, 5635.6618602883955, 1363.0731102850157, 1375.642332993429, 1380.6065271397604, 1396.9930150349387, 1400.8389035261075, 889.7820034091689, 898.2723993565234, 909.3180114913814, 910.904355042711, 918.6830543462495, 5316.6544174628525, 5338.065838478251, 5376.462353764592, 5418.512333889968, 5420.186971954159, 5444.292242008513, 5741.45456181662, 5773.538116950634, 5823.30120385548, 5858.853528661817, 5282.52457278839, 5312.096943519611, 5340.412554618989, 5372.570194384518, 5416.566674666017, 2908.2147820088458, 3025.848707564613, 3050.7864449488325, 3064.7088526589937, 3111.7510599152465, 5850.853728656818, 5957.672328021914, 5967.403259673998, 6065.909011364833, 6088.543359248074, 5916.645001299936, 5943.286805583358, 5980.192673988956, 6044.637321760709, 6045.425684559959, 5875.911861322169, 5946.078357854453, 5988.04191329394, 6038.335783063947, 6051.213342265565, 5780.884382312414, 5792.333881603501, 5798.275215598051, 5860.706964651665, 5919.348871624204, 5681.0910254359105, 5686.601937864475, 5790.594658373873, 5791.420857914343, 5795.188673585617, 5964.582479226413, 5969.611975221596, 5973.193618861398, 6053.334133245251, 6066.848328791639, 3692.5753538343433, 3850.9807450962567, 3856.7878766668105, 3879.0302424393903, 3890.513685789276, 5810.273715785527, 5816.70916454184, 5853.326867410132, 5882.176495290748, 5921.940780592139, 5622.353429355677, 5663.2071509989455, 5666.603337766317, 5722.055860783091, 5727.7422515986045, 5554.611177217717, 5624.690642014729, 5695.088785794253, 5701.344345400332, 5714.828555143353, 5496.945030549803, 5499.257600223918, 5582.49757521825, 5589.189567512769, 5593.972030139823, 5606.467385598362, 5679.0, 5706.172604972173, 5710.257666503494, 5738.713064346849, 5371.892562148813, 5377.327834020747, 5503.889922201613, 5516.310461192351, 5545.611807173459], "yui.html": [549.1981706708206, 586.6685322792622, 601.386585682604, 602.4638072115818, 651.0624700431381, 11213.271137376076, 11490.540378384865, 11676.532938682463, 11911.880881191186, 11940.164188506786, 9536.666216682417, 12120.69698257544, 12149.392530373469, 12208.45061972211, 12351.876481235186, 572.8109723791139, 577.4081566394458, 715.9725793486364, 722.3101937649545, 729.7555318968152, 560.6383882395852, 743.3941337809667, 751.7481643649356, 752.838139799943, 754.8678981178299, 770.1528318849277, 784.0787075186662, 786.9803254918615, 796.2037962037962, 799.5722288575613, 618.2704408797595, 628.3779058731823, 790.8102055506695, 793.654760179318, 803.0844836885925, 582.8280657206134, 584.3776378157249, 585.7569108819835, 591.60658162322, 595.502755199409, 11521.711957201052, 11685.2404593702, 11704.356260405675, 11752.764944701059, 11782.882171178264, 9674.0, 9716.12554870058, 9865.80268394628, 9903.801923961553, 10343.89656103437, 7560.810979725496, 7893.368530517545, 7953.284204421572, 8056.1541038190735, 8139.389545784031, 2839.261791934112, 2851.9714802851913, 2861.241770930705, 2873.6551613806478, 2942.0732469272325, 42426.0, 42791.0, 43104.3534346985, 43378.783106084586, 43619.12761744748, 7896.565688887052, 7905.288524032865, 7944.165862584346, 7947.205279472122, 8024.438289319808, 16373.91813040951, 16436.506904792874, 16605.6678866422, 16643.33426662944, 16663.33346666144, 5958.612690175125, 5973.731182096816, 5983.820485385445, 6079.422454866781, 6095.390460953958, 2921.3134913295357, 2922.547005214195, 3052.9542056869163, 3088.104449709604, 3104.98447507761, 2595.779358754527, 2613.333599932005, 2615.1239334822667, 2617.293330800673, 2636.8286061405947, 365.3241503219024, 376.1592840002592, 377.59408635716716, 382.21645626465636, 388.09573693294556, 452.7215762306158, 484.58810011489953, 493.46212628235395, 514.1644827155872, 521.713057818206, 6536.281009088996, 6875.724971001104, 7066.646667666699, 7167.0, 7487.1389790173735, 391.09266501715746, 392.65250253525835, 496.9353983982059, 518.2873548870303, 545.9563234941195, 3136.8274744888795, 3187.2031992002, 3219.532093342536, 3275.295811400513, 3386.49202619609, 50322.0, 50793.746031269606, 50821.49178508241, 50915.74542127266, 51341.22988155181, 42870.78564607157, 43317.133657326674, 43637.345439818426, 44017.0, 44420.55579444164, 39105.80447097746, 39520.60479395227, 39799.80100099481, 40071.0, 40595.59404405977, 6576.2766095728475, 6642.269350371359, 6733.091032710718, 6752.291009443938, 6886.173659160932, 27126.864365678834, 27245.86377068181, 27773.166804995883, 28542.0, 28916.855415722788, 33560.1609959753, 37697.43453848139, 38960.80519597497, 39665.0, 40254.39618405668, 5850.297964244318, 5946.0, 5963.731632076654, 5966.224390829165, 6045.939540604538, 8587.656493740431, 8723.389362744547, 8757.824843503222, 8762.868556971524, 8818.470891746516, 8129.75610731679, 8218.342532597497, 8252.257296843312, 8310.584470776557, 8419.579021048801, 8118.107008229208, 8240.752777416687, 8283.50298982063, 8350.665973360998, 8439.578021099043, 8145.185481451807, 8177.100518943031, 8236.794080148044, 8311.459755115899, 8401.663933442594, 7181.82045448847, 7253.310935461122, 7434.888476672746, 7484.925150748423, 7620.8475830484185, 7242.710291588278, 7484.035887424949, 7516.285952834472, 7567.091948966159, 7606.733764318223]}, "summary": {"lowerIsBetter": false, "suite": 5712.026258419438, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6307.285371655886, "unit": "ms", "value": 6307.285371655886}, "dojo.html": {"lowerIsBetter": false, "filtered": 4507.905085414546, "unit": "ms", "value": 4507.905085414546}, "mootools.html": {"lowerIsBetter": false, "filtered": 3782.039665917703, "unit": "ms", "value": 3782.039665917703}, "ext.html": {"lowerIsBetter": false, "filtered": 15341.618307816461, "unit": "ms", "value": 15341.618307816461}, "prototype.html": {"lowerIsBetter": false, "filtered": 4179.585310521437, "unit": "ms", "value": 4179.585310521437}, "yui.html": {"lowerIsBetter": false, "filtered": 5036.75949491196, "unit": "ms", "value": 5036.75949491196}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0090"}, "testrun": {"date": 1447650859, "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": "20151115191934", "branch": "Fx-Team", "revision": "04fb61e343addd47b88ac694041c0bce5a98cfc0"}}, {"talos_counters": {}, "results": {"audio-dft": [187.0, 192.0, 196.0, 195.0, 186.0, 189.0, 197.0, 197.0, 191.0, 188.0], "ai-astar": [123.0, 132.0, 124.0, 131.0, 129.0, 125.0, 113.0, 137.0, 136.0, 117.0], "imaging-gaussian-blur": [142.0, 148.0, 148.0, 140.0, 142.0, 141.0, 141.0, 145.0, 134.0, 148.0], "audio-beat-detection": [185.0, 160.0, 185.0, 198.0, 155.0, 182.0, 180.0, 155.0, 197.0, 156.0], "json-stringify-tinderbox": [77.0, 82.0, 82.0, 85.0, 87.0, 85.0, 86.0, 84.0, 81.0, 82.0], "stanford-crypto-pbkdf2": [166.0, 170.0, 189.0, 191.0, 179.0, 166.0, 187.0, 191.0, 188.0, 179.0], "json-parse-financial": [64.0, 66.0, 70.0, 69.0, 72.0, 72.0, 73.0, 83.0, 72.0, 72.0], "stanford-crypto-sha256-iterative": [80.0, 82.0, 83.0, 88.0, 91.0, 91.0, 87.0, 88.0, 87.0, 87.0], "audio-fft": [85.0, 95.0, 109.0, 103.0, 85.0, 85.0, 92.0, 99.0, 103.0, 83.0], "imaging-darkroom": [156.0, 155.0, 152.0, 148.0, 154.0, 155.0, 154.0, 148.0, 147.0, 154.0], "stanford-crypto-ccm": [154.0, 156.0, 158.0, 152.0, 159.0, 152.0, 149.0, 157.0, 162.0, 154.0], "audio-oscillator": [114.0, 114.0, 165.0, 110.0, 110.0, 110.0, 155.0, 107.0, 105.0, 152.0], "stanford-crypto-aes": [99.0, 103.0, 106.0, 104.0, 104.0, 105.0, 103.0, 105.0, 107.0, 106.0], "imaging-desaturate": [110.0, 124.0, 115.0, 115.0, 115.0, 124.0, 114.0, 124.0, 114.0, 124.0]}, "summary": {"lowerIsBetter": true, "suite": 1805.9, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 93.9, "unit": "ms", "value": 93.9}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 180.6, "unit": "ms", "value": 180.6}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 175.3, "unit": "ms", "value": 175.3}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 155.3, "unit": "ms", "value": 155.3}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 152.3, "unit": "ms", "value": 152.3}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 71.3, "unit": "ms", "value": 71.3}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 124.2, "unit": "ms", "value": 124.2}, "ai-astar": {"lowerIsBetter": true, "filtered": 126.7, "unit": "ms", "value": 126.7}, "audio-dft": {"lowerIsBetter": true, "filtered": 191.8, "unit": "ms", "value": 191.8}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 86.4, "unit": "ms", "value": 86.4}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 83.1, "unit": "ms", "value": 83.1}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 142.9, "unit": "ms", "value": 142.9}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 104.2, "unit": "ms", "value": 104.2}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 117.9, "unit": "ms", "value": 117.9}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0090"}, "testrun": {"date": 1447650859, "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": "20151115191934", "branch": "Fx-Team", "revision": "04fb61e343addd47b88ac694041c0bce5a98cfc0"}}, {"talos_counters": {}, "results": {"DeltaBlue": [229.77941176470588], "Encrypt": [376.6478342749529], "NavierStokes": [6849.315068493151], "Decrypt": [6724.832214765101], "Splay": [748.6950037285608], "Richards": [199.0842126219391], "RegExp": [35344.8275862069], "Earley": [954.2421353670162], "Boyer": [15212.121212121212], "RayTrace": [2306.451612903226]}, "summary": {"lowerIsBetter": false, "suite": 15675.916120290396, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 287.745536, "unit": "score", "value": 287.745536}, "Encrypt": {"lowerIsBetter": false, "filtered": 706.7105550000002, "unit": "score", "value": 706.7105550000002}, "NavierStokes": {"lowerIsBetter": false, "filtered": 216.66400000000004, "unit": "score", "value": 216.66400000000004}, "Decrypt": {"lowerIsBetter": false, "filtered": 39.581805389221536, "unit": "score", "value": 39.581805389221536}, "Splay": {"lowerIsBetter": false, "filtered": 108.84405478087649, "unit": "score", "value": 108.84405478087649}, "RegExp": {"lowerIsBetter": false, "filtered": 25.774209756097555, "unit": "score", "value": 25.774209756097555}, "Richards": {"lowerIsBetter": false, "filtered": 177.32194600000005, "unit": "score", "value": 177.32194600000005}, "Earley": {"lowerIsBetter": false, "filtered": 698.4212657342658, "unit": "score", "value": 698.4212657342658}, "Boyer": {"lowerIsBetter": false, "filtered": 43.811312749004024, "unit": "score", "value": 43.811312749004024}, "RayTrace": {"lowerIsBetter": false, "filtered": 320.8343916083915, "unit": "score", "value": 320.8343916083915}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0090"}, "testrun": {"date": 1447650859, "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": "20151115191934", "branch": "Fx-Team", "revision": "04fb61e343addd47b88ac694041c0bce5a98cfc0"}}] 21:34:38 INFO - RETURN: dromaeo_css: 5712.03 21:34:38 INFO - RETURN: kraken: 1805.90 21:34:38 INFO - RETURN: v8_7: 15675.92 21:34:38 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,55]]", "result": "15675.92"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,55]]", "result": "1805.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,55]]", "result": "5712.03"}}} 21:34:38 INFO - Return code: 0 21:34:38 INFO - # TBPL SUCCESS # 21:34:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:34:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:34:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:34:38 INFO - 2015-11-15 21:34:38.655 screenresolution[1671:11321] starting screenresolution argv=screenresolution get 21:34:38 INFO - 2015-11-15 21:34:38.659 screenresolution[1671:11321] Display 0: 1600x1200x32@60 21:34:38 INFO - 2015-11-15 21:34:38.665 screenresolution[1672:11324] starting screenresolution argv=screenresolution list 21:34:38 INFO - Available Modes on Display 0 21:34:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:34:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:34:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:34:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:34:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:34:38 INFO - Intel HD Graphics 3000: 21:34:38 INFO - Chipset Model: Intel HD Graphics 3000 21:34:38 INFO - Type: GPU 21:34:38 INFO - Bus: Built-In 21:34:38 INFO - VRAM (Total): 512 MB 21:34:38 INFO - VRAM (Dynamic, Max): 10 21:34:38 INFO - Vendor: Intel (0x8086) 21:34:38 INFO - Device ID: 0x0116 21:34:38 INFO - Revision ID: 0x0009 21:34:38 INFO - Displays: 21:34:38 INFO - Display: 21:34:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:34:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:34:38 INFO - Display Serial Number: 1600x1200 60 21:34:38 INFO - Main Display: Yes 21:34:38 INFO - Mirror: Off 21:34:38 INFO - Online: Yes 21:34:38 INFO - Rotation: Supported 21:34:38 INFO - Return code: 0 21:34:38 INFO - Running post-action listener: _resource_record_post_action 21:34:38 INFO - Running post-run listener: _resource_record_post_run 21:34:40 INFO - Total resource usage - Wall time: 1262s; CPU: 30.0%; Read bytes: 39330816; Write bytes: 686897152; Read time: 4584; Write time: 65094 21:34:40 INFO - install - Wall time: 42s; CPU: 30.0%; Read bytes: 343646720; Write bytes: 345902080; Read time: 37436; Write time: 10917 21:34:40 INFO - run-tests - Wall time: 1221s; CPU: 30.0%; Read bytes: 37061632; Write bytes: 339228672; Read time: 4152; Write time: 53619 21:34:40 INFO - Running post-run listener: _upload_blobber_files 21:34:40 INFO - Blob upload gear active. 21:34:40 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 21:34:40 INFO - Copying logs to upload dir... 21:34:40 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1326.406777 ========= master_lag: 2.83 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 9 secs) (at 2015-11-15 21:34:42.895871) ========= ========= Started set props: build_url (results: 0, elapsed: 1 secs) (at 2015-11-15 21:34:42.899392) ========= 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.wczxMZNuOj/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.qjWURUTijg/Listeners TMPDIR=/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/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/ZjTbuTY2RkSkT863-Sdzjw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010576 build_url: 'https://queue.taskcluster.net/v1/task/ZjTbuTY2RkSkT863-Sdzjw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 1.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 1 secs) (at 2015-11-15 21:34:43.926627) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2015-11-15 21:34:43.927006) ========= 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.wczxMZNuOj/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.qjWURUTijg/Listeners TMPDIR=/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/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.005382 ========= master_lag: 3.33 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2015-11-15 21:34:47.266187) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-15 21:34:47.266501) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-15 21:34:47.270399) ========= ========= Total master_lag: 8.31 =========