builder: mozilla-central_yosemite_test-dromaeojs-e10s slave: t-yosemite-r5-0061 starttime: 1447861616.61 results: success (0) buildid: 20151118055124 builduid: ce34fd181fd54a40b2bbe96e3cc9f471 revision: 1d6155d7e6c91fa5ec1ef6927f3d3a044187896d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 07:46:56.608808) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 07:46:56.609268) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 07:46:56.609565) ========= 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.H9CHcKlSdB/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.2o9j6LC1JW/Listeners TMPDIR=/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/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.006530 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 07:46:56.671553) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 07:46:56.672050) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 07:46:56.697750) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:46:56.698191) ========= 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.H9CHcKlSdB/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.2o9j6LC1JW/Listeners TMPDIR=/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/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.032290 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:46:56.748010) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 07:46:56.748332) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 07:46:56.748853) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:46:56.749340) ========= 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.H9CHcKlSdB/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.2o9j6LC1JW/Listeners TMPDIR=/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False --2015-11-18 07:46:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 8.65M=0.001s 2015-11-18 07:46:56 (8.65 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.208221 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:46:56.973859) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:46:56.974231) ========= 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.H9CHcKlSdB/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.2o9j6LC1JW/Listeners TMPDIR=/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/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.153181 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:46:57.144627) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2015-11-18 07:46:57.145240) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1d6155d7e6c91fa5ec1ef6927f3d3a044187896d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 1d6155d7e6c91fa5ec1ef6927f3d3a044187896d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.H9CHcKlSdB/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.2o9j6LC1JW/Listeners TMPDIR=/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 2015-11-18 07:46:57,247 truncating revision to first 12 chars 2015-11-18 07:46:57,247 Setting DEBUG logging. 2015-11-18 07:46:57,247 attempt 1/10 2015-11-18 07:46:57,247 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1d6155d7e6c9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-18 07:46:58,268 unpacking tar archive at: mozilla-central-1d6155d7e6c9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.322455 ========= master_lag: 2.40 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2015-11-18 07:47:00.867179) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 07:47:00.867524) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 07:47:00.885409) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 07:47:00.885734) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 07:47:00.886163) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 3 secs) (at 2015-11-18 07:47:00.886461) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.H9CHcKlSdB/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.2o9j6LC1JW/Listeners TMPDIR=/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/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 07:47:01 INFO - MultiFileLogger online at 20151118 07:47:01 in /builds/slave/test 07:47:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:47:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:47:01 INFO - {'append_to_log': False, 07:47:01 INFO - 'base_work_dir': '/builds/slave/test', 07:47:01 INFO - 'blob_upload_branch': 'Firefox', 07:47:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:47:01 INFO - 'branch': 'Firefox', 07:47:01 INFO - 'buildbot_json_path': 'buildprops.json', 07:47:01 INFO - 'config_files': ('talos/mac_config.py',), 07:47:01 INFO - 'default_actions': ('clobber', 07:47:01 INFO - 'read-buildbot-config', 07:47:01 INFO - 'download-and-extract', 07:47:01 INFO - 'populate-webroot', 07:47:01 INFO - 'create-virtualenv', 07:47:01 INFO - 'install', 07:47:01 INFO - 'run-tests'), 07:47:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:47:01 INFO - 'download_minidump_stackwalk': True, 07:47:01 INFO - 'download_symbols': 'ondemand', 07:47:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:47:01 INFO - 'tooltool.py': '/tools/tooltool.py', 07:47:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:47:01 INFO - '/tools/misc-python/virtualenv.py')}, 07:47:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:47:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:47:01 INFO - 'installer_path': 'installer.exe', 07:47:01 INFO - 'log_level': 'info', 07:47:01 INFO - 'log_name': 'talos', 07:47:01 INFO - 'log_to_console': True, 07:47:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:47:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:47:01 INFO - 'opt_config_files': (), 07:47:01 INFO - 'pip_index': False, 07:47:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:47:01 INFO - 'cmd': ('bash', 07:47:01 INFO - '-c', 07:47:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:47:01 INFO - 'enabled': True, 07:47:01 INFO - 'halt_on_failure': False, 07:47:01 INFO - 'name': 'check_screen_resolution'},), 07:47:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:47:01 INFO - 'cmd': ('bash', 07:47:01 INFO - '-c', 07:47:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:47:01 INFO - 'enabled': True, 07:47:01 INFO - 'halt_on_failure': False, 07:47:01 INFO - 'name': 'check_screen_resolution'},), 07:47:01 INFO - 'run_cmd_checks_enabled': True, 07:47:01 INFO - 'sps_profile': False, 07:47:01 INFO - 'sps_profile_interval': 0, 07:47:01 INFO - 'suite': 'dromaeojs-e10s', 07:47:01 INFO - 'system_bits': '64', 07:47:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:47:01 INFO - 'title': 't-yosemite-r5-0061', 07:47:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:47:01 INFO - 'use_talos_json': True, 07:47:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:47:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:47:01 INFO - 'work_dir': 'build'} 07:47:01 INFO - ##### 07:47:01 INFO - ##### Running clobber step. 07:47:01 INFO - ##### 07:47:01 INFO - Running pre-action listener: _resource_record_pre_action 07:47:01 INFO - Running main action method: clobber 07:47:01 INFO - rmtree: /builds/slave/test/build 07:47:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:47:05 INFO - Running post-action listener: _resource_record_post_action 07:47:05 INFO - ##### 07:47:05 INFO - ##### Running read-buildbot-config step. 07:47:05 INFO - ##### 07:47:05 INFO - Running pre-action listener: _resource_record_pre_action 07:47:05 INFO - Running main action method: read_buildbot_config 07:47:05 INFO - Using buildbot properties: 07:47:05 INFO - { 07:47:05 INFO - "properties": { 07:47:05 INFO - "buildnumber": 23, 07:47:05 INFO - "product": "firefox", 07:47:05 INFO - "script_repo_revision": "production", 07:47:05 INFO - "builddir": "mozilla-central_yosemite_test-dromaeojs-e10s", 07:47:05 INFO - "repository": "", 07:47:05 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-central talos dromaeojs-e10s", 07:47:05 INFO - "buildid": "20151118055124", 07:47:05 INFO - "slavename": "t-yosemite-r5-0061", 07:47:05 INFO - "pgo_build": "False", 07:47:05 INFO - "basedir": "/builds/slave/test", 07:47:05 INFO - "project": "", 07:47:05 INFO - "platform": "yosemite", 07:47:05 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 07:47:05 INFO - "slavebuilddir": "test", 07:47:05 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 07:47:05 INFO - "branch": "mozilla-central", 07:47:05 INFO - "repo_path": "mozilla-central", 07:47:05 INFO - "stage_platform": "macosx64", 07:47:05 INFO - "builduid": "ce34fd181fd54a40b2bbe96e3cc9f471", 07:47:05 INFO - "revision": "1d6155d7e6c91fa5ec1ef6927f3d3a044187896d" 07:47:05 INFO - }, 07:47:05 INFO - "sourcestamp": { 07:47:05 INFO - "repository": "", 07:47:05 INFO - "hasPatch": false, 07:47:05 INFO - "project": "", 07:47:05 INFO - "branch": "mozilla-central-macosx64-talos", 07:47:05 INFO - "changes": [ 07:47:05 INFO - { 07:47:05 INFO - "category": null, 07:47:05 INFO - "files": [ 07:47:05 INFO - { 07:47:05 INFO - "url": null, 07:47:05 INFO - "name": "https://queue.taskcluster.net/v1/task/iAAtYJgHTESXiDnxeO6vbg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 07:47:05 INFO - } 07:47:05 INFO - ], 07:47:05 INFO - "repository": "", 07:47:05 INFO - "rev": "1d6155d7e6c91fa5ec1ef6927f3d3a044187896d", 07:47:05 INFO - "who": "cbook@mozilla.com", 07:47:05 INFO - "when": 1447861342, 07:47:05 INFO - "number": 6677342, 07:47:05 INFO - "comments": "merge mozilla-inbound to mozilla-central a=merge", 07:47:05 INFO - "project": "", 07:47:05 INFO - "at": "Wed 18 Nov 2015 07:42:22", 07:47:05 INFO - "branch": "mozilla-central-macosx64-talos", 07:47:05 INFO - "revlink": "", 07:47:05 INFO - "properties": [ 07:47:05 INFO - [ 07:47:05 INFO - "buildid", 07:47:05 INFO - "20151118055124", 07:47:05 INFO - "Change" 07:47:05 INFO - ], 07:47:05 INFO - [ 07:47:05 INFO - "builduid", 07:47:05 INFO - "ce34fd181fd54a40b2bbe96e3cc9f471", 07:47:05 INFO - "Change" 07:47:05 INFO - ], 07:47:05 INFO - [ 07:47:05 INFO - "pgo_build", 07:47:05 INFO - "False", 07:47:05 INFO - "Change" 07:47:05 INFO - ] 07:47:05 INFO - ], 07:47:05 INFO - "revision": "1d6155d7e6c91fa5ec1ef6927f3d3a044187896d" 07:47:05 INFO - } 07:47:05 INFO - ], 07:47:05 INFO - "revision": "1d6155d7e6c91fa5ec1ef6927f3d3a044187896d" 07:47:05 INFO - } 07:47:05 INFO - } 07:47:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/iAAtYJgHTESXiDnxeO6vbg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 07:47:05 INFO - Running post-action listener: _resource_record_post_action 07:47:05 INFO - ##### 07:47:05 INFO - ##### Running download-and-extract step. 07:47:05 INFO - ##### 07:47:05 INFO - Running pre-action listener: _resource_record_pre_action 07:47:05 INFO - Running main action method: download_and_extract 07:47:05 INFO - mkdir: /builds/slave/test/build/tests 07:47:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:47:05 INFO - https://queue.taskcluster.net/v1/task/iAAtYJgHTESXiDnxeO6vbg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:47:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iAAtYJgHTESXiDnxeO6vbg/artifacts/public/build/test_packages.json 07:47:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iAAtYJgHTESXiDnxeO6vbg/artifacts/public/build/test_packages.json 07:47:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iAAtYJgHTESXiDnxeO6vbg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 07:47:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iAAtYJgHTESXiDnxeO6vbg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 07:47:05 INFO - Downloaded 1149 bytes. 07:47:05 INFO - Reading from file /builds/slave/test/build/test_packages.json 07:47:05 INFO - Using the following test package requirements: 07:47:05 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 07:47:05 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:47:05 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 07:47:05 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:47:05 INFO - u'jsshell-mac.zip'], 07:47:05 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:47:05 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 07:47:05 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 07:47:05 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:47:05 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 07:47:05 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:47:05 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 07:47:05 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:47:05 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 07:47:05 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 07:47:05 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:47:05 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 07:47:05 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:47:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:47:05 INFO - https://queue.taskcluster.net/v1/task/iAAtYJgHTESXiDnxeO6vbg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:47:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iAAtYJgHTESXiDnxeO6vbg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 07:47:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iAAtYJgHTESXiDnxeO6vbg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 07:47:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iAAtYJgHTESXiDnxeO6vbg/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 07:47:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iAAtYJgHTESXiDnxeO6vbg/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 07:47:07 INFO - Downloaded 17463548 bytes. 07:47:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 07:47:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 07:47:07 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 07:47:12 INFO - Return code: 0 07:47:12 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 07:47:12 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')]} 07:47:12 INFO - https://queue.taskcluster.net/v1/task/iAAtYJgHTESXiDnxeO6vbg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:47:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iAAtYJgHTESXiDnxeO6vbg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 07:47:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iAAtYJgHTESXiDnxeO6vbg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 07:47:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iAAtYJgHTESXiDnxeO6vbg/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 07:47:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iAAtYJgHTESXiDnxeO6vbg/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 07:47:13 INFO - Downloaded 17463548 bytes. 07:47:13 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 07:47:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 07:47:13 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 07:47:19 INFO - Return code: 0 07:47:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:47:19 INFO - https://queue.taskcluster.net/v1/task/iAAtYJgHTESXiDnxeO6vbg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 07:47:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iAAtYJgHTESXiDnxeO6vbg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 07:47:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iAAtYJgHTESXiDnxeO6vbg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 07:47:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iAAtYJgHTESXiDnxeO6vbg/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 07:47:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iAAtYJgHTESXiDnxeO6vbg/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 07:47:20 INFO - Downloaded 11130997 bytes. 07:47:20 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 07:47:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 07:47:20 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 07:47:20 INFO - Return code: 0 07:47:20 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')]} 07:47:20 INFO - https://queue.taskcluster.net/v1/task/iAAtYJgHTESXiDnxeO6vbg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 07:47:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iAAtYJgHTESXiDnxeO6vbg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 07:47:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iAAtYJgHTESXiDnxeO6vbg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 07:47:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iAAtYJgHTESXiDnxeO6vbg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 07:47:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iAAtYJgHTESXiDnxeO6vbg/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 07:47:23 INFO - Downloaded 108847488 bytes. 07:47:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/iAAtYJgHTESXiDnxeO6vbg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 07:47:23 INFO - mkdir: /builds/slave/test/properties 07:47:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:47:23 INFO - Writing to file /builds/slave/test/properties/build_url 07:47:23 INFO - Contents: 07:47:23 INFO - build_url:https://queue.taskcluster.net/v1/task/iAAtYJgHTESXiDnxeO6vbg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 07:47:23 INFO - Running post-action listener: _resource_record_post_action 07:47:23 INFO - Running post-action listener: set_extra_try_arguments 07:47:23 INFO - ##### 07:47:23 INFO - ##### Running populate-webroot step. 07:47:23 INFO - ##### 07:47:23 INFO - Running pre-action listener: _resource_record_pre_action 07:47:23 INFO - Running main action method: populate_webroot 07:47:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:47:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:47:24 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 07:47:24 INFO - '../fennec_ids.txt'], 07:47:24 INFO - 'tests': ['tcheck2']}, 07:47:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:47:24 INFO - '--tppagecycles', 07:47:24 INFO - '7'], 07:47:24 INFO - 'tests': ['tsvgm']}}, 07:47:24 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:47:24 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:47:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:47:24 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:47:24 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:47:24 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:47:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:47:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:47:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:47:24 INFO - 'talos_options': ['--e10s'], 07:47:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:47:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:47:24 INFO - 'tests': ['damp', 'tps']}, 07:47:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:47:24 INFO - 'talos_options': ['--e10s'], 07:47:24 INFO - 'tests': ['damp', 'tps']}, 07:47:24 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:47:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:47:24 INFO - 'other': {'tests': ['a11yr', 07:47:24 INFO - 'ts_paint', 07:47:24 INFO - 'tpaint', 07:47:24 INFO - 'sessionrestore', 07:47:24 INFO - 'sessionrestore_no_auto_restore']}, 07:47:24 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:47:24 INFO - 'tests': ['a11yr', 07:47:24 INFO - 'ts_paint', 07:47:24 INFO - 'tpaint', 07:47:24 INFO - 'sessionrestore', 07:47:24 INFO - 'sessionrestore_no_auto_restore']}, 07:47:24 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:47:24 INFO - 'tests': ['a11yr', 07:47:24 INFO - 'ts_paint', 07:47:24 INFO - 'tpaint', 07:47:24 INFO - 'sessionrestore', 07:47:24 INFO - 'sessionrestore_no_auto_restore']}, 07:47:24 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:47:24 INFO - 'tests': ['a11yr', 07:47:24 INFO - 'ts_paint', 07:47:24 INFO - 'tpaint', 07:47:24 INFO - 'sessionrestore', 07:47:24 INFO - 'sessionrestore_no_auto_restore']}, 07:47:24 INFO - 'other_l64': {'tests': ['a11yr', 07:47:24 INFO - 'ts_paint', 07:47:24 INFO - 'tpaint', 07:47:24 INFO - 'sessionrestore', 07:47:24 INFO - 'sessionrestore_no_auto_restore']}, 07:47:24 INFO - 'other_nol64': {'tests': ['a11yr', 07:47:24 INFO - 'ts_paint', 07:47:24 INFO - 'tpaint', 07:47:24 INFO - 'sessionrestore', 07:47:24 INFO - 'sessionrestore_no_auto_restore']}, 07:47:24 INFO - 'svgr': {'tests': ['tsvgx', 07:47:24 INFO - 'tsvgr_opacity', 07:47:24 INFO - 'tart', 07:47:24 INFO - 'tscrollx', 07:47:24 INFO - 'cart']}, 07:47:24 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:47:24 INFO - 'tests': ['tsvgx', 07:47:24 INFO - 'tsvgr_opacity', 07:47:24 INFO - 'tart', 07:47:24 INFO - 'tscrollx', 07:47:24 INFO - 'cart']}, 07:47:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:47:24 INFO - 'tests': ['tp5o']}, 07:47:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:47:24 INFO - 'talos_options': ['--e10s'], 07:47:24 INFO - 'tests': ['tp5o']}, 07:47:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:47:24 INFO - 'talos_options': ['--xperf_path', 07:47:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:47:24 INFO - 'tests': ['tp5n']}, 07:47:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:47:24 INFO - 'talos_options': ['--e10s', 07:47:24 INFO - '--xperf_path', 07:47:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:47:24 INFO - 'tests': ['tp5n']}}, 07:47:24 INFO - 'talos.zip': {'path': '', 07:47:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:47:24 INFO - Running post-action listener: _resource_record_post_action 07:47:24 INFO - ##### 07:47:24 INFO - ##### Running create-virtualenv step. 07:47:24 INFO - ##### 07:47:24 INFO - Running pre-action listener: _resource_record_pre_action 07:47:24 INFO - Running main action method: create_virtualenv 07:47:24 INFO - Creating virtualenv /builds/slave/test/build/venv 07:47:24 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 07:47:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:47:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:47:24 INFO - Using real prefix '/tools/python27' 07:47:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:47:25 INFO - Installing distribute.............................................................................................................................................................................................done. 07:47:29 INFO - Installing pip.................done. 07:47:29 INFO - Return code: 0 07:47:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:47: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')]} 07:47:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47: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')]} 07:47:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47: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', '--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 0x1100bb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110098228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd02e529e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ffdf9f0>, '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 0x10fd3edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ffd28c8>, '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.H9CHcKlSdB/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.2o9j6LC1JW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/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 07:47:29 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 07:47:29 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 07:47:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H9CHcKlSdB/Render', 07:47:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:29 INFO - 'HOME': '/Users/cltbld', 07:47:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:29 INFO - 'LOGNAME': 'cltbld', 07:47:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:29 INFO - 'MOZ_NO_REMOTE': '1', 07:47:29 INFO - 'NO_EM_RESTART': '1', 07:47:29 INFO - 'PAGER': '/bin/cat', 07:47:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:29 INFO - 'PWD': '/builds/slave/test', 07:47:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:29 INFO - 'SHELL': '/bin/bash', 07:47:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2o9j6LC1JW/Listeners', 07:47:29 INFO - 'TMPDIR': '/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/', 07:47:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:29 INFO - 'USER': 'cltbld', 07:47:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:29 INFO - 'XPC_FLAGS': '0x0', 07:47:29 INFO - 'XPC_SERVICE_NAME': '0', 07:47:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:47:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:30 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 07:47:30 INFO - Cleaning up... 07:47:30 INFO - Return code: 0 07:47:30 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:47:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:47:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:47:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1100bb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110098228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd02e529e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ffdf9f0>, '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 0x10fd3edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ffd28c8>, '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.H9CHcKlSdB/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.2o9j6LC1JW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/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 07:47:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 07:47:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:47:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H9CHcKlSdB/Render', 07:47:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:30 INFO - 'HOME': '/Users/cltbld', 07:47:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:30 INFO - 'LOGNAME': 'cltbld', 07:47:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:30 INFO - 'MOZ_NO_REMOTE': '1', 07:47:30 INFO - 'NO_EM_RESTART': '1', 07:47:30 INFO - 'PAGER': '/bin/cat', 07:47:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:30 INFO - 'PWD': '/builds/slave/test', 07:47:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:30 INFO - 'SHELL': '/bin/bash', 07:47:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2o9j6LC1JW/Listeners', 07:47:30 INFO - 'TMPDIR': '/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/', 07:47:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:30 INFO - 'USER': 'cltbld', 07:47:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:30 INFO - 'XPC_FLAGS': '0x0', 07:47:30 INFO - 'XPC_SERVICE_NAME': '0', 07:47:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:47:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:30 INFO - Downloading/unpacking psutil>=0.7.1 07:47:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:33 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 07:47:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:47:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:47:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:47:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:47:33 INFO - Installing collected packages: psutil 07:47:33 INFO - Running setup.py install for psutil 07:47:33 INFO - building 'psutil._psutil_osx' extension 07:47:33 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 07:47:35 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 07:47:35 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 07:47:35 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 07:47:35 INFO - building 'psutil._psutil_posix' extension 07:47:35 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 07:47:36 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:47:36 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:47:36 INFO - ^ 07:47:36 INFO - 1 warning generated. 07:47:36 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 07:47:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:47:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:47:36 INFO - Successfully installed psutil 07:47:36 INFO - Cleaning up... 07:47:36 INFO - Return code: 0 07:47:36 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:47:36 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')]} 07:47:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:36 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')]} 07:47:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:36 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 0x1100bb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110098228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd02e529e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ffdf9f0>, '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 0x10fd3edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ffd28c8>, '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.H9CHcKlSdB/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.2o9j6LC1JW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/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 07:47:36 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 07:47:36 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 07:47:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H9CHcKlSdB/Render', 07:47:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:36 INFO - 'HOME': '/Users/cltbld', 07:47:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:36 INFO - 'LOGNAME': 'cltbld', 07:47:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:36 INFO - 'MOZ_NO_REMOTE': '1', 07:47:36 INFO - 'NO_EM_RESTART': '1', 07:47:36 INFO - 'PAGER': '/bin/cat', 07:47:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:36 INFO - 'PWD': '/builds/slave/test', 07:47:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:36 INFO - 'SHELL': '/bin/bash', 07:47:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2o9j6LC1JW/Listeners', 07:47:36 INFO - 'TMPDIR': '/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/', 07:47:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:36 INFO - 'USER': 'cltbld', 07:47:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:36 INFO - 'XPC_FLAGS': '0x0', 07:47:36 INFO - 'XPC_SERVICE_NAME': '0', 07:47:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:47:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:36 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:47:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:39 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:47:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:47:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:47:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:47:39 INFO - Installing collected packages: mozsystemmonitor 07:47:39 INFO - Running setup.py install for mozsystemmonitor 07:47:39 INFO - Successfully installed mozsystemmonitor 07:47:39 INFO - Cleaning up... 07:47:39 INFO - Return code: 0 07:47:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:47:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:47:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:47:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:39 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 0x1100bb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110098228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd02e529e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ffdf9f0>, '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 0x10fd3edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ffd28c8>, '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.H9CHcKlSdB/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.2o9j6LC1JW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/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 07:47:39 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 07:47:39 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 07:47:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H9CHcKlSdB/Render', 07:47:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:39 INFO - 'HOME': '/Users/cltbld', 07:47:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:39 INFO - 'LOGNAME': 'cltbld', 07:47:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:39 INFO - 'MOZ_NO_REMOTE': '1', 07:47:39 INFO - 'NO_EM_RESTART': '1', 07:47:39 INFO - 'PAGER': '/bin/cat', 07:47:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:39 INFO - 'PWD': '/builds/slave/test', 07:47:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:39 INFO - 'SHELL': '/bin/bash', 07:47:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2o9j6LC1JW/Listeners', 07:47:39 INFO - 'TMPDIR': '/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/', 07:47:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:39 INFO - 'USER': 'cltbld', 07:47:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:39 INFO - 'XPC_FLAGS': '0x0', 07:47:39 INFO - 'XPC_SERVICE_NAME': '0', 07:47:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:47:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:40 INFO - Downloading/unpacking blobuploader==1.2.4 07:47:40 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 07:47:40 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 07:47:40 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 07:47:40 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 07:47:40 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 07:47:40 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 07:47:43 INFO - Downloading blobuploader-1.2.4.tar.gz 07:47:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:47:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:47:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:47:43 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 07:47:43 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 07:47:43 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 07:47:43 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 07:47:43 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 07:47:43 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 07:47:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:47:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:47:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:47:44 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 07:47:44 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 07:47:44 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 07:47:44 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 07:47:44 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 07:47:44 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 07:47:44 INFO - Downloading docopt-0.6.1.tar.gz 07:47:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:47:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:47:44 INFO - Installing collected packages: blobuploader, requests, docopt 07:47:44 INFO - Running setup.py install for blobuploader 07:47:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:47:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:47:44 INFO - Running setup.py install for requests 07:47:45 INFO - Running setup.py install for docopt 07:47:45 INFO - Successfully installed blobuploader requests docopt 07:47:45 INFO - Cleaning up... 07:47:45 INFO - Return code: 0 07:47:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:47:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:47:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:47:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:45 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 0x1100bb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110098228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd02e529e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ffdf9f0>, '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 0x10fd3edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ffd28c8>, '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.H9CHcKlSdB/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.2o9j6LC1JW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/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 07:47:45 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 07:47:45 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 07:47:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H9CHcKlSdB/Render', 07:47:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:45 INFO - 'HOME': '/Users/cltbld', 07:47:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:45 INFO - 'LOGNAME': 'cltbld', 07:47:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:45 INFO - 'MOZ_NO_REMOTE': '1', 07:47:45 INFO - 'NO_EM_RESTART': '1', 07:47:45 INFO - 'PAGER': '/bin/cat', 07:47:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:45 INFO - 'PWD': '/builds/slave/test', 07:47:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:45 INFO - 'SHELL': '/bin/bash', 07:47:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2o9j6LC1JW/Listeners', 07:47:45 INFO - 'TMPDIR': '/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/', 07:47:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:45 INFO - 'USER': 'cltbld', 07:47:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:45 INFO - 'XPC_FLAGS': '0x0', 07:47:45 INFO - 'XPC_SERVICE_NAME': '0', 07:47:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:47:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:47:46 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-IwEDAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:47:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:47:46 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-BaWCqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:47:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:47:46 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-NiR9Vh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:47:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:47:46 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-8sdtiV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:47:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:47:46 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-csLWZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:47:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:47:46 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-Mt_q5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:47:47 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-i6mvZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:47:47 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-BzTxst-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:47:47 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-wCLY48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:47:47 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-gCRUJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:47:47 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-XMU5ul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:47:47 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-PAIKOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:47:47 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-dVF0eI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:47:48 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-3wmMUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:47:48 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-Ew2mHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:47:48 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-kqziRn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:47:48 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-oM2AN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:47:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:47:48 INFO - Running setup.py install for manifestparser 07:47:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:47:48 INFO - Running setup.py install for mozcrash 07:47:48 INFO - Running setup.py install for mozdebug 07:47:49 INFO - Running setup.py install for mozdevice 07:47:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:47:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:47:49 INFO - Running setup.py install for mozfile 07:47:49 INFO - Running setup.py install for mozhttpd 07:47:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:47:49 INFO - Running setup.py install for mozinfo 07:47:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:47:49 INFO - Running setup.py install for mozInstall 07:47:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:47:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:47:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:47:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:47:50 INFO - Running setup.py install for mozleak 07:47:50 INFO - Running setup.py install for mozlog 07:47:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:47:50 INFO - Running setup.py install for moznetwork 07:47:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:47:50 INFO - Running setup.py install for mozprocess 07:47:50 INFO - Running setup.py install for mozprofile 07:47:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:47:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:47:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:47:51 INFO - Running setup.py install for mozrunner 07:47:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:47:51 INFO - Running setup.py install for mozscreenshot 07:47:51 INFO - Running setup.py install for moztest 07:47:51 INFO - Running setup.py install for mozversion 07:47:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:47:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:47:52 INFO - Cleaning up... 07:47:52 INFO - Return code: 0 07:47:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:47:52 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')]} 07:47:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:52 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')]} 07:47:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:52 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 0x1100bb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110098228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd02e529e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ffdf9f0>, '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 0x10fd3edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ffd28c8>, '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.H9CHcKlSdB/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.2o9j6LC1JW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/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 07:47:52 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 07:47:52 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 07:47:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H9CHcKlSdB/Render', 07:47:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:52 INFO - 'HOME': '/Users/cltbld', 07:47:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:52 INFO - 'LOGNAME': 'cltbld', 07:47:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:52 INFO - 'MOZ_NO_REMOTE': '1', 07:47:52 INFO - 'NO_EM_RESTART': '1', 07:47:52 INFO - 'PAGER': '/bin/cat', 07:47:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:52 INFO - 'PWD': '/builds/slave/test', 07:47:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:52 INFO - 'SHELL': '/bin/bash', 07:47:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2o9j6LC1JW/Listeners', 07:47:52 INFO - 'TMPDIR': '/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/', 07:47:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:52 INFO - 'USER': 'cltbld', 07:47:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:52 INFO - 'XPC_FLAGS': '0x0', 07:47:52 INFO - 'XPC_SERVICE_NAME': '0', 07:47:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:47:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:47:52 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-eCDXQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:47:52 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)) 07:47:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:47:52 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-eOpYXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:47:52 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)) 07:47:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:47:52 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-JOLIl4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:47:52 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)) 07:47:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:47:52 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-5Pb8Xm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:47:53 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)) 07:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:47:53 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-E6J0Ii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:47:53 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)) 07:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:47:53 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-5ZVBFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:47:53 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)) 07:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:47:53 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-KDbRAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:47:53 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)) 07:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:47:53 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-Da0M8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:47:53 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)) 07:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:47:53 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-NFaVmQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:47:53 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)) 07:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:47:53 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-3KwIND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:47:53 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)) 07:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:47:53 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-bFD5_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:47:54 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)) 07:47:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:47:54 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-ohp6yj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:47:54 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)) 07:47:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:47:54 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-sbf5M_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:47:54 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)) 07:47:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:47:54 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-XjR3Ai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:47:54 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)) 07:47:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:47:54 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-IS82N1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:47:54 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)) 07:47:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:47:54 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-btjaH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:47:54 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)) 07:47:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:47:54 INFO - Running setup.py (path:/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/pip-QAQTvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:47:54 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)) 07:47:54 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)) 07:47:54 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)) 07:47:54 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)) 07:47:54 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)) 07:47:54 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)) 07:47:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:57 INFO - Downloading blessings-1.5.1.tar.gz 07:47:57 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 07:47:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:47:57 INFO - Installing collected packages: blessings 07:47:57 INFO - Running setup.py install for blessings 07:47:58 INFO - Successfully installed blessings 07:47:58 INFO - Cleaning up... 07:47:58 INFO - Return code: 0 07:47:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:47:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:47:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:47:58 INFO - Reading from file tmpfile_stdout 07:47:58 INFO - Current package versions: 07:47:58 INFO - blessings == 1.5.1 07:47:58 INFO - blobuploader == 1.2.4 07:47:58 INFO - docopt == 0.6.1 07:47:58 INFO - manifestparser == 1.1 07:47:58 INFO - mozInstall == 1.12 07:47:58 INFO - mozcrash == 0.16 07:47:58 INFO - mozdebug == 0.1 07:47:58 INFO - mozdevice == 0.47 07:47:58 INFO - mozfile == 1.2 07:47:58 INFO - mozhttpd == 0.7 07:47:58 INFO - mozinfo == 0.9 07:47:58 INFO - mozleak == 0.1 07:47:58 INFO - mozlog == 3.0 07:47:58 INFO - moznetwork == 0.27 07:47:58 INFO - mozprocess == 0.22 07:47:58 INFO - mozprofile == 0.27 07:47:58 INFO - mozrunner == 6.11 07:47:58 INFO - mozscreenshot == 0.1 07:47:58 INFO - mozsystemmonitor == 0.0 07:47:58 INFO - moztest == 0.7 07:47:58 INFO - mozversion == 1.4 07:47:58 INFO - psutil == 3.1.1 07:47:58 INFO - requests == 1.2.3 07:47:58 INFO - wsgiref == 0.1.2 07:47:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:47: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')]} 07:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47: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')]} 07:47:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:58 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 0x1100bb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110098228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd02e529e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ffdf9f0>, '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 0x10fd3edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ffd28c8>, '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.H9CHcKlSdB/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.2o9j6LC1JW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/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 07:47:58 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 07:47:58 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 07:47:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H9CHcKlSdB/Render', 07:47:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:58 INFO - 'HOME': '/Users/cltbld', 07:47:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:58 INFO - 'LOGNAME': 'cltbld', 07:47:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:58 INFO - 'MOZ_NO_REMOTE': '1', 07:47:58 INFO - 'NO_EM_RESTART': '1', 07:47:58 INFO - 'PAGER': '/bin/cat', 07:47:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:58 INFO - 'PWD': '/builds/slave/test', 07:47:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:58 INFO - 'SHELL': '/bin/bash', 07:47:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2o9j6LC1JW/Listeners', 07:47:58 INFO - 'TMPDIR': '/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/', 07:47:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:58 INFO - 'USER': 'cltbld', 07:47:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:58 INFO - 'XPC_FLAGS': '0x0', 07:47:58 INFO - 'XPC_SERVICE_NAME': '0', 07:47:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:47:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:58 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)) 07:47:58 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)) 07:47:58 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)) 07:47:58 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)) 07:47:58 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)) 07:47:58 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)) 07:47:58 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)) 07:47:58 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)) 07:47:58 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)) 07:47:58 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)) 07:47:58 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)) 07:47:58 INFO - Cleaning up... 07:47:58 INFO - Return code: 0 07:47:58 INFO - Running post-action listener: _resource_record_post_action 07:47:58 INFO - Running post-action listener: _start_resource_monitoring 07:47:59 INFO - Starting resource monitoring. 07:47:59 INFO - ##### 07:47:59 INFO - ##### Running install step. 07:47:59 INFO - ##### 07:47:59 INFO - Running pre-action listener: _resource_record_pre_action 07:47:59 INFO - Running main action method: install 07:47:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:47:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:47:59 INFO - Reading from file tmpfile_stdout 07:47:59 INFO - Detecting whether we're running mozinstall >=1.0... 07:47:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:47:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:47:59 INFO - Reading from file tmpfile_stdout 07:47:59 INFO - Output received: 07:47:59 INFO - Usage: mozinstall [options] installer 07:47:59 INFO - Options: 07:47:59 INFO - -h, --help show this help message and exit 07:47:59 INFO - -d DEST, --destination=DEST 07:47:59 INFO - Directory to install application into. [default: 07:47:59 INFO - "/builds/slave/test"] 07:47:59 INFO - --app=APP Application being installed. [default: firefox] 07:47:59 INFO - mkdir: /builds/slave/test/build/application 07:47:59 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'] 07:47:59 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 07:48:43 INFO - Reading from file tmpfile_stdout 07:48:43 INFO - Output received: 07:48:43 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:48:43 INFO - Running post-action listener: _resource_record_post_action 07:48:43 INFO - ##### 07:48:43 INFO - ##### Running run-tests step. 07:48:43 INFO - ##### 07:48:43 INFO - Running pre-action listener: _resource_record_pre_action 07:48:43 INFO - Running main action method: run_tests 07:48:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:48:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:48:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:48:43 INFO - 2015-11-18 07:48:43.308 screenresolution[1631:7609] starting screenresolution argv=screenresolution get 07:48:43 INFO - 2015-11-18 07:48:43.312 screenresolution[1631:7609] Display 0: 1600x1200x32@60 07:48:43 INFO - 2015-11-18 07:48:43.319 screenresolution[1632:7611] starting screenresolution argv=screenresolution list 07:48:43 INFO - Available Modes on Display 0 07:48:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:48:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:48:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:48:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:48:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:48:43 INFO - Intel HD Graphics 3000: 07:48:43 INFO - Chipset Model: Intel HD Graphics 3000 07:48:43 INFO - Type: GPU 07:48:43 INFO - Bus: Built-In 07:48:43 INFO - VRAM (Total): 512 MB 07:48:43 INFO - VRAM (Dynamic, Max): 10 07:48:43 INFO - Vendor: Intel (0x8086) 07:48:43 INFO - Device ID: 0x0116 07:48:43 INFO - Revision ID: 0x0009 07:48:43 INFO - Displays: 07:48:43 INFO - Display: 07:48:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:48:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:48:43 INFO - Display Serial Number: 1600x1200 60 07:48:43 INFO - Main Display: Yes 07:48:43 INFO - Mirror: Off 07:48:43 INFO - Online: Yes 07:48:43 INFO - Rotation: Supported 07:48:43 INFO - Return code: 0 07:48:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:48:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:48:43 INFO - Python 2.7.3 07:48:43 INFO - Return code: 0 07:48:43 INFO - grabbing minidump binary from tooltool 07:48:43 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')]} 07:48:43 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 0x10ffdf9f0>, '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 0x10fd3edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ffd28c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:48:43 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 07:48:43 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 07:48:43 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:48:43 INFO - Return code: 0 07:48:43 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:48:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:48:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:48:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:48:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:48:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/iAAtYJgHTESXiDnxeO6vbg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0061', '--webServer', 'localhost'] in /builds/slave/test/build 07:48:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/iAAtYJgHTESXiDnxeO6vbg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0061 --webServer localhost 07:48:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H9CHcKlSdB/Render', 07:48:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:48:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:48:43 INFO - 'HOME': '/Users/cltbld', 07:48:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:48:43 INFO - 'LOGNAME': 'cltbld', 07:48:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:48:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:48:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:43 INFO - 'MOZ_NO_REMOTE': '1', 07:48:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:48:43 INFO - 'NO_EM_RESTART': '1', 07:48:43 INFO - 'PAGER': '/bin/cat', 07:48:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:48:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:43 INFO - 'PWD': '/builds/slave/test', 07:48:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:48:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:48:43 INFO - 'SHELL': '/bin/bash', 07:48:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2o9j6LC1JW/Listeners', 07:48:43 INFO - 'TMPDIR': '/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/', 07:48:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:48:43 INFO - 'USER': 'cltbld', 07:48:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:48:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:48:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:43 INFO - 'XPC_FLAGS': '0x0', 07:48:43 INFO - 'XPC_SERVICE_NAME': '0', 07:48:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:48:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/iAAtYJgHTESXiDnxeO6vbg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0061', '--webServer', 'localhost'] with output_timeout 3600 07:48:44 INFO - mozversion INFO | application_buildid: 20151118055124 07:48:44 INFO - mozversion INFO | application_changeset: 1d6155d7e6c91fa5ec1ef6927f3d3a044187896d 07:48:44 INFO - mozversion INFO | application_display_name: Nightly 07:48:44 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:48:44 INFO - mozversion INFO | application_name: Firefox 07:48:44 INFO - mozversion INFO | application_remotingname: firefox 07:48:44 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 07:48:44 INFO - mozversion INFO | application_vendor: Mozilla 07:48:44 INFO - mozversion INFO | application_version: 45.0a1 07:48:44 INFO - mozversion INFO | platform_buildid: 20151118055124 07:48:44 INFO - mozversion INFO | platform_changeset: 1d6155d7e6c91fa5ec1ef6927f3d3a044187896d 07:48:44 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 07:48:44 INFO - mozversion INFO | platform_version: 45.0a1 07:48:44 INFO - 2015-11-18 07:48:44,160 DEBUG : using testdate: 1447861724 07:48:44 INFO - 2015-11-18 07:48:44,160 DEBUG : actual date: 1447861724 07:48:44 INFO - 2015-11-18 07:48:44,170 INFO : starting webserver on 'localhost:49257' 07:48:44 INFO - 2015-11-18 07:48:44,171 INFO : Starting test suite t-yosemite-r5-0061.e 07:48:44 INFO - 2015-11-18 07:48:44,171 INFO : Starting test dromaeo_css 07:48:44 INFO - 2015-11-18 07:48:44,171 DEBUG : operating with platform_type : mac_ 07:48:44 INFO - 2015-11-18 07:48:44,172 INFO : Initialising browser for dromaeo_css test... 07:48:44 INFO - 2015-11-18 07:48:44,199 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/tmp0LIsUB/profile http://localhost:49257/getInfo.html 07:48:48 INFO - 2015-11-18 07:48:48,786 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:48:48 INFO - 2015-11-18 07:48:48,786 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:48:48 INFO - 2015-11-18 07:48:48,787 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 07:48:48 INFO - 2015-11-18 07:48:48,787 DEBUG : BROWSER_OUTPUT: __metrics 07:48:49 INFO - 2015-11-18 07:48:49,588 INFO : Browser initialized. 07:48:49 INFO - 2015-11-18 07:48:49,588 INFO : Running cycle 1/1 for dromaeo_css test... 07:48:49 INFO - 2015-11-18 07:48:49,588 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/tmp0LIsUB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:49:01 INFO - 2015-11-18 07:49:01,926 DEBUG : BROWSER_OUTPUT: RSS: Main: 240906240 07:49:01 INFO - 2015-11-18 07:49:01,926 DEBUG : BROWSER_OUTPUT: 07:49:51 INFO - 2015-11-18 07:49:51,800 DEBUG : BROWSER_OUTPUT: 1447861791798 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] 07:52:02 INFO - 2015-11-18 07:52:02,061 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49257/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49257/tests/dromaeo/cssquery-ext.html) 07:52:03 INFO - 2015-11-18 07:52:03,070 DEBUG : BROWSER_OUTPUT: RSS: Main: 268472320 07:52:03 INFO - 2015-11-18 07:52:03,070 DEBUG : BROWSER_OUTPUT: 07:55:05 INFO - 2015-11-18 07:55:05,188 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49257/tests/dromaeo/cssquery-ext.html (next: http://localhost:49257/tests/dromaeo/cssquery-jquery.html) 07:55:05 INFO - 2015-11-18 07:55:05,772 DEBUG : BROWSER_OUTPUT: RSS: Main: 274178048 07:55:05 INFO - 2015-11-18 07:55:05,773 DEBUG : BROWSER_OUTPUT: 07:58:07 INFO - 2015-11-18 07:58:07,537 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49257/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49257/tests/dromaeo/cssquery-mootools.html) 07:58:08 INFO - 2015-11-18 07:58:08,123 DEBUG : BROWSER_OUTPUT: RSS: Main: 278736896 07:58:08 INFO - 2015-11-18 07:58:08,124 DEBUG : BROWSER_OUTPUT: 08:01:09 INFO - 2015-11-18 08:01:09,902 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49257/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49257/tests/dromaeo/cssquery-prototype.html) 08:01:10 INFO - 2015-11-18 08:01:10,511 DEBUG : BROWSER_OUTPUT: RSS: Main: 281538560 08:01:10 INFO - 2015-11-18 08:01:10,511 DEBUG : BROWSER_OUTPUT: 08:04:13 INFO - 2015-11-18 08:04:13,258 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49257/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49257/tests/dromaeo/cssquery-yui.html) 08:04:13 INFO - 2015-11-18 08:04:13,868 DEBUG : BROWSER_OUTPUT: RSS: Main: 287404032 08:04:13 INFO - 2015-11-18 08:04:13,868 DEBUG : BROWSER_OUTPUT: 08:07:16 INFO - 2015-11-18 08:07:16,184 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49257/tests/dromaeo/cssquery-yui.html (next: http://localhost:49257/tests/dromaeo/cssquery-dojo.html) 08:07:16 INFO - 2015-11-18 08:07:16,436 DEBUG : BROWSER_OUTPUT: RSS: Main: 292847616 08:07:16 INFO - 2015-11-18 08:07:16,436 DEBUG : BROWSER_OUTPUT: 08:07:16 INFO - 2015-11-18 08:07:16,436 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:07:16 INFO - 2015-11-18 08:07:16,436 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:07:16 INFO - 2015-11-18 08:07:16,436 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:07:16 INFO - 2015-11-18 08:07:16,436 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:07:16 INFO - 2015-11-18 08:07:16,440 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2440.1093600835693;2468.2718598013594;2478.752124787521;2527.7219505854364;2536.695596528417;4047.8178481968307;4088.713790034699;4121.814518346674;4128.649064829489;4131.297679394506;3995.1809878974814;4104.774237416941;4106.384042393643;4120.711550191488;4236.216299984505;3901.4342920276545;3938.1926705025403;3977.4232736253225;3983.58172391899;4069.674426045924;3873.3028054950096;3961.9207615847668;4017.4174744662005;4017.919641607166;4042.73722208057;3710.777353358807;3755.361588529929;3883.339832228528;3895.9610403896163;3903.512060992376;3786.4320351947426;3798.924021519582;3834.9808250958845;3909.354956432185;3909.4331321958443;3742.6631603155574;3794.924101517954;3800.0309920970253;3843.5195600549932;3849.2109117630816;3870.9225815483815;3873;4100.282450571168;4178.8328466861285;4195.580441955811;4432.024954510002;4434.268345722952;4443.289073748185;4483.282674772021;4492.415985921842;4344.695871288979;4466.1737578547745;4542.727436353829;4545.613622842063;4590.517995610447;4099.672026237953;4110.815013324378;4152;4153.418521407006;4197.538270790211;4565.771711414416;4572.337011133367;4579.290210017452;4584.243599806061;4629.745364004944;4150.377443383517;4296.2696341621995;4379.4525684289465;4429.579189976947;4443.888902777392;4358.280883654225;4455.287154055336;4471.821127154877;4478.888027799331;4487.439070116236;4373.497047839539;4391.7584532851;4451.043025749479;4461.709988850715;4512.187806194851;4201.117765269267;4289.656827453859;4330.783460826946;4383.057642606855;4475.462944446687;3441.9483707744403;3459.8616055358007;3504.737144714157;3518.7712798668003;3542.397792375251;3154.463741164008;3171.8731250750175;3180.3162320101287;3247.269364392993;3250.3661785951513;3940.369540873504;4054.6756259499757;4152.522459917088;4229.45017147775;4248.235317642854;4452.220861349251;4463.799129039201;4481.417415735934;4503.414556107685;4629.606483448944;4169.291220492523;4175.91648167035;4224.556421575752;4248.936265956013;4257.510386305615;3741.3639681254253;3754.4556039374684;3852.3065848147044;3903.965449155976;3944.8027598619956;4508.098380323882;4516.774161291923;4567.543245675406;4620.722756634613;4625.236835922035;4367.737935723867;4438.778061096997;4459.777011149365;4481.551844815493;4523.366728657925;4419.845305414295;4483.932741008953;4531;4583.908321833478;4607.815687372602;4387.319965405367;4401.317795741666;4420.182266280748;4467.441569803775;4489.506154323087;4204.07510347723;4250.7662078584735;4433.423654924968;4460.30865215892;4497.460304763449;4300.311950087971;4314.288142456585;4350.847720329773;4409.669274804339;4442.844860336271;4313.460817397825;4319.97840010798;4335.436393268855;4354.934675979926;4382.737035777864;3994.46074779901;4160.271952408256;4203.495580530356;4221.704480686445;4294.162638285505;4197.727147735387;4334.696571239983;4389;4397.978010109929;4433.556644335541;4252.319628859492;4264.168487144977;4273.102648443862;4390.0122472443445;4394.956050439455 08:07:16 INFO - 2015-11-18 08:07:16,441 DEBUG : BROWSER_OUTPUT: |1;ext.html;457.77797768082485;464.8117512407474;475.95954343880766;478.98563043108675;487.17667142529103;29781.255468613268;30528.54207186894;30811.84594077032;30858.84570577147;30922.69077309226;34438.48342274861;35659.82170089146;36226.8188659057;36235.456468152996;36300.636993630054;7457.925420745777;7570.772876813704;7679.347255483291;7718.536887786723;7768.106667733198;7536.4724469287175;7541.358984486325;7642.465027448081;7658.617069146549;7662.961685191594;7484.663190156429;7537.962310188442;7671.156172821014;7703.191164927686;7715.614219289041;7575.924240757605;7605.619719014055;7687.500312479671;7689.50018248812;7707.113681926538;7384.520006199634;7417.777466676009;7431.85136297271;7576;7588.544687318778;32687.836560817283;32726.836365818257;33188.17029574256;33199.502007469906;33244;2442.3894026493376;2453.8036957043396;2486.185104715433;2537.5305568469707;2878.568214767781;22297.44256393587;22660.206892758673;23053.884730576407;23311.533769324687;23576.410589735224;1909.226763160922;1951.219512195119;1976.5651556657656;1978.3372570189003;1993.8404927605757;212647;214101;215151;217261;217691;49731.53490046343;50050.4934358531;50117.498825012015;50120;50210.748946255764;55836.16245756317;57471;57619.711901441064;57625.42374576285;57652;13710.862891370958;13995.650108747363;14178.71642567143;14188.85811141896;14313.713725725427;10136.847947280796;10587.735306617242;10628.309159904582;10669.946650266855;10874.510647020903;16871.91564042172;16995.74506382405;17118.657626847642;17190.656186876193;17219.483415497554;6996.405305548984;7247.094113235846;7258.528195667264;7320.194778574352;7340.596267205355;733.2008111158863;771.5602106799071;783.244169376543;849.5370023337296;856.4475913036057;23745.168919088093;24168.154114605903;24287.149949752027;24384.878075609508;24416.63375049376;870.8388948044632;882.170759486081;959.9760005999766;975.8438649815995;995.9452230127413;12092.395380230953;12477.5008999639;12570.560030398892;12724.363781810873;12748.171368860994;303666;311363.87498687336;312786;312859;313948;46862.76568617203;47284.29073563899;47862;47954.76022619865;48000.27999580009;1096.276457538021;1104.9502772375263;1114.7436089699415;1139.1797905508022;1139.846120773685;22785.772142278365;23228.3031509055;23238.767612324336;23306.883465582563;23594;39656.206875862896;40302.798486008556;40858.182836342516;40901.59098408978;40993;228841;229181;229521;229574;231240;27088.45823083488;33886.66113338934;34944.475832862016;35608.46587301141;35679.28641427209;36940;37422.625773741915;37489.4376584346;37813;38009;29751.553726693684;30829.075127746204;30915;31339.216519587193;31379.529307060868;30634.387312254075;31126.844365778026;31163.84418077986;31313.84343078361;31480.212994675316;31888.36223275475;32506.512402314456;32584.185395365304;32607.836960815042;33725;26943.461130777665;27888.44223115486;29810.403791924473;30079.248018799706;30096.849515753158;20751.273705420237;20787.272445464336;20866.92799056466;20893.791062089793;22109.115635374405 08:07:16 INFO - 2015-11-18 08:07:16,446 DEBUG : BROWSER_OUTPUT: |2;jquery.html;259.8453919917648;269.2649068044239;269.4355325592883;272.50540269411016;280.99719002809974;10996.711282599772;14190.787138192922;14215.502457413993;14504.202268875195;14694.926525367371;9147.405418647782;9562.139407453327;9726.65956691516;14227.71544569108;14822.55532334029;3432.4851272309165;3548.6273941236186;3558.7864728116265;3596.172880237547;3618.656227658368;3530.5939816920995;3641.708663306929;3695.8152092395408;3823.808809559525;3878.45701601776;2689.1125928443566;2808.873600687974;3777.527809023872;3802.9619703803023;3819;3909.3745000799736;3910.6284902934176;3929.1159489115007;3933.0757272041046;3967.2065586882595;3289.3750187464543;3305.9173520662175;3311.2053107254087;3363.4954756786433;3366.9663303367142;10317;10732.463376831205;10737.892621073846;10918.50866711;10938.124950003981;1476.9483068092566;1515.6892836968395;1530.418440992427;1637.4164100417638;1655.6357601327688;7449;7464;7704.730334438268;7728.961355193244;7882.80292992674;1252.1110011891567;1266.4617537546505;1274.9553765618252;1289.2586762611536;1360.2586590308306;44953.325700114525;46961.29558056598;47354;47508.28737568939;47726.28410573844;5069.062223488666;5136.666116702402;5166.560842328369;5187.559057480081;5188.896222075613;5765.942340576625;5909.793157239476;5921.348651648315;5974.551908606872;5974.85062873423;4407.0524837160165;4416.4258646375765;4457.353683715843;4485.842995495207;4494.977525112419;4446.199684056836;4509.977450112729;4532.818687252539;4739.620830333634;4832.009438065188;2310.676505289261;2313.710786151731;2316.895739691718;2360.7403185649564;2366.8816559171973;830.0537387378394;831.1065604475092;836.1847198980945;857.7426771968385;886.3219636977589;328.78464605683314;341.718082581866;344.78278684429154;346.9600995885455;349.03839921017436;9106.86339704905;9259.861102083474;9489.098535639103;9588.90411095894;9742.269329800152;366.49057809644614;367.6415494892512;381.99045023874623;388.3882884456992;393.7893227123532;5053.898922021539;5126.564242039394;5180.7150606717;5183.559397451183;5261.605379596545;464986;466676;467926;471651;478521;55660.44339556633;55806;56788.71605641946;57236.71381643065;57277.427225728046;410.6571013203948;416.6416881481923;418.5437872718751;419.85934711871255;421.09674747666696;8439.409241353047;8860.025397206173;8910.37627366104;8932.598033088396;8998.865017024618;15584.844151558793;24033.639495407933;25407.745922540536;26251.55616441114;27013.86493067522;35211.29577408489;36203.63796362003;36290.63709362978;36823.26353472862;36914.44628330523;4744.240921452551;4785.784639691153;4829.66192366531;4972.8508144755715;4973.5523802857915;9048.502332371783;9227.35408521397;9287.62849486013;9321.580528876082;9436.433813971184;7946.086200087064;8007.279344858991;8019.9198008019175;8086.1913808618665;8230.09468958426;7560.281773231534;7799.37604991588;7903.249191326815;7979.800504987422;8137.715179968673;7923.603819808871;8254;8275.337972962268;8359.540225287668;8374.53940033304;4677.625789936865;4987.376577927759;5042.747862606781;5050.368703912011;5060.038592667382;8111.837763244584;8120.8989460322155;8260.256576908107;8315;8434.114417986268 08:07:16 INFO - 2015-11-18 08:07:16,446 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1090.869095708515;1104.3153244988107;1128.9717757056073;1303.8565757766644;1435.6913263648314;5065.442801291864;5163;5567.582431317652;5604.719764011793;5690.402507736685;5416.702081385522;5592.888142237153;5619.072852979264;5682.51698605619;5699.373068962411;1638.844309790571;1659.5768079139802;1687.0974028894543;1687.4347093723618;1689.6113893804431;1679.4793613979643;1683.1079527850259;1691.2558474271282;1711.7689111969848;1712.8372804583607;1694.8305169483076;1705.0707364486323;1706.2748331958867;1709.948701538956;1720.3548669249033;1629.1202750514708;1645.2760785254509;1653.0247154179033;1657.1548510259734;1730.0052469829773;1700.1839117223678;1731.0652247786181;1732.1858726398573;1739.7999230088576;1769.177332540362;5635.126555383881;5650.152477128422;5665.093585026417;5693.28833895763;5843.2695913010875;3445.414279572479;3470.4794280857823;3509.31568344173;3511.157322242669;3542;2126.755423126345;2236.1502629000875;2242.360927135775;2242.7757224277607;2244.932652020426;688.8932215506604;696.0811728518307;702.1714377035097;710.928907109285;1228.12189284661;7103.112110986127;7123.964380178118;7227.277272272783;7239.855202895966;7244.058272424551;2959.067893613505;3037.863296151634;3040.741536969338;3043.3913217356176;3044.58898048765;5810.82567522975;5897.52819774417;5900.557458190653;5910.438508341701;5920.437558431942;3437.071990562534;3474.6004209515722;3478.860845566149;3487.982560087183;3490.3891818931584;2920.5765164051095;3177.53925680775;3205.6954589313978;3251.349730053999;3252.3657886711862;2356.092904231849;2423.5395274897714;2522.079441004057;2533.5312967101145;2586.663733714605;767.2365995834181;768.0207735137633;771.3019717155983;775.4765533265023;775.5153029356652;693.4106009891552;695.5722230828004;696.4324075878143;697.9162500499973;789.9131095579481;5175.7153356564995;5226.790928362899;5281.683099014072;5294.470552944675;5313.017091838023;520.0311028126215;529.264322591598;534.6124060056428;540.5270388410141;664.962658253117;4153.584641535822;4254.404383386328;4335.848245311399;4337.761423121696;4343.5656434356315;6395.104685344056;6480.060391243243;6509.934900650933;6590.044443555754;6593.3736295051895;6437.806865794034;6494.902576461357;6518.771842985473;6550.639714815731;6558.967205164039;5226.555742761908;5258.211268309784;5280.313559237351;5288.867778305496;5301.628885977944;5013.598912087097;5101.92347114801;5112.821051263188;5117.744112794271;5131.512506311894;5809.24479817621;5891.440313170242;5917.28992520883;5921.851953701192;5953.821385358447;5653.180288858175;5746.339170995389;5762.222100016612;5766.94233057664;5781.768729250783;4714.4106986626675;4889.853304400874;4894.143524883202;4898.289747986593;4899.485554016777;4716.3868697069165;5248.685078895279;5264.578833693372;5284.022455845681;5341.813036543703;4948.529889660476;4960.379952505937;4963.851084467472;5021.096202683406;5039.647224694236;4765.404324459442;4914.311996320589;4964.801407943642;4977.328060711758;4983.725895075806;4974.801007959786;5012.548870601663;5043.747812609428;5058.519440653279;5078.187490001582;4534.863954081383;4576.405067341224;4611.3544103824825;4627.838025669085;4646.907061858677;4590.77046147698;4672.5327467253;4674.6260299176665;4703.223968045234;4708.246680531099 08:07:16 INFO - 2015-11-18 08:07:16,449 DEBUG : BROWSER_OUTPUT: |4;prototype.html;248.4323321211033;252.6235908496341;256.04622780143967;259.09962878995503;261.0822957305073;5075.111855425304;5153.948460515389;5214.921776173355;5215.86960325992;5231.73841307935;4971.204607262839;5126.077306084912;5177.508136727005;5217.739113044351;5307.867303317419;3984.3226651469176;3998.840046398148;4051.554329023805;4052.0680243543857;4072.857449989251;3998.8000599970032;4069.409935559342;4071.9592804072026;4073.4704488416464;4088.8364465421346;3818.5035945327068;4012.3379642358977;4021.919561608766;4033.1933613277315;4042.2319759245647;3952.486176796998;3958.208358328317;4005;4030.0730831908827;4040.9797951010205;3362.159460134966;3406.880759173417;3417.8632854685784;3438.7420943429343;3440.1571614954246;4835.564799168056;4847.830325938575;4967.950320496785;4994.475580064077;5037.29477873098;4335.5014173370155;4462.062966776981;4463.799129039201;4464.709793863421;4465.598096171328;5412.107002344608;5433.510984011418;5451.509364157245;5479.068558345091;5513.365962914236;3634.636536346344;3654.835532401048;3688.2254726507467;3697.7041836653;3702.9444558331647;5531.529819965308;5643.435656434365;5668.801591944303;5673.149027645845;5730.4269573042775;3532.6643968822923;3583.7312201584987;3610.6028336882923;3623.547056617923;3666.5416822897137;3694.704423646102;3717.4795528626014;3737.551493820759;3738.2523495300507;3741.4387841823946;4280.957190428118;4294.76378799169;4371.082072764755;4379.4525684289465;4388.253996820548;5264.236685680555;5351.705656188869;5391.245225668331;5448.855740294583;5451.890962180734;1265.6835791052238;1280.6798300424894;1283.5828355784408;1294.6504443800122;1306.0531114941782;819.7827575692446;832.4006715165071;833.9492239777924;840.4116220343556;851.5529347092826;5034.949650503521;5116.3348764661105;5118.309028281209;5191.883744994844;5193.974030129901;5572.498475137257;5573.944260557342;5602.4033150551895;5649.519790817826;5682.545396368363;5073.873153171126;5086.033653605803;5169.224616307509;5192.8961420771375;5201.7919283229;2935.5156399193893;3056.1901096209076;3062.6018617580016;3100.9379812403627;3105.736012438923;5822.184894114827;5860.326062502867;5875.441833025856;5938.881222375615;5944.4352786485215;5610.663360198401;5629.549636029108;5845.09401042839;5879.764809407661;5927.614705044159;5809.912851307149;5934.703264836741;5935.169076329404;5941.168236446901;5943.613665111754;5646.745896434588;5681.659100453986;5789.478946894631;5790.073588225863;5798.1302804579655;5404.189371594292;5537.335519737658;5550.111982082847;5628.240187574625;5650.502616806467;5816.9127463088935;5827.213326200908;5919.319278283053;5928.8814223716145;5932.7033648318275;3580.9462858056627;3618.5295911531334;3634.945475817812;3662.212624285791;3689.0777305673582;5608.4111168326735;5634.042212823748;5683.2895888014;5694.1458781183155;5716.828495145152;5367.651102678314;5464.726763661722;5528.474794894479;5550.139728342114;5578.721063946868;5482.985647655197;5502.477264659851;5507.779688812403;5575.052241118939;5645.237892884408;5376.354837419534;5438.211459338295;5443.020256353736;5457.317835270591;5458.945410546003;5402.243685883901;5503.862403439946;5534.280543529477;5561.721913904369;5586.16207568868;5382.434844341287;5438.075527160313;5453.7545810439415;5459.672419654833;5463.726813659222 08:07:16 INFO - 2015-11-18 08:07:16,451 DEBUG : BROWSER_OUTPUT: |5;yui.html;585.4496773033349;602.9788957386489;603.4870360193836;617.6964081547803;624.8750249950011;10896.073833724133;11333.489992950317;12504.374781260924;12602;12897.935510322435;10961.232713710044;11601.129915256368;11688.883111168885;11691.123165762581;11699.649010529676;688.4870771275407;693.7849266727305;694.0214297840047;705.2101646156312;709.6558169287891;548.9862753431177;561.839875635444;681.094144787434;709.0392518137926;711.5055036749461;678.8811957907371;704.6089420371692;722.1839321566648;722.7109156337455;730.2150188547306;713.8358177619177;714.7284032067832;718.859822334645;720.9690143095371;728.938040266578;522.7543054764293;522.9555487783543;527.0802449725215;527.5647590737618;533.965292256006;10644.361338319726;10891.400972946485;10973.067289280421;11034.668959931216;11103.333799972028;7311.268873112646;7561.886571701429;7562.962185189094;7929;7934.484258523177;6610.140681711395;6855.725770969155;7039.507234493588;7338.339549440576;7481.551106933547;2264.2867496738477;2278.646809744492;2318.9652155217686;2343.6068366755644;2435.4641978764644;36066.27867442663;36670.816645916864;36676;36706.816465917764;37236.06909827249;5195.038917800143;5390.973045134828;5445.183222516575;5451.727413629303;5689.374168841424;8912.821743565222;8969.058248883905;9014.323925705598;9094.090590940985;9107.590158442754;5158.432572417031;5192.350956130484;5211.739413029333;5220.216967454836;5277.868053298698;3019.426309001283;3144.8742050317733;3158.2578094147857;3270.640229574745;3331.733461323137;1934.584064426127;1970.7733610634673;1993.521554826831;2001.2595339724105;2001.4395969128668;299.50282530998874;299.61050634175484;307.89993252193125;308.22635185684095;309.0697002023924;395.57278139609156;413.9898647300577;427.3568279738973;458.71788849857097;510.3289174735285;5932.377100404482;6415.871682566416;6504.902426463606;6549.312322206195;6561.8188726029775;385.65676547872414;463.81447421031856;464.7118786352483;512.4158459356337;526.9908125938784;2900.622919020514;2978.5681076244255;3075.600171977673;3164.556962025318;3184.26761844777;46535.30197047047;47547.28679069817;48085.5191448088;48495.5150448498;48631;41630;42022.15955680869;42089;42517.14965700669;42918;35645.643543564234;35652;36377.09057273589;38009;38408.615913840506;6444;6594.670266486753;6650.168728908887;6860.931390686229;6878.38094571491;29189;29301.560476592444;29488.41023179567;29785;29932;35190.64809351976;36767;37121.25757484781;37572.43641345327;37663.43504847484;5668.971655141863;5888.440598143169;5985.191999080069;6016.849578760566;6213.96893015532;8876.289896808368;8961.372703910663;8963.686270980485;8991.14584114508;9080.954595226982;8363.414560980917;8450.830983380421;8483.151684831468;8617.82764344697;9178.449293042439;8281.130481299377;8379.371547134111;8435.336084493181;8582.141785821617;8622.094680058755;7697.846043079219;7892.565908875067;7972.322352600094;8163.387745919199;8313.6674533018;7089.468289878177;7183.497155199295;7237.493375463667;7313.853722925405;7467.92532074694;6871.415929646036;7466.887996679946;7514.924850751422;7524.209957954336;7627.545800707518 08:07:16 INFO - 2015-11-18 08:07:16,451 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:07:16 INFO - 2015-11-18 08:07:16,451 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:07:16 INFO - 2015-11-18 08:07:16,451 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,313 08:07:16 INFO - 2015-11-18 08:07:16,452 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:07:16 INFO - 2015-11-18 08:07:16,452 DEBUG : BROWSER_OUTPUT: __startTimestamp1447862836435__endTimestamp 08:07:16 INFO - 2015-11-18 08:07:16,452 DEBUG : BROWSER_OUTPUT: 08:07:16 INFO - 2015-11-18 08:07:16,452 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:07:16 INFO - 2015-11-18 08:07:16,452 DEBUG : BROWSER_OUTPUT: Number of tests: 6 08:07:16 INFO - 2015-11-18 08:07:16,453 DEBUG : BROWSER_OUTPUT: 08:07:16 INFO - 2015-11-18 08:07:16,453 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4142.85 Median:4250.77 stddev:434.55 (10.2%) stddev-sans-first:414.85 08:07:16 INFO - 2015-11-18 08:07:16,454 DEBUG : BROWSER_OUTPUT: Values: 2440.1 2468.3 2478.8 2527.7 2536.7 4047.8 4088.7 4121.8 4128.6 4131.3 3995.2 4104.8 4106.4 4120.7 4236.2 3901.4 3938.2 3977.4 3983.6 4069.7 3873.3 3961.9 4017.4 4017.9 4042.7 3710.8 3755.4 3883.3 3896.0 3903.5 3786.4 3798.9 3835.0 3909.4 3909.4 3742.7 3794.9 3800.0 3843.5 3849.2 3870.9 3873.0 4100.3 4178.8 4195.6 4432.0 4434.3 4443.3 4483.3 4492.4 4344.7 4466.2 4542.7 4545.6 4590.5 4099.7 4110.8 4152.0 4153.4 4197.5 4565.8 4572.3 4579.3 4584.2 4629.7 4150.4 4296.3 4379.5 4429.6 4443.9 4358.3 4455.3 4471.8 4478.9 4487.4 4373.5 4391.8 4451.0 4461.7 4512.2 4201.1 4289.7 4330.8 4383.1 4475.5 3441.9 3459.9 3504.7 3518.8 3542.4 3154.5 3171.9 3180.3 3247.3 3250.4 3940.4 4054.7 4152.5 4229.5 4248.2 4452.2 4463.8 4481.4 4503.4 4629.6 4169.3 4175.9 4224.6 4248.9 4257.5 3741.4 3754.5 3852.3 3904.0 3944.8 4508.1 4516.8 4567.5 4620.7 4625.2 4367.7 4438.8 4459.8 4481.6 4523.4 4419.8 4483.9 4531.0 4583.9 4607.8 4387.3 4401.3 4420.2 4467.4 4489.5 4204.1 4250.8 4433.4 4460.3 4497.5 4300.3 4314.3 4350.8 4409.7 4442.8 4313.5 4320.0 4335.4 4354.9 4382.7 3994.5 4160.3 4203.5 4221.7 4294.2 4197.7 4334.7 4389.0 4398.0 4433.6 4252.3 4264.2 4273.1 4390.0 4395.0 08:07:16 INFO - 2015-11-18 08:07:16,454 DEBUG : BROWSER_OUTPUT: 08:07:16 INFO - 2015-11-18 08:07:16,455 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40115.99 Median:31684.29 stddev:66949.94 (211.3%) stddev-sans-first:67071.54 08:07:16 INFO - 2015-11-18 08:07:16,456 DEBUG : BROWSER_OUTPUT: Values: 457.8 464.8 476.0 479.0 487.2 29781.3 30528.5 30811.8 30858.8 30922.7 34438.5 35659.8 36226.8 36235.5 36300.6 7457.9 7570.8 7679.3 7718.5 7768.1 7536.5 7541.4 7642.5 7658.6 7663.0 7484.7 7538.0 7671.2 7703.2 7715.6 7575.9 7605.6 7687.5 7689.5 7707.1 7384.5 7417.8 7431.9 7576.0 7588.5 32687.8 32726.8 33188.2 33199.5 33244.0 2442.4 2453.8 2486.2 2537.5 2878.6 22297.4 22660.2 23053.9 23311.5 23576.4 1909.2 1951.2 1976.6 1978.3 1993.8 212647.0 214101.0 215151.0 217261.0 217691.0 49731.5 50050.5 50117.5 50120.0 50210.7 55836.2 57471.0 57619.7 57625.4 57652.0 13710.9 13995.7 14178.7 14188.9 14313.7 10136.8 10587.7 10628.3 10669.9 10874.5 16871.9 16995.7 17118.7 17190.7 17219.5 6996.4 7247.1 7258.5 7320.2 7340.6 733.2 771.6 783.2 849.5 856.4 23745.2 24168.2 24287.1 24384.9 24416.6 870.8 882.2 960.0 975.8 995.9 12092.4 12477.5 12570.6 12724.4 12748.2 303666.0 311363.9 312786.0 312859.0 313948.0 46862.8 47284.3 47862.0 47954.8 48000.3 1096.3 1105.0 1114.7 1139.2 1139.8 22785.8 23228.3 23238.8 23306.9 23594.0 39656.2 40302.8 40858.2 40901.6 40993.0 228841.0 229181.0 229521.0 229574.0 231240.0 27088.5 33886.7 34944.5 35608.5 35679.3 36940.0 37422.6 37489.4 37813.0 38009.0 29751.6 30829.1 30915.0 31339.2 31379.5 30634.4 31126.8 31163.8 31313.8 31480.2 31888.4 32506.5 32584.2 32607.8 33725.0 26943.5 27888.4 29810.4 30079.2 30096.8 20751.3 20787.3 20866.9 20893.8 22109.1 08:07:16 INFO - 2015-11-18 08:07:16,456 DEBUG : BROWSER_OUTPUT: 08:07:16 INFO - 2015-11-18 08:07:16,456 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:22148.63 Median:234759.41 stddev:76913.67 (32.8%) stddev-sans-first:77111.87 08:07:16 INFO - 2015-11-18 08:07:16,460 DEBUG : BROWSER_OUTPUT: Values: 259.8 269.3 269.4 272.5 281.0 10996.7 14190.8 14215.5 14504.2 14694.9 9147.4 9562.1 9726.7 14227.7 14822.6 3432.5 3548.6 3558.8 3596.2 3618.7 3530.6 3641.7 3695.8 3823.8 3878.5 2689.1 2808.9 3777.5 3803.0 3819.0 3909.4 3910.6 3929.1 3933.1 3967.2 3289.4 3305.9 3311.2 3363.5 3367.0 10317.0 10732.5 10737.9 10918.5 10938.1 1476.9 1515.7 1530.4 1637.4 1655.6 7449.0 7464.0 7704.7 7729.0 7882.8 1252.1 1266.5 1275.0 1289.3 1360.3 44953.3 46961.3 47354.0 47508.3 47726.3 5069.1 5136.7 5166.6 5187.6 5188.9 5765.9 5909.8 5921.3 5974.6 5974.9 4407.1 4416.4 4457.4 4485.8 4495.0 4446.2 4510.0 4532.8 4739.6 4832.0 2310.7 2313.7 2316.9 2360.7 2366.9 830.1 831.1 836.2 857.7 886.3 328.8 341.7 344.8 347.0 349.0 9106.9 9259.9 9489.1 9588.9 9742.3 366.5 367.6 382.0 388.4 393.8 5053.9 5126.6 5180.7 5183.6 5261.6 464986.0 466676.0 467926.0 471651.0 478521.0 55660.4 55806.0 56788.7 57236.7 57277.4 410.7 416.6 418.5 419.9 421.1 8439.4 8860.0 8910.4 8932.6 8998.9 15584.8 24033.6 25407.7 26251.6 27013.9 35211.3 36203.6 36290.6 36823.3 36914.4 4744.2 4785.8 4829.7 4972.9 4973.6 9048.5 9227.4 9287.6 9321.6 9436.4 7946.1 8007.3 8019.9 8086.2 8230.1 7560.3 7799.4 7903.2 7979.8 8137.7 7923.6 8254.0 8275.3 8359.5 8374.5 4677.6 4987.4 5042.7 5050.4 5060.0 8111.8 8120.9 8260.3 8315.0 8434.1 08:07:16 INFO - 2015-11-18 08:07:16,461 DEBUG : BROWSER_OUTPUT: 08:07:16 INFO - 2015-11-18 08:07:16,461 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:3861.25 Median:4998.14 stddev:1946.20 (38.9%) stddev-sans-first:1940.51 08:07:16 INFO - 2015-11-18 08:07:16,461 DEBUG : BROWSER_OUTPUT: Values: 1090.9 1104.3 1129.0 1303.9 1435.7 5065.4 5163.0 5567.6 5604.7 5690.4 5416.7 5592.9 5619.1 5682.5 5699.4 1638.8 1659.6 1687.1 1687.4 1689.6 1679.5 1683.1 1691.3 1711.8 1712.8 1694.8 1705.1 1706.3 1709.9 1720.4 1629.1 1645.3 1653.0 1657.2 1730.0 1700.2 1731.1 1732.2 1739.8 1769.2 5635.1 5650.2 5665.1 5693.3 5843.3 3445.4 3470.5 3509.3 3511.2 3542.0 2126.8 2236.2 2242.4 2242.8 2244.9 688.9 696.1 702.2 710.9 1228.1 7103.1 7124.0 7227.3 7239.9 7244.1 2959.1 3037.9 3040.7 3043.4 3044.6 5810.8 5897.5 5900.6 5910.4 5920.4 3437.1 3474.6 3478.9 3488.0 3490.4 2920.6 3177.5 3205.7 3251.3 3252.4 2356.1 2423.5 2522.1 2533.5 2586.7 767.2 768.0 771.3 775.5 775.5 693.4 695.6 696.4 697.9 789.9 5175.7 5226.8 5281.7 5294.5 5313.0 520.0 529.3 534.6 540.5 665.0 4153.6 4254.4 4335.8 4337.8 4343.6 6395.1 6480.1 6509.9 6590.0 6593.4 6437.8 6494.9 6518.8 6550.6 6559.0 5226.6 5258.2 5280.3 5288.9 5301.6 5013.6 5101.9 5112.8 5117.7 5131.5 5809.2 5891.4 5917.3 5921.9 5953.8 5653.2 5746.3 5762.2 5766.9 5781.8 4714.4 4889.9 4894.1 4898.3 4899.5 4716.4 5248.7 5264.6 5284.0 5341.8 4948.5 4960.4 4963.9 5021.1 5039.6 4765.4 4914.3 4964.8 4977.3 4983.7 4974.8 5012.5 5043.7 5058.5 5078.2 4534.9 4576.4 4611.4 4627.8 4646.9 4590.8 4672.5 4674.6 4703.2 4708.2 08:07:16 INFO - 2015-11-18 08:07:16,461 DEBUG : BROWSER_OUTPUT: 08:07:16 INFO - 2015-11-18 08:07:16,461 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4551.59 Median:5215.40 stddev:1412.11 (27.1%) stddev-sans-first:1378.64 08:07:16 INFO - 2015-11-18 08:07:16,462 DEBUG : BROWSER_OUTPUT: Values: 248.4 252.6 256.0 259.1 261.1 5075.1 5153.9 5214.9 5215.9 5231.7 4971.2 5126.1 5177.5 5217.7 5307.9 3984.3 3998.8 4051.6 4052.1 4072.9 3998.8 4069.4 4072.0 4073.5 4088.8 3818.5 4012.3 4021.9 4033.2 4042.2 3952.5 3958.2 4005.0 4030.1 4041.0 3362.2 3406.9 3417.9 3438.7 3440.2 4835.6 4847.8 4968.0 4994.5 5037.3 4335.5 4462.1 4463.8 4464.7 4465.6 5412.1 5433.5 5451.5 5479.1 5513.4 3634.6 3654.8 3688.2 3697.7 3702.9 5531.5 5643.4 5668.8 5673.1 5730.4 3532.7 3583.7 3610.6 3623.5 3666.5 3694.7 3717.5 3737.6 3738.3 3741.4 4281.0 4294.8 4371.1 4379.5 4388.3 5264.2 5351.7 5391.2 5448.9 5451.9 1265.7 1280.7 1283.6 1294.7 1306.1 819.8 832.4 833.9 840.4 851.6 5034.9 5116.3 5118.3 5191.9 5194.0 5572.5 5573.9 5602.4 5649.5 5682.5 5073.9 5086.0 5169.2 5192.9 5201.8 2935.5 3056.2 3062.6 3100.9 3105.7 5822.2 5860.3 5875.4 5938.9 5944.4 5610.7 5629.5 5845.1 5879.8 5927.6 5809.9 5934.7 5935.2 5941.2 5943.6 5646.7 5681.7 5789.5 5790.1 5798.1 5404.2 5537.3 5550.1 5628.2 5650.5 5816.9 5827.2 5919.3 5928.9 5932.7 3580.9 3618.5 3634.9 3662.2 3689.1 5608.4 5634.0 5683.3 5694.1 5716.8 5367.7 5464.7 5528.5 5550.1 5578.7 5483.0 5502.5 5507.8 5575.1 5645.2 5376.4 5438.2 5443.0 5457.3 5458.9 5402.2 5503.9 5534.3 5561.7 5586.2 5382.4 5438.1 5453.8 5459.7 5463.7 08:07:16 INFO - 2015-11-18 08:07:16,462 DEBUG : BROWSER_OUTPUT: 08:07:16 INFO - 2015-11-18 08:07:16,462 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:10619.79 Median:2962.47 stddev:13102.07 (442.3%) stddev-sans-first:13117.16 08:07:16 INFO - 2015-11-18 08:07:16,464 DEBUG : BROWSER_OUTPUT: Values: 585.4 603.0 603.5 617.7 624.9 10896.1 11333.5 12504.4 12602.0 12897.9 10961.2 11601.1 11688.9 11691.1 11699.6 688.5 693.8 694.0 705.2 709.7 549.0 561.8 681.1 709.0 711.5 678.9 704.6 722.2 722.7 730.2 713.8 714.7 718.9 721.0 728.9 522.8 523.0 527.1 527.6 534.0 10644.4 10891.4 10973.1 11034.7 11103.3 7311.3 7561.9 7563.0 7929.0 7934.5 6610.1 6855.7 7039.5 7338.3 7481.6 2264.3 2278.6 2319.0 2343.6 2435.5 36066.3 36670.8 36676.0 36706.8 37236.1 5195.0 5391.0 5445.2 5451.7 5689.4 8912.8 8969.1 9014.3 9094.1 9107.6 5158.4 5192.4 5211.7 5220.2 5277.9 3019.4 3144.9 3158.3 3270.6 3331.7 1934.6 1970.8 1993.5 2001.3 2001.4 299.5 299.6 307.9 308.2 309.1 395.6 414.0 427.4 458.7 510.3 5932.4 6415.9 6504.9 6549.3 6561.8 385.7 463.8 464.7 512.4 527.0 2900.6 2978.6 3075.6 3164.6 3184.3 46535.3 47547.3 48085.5 48495.5 48631.0 41630.0 42022.2 42089.0 42517.1 42918.0 35645.6 35652.0 36377.1 38009.0 38408.6 6444.0 6594.7 6650.2 6860.9 6878.4 29189.0 29301.6 29488.4 29785.0 29932.0 35190.6 36767.0 37121.3 37572.4 37663.4 5669.0 5888.4 5985.2 6016.8 6214.0 8876.3 8961.4 8963.7 8991.1 9081.0 8363.4 8450.8 8483.2 8617.8 9178.4 8281.1 8379.4 8435.3 8582.1 8622.1 7697.8 7892.6 7972.3 8163.4 8313.7 7089.5 7183.5 7237.5 7313.9 7467.9 6871.4 7466.9 7514.9 7524.2 7627.5 08:07:16 INFO - 2015-11-18 08:07:16,464 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:07:16 INFO - 2015-11-18 08:07:16,464 DEBUG : BROWSER_OUTPUT: 08:07:17 INFO - 2015-11-18 08:07:17,141 INFO : Browser exited with error code: 0 08:07:17 INFO - 2015-11-18 08:07:17,175 INFO : Completed test dromaeo_css (00:18:33) 08:07:17 INFO - 2015-11-18 08:07:17,175 INFO : Starting test kraken 08:07:17 INFO - 2015-11-18 08:07:17,175 DEBUG : operating with platform_type : mac_ 08:07:17 INFO - 2015-11-18 08:07:17,175 INFO : Initialising browser for kraken test... 08:07:17 INFO - 2015-11-18 08:07:17,191 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/tmpuLi0zB/profile http://localhost:49257/getInfo.html 08:07:20 INFO - 2015-11-18 08:07:20,649 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:07:20 INFO - 2015-11-18 08:07:20,649 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:07:20 INFO - 2015-11-18 08:07:20,649 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 08:07:20 INFO - 2015-11-18 08:07:20,650 DEBUG : BROWSER_OUTPUT: __metrics 08:07:21 INFO - 2015-11-18 08:07:21,387 INFO : Browser initialized. 08:07:21 INFO - 2015-11-18 08:07:21,387 INFO : Running cycle 1/1 for kraken test... 08:07:21 INFO - 2015-11-18 08:07:21,388 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/tmpuLi0zB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:07:33 INFO - 2015-11-18 08:07:33,695 DEBUG : BROWSER_OUTPUT: RSS: Main: 240668672 08:07:33 INFO - 2015-11-18 08:07:33,696 DEBUG : BROWSER_OUTPUT: 08:07:36 INFO - 2015-11-18 08:07:36,723 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49257/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49257/tests/kraken/driver.html?testName=audio-beat-detection) 08:07:37 INFO - 2015-11-18 08:07:37,337 DEBUG : BROWSER_OUTPUT: RSS: Main: 260382720 08:07:37 INFO - 2015-11-18 08:07:37,337 DEBUG : BROWSER_OUTPUT: 08:07:40 INFO - 2015-11-18 08:07:40,515 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49257/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49257/tests/kraken/driver.html?testName=audio-dft) 08:07:41 INFO - 2015-11-18 08:07:41,120 DEBUG : BROWSER_OUTPUT: RSS: Main: 267763712 08:07:41 INFO - 2015-11-18 08:07:41,120 DEBUG : BROWSER_OUTPUT: 08:07:44 INFO - 2015-11-18 08:07:44,564 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49257/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49257/tests/kraken/driver.html?testName=audio-fft) 08:07:45 INFO - 2015-11-18 08:07:45,135 DEBUG : BROWSER_OUTPUT: RSS: Main: 267870208 08:07:45 INFO - 2015-11-18 08:07:45,135 DEBUG : BROWSER_OUTPUT: 08:07:47 INFO - 2015-11-18 08:07:47,440 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49257/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49257/tests/kraken/driver.html?testName=audio-oscillator) 08:07:48 INFO - 2015-11-18 08:07:48,039 DEBUG : BROWSER_OUTPUT: RSS: Main: 269336576 08:07:48 INFO - 2015-11-18 08:07:48,039 DEBUG : BROWSER_OUTPUT: 08:07:50 INFO - 2015-11-18 08:07:50,523 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49257/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49257/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:07:51 INFO - 2015-11-18 08:07:51,110 DEBUG : BROWSER_OUTPUT: RSS: Main: 269500416 08:07:51 INFO - 2015-11-18 08:07:51,110 DEBUG : BROWSER_OUTPUT: 08:07:54 INFO - 2015-11-18 08:07:54,759 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49257/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49257/tests/kraken/driver.html?testName=imaging-darkroom) 08:07:55 INFO - 2015-11-18 08:07:55,342 DEBUG : BROWSER_OUTPUT: RSS: Main: 271130624 08:07:55 INFO - 2015-11-18 08:07:55,342 DEBUG : BROWSER_OUTPUT: 08:07:59 INFO - 2015-11-18 08:07:59,122 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49257/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49257/tests/kraken/driver.html?testName=imaging-desaturate) 08:07:59 INFO - 2015-11-18 08:07:59,711 DEBUG : BROWSER_OUTPUT: RSS: Main: 271269888 08:07:59 INFO - 2015-11-18 08:07:59,712 DEBUG : BROWSER_OUTPUT: 08:08:03 INFO - 2015-11-18 08:08:03,093 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49257/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49257/tests/kraken/driver.html?testName=json-parse-financial) 08:08:03 INFO - 2015-11-18 08:08:03,685 DEBUG : BROWSER_OUTPUT: RSS: Main: 271503360 08:08:03 INFO - 2015-11-18 08:08:03,686 DEBUG : BROWSER_OUTPUT: 08:08:05 INFO - 2015-11-18 08:08:05,558 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49257/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49257/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:08:06 INFO - 2015-11-18 08:08:06,157 DEBUG : BROWSER_OUTPUT: RSS: Main: 270077952 08:08:06 INFO - 2015-11-18 08:08:06,157 DEBUG : BROWSER_OUTPUT: 08:08:08 INFO - 2015-11-18 08:08:08,271 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49257/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49257/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:08:08 INFO - 2015-11-18 08:08:08,902 DEBUG : BROWSER_OUTPUT: RSS: Main: 271683584 08:08:08 INFO - 2015-11-18 08:08:08,902 DEBUG : BROWSER_OUTPUT: 08:08:11 INFO - 2015-11-18 08:08:11,379 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49257/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49257/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:08:11 INFO - 2015-11-18 08:08:11,970 DEBUG : BROWSER_OUTPUT: RSS: Main: 271241216 08:08:11 INFO - 2015-11-18 08:08:11,970 DEBUG : BROWSER_OUTPUT: 08:08:15 INFO - 2015-11-18 08:08:15,100 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49257/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49257/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:08:15 INFO - 2015-11-18 08:08:15,701 DEBUG : BROWSER_OUTPUT: RSS: Main: 271527936 08:08:15 INFO - 2015-11-18 08:08:15,701 DEBUG : BROWSER_OUTPUT: 08:08:18 INFO - 2015-11-18 08:08:18,797 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49257/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49257/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:08:19 INFO - 2015-11-18 08:08:19,389 DEBUG : BROWSER_OUTPUT: RSS: Main: 271777792 08:08:19 INFO - 2015-11-18 08:08:19,389 DEBUG : BROWSER_OUTPUT: 08:08:21 INFO - 2015-11-18 08:08:21,362 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49257/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49257/tests/kraken/driver.html?testName=ai-astar) 08:08:21 INFO - 2015-11-18 08:08:21,614 DEBUG : BROWSER_OUTPUT: RSS: Main: 271495168 08:08:21 INFO - 2015-11-18 08:08:21,614 DEBUG : BROWSER_OUTPUT: 08:08:21 INFO - 2015-11-18 08:08:21,614 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:08:21 INFO - 2015-11-18 08:08:21,615 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:08:21 INFO - 2015-11-18 08:08:21,615 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:08:21 INFO - 2015-11-18 08:08:21,615 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:08:21 INFO - 2015-11-18 08:08:21,615 DEBUG : BROWSER_OUTPUT: |0;ai-astar;137;132;146;144;142;157;145;143;143;137 08:08:21 INFO - 2015-11-18 08:08:21,615 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;193;173;193;204;166;191;192;167;205;176 08:08:21 INFO - 2015-11-18 08:08:21,615 DEBUG : BROWSER_OUTPUT: |2;audio-dft;213;212;210;209;211;212;208;201;202;208 08:08:21 INFO - 2015-11-18 08:08:21,616 DEBUG : BROWSER_OUTPUT: |3;audio-fft;88;93;104;144;87;84;89;91;149;88 08:08:21 INFO - 2015-11-18 08:08:21,616 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;108;113;159;112;115;114;156;113;116;157 08:08:21 INFO - 2015-11-18 08:08:21,616 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;151;149;151;157;157;156;157;156;157;150 08:08:21 INFO - 2015-11-18 08:08:21,616 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;165;165;164;164;164;164;164;167;164;165 08:08:21 INFO - 2015-11-18 08:08:21,616 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;124;133;123;136;124;131;135;129;123;133 08:08:21 INFO - 2015-11-18 08:08:21,617 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;81;83;91;87;88;86;88;94;88;85 08:08:21 INFO - 2015-11-18 08:08:21,617 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;83;87;95;91;91;92;91;91;90;92 08:08:21 INFO - 2015-11-18 08:08:21,617 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;107;114;116;115;114;111;116;115;113;115 08:08:21 INFO - 2015-11-18 08:08:21,617 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;176;176;170;170;176;180;170;162;182;165 08:08:21 INFO - 2015-11-18 08:08:21,619 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;179;202;201;198;201;187;192;198;200;188 08:08:21 INFO - 2015-11-18 08:08:21,619 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;86;88;92;93;93;91;92;91;95;94 08:08:21 INFO - 2015-11-18 08:08:21,619 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:08:21 INFO - 2015-11-18 08:08:21,619 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:08:21 INFO - 2015-11-18 08:08:21,620 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,780 08:08:21 INFO - 2015-11-18 08:08:21,620 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:08:21 INFO - 2015-11-18 08:08:21,620 DEBUG : BROWSER_OUTPUT: __startTimestamp1447862901613__endTimestamp 08:08:21 INFO - 2015-11-18 08:08:21,620 DEBUG : BROWSER_OUTPUT: 08:08:21 INFO - 2015-11-18 08:08:21,620 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:08:21 INFO - 2015-11-18 08:08:21,621 DEBUG : BROWSER_OUTPUT: Number of tests: 14 08:08:21 INFO - 2015-11-18 08:08:21,621 DEBUG : BROWSER_OUTPUT: 08:08:21 INFO - 2015-11-18 08:08:21,621 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:142.60 Median:143.50 stddev:6.69 (4.7%) stddev-sans-first:6.78 08:08:21 INFO - 2015-11-18 08:08:21,621 DEBUG : BROWSER_OUTPUT: Values: 137.0 132.0 146.0 144.0 142.0 157.0 145.0 143.0 143.0 137.0 08:08:21 INFO - 2015-11-18 08:08:21,621 DEBUG : BROWSER_OUTPUT: 08:08:21 INFO - 2015-11-18 08:08:21,621 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:186.00 Median:192.50 stddev:14.43 (7.5%) stddev-sans-first:15.08 08:08:21 INFO - 2015-11-18 08:08:21,622 DEBUG : BROWSER_OUTPUT: Values: 193.0 173.0 193.0 204.0 166.0 191.0 192.0 167.0 205.0 176.0 08:08:21 INFO - 2015-11-18 08:08:21,622 DEBUG : BROWSER_OUTPUT: 08:08:21 INFO - 2015-11-18 08:08:21,623 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:208.60 Median:210.50 stddev:4.12 (2.0%) stddev-sans-first:4.04 08:08:21 INFO - 2015-11-18 08:08:21,623 DEBUG : BROWSER_OUTPUT: Values: 213.0 212.0 210.0 209.0 211.0 212.0 208.0 201.0 202.0 208.0 08:08:21 INFO - 2015-11-18 08:08:21,623 DEBUG : BROWSER_OUTPUT: 08:08:21 INFO - 2015-11-18 08:08:21,623 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:101.70 Median:88.00 stddev:24.24 (27.5%) stddev-sans-first:25.20 08:08:21 INFO - 2015-11-18 08:08:21,624 DEBUG : BROWSER_OUTPUT: Values: 88.0 93.0 104.0 144.0 87.0 84.0 89.0 91.0 149.0 88.0 08:08:21 INFO - 2015-11-18 08:08:21,624 DEBUG : BROWSER_OUTPUT: 08:08:21 INFO - 2015-11-18 08:08:21,624 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:126.30 Median:115.50 stddev:21.53 (18.6%) stddev-sans-first:21.79 08:08:21 INFO - 2015-11-18 08:08:21,624 DEBUG : BROWSER_OUTPUT: Values: 108.0 113.0 159.0 112.0 115.0 114.0 156.0 113.0 116.0 157.0 08:08:21 INFO - 2015-11-18 08:08:21,624 DEBUG : BROWSER_OUTPUT: 08:08:21 INFO - 2015-11-18 08:08:21,625 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:154.10 Median:156.50 stddev:3.38 (2.2%) stddev-sans-first:3.40 08:08:21 INFO - 2015-11-18 08:08:21,625 DEBUG : BROWSER_OUTPUT: Values: 151.0 149.0 151.0 157.0 157.0 156.0 157.0 156.0 157.0 150.0 08:08:21 INFO - 2015-11-18 08:08:21,625 DEBUG : BROWSER_OUTPUT: 08:08:21 INFO - 2015-11-18 08:08:21,625 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:164.60 Median:164.50 stddev:0.97 (0.6%) stddev-sans-first:1.01 08:08:21 INFO - 2015-11-18 08:08:21,625 DEBUG : BROWSER_OUTPUT: Values: 165.0 165.0 164.0 164.0 164.0 164.0 164.0 167.0 164.0 165.0 08:08:21 INFO - 2015-11-18 08:08:21,625 DEBUG : BROWSER_OUTPUT: 08:08:21 INFO - 2015-11-18 08:08:21,626 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:129.10 Median:132.00 stddev:5.20 (3.9%) stddev-sans-first:5.17 08:08:21 INFO - 2015-11-18 08:08:21,626 DEBUG : BROWSER_OUTPUT: Values: 124.0 133.0 123.0 136.0 124.0 131.0 135.0 129.0 123.0 133.0 08:08:21 INFO - 2015-11-18 08:08:21,626 DEBUG : BROWSER_OUTPUT: 08:08:21 INFO - 2015-11-18 08:08:21,626 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:87.10 Median:88.00 stddev:3.73 (4.2%) stddev-sans-first:3.23 08:08:21 INFO - 2015-11-18 08:08:21,627 DEBUG : BROWSER_OUTPUT: Values: 81.0 83.0 91.0 87.0 88.0 86.0 88.0 94.0 88.0 85.0 08:08:21 INFO - 2015-11-18 08:08:21,627 DEBUG : BROWSER_OUTPUT: 08:08:21 INFO - 2015-11-18 08:08:21,627 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:90.30 Median:91.00 stddev:3.23 (3.6%) stddev-sans-first:2.09 08:08:21 INFO - 2015-11-18 08:08:21,627 DEBUG : BROWSER_OUTPUT: Values: 83.0 87.0 95.0 91.0 91.0 92.0 91.0 91.0 90.0 92.0 08:08:21 INFO - 2015-11-18 08:08:21,627 DEBUG : BROWSER_OUTPUT: 08:08:21 INFO - 2015-11-18 08:08:21,627 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:113.60 Median:115.00 stddev:2.76 (2.4%) stddev-sans-first:1.58 08:08:21 INFO - 2015-11-18 08:08:21,629 DEBUG : BROWSER_OUTPUT: Values: 107.0 114.0 116.0 115.0 114.0 111.0 116.0 115.0 113.0 115.0 08:08:21 INFO - 2015-11-18 08:08:21,629 DEBUG : BROWSER_OUTPUT: 08:08:21 INFO - 2015-11-18 08:08:21,629 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:172.70 Median:176.00 stddev:6.40 (3.6%) stddev-sans-first:6.67 08:08:21 INFO - 2015-11-18 08:08:21,629 DEBUG : BROWSER_OUTPUT: Values: 176.0 176.0 170.0 170.0 176.0 180.0 170.0 162.0 182.0 165.0 08:08:21 INFO - 2015-11-18 08:08:21,629 DEBUG : BROWSER_OUTPUT: 08:08:21 INFO - 2015-11-18 08:08:21,629 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.60 Median:199.00 stddev:7.75 (3.9%) stddev-sans-first:5.81 08:08:21 INFO - 2015-11-18 08:08:21,630 DEBUG : BROWSER_OUTPUT: Values: 179.0 202.0 201.0 198.0 201.0 187.0 192.0 198.0 200.0 188.0 08:08:21 INFO - 2015-11-18 08:08:21,630 DEBUG : BROWSER_OUTPUT: 08:08:21 INFO - 2015-11-18 08:08:21,630 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:91.50 Median:92.50 stddev:2.72 (2.9%) stddev-sans-first:2.03 08:08:21 INFO - 2015-11-18 08:08:21,630 DEBUG : BROWSER_OUTPUT: Values: 86.0 88.0 92.0 93.0 93.0 91.0 92.0 91.0 95.0 94.0 08:08:21 INFO - 2015-11-18 08:08:21,630 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:08:21 INFO - 2015-11-18 08:08:21,630 DEBUG : BROWSER_OUTPUT: 08:08:22 INFO - 2015-11-18 08:08:22,367 INFO : Browser exited with error code: 0 08:08:22 INFO - 2015-11-18 08:08:22,424 INFO : Completed test kraken (00:01:05) 08:08:22 INFO - 2015-11-18 08:08:22,424 INFO : Starting test v8_7 08:08:22 INFO - 2015-11-18 08:08:22,424 DEBUG : operating with platform_type : mac_ 08:08:22 INFO - 2015-11-18 08:08:22,425 INFO : Initialising browser for v8_7 test... 08:08:22 INFO - 2015-11-18 08:08:22,440 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/tmp46aUe6/profile http://localhost:49257/getInfo.html 08:08:25 INFO - 2015-11-18 08:08:25,730 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:08:25 INFO - 2015-11-18 08:08:25,730 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:08:25 INFO - 2015-11-18 08:08:25,730 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 08:08:25 INFO - 2015-11-18 08:08:25,730 DEBUG : BROWSER_OUTPUT: __metrics 08:08:26 INFO - 2015-11-18 08:08:26,447 INFO : Browser initialized. 08:08:26 INFO - 2015-11-18 08:08:26,448 INFO : Running cycle 1/1 for v8_7 test... 08:08:26 INFO - 2015-11-18 08:08:26,448 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/T/tmp46aUe6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:08:38 INFO - 2015-11-18 08:08:38,760 DEBUG : BROWSER_OUTPUT: RSS: Main: 240349184 08:08:38 INFO - 2015-11-18 08:08:38,760 DEBUG : BROWSER_OUTPUT: 08:09:01 INFO - 2015-11-18 08:09:01,391 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49257/tests/v8_7/run.html (next: http://localhost:49257/tests/v8_7/run.html) 08:09:01 INFO - 2015-11-18 08:09:01,638 DEBUG : BROWSER_OUTPUT: RSS: Main: 261332992 08:09:01 INFO - 2015-11-18 08:09:01,639 DEBUG : BROWSER_OUTPUT: 08:09:01 INFO - 2015-11-18 08:09:01,639 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:09:01 INFO - 2015-11-18 08:09:01,639 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:09:01 INFO - 2015-11-18 08:09:01,639 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:09:01 INFO - 2015-11-18 08:09:01,639 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:09:01 INFO - 2015-11-18 08:09:01,639 DEBUG : BROWSER_OUTPUT: |0;Richards;203.2520325203252 08:09:01 INFO - 2015-11-18 08:09:01,640 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;247.70869457517958 08:09:01 INFO - 2015-11-18 08:09:01,640 DEBUG : BROWSER_OUTPUT: |2;Encrypt;392.31071008238524 08:09:01 INFO - 2015-11-18 08:09:01,640 DEBUG : BROWSER_OUTPUT: |3;Decrypt;7120.567375886525 08:09:01 INFO - 2015-11-18 08:09:01,640 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1472.0588235294117 08:09:01 INFO - 2015-11-18 08:09:01,640 DEBUG : BROWSER_OUTPUT: |5;Earley;948.8151658767772 08:09:01 INFO - 2015-11-18 08:09:01,640 DEBUG : BROWSER_OUTPUT: |6;Boyer;16540.983606557376 08:09:01 INFO - 2015-11-18 08:09:01,641 DEBUG : BROWSER_OUTPUT: |7;RegExp;35964.28571428572 08:09:01 INFO - 2015-11-18 08:09:01,641 DEBUG : BROWSER_OUTPUT: |8;Splay;816.3265306122449 08:09:01 INFO - 2015-11-18 08:09:01,641 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;7171.428571428572 08:09:01 INFO - 2015-11-18 08:09:01,641 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:09:01 INFO - 2015-11-18 08:09:01,642 DEBUG : BROWSER_OUTPUT: __startTimestamp1447862941636__endTimestamp 08:09:01 INFO - 2015-11-18 08:09:01,642 DEBUG : BROWSER_OUTPUT: 08:09:01 INFO - 2015-11-18 08:09:01,642 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:09:01 INFO - 2015-11-18 08:09:01,643 DEBUG : BROWSER_OUTPUT: Number of tests: 10 08:09:01 INFO - 2015-11-18 08:09:01,643 DEBUG : BROWSER_OUTPUT: 08:09:01 INFO - 2015-11-18 08:09:01,643 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:203.25 Median:203.25 stddev:0.00 (0.0%) 08:09:01 INFO - 2015-11-18 08:09:01,643 DEBUG : BROWSER_OUTPUT: Values: 203.3 08:09:01 INFO - 2015-11-18 08:09:01,644 DEBUG : BROWSER_OUTPUT: 08:09:01 INFO - 2015-11-18 08:09:01,644 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:247.71 Median:247.71 stddev:0.00 (0.0%) 08:09:01 INFO - 2015-11-18 08:09:01,644 DEBUG : BROWSER_OUTPUT: Values: 247.7 08:09:01 INFO - 2015-11-18 08:09:01,644 DEBUG : BROWSER_OUTPUT: 08:09:01 INFO - 2015-11-18 08:09:01,644 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:392.31 Median:392.31 stddev:0.00 (0.0%) 08:09:01 INFO - 2015-11-18 08:09:01,644 DEBUG : BROWSER_OUTPUT: Values: 392.3 08:09:01 INFO - 2015-11-18 08:09:01,645 DEBUG : BROWSER_OUTPUT: 08:09:01 INFO - 2015-11-18 08:09:01,645 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:7120.57 Median:7120.57 stddev:0.00 (0.0%) 08:09:01 INFO - 2015-11-18 08:09:01,645 DEBUG : BROWSER_OUTPUT: Values: 7120.6 08:09:01 INFO - 2015-11-18 08:09:01,645 DEBUG : BROWSER_OUTPUT: 08:09:01 INFO - 2015-11-18 08:09:01,645 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1472.06 Median:1472.06 stddev:0.00 (0.0%) 08:09:01 INFO - 2015-11-18 08:09:01,646 DEBUG : BROWSER_OUTPUT: Values: 1472.1 08:09:01 INFO - 2015-11-18 08:09:01,646 DEBUG : BROWSER_OUTPUT: 08:09:01 INFO - 2015-11-18 08:09:01,646 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:948.82 Median:948.82 stddev:0.00 (0.0%) 08:09:01 INFO - 2015-11-18 08:09:01,646 DEBUG : BROWSER_OUTPUT: Values: 948.8 08:09:01 INFO - 2015-11-18 08:09:01,646 DEBUG : BROWSER_OUTPUT: 08:09:01 INFO - 2015-11-18 08:09:01,647 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:16540.98 Median:16540.98 stddev:0.00 (0.0%) 08:09:01 INFO - 2015-11-18 08:09:01,647 DEBUG : BROWSER_OUTPUT: Values: 16541.0 08:09:01 INFO - 2015-11-18 08:09:01,647 DEBUG : BROWSER_OUTPUT: 08:09:01 INFO - 2015-11-18 08:09:01,647 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:35964.29 Median:35964.29 stddev:0.00 (0.0%) 08:09:01 INFO - 2015-11-18 08:09:01,647 DEBUG : BROWSER_OUTPUT: Values: 35964.3 08:09:01 INFO - 2015-11-18 08:09:01,648 DEBUG : BROWSER_OUTPUT: 08:09:01 INFO - 2015-11-18 08:09:01,648 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:816.33 Median:816.33 stddev:0.00 (0.0%) 08:09:01 INFO - 2015-11-18 08:09:01,648 DEBUG : BROWSER_OUTPUT: Values: 816.3 08:09:01 INFO - 2015-11-18 08:09:01,648 DEBUG : BROWSER_OUTPUT: 08:09:01 INFO - 2015-11-18 08:09:01,648 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:7171.43 Median:7171.43 stddev:0.00 (0.0%) 08:09:01 INFO - 2015-11-18 08:09:01,648 DEBUG : BROWSER_OUTPUT: Values: 7171.4 08:09:01 INFO - 2015-11-18 08:09:01,648 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:09:01 INFO - 2015-11-18 08:09:01,648 DEBUG : BROWSER_OUTPUT: 08:09:02 INFO - 2015-11-18 08:09:02,402 INFO : Browser exited with error code: 0 08:09:02 INFO - 2015-11-18 08:09:02,426 INFO : Completed test v8_7 (00:00:40) 08:09:02 INFO - 2015-11-18 08:09:02,599 INFO : Completed test suite (00:20:18) 08:09:02 INFO - 2015-11-18 08:09:02,599 DEBUG : Working with test: dromaeo_css 08:09:02 INFO - 2015-11-18 08:09:02,599 DEBUG : Generating results file: dromaeo_css 08:09:02 INFO - 2015-11-18 08:09:02,600 DEBUG : Working with test: kraken 08:09:02 INFO - 2015-11-18 08:09:02,600 DEBUG : Generating results file: kraken 08:09:02 INFO - 2015-11-18 08:09:02,600 INFO : javascript benchmark 08:09:02 INFO - 2015-11-18 08:09:02,601 DEBUG : Working with test: v8_7 08:09:02 INFO - 2015-11-18 08:09:02,601 DEBUG : Generating results file: v8_7 08:09:02 INFO - 2015-11-18 08:09:02,601 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:09:02 INFO - 2015-11-18 08:09:02,653 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,57]] 08:09:02 INFO - 2015-11-18 08:09:02,653 DEBUG : process_Request line: dromaeo_css 5233.01 graph.html#tests=[[72,1,57]] 08:09:02 INFO - 2015-11-18 08:09:02,653 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:09:02 INFO - 2015-11-18 08:09:02,686 DEBUG : process_Request line: kraken 1962.80 graph.html#tests=[[232,1,57]] 08:09:02 INFO - 2015-11-18 08:09:02,687 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:09:02 INFO - 2015-11-18 08:09:02,720 DEBUG : process_Request line: v8_7 15726.19 graph.html#tests=[[230,1,57]] 08:09:02 INFO - 2015-11-18 08:09:02,721 INFO : javascript benchmark 08:09:02 INFO - 2015-11-18 08:09:02,723 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2440.1093600835693, 2468.2718598013594, 2478.752124787521, 2527.7219505854364, 2536.695596528417, 4047.8178481968307, 4088.713790034699, 4121.814518346674, 4128.649064829489, 4131.297679394506, 3995.1809878974814, 4104.774237416941, 4106.384042393643, 4120.711550191488, 4236.216299984505, 3901.4342920276545, 3938.1926705025403, 3977.4232736253225, 3983.58172391899, 4069.674426045924, 3873.3028054950096, 3961.9207615847668, 4017.4174744662005, 4017.919641607166, 4042.73722208057, 3710.777353358807, 3755.361588529929, 3883.339832228528, 3895.9610403896163, 3903.512060992376, 3786.4320351947426, 3798.924021519582, 3834.9808250958845, 3909.354956432185, 3909.4331321958443, 3742.6631603155574, 3794.924101517954, 3800.0309920970253, 3843.5195600549932, 3849.2109117630816, 3870.9225815483815, 3873.0, 4100.282450571168, 4178.8328466861285, 4195.580441955811, 4432.024954510002, 4434.268345722952, 4443.289073748185, 4483.282674772021, 4492.415985921842, 4344.695871288979, 4466.1737578547745, 4542.727436353829, 4545.613622842063, 4590.517995610447, 4099.672026237953, 4110.815013324378, 4152.0, 4153.418521407006, 4197.538270790211, 4565.771711414416, 4572.337011133367, 4579.290210017452, 4584.243599806061, 4629.745364004944, 4150.377443383517, 4296.2696341621995, 4379.4525684289465, 4429.579189976947, 4443.888902777392, 4358.280883654225, 4455.287154055336, 4471.821127154877, 4478.888027799331, 4487.439070116236, 4373.497047839539, 4391.7584532851, 4451.043025749479, 4461.709988850715, 4512.187806194851, 4201.117765269267, 4289.656827453859, 4330.783460826946, 4383.057642606855, 4475.462944446687, 3441.9483707744403, 3459.8616055358007, 3504.737144714157, 3518.7712798668003, 3542.397792375251, 3154.463741164008, 3171.8731250750175, 3180.3162320101287, 3247.269364392993, 3250.3661785951513, 3940.369540873504, 4054.6756259499757, 4152.522459917088, 4229.45017147775, 4248.235317642854, 4452.220861349251, 4463.799129039201, 4481.417415735934, 4503.414556107685, 4629.606483448944, 4169.291220492523, 4175.91648167035, 4224.556421575752, 4248.936265956013, 4257.510386305615, 3741.3639681254253, 3754.4556039374684, 3852.3065848147044, 3903.965449155976, 3944.8027598619956, 4508.098380323882, 4516.774161291923, 4567.543245675406, 4620.722756634613, 4625.236835922035, 4367.737935723867, 4438.778061096997, 4459.777011149365, 4481.551844815493, 4523.366728657925, 4419.845305414295, 4483.932741008953, 4531.0, 4583.908321833478, 4607.815687372602, 4387.319965405367, 4401.317795741666, 4420.182266280748, 4467.441569803775, 4489.506154323087, 4204.07510347723, 4250.7662078584735, 4433.423654924968, 4460.30865215892, 4497.460304763449, 4300.311950087971, 4314.288142456585, 4350.847720329773, 4409.669274804339, 4442.844860336271, 4313.460817397825, 4319.97840010798, 4335.436393268855, 4354.934675979926, 4382.737035777864, 3994.46074779901, 4160.271952408256, 4203.495580530356, 4221.704480686445, 4294.162638285505, 4197.727147735387, 4334.696571239983, 4389.0, 4397.978010109929, 4433.556644335541, 4252.319628859492, 4264.168487144977, 4273.102648443862, 4390.0122472443445, 4394.956050439455], "unit": "ms", "name": "dojo.html", "value": 4116.460915415927}, {"lowerIsBetter": false, "replicates": [457.77797768082485, 464.8117512407474, 475.95954343880766, 478.98563043108675, 487.17667142529103, 29781.255468613268, 30528.54207186894, 30811.84594077032, 30858.84570577147, 30922.69077309226, 34438.48342274861, 35659.82170089146, 36226.8188659057, 36235.456468152996, 36300.636993630054, 7457.925420745777, 7570.772876813704, 7679.347255483291, 7718.536887786723, 7768.106667733198, 7536.4724469287175, 7541.358984486325, 7642.465027448081, 7658.617069146549, 7662.961685191594, 7484.663190156429, 7537.962310188442, 7671.156172821014, 7703.191164927686, 7715.614219289041, 7575.924240757605, 7605.619719014055, 7687.500312479671, 7689.50018248812, 7707.113681926538, 7384.520006199634, 7417.777466676009, 7431.85136297271, 7576.0, 7588.544687318778, 32687.836560817283, 32726.836365818257, 33188.17029574256, 33199.502007469906, 33244.0, 2442.3894026493376, 2453.8036957043396, 2486.185104715433, 2537.5305568469707, 2878.568214767781, 22297.44256393587, 22660.206892758673, 23053.884730576407, 23311.533769324687, 23576.410589735224, 1909.226763160922, 1951.219512195119, 1976.5651556657656, 1978.3372570189003, 1993.8404927605757, 212647.0, 214101.0, 215151.0, 217261.0, 217691.0, 49731.53490046343, 50050.4934358531, 50117.498825012015, 50120.0, 50210.748946255764, 55836.16245756317, 57471.0, 57619.711901441064, 57625.42374576285, 57652.0, 13710.862891370958, 13995.650108747363, 14178.71642567143, 14188.85811141896, 14313.713725725427, 10136.847947280796, 10587.735306617242, 10628.309159904582, 10669.946650266855, 10874.510647020903, 16871.91564042172, 16995.74506382405, 17118.657626847642, 17190.656186876193, 17219.483415497554, 6996.405305548984, 7247.094113235846, 7258.528195667264, 7320.194778574352, 7340.596267205355, 733.2008111158863, 771.5602106799071, 783.244169376543, 849.5370023337296, 856.4475913036057, 23745.168919088093, 24168.154114605903, 24287.149949752027, 24384.878075609508, 24416.63375049376, 870.8388948044632, 882.170759486081, 959.9760005999766, 975.8438649815995, 995.9452230127413, 12092.395380230953, 12477.5008999639, 12570.560030398892, 12724.363781810873, 12748.171368860994, 303666.0, 311363.87498687336, 312786.0, 312859.0, 313948.0, 46862.76568617203, 47284.29073563899, 47862.0, 47954.76022619865, 48000.27999580009, 1096.276457538021, 1104.9502772375263, 1114.7436089699415, 1139.1797905508022, 1139.846120773685, 22785.772142278365, 23228.3031509055, 23238.767612324336, 23306.883465582563, 23594.0, 39656.206875862896, 40302.798486008556, 40858.182836342516, 40901.59098408978, 40993.0, 228841.0, 229181.0, 229521.0, 229574.0, 231240.0, 27088.45823083488, 33886.66113338934, 34944.475832862016, 35608.46587301141, 35679.28641427209, 36940.0, 37422.625773741915, 37489.4376584346, 37813.0, 38009.0, 29751.553726693684, 30829.075127746204, 30915.0, 31339.216519587193, 31379.529307060868, 30634.387312254075, 31126.844365778026, 31163.84418077986, 31313.84343078361, 31480.212994675316, 31888.36223275475, 32506.512402314456, 32584.185395365304, 32607.836960815042, 33725.0, 26943.461130777665, 27888.44223115486, 29810.403791924473, 30079.248018799706, 30096.849515753158, 20751.273705420237, 20787.272445464336, 20866.92799056466, 20893.791062089793, 22109.115635374405], "unit": "ms", "name": "ext.html", "value": 15694.644678172193}, {"lowerIsBetter": false, "replicates": [259.8453919917648, 269.2649068044239, 269.4355325592883, 272.50540269411016, 280.99719002809974, 10996.711282599772, 14190.787138192922, 14215.502457413993, 14504.202268875195, 14694.926525367371, 9147.405418647782, 9562.139407453327, 9726.65956691516, 14227.71544569108, 14822.55532334029, 3432.4851272309165, 3548.6273941236186, 3558.7864728116265, 3596.172880237547, 3618.656227658368, 3530.5939816920995, 3641.708663306929, 3695.8152092395408, 3823.808809559525, 3878.45701601776, 2689.1125928443566, 2808.873600687974, 3777.527809023872, 3802.9619703803023, 3819.0, 3909.3745000799736, 3910.6284902934176, 3929.1159489115007, 3933.0757272041046, 3967.2065586882595, 3289.3750187464543, 3305.9173520662175, 3311.2053107254087, 3363.4954756786433, 3366.9663303367142, 10317.0, 10732.463376831205, 10737.892621073846, 10918.50866711, 10938.124950003981, 1476.9483068092566, 1515.6892836968395, 1530.418440992427, 1637.4164100417638, 1655.6357601327688, 7449.0, 7464.0, 7704.730334438268, 7728.961355193244, 7882.80292992674, 1252.1110011891567, 1266.4617537546505, 1274.9553765618252, 1289.2586762611536, 1360.2586590308306, 44953.325700114525, 46961.29558056598, 47354.0, 47508.28737568939, 47726.28410573844, 5069.062223488666, 5136.666116702402, 5166.560842328369, 5187.559057480081, 5188.896222075613, 5765.942340576625, 5909.793157239476, 5921.348651648315, 5974.551908606872, 5974.85062873423, 4407.0524837160165, 4416.4258646375765, 4457.353683715843, 4485.842995495207, 4494.977525112419, 4446.199684056836, 4509.977450112729, 4532.818687252539, 4739.620830333634, 4832.009438065188, 2310.676505289261, 2313.710786151731, 2316.895739691718, 2360.7403185649564, 2366.8816559171973, 830.0537387378394, 831.1065604475092, 836.1847198980945, 857.7426771968385, 886.3219636977589, 328.78464605683314, 341.718082581866, 344.78278684429154, 346.9600995885455, 349.03839921017436, 9106.86339704905, 9259.861102083474, 9489.098535639103, 9588.90411095894, 9742.269329800152, 366.49057809644614, 367.6415494892512, 381.99045023874623, 388.3882884456992, 393.7893227123532, 5053.898922021539, 5126.564242039394, 5180.7150606717, 5183.559397451183, 5261.605379596545, 464986.0, 466676.0, 467926.0, 471651.0, 478521.0, 55660.44339556633, 55806.0, 56788.71605641946, 57236.71381643065, 57277.427225728046, 410.6571013203948, 416.6416881481923, 418.5437872718751, 419.85934711871255, 421.09674747666696, 8439.409241353047, 8860.025397206173, 8910.37627366104, 8932.598033088396, 8998.865017024618, 15584.844151558793, 24033.639495407933, 25407.745922540536, 26251.55616441114, 27013.86493067522, 35211.29577408489, 36203.63796362003, 36290.63709362978, 36823.26353472862, 36914.44628330523, 4744.240921452551, 4785.784639691153, 4829.66192366531, 4972.8508144755715, 4973.5523802857915, 9048.502332371783, 9227.35408521397, 9287.62849486013, 9321.580528876082, 9436.433813971184, 7946.086200087064, 8007.279344858991, 8019.9198008019175, 8086.1913808618665, 8230.09468958426, 7560.281773231534, 7799.37604991588, 7903.249191326815, 7979.800504987422, 8137.715179968673, 7923.603819808871, 8254.0, 8275.337972962268, 8359.540225287668, 8374.53940033304, 4677.625789936865, 4987.376577927759, 5042.747862606781, 5050.368703912011, 5060.038592667382, 8111.837763244584, 8120.8989460322155, 8260.256576908107, 8315.0, 8434.114417986268], "unit": "ms", "name": "jquery.html", "value": 5306.297802785479}, {"lowerIsBetter": false, "replicates": [1090.869095708515, 1104.3153244988107, 1128.9717757056073, 1303.8565757766644, 1435.6913263648314, 5065.442801291864, 5163.0, 5567.582431317652, 5604.719764011793, 5690.402507736685, 5416.702081385522, 5592.888142237153, 5619.072852979264, 5682.51698605619, 5699.373068962411, 1638.844309790571, 1659.5768079139802, 1687.0974028894543, 1687.4347093723618, 1689.6113893804431, 1679.4793613979643, 1683.1079527850259, 1691.2558474271282, 1711.7689111969848, 1712.8372804583607, 1694.8305169483076, 1705.0707364486323, 1706.2748331958867, 1709.948701538956, 1720.3548669249033, 1629.1202750514708, 1645.2760785254509, 1653.0247154179033, 1657.1548510259734, 1730.0052469829773, 1700.1839117223678, 1731.0652247786181, 1732.1858726398573, 1739.7999230088576, 1769.177332540362, 5635.126555383881, 5650.152477128422, 5665.093585026417, 5693.28833895763, 5843.2695913010875, 3445.414279572479, 3470.4794280857823, 3509.31568344173, 3511.157322242669, 3542.0, 2126.755423126345, 2236.1502629000875, 2242.360927135775, 2242.7757224277607, 2244.932652020426, 688.8932215506604, 696.0811728518307, 702.1714377035097, 710.928907109285, 1228.12189284661, 7103.112110986127, 7123.964380178118, 7227.277272272783, 7239.855202895966, 7244.058272424551, 2959.067893613505, 3037.863296151634, 3040.741536969338, 3043.3913217356176, 3044.58898048765, 5810.82567522975, 5897.52819774417, 5900.557458190653, 5910.438508341701, 5920.437558431942, 3437.071990562534, 3474.6004209515722, 3478.860845566149, 3487.982560087183, 3490.3891818931584, 2920.5765164051095, 3177.53925680775, 3205.6954589313978, 3251.349730053999, 3252.3657886711862, 2356.092904231849, 2423.5395274897714, 2522.079441004057, 2533.5312967101145, 2586.663733714605, 767.2365995834181, 768.0207735137633, 771.3019717155983, 775.4765533265023, 775.5153029356652, 693.4106009891552, 695.5722230828004, 696.4324075878143, 697.9162500499973, 789.9131095579481, 5175.7153356564995, 5226.790928362899, 5281.683099014072, 5294.470552944675, 5313.017091838023, 520.0311028126215, 529.264322591598, 534.6124060056428, 540.5270388410141, 664.962658253117, 4153.584641535822, 4254.404383386328, 4335.848245311399, 4337.761423121696, 4343.5656434356315, 6395.104685344056, 6480.060391243243, 6509.934900650933, 6590.044443555754, 6593.3736295051895, 6437.806865794034, 6494.902576461357, 6518.771842985473, 6550.639714815731, 6558.967205164039, 5226.555742761908, 5258.211268309784, 5280.313559237351, 5288.867778305496, 5301.628885977944, 5013.598912087097, 5101.92347114801, 5112.821051263188, 5117.744112794271, 5131.512506311894, 5809.24479817621, 5891.440313170242, 5917.28992520883, 5921.851953701192, 5953.821385358447, 5653.180288858175, 5746.339170995389, 5762.222100016612, 5766.94233057664, 5781.768729250783, 4714.4106986626675, 4889.853304400874, 4894.143524883202, 4898.289747986593, 4899.485554016777, 4716.3868697069165, 5248.685078895279, 5264.578833693372, 5284.022455845681, 5341.813036543703, 4948.529889660476, 4960.379952505937, 4963.851084467472, 5021.096202683406, 5039.647224694236, 4765.404324459442, 4914.311996320589, 4964.801407943642, 4977.328060711758, 4983.725895075806, 4974.801007959786, 5012.548870601663, 5043.747812609428, 5058.519440653279, 5078.187490001582, 4534.863954081383, 4576.405067341224, 4611.3544103824825, 4627.838025669085, 4646.907061858677, 4590.77046147698, 4672.5327467253, 4674.6260299176665, 4703.223968045234, 4708.246680531099], "unit": "ms", "name": "mootools.html", "value": 3174.1034339564317}, {"lowerIsBetter": false, "replicates": [248.4323321211033, 252.6235908496341, 256.04622780143967, 259.09962878995503, 261.0822957305073, 5075.111855425304, 5153.948460515389, 5214.921776173355, 5215.86960325992, 5231.73841307935, 4971.204607262839, 5126.077306084912, 5177.508136727005, 5217.739113044351, 5307.867303317419, 3984.3226651469176, 3998.840046398148, 4051.554329023805, 4052.0680243543857, 4072.857449989251, 3998.8000599970032, 4069.409935559342, 4071.9592804072026, 4073.4704488416464, 4088.8364465421346, 3818.5035945327068, 4012.3379642358977, 4021.919561608766, 4033.1933613277315, 4042.2319759245647, 3952.486176796998, 3958.208358328317, 4005.0, 4030.0730831908827, 4040.9797951010205, 3362.159460134966, 3406.880759173417, 3417.8632854685784, 3438.7420943429343, 3440.1571614954246, 4835.564799168056, 4847.830325938575, 4967.950320496785, 4994.475580064077, 5037.29477873098, 4335.5014173370155, 4462.062966776981, 4463.799129039201, 4464.709793863421, 4465.598096171328, 5412.107002344608, 5433.510984011418, 5451.509364157245, 5479.068558345091, 5513.365962914236, 3634.636536346344, 3654.835532401048, 3688.2254726507467, 3697.7041836653, 3702.9444558331647, 5531.529819965308, 5643.435656434365, 5668.801591944303, 5673.149027645845, 5730.4269573042775, 3532.6643968822923, 3583.7312201584987, 3610.6028336882923, 3623.547056617923, 3666.5416822897137, 3694.704423646102, 3717.4795528626014, 3737.551493820759, 3738.2523495300507, 3741.4387841823946, 4280.957190428118, 4294.76378799169, 4371.082072764755, 4379.4525684289465, 4388.253996820548, 5264.236685680555, 5351.705656188869, 5391.245225668331, 5448.855740294583, 5451.890962180734, 1265.6835791052238, 1280.6798300424894, 1283.5828355784408, 1294.6504443800122, 1306.0531114941782, 819.7827575692446, 832.4006715165071, 833.9492239777924, 840.4116220343556, 851.5529347092826, 5034.949650503521, 5116.3348764661105, 5118.309028281209, 5191.883744994844, 5193.974030129901, 5572.498475137257, 5573.944260557342, 5602.4033150551895, 5649.519790817826, 5682.545396368363, 5073.873153171126, 5086.033653605803, 5169.224616307509, 5192.8961420771375, 5201.7919283229, 2935.5156399193893, 3056.1901096209076, 3062.6018617580016, 3100.9379812403627, 3105.736012438923, 5822.184894114827, 5860.326062502867, 5875.441833025856, 5938.881222375615, 5944.4352786485215, 5610.663360198401, 5629.549636029108, 5845.09401042839, 5879.764809407661, 5927.614705044159, 5809.912851307149, 5934.703264836741, 5935.169076329404, 5941.168236446901, 5943.613665111754, 5646.745896434588, 5681.659100453986, 5789.478946894631, 5790.073588225863, 5798.1302804579655, 5404.189371594292, 5537.335519737658, 5550.111982082847, 5628.240187574625, 5650.502616806467, 5816.9127463088935, 5827.213326200908, 5919.319278283053, 5928.8814223716145, 5932.7033648318275, 3580.9462858056627, 3618.5295911531334, 3634.945475817812, 3662.212624285791, 3689.0777305673582, 5608.4111168326735, 5634.042212823748, 5683.2895888014, 5694.1458781183155, 5716.828495145152, 5367.651102678314, 5464.726763661722, 5528.474794894479, 5550.139728342114, 5578.721063946868, 5482.985647655197, 5502.477264659851, 5507.779688812403, 5575.052241118939, 5645.237892884408, 5376.354837419534, 5438.211459338295, 5443.020256353736, 5457.317835270591, 5458.945410546003, 5402.243685883901, 5503.862403439946, 5534.280543529477, 5561.721913904369, 5586.16207568868, 5382.434844341287, 5438.075527160313, 5453.7545810439415, 5459.672419654833, 5463.726813659222], "unit": "ms", "name": "prototype.html", "value": 4071.598032762953}, {"lowerIsBetter": false, "replicates": [585.4496773033349, 602.9788957386489, 603.4870360193836, 617.6964081547803, 624.8750249950011, 10896.073833724133, 11333.489992950317, 12504.374781260924, 12602.0, 12897.935510322435, 10961.232713710044, 11601.129915256368, 11688.883111168885, 11691.123165762581, 11699.649010529676, 688.4870771275407, 693.7849266727305, 694.0214297840047, 705.2101646156312, 709.6558169287891, 548.9862753431177, 561.839875635444, 681.094144787434, 709.0392518137926, 711.5055036749461, 678.8811957907371, 704.6089420371692, 722.1839321566648, 722.7109156337455, 730.2150188547306, 713.8358177619177, 714.7284032067832, 718.859822334645, 720.9690143095371, 728.938040266578, 522.7543054764293, 522.9555487783543, 527.0802449725215, 527.5647590737618, 533.965292256006, 10644.361338319726, 10891.400972946485, 10973.067289280421, 11034.668959931216, 11103.333799972028, 7311.268873112646, 7561.886571701429, 7562.962185189094, 7929.0, 7934.484258523177, 6610.140681711395, 6855.725770969155, 7039.507234493588, 7338.339549440576, 7481.551106933547, 2264.2867496738477, 2278.646809744492, 2318.9652155217686, 2343.6068366755644, 2435.4641978764644, 36066.27867442663, 36670.816645916864, 36676.0, 36706.816465917764, 37236.06909827249, 5195.038917800143, 5390.973045134828, 5445.183222516575, 5451.727413629303, 5689.374168841424, 8912.821743565222, 8969.058248883905, 9014.323925705598, 9094.090590940985, 9107.590158442754, 5158.432572417031, 5192.350956130484, 5211.739413029333, 5220.216967454836, 5277.868053298698, 3019.426309001283, 3144.8742050317733, 3158.2578094147857, 3270.640229574745, 3331.733461323137, 1934.584064426127, 1970.7733610634673, 1993.521554826831, 2001.2595339724105, 2001.4395969128668, 299.50282530998874, 299.61050634175484, 307.89993252193125, 308.22635185684095, 309.0697002023924, 395.57278139609156, 413.9898647300577, 427.3568279738973, 458.71788849857097, 510.3289174735285, 5932.377100404482, 6415.871682566416, 6504.902426463606, 6549.312322206195, 6561.8188726029775, 385.65676547872414, 463.81447421031856, 464.7118786352483, 512.4158459356337, 526.9908125938784, 2900.622919020514, 2978.5681076244255, 3075.600171977673, 3164.556962025318, 3184.26761844777, 46535.30197047047, 47547.28679069817, 48085.5191448088, 48495.5150448498, 48631.0, 41630.0, 42022.15955680869, 42089.0, 42517.14965700669, 42918.0, 35645.643543564234, 35652.0, 36377.09057273589, 38009.0, 38408.615913840506, 6444.0, 6594.670266486753, 6650.168728908887, 6860.931390686229, 6878.38094571491, 29189.0, 29301.560476592444, 29488.41023179567, 29785.0, 29932.0, 35190.64809351976, 36767.0, 37121.25757484781, 37572.43641345327, 37663.43504847484, 5668.971655141863, 5888.440598143169, 5985.191999080069, 6016.849578760566, 6213.96893015532, 8876.289896808368, 8961.372703910663, 8963.686270980485, 8991.14584114508, 9080.954595226982, 8363.414560980917, 8450.830983380421, 8483.151684831468, 8617.82764344697, 9178.449293042439, 8281.130481299377, 8379.371547134111, 8435.336084493181, 8582.141785821617, 8622.094680058755, 7697.846043079219, 7892.565908875067, 7972.322352600094, 8163.387745919199, 8313.6674533018, 7089.468289878177, 7183.497155199295, 7237.493375463667, 7313.853722925405, 7467.92532074694, 6871.415929646036, 7466.887996679946, 7514.924850751422, 7524.209957954336, 7627.545800707518], "unit": "ms", "name": "yui.html", "value": 4634.4817248843}], "name": "dromaeo_css", "value": 5233.008214269015}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [137.0, 132.0, 146.0, 144.0, 142.0, 157.0, 145.0, 143.0, 143.0, 137.0], "unit": "ms", "name": "ai-astar", "value": 142.6}, {"lowerIsBetter": true, "replicates": [193.0, 173.0, 193.0, 204.0, 166.0, 191.0, 192.0, 167.0, 205.0, 176.0], "unit": "ms", "name": "audio-beat-detection", "value": 186.0}, {"lowerIsBetter": true, "replicates": [213.0, 212.0, 210.0, 209.0, 211.0, 212.0, 208.0, 201.0, 202.0, 208.0], "unit": "ms", "name": "audio-dft", "value": 208.6}, {"lowerIsBetter": true, "replicates": [88.0, 93.0, 104.0, 144.0, 87.0, 84.0, 89.0, 91.0, 149.0, 88.0], "unit": "ms", "name": "audio-fft", "value": 101.7}, {"lowerIsBetter": true, "replicates": [108.0, 113.0, 159.0, 112.0, 115.0, 114.0, 156.0, 113.0, 116.0, 157.0], "unit": "ms", "name": "audio-oscillator", "value": 126.3}, {"lowerIsBetter": true, "replicates": [151.0, 149.0, 151.0, 157.0, 157.0, 156.0, 157.0, 156.0, 157.0, 150.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 154.1}, {"lowerIsBetter": true, "replicates": [165.0, 165.0, 164.0, 164.0, 164.0, 164.0, 164.0, 167.0, 164.0, 165.0], "unit": "ms", "name": "imaging-darkroom", "value": 164.6}, {"lowerIsBetter": true, "replicates": [124.0, 133.0, 123.0, 136.0, 124.0, 131.0, 135.0, 129.0, 123.0, 133.0], "unit": "ms", "name": "imaging-desaturate", "value": 129.1}, {"lowerIsBetter": true, "replicates": [81.0, 83.0, 91.0, 87.0, 88.0, 86.0, 88.0, 94.0, 88.0, 85.0], "unit": "ms", "name": "json-parse-financial", "value": 87.1}, {"lowerIsBetter": true, "replicates": [83.0, 87.0, 95.0, 91.0, 91.0, 92.0, 91.0, 91.0, 90.0, 92.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 90.3}, {"lowerIsBetter": true, "replicates": [107.0, 114.0, 116.0, 115.0, 114.0, 111.0, 116.0, 115.0, 113.0, 115.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 113.6}, {"lowerIsBetter": true, "replicates": [176.0, 176.0, 170.0, 170.0, 176.0, 180.0, 170.0, 162.0, 182.0, 165.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 172.7}, {"lowerIsBetter": true, "replicates": [179.0, 202.0, 201.0, 198.0, 201.0, 187.0, 192.0, 198.0, 200.0, 188.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 194.6}, {"lowerIsBetter": true, "replicates": [86.0, 88.0, 92.0, 93.0, 93.0, 91.0, 92.0, 91.0, 95.0, 94.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 91.5}], "name": "kraken", "value": 1962.7999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [203.2520325203252], "unit": "score", "name": "Richards", "value": 173.68584}, {"lowerIsBetter": false, "replicates": [247.70869457517958], "unit": "score", "name": "DeltaBlue", "value": 266.91836600000005}, {"lowerIsBetter": false, "replicates": [392.31071008238524], "unit": "score", "name": "Encrypt", "value": 678.4953689999999}, {"lowerIsBetter": false, "replicates": [7120.567375886525], "unit": "score", "name": "Decrypt", "value": 37.381993027888434}, {"lowerIsBetter": false, "replicates": [1472.0588235294117], "unit": "score", "name": "RayTrace", "value": 502.68983016983026}, {"lowerIsBetter": false, "replicates": [948.8151658767772], "unit": "score", "name": "Earley", "value": 702.4160489510488}, {"lowerIsBetter": false, "replicates": [16540.983606557376], "unit": "score", "name": "Boyer", "value": 40.29161843409314}, {"lowerIsBetter": false, "replicates": [35964.28571428572], "unit": "score", "name": "RegExp", "value": 25.33026812313805}, {"lowerIsBetter": false, "replicates": [816.3265306122449], "unit": "score", "name": "Splay", "value": 99.82647500000002}, {"lowerIsBetter": false, "replicates": [7171.428571428572], "unit": "score", "name": "NavierStokes", "value": 206.93227091633472}], "name": "v8_7", "value": 15726.18847555397}]} 08:09:02 INFO - RETURN: dromaeo_css: 5233.01 08:09:02 INFO - RETURN: kraken: 1962.80 08:09:02 INFO - RETURN: v8_7: 15726.19 08:09:02 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,57]]", "result": "15726.19"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,57]]", "result": "1962.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,57]]", "result": "5233.01"}}} 08:09:02 INFO - Return code: 0 08:09:02 INFO - # TBPL SUCCESS # 08:09:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:09:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:09:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:09:02 INFO - 2015-11-18 08:09:02.817 screenresolution[1666:10641] starting screenresolution argv=screenresolution get 08:09:02 INFO - 2015-11-18 08:09:02.821 screenresolution[1666:10641] Display 0: 1600x1200x32@60 08:09:02 INFO - 2015-11-18 08:09:02.828 screenresolution[1667:10645] starting screenresolution argv=screenresolution list 08:09:02 INFO - Available Modes on Display 0 08:09:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:09:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:09:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:09:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:09:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:09:03 INFO - Intel HD Graphics 3000: 08:09:03 INFO - Chipset Model: Intel HD Graphics 3000 08:09:03 INFO - Type: GPU 08:09:03 INFO - Bus: Built-In 08:09:03 INFO - VRAM (Total): 512 MB 08:09:03 INFO - VRAM (Dynamic, Max): 10 08:09:03 INFO - Vendor: Intel (0x8086) 08:09:03 INFO - Device ID: 0x0116 08:09:03 INFO - Revision ID: 0x0009 08:09:03 INFO - Displays: 08:09:03 INFO - Display: 08:09:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:09:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:09:03 INFO - Display Serial Number: 1600x1200 60 08:09:03 INFO - Main Display: Yes 08:09:03 INFO - Mirror: Off 08:09:03 INFO - Online: Yes 08:09:03 INFO - Rotation: Supported 08:09:03 INFO - Return code: 0 08:09:03 INFO - Running post-action listener: _resource_record_post_action 08:09:03 INFO - Running post-run listener: _resource_record_post_run 08:09:04 INFO - Total resource usage - Wall time: 1264s; CPU: 30.0%; Read bytes: 40756224; Write bytes: 692398080; Read time: 4705; Write time: 52377 08:09:04 INFO - install - Wall time: 44s; CPU: 30.0%; Read bytes: 342841856; Write bytes: 346087424; Read time: 39129; Write time: 6115 08:09:04 INFO - run-tests - Wall time: 1220s; CPU: 30.0%; Read bytes: 38765568; Write bytes: 344717312; Read time: 4304; Write time: 46238 08:09:04 INFO - Running post-run listener: _upload_blobber_files 08:09:04 INFO - Blob upload gear active. 08:09:04 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 08:09:04 INFO - Copying logs to upload dir... 08:09:04 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1323.354769 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 3 secs) (at 2015-11-18 08:09:04.277018) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 08:09:04.280456) ========= 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.H9CHcKlSdB/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.2o9j6LC1JW/Listeners TMPDIR=/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/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/iAAtYJgHTESXiDnxeO6vbg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010673 build_url: 'https://queue.taskcluster.net/v1/task/iAAtYJgHTESXiDnxeO6vbg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 08:09:04.308707) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 08:09:04.309085) ========= 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.H9CHcKlSdB/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.2o9j6LC1JW/Listeners TMPDIR=/var/folders/ql/zf453_qj7f3dprs4zvm9s2y800000w/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.005774 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 08:09:04.358958) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 08:09:04.359288) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 08:09:04.359785) ========= ========= Total master_lag: 2.60 =========