builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0051 starttime: 1448311639.25 results: success (0) buildid: 20151120125133 builduid: 13d140bdac044294b4e815cf961efc82 revision: 924d421d766ad07c2e76a1a299ec3e05b7ad0b4f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 12:47:19.254576) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 12:47:19.255064) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 12:47:19.255346) ========= 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.MUwXuQL6uA/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.rcVdDIaxbA/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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:0:0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005570 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 12:47:19.275840) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 12:47:19.276146) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 12:47:19.290745) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:47:19.291123) ========= 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.MUwXuQL6uA/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.rcVdDIaxbA/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005357 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:47:19.340091) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 12:47:19.340438) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 12:47:19.340815) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:47:19.341085) ========= 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.MUwXuQL6uA/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.rcVdDIaxbA/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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:0:0 using PTY: False --2015-11-23 12:47:19-- 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.07M=0.001s 2015-11-23 12:47:19 (8.07 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.193547 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:47:19.547800) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:47:19.548143) ========= 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.MUwXuQL6uA/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.rcVdDIaxbA/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.019964 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:47:19.597029) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 12:47:19.597394) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 924d421d766ad07c2e76a1a299ec3e05b7ad0b4f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 924d421d766ad07c2e76a1a299ec3e05b7ad0b4f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.MUwXuQL6uA/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.rcVdDIaxbA/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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:0:0 using PTY: False 2015-11-23 12:47:19,683 truncating revision to first 12 chars 2015-11-23 12:47:19,683 Setting DEBUG logging. 2015-11-23 12:47:19,683 attempt 1/10 2015-11-23 12:47:19,683 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/924d421d766a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 12:47:21,362 unpacking tar archive at: fx-team-924d421d766a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.922863 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 12:47:21.534986) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 12:47:21.535384) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 12:47:21.547458) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 12:47:21.547847) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 12:47:21.548295) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2015-11-23 12:47:21.548577) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.MUwXuQL6uA/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.rcVdDIaxbA/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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:0:0 using PTY: False 12:47:21 INFO - MultiFileLogger online at 20151123 12:47:21 in /builds/slave/test 12:47:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 12:47:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:47:21 INFO - {'append_to_log': False, 12:47:21 INFO - 'base_work_dir': '/builds/slave/test', 12:47:21 INFO - 'blob_upload_branch': 'Fx-Team', 12:47:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:47:21 INFO - 'branch': 'Fx-Team', 12:47:21 INFO - 'buildbot_json_path': 'buildprops.json', 12:47:21 INFO - 'config_files': ('talos/mac_config.py',), 12:47:21 INFO - 'default_actions': ('clobber', 12:47:21 INFO - 'read-buildbot-config', 12:47:21 INFO - 'download-and-extract', 12:47:21 INFO - 'populate-webroot', 12:47:21 INFO - 'create-virtualenv', 12:47:21 INFO - 'install', 12:47:21 INFO - 'run-tests'), 12:47:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:47:21 INFO - 'download_minidump_stackwalk': True, 12:47:21 INFO - 'download_symbols': 'ondemand', 12:47:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:47:21 INFO - 'tooltool.py': '/tools/tooltool.py', 12:47:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:47:21 INFO - '/tools/misc-python/virtualenv.py')}, 12:47:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:47:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:47:21 INFO - 'installer_path': 'installer.exe', 12:47:21 INFO - 'log_level': 'info', 12:47:21 INFO - 'log_name': 'talos', 12:47:21 INFO - 'log_to_console': True, 12:47:21 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:47:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:47:21 INFO - 'opt_config_files': (), 12:47:21 INFO - 'pip_index': False, 12:47:21 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:47:21 INFO - 'cmd': ('bash', 12:47:21 INFO - '-c', 12:47:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:47:21 INFO - 'enabled': True, 12:47:21 INFO - 'halt_on_failure': False, 12:47:21 INFO - 'name': 'check_screen_resolution'},), 12:47:21 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:47:21 INFO - 'cmd': ('bash', 12:47:21 INFO - '-c', 12:47:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:47:21 INFO - 'enabled': True, 12:47:21 INFO - 'halt_on_failure': False, 12:47:21 INFO - 'name': 'check_screen_resolution'},), 12:47:21 INFO - 'run_cmd_checks_enabled': True, 12:47:21 INFO - 'sps_profile': False, 12:47:21 INFO - 'sps_profile_interval': 0, 12:47:21 INFO - 'suite': 'dromaeojs', 12:47:21 INFO - 'system_bits': '64', 12:47:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:47:21 INFO - 'title': 't-yosemite-r7-0051', 12:47:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:47:21 INFO - 'use_talos_json': True, 12:47:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:47:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:47:21 INFO - 'work_dir': 'build'} 12:47:21 INFO - ##### 12:47:21 INFO - ##### Running clobber step. 12:47:21 INFO - ##### 12:47:21 INFO - Running pre-action listener: _resource_record_pre_action 12:47:21 INFO - Running main action method: clobber 12:47:21 INFO - rmtree: /builds/slave/test/build 12:47:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:47:23 INFO - Running post-action listener: _resource_record_post_action 12:47:23 INFO - ##### 12:47:23 INFO - ##### Running read-buildbot-config step. 12:47:23 INFO - ##### 12:47:23 INFO - Running pre-action listener: _resource_record_pre_action 12:47:23 INFO - Running main action method: read_buildbot_config 12:47:23 INFO - Using buildbot properties: 12:47:23 INFO - { 12:47:23 INFO - "properties": { 12:47:23 INFO - "buildnumber": 21, 12:47:23 INFO - "product": "firefox", 12:47:23 INFO - "script_repo_revision": "production", 12:47:23 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 12:47:23 INFO - "repository": "", 12:47:23 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 12:47:23 INFO - "buildid": "20151120125133", 12:47:23 INFO - "slavename": "t-yosemite-r7-0051", 12:47:23 INFO - "pgo_build": "False", 12:47:23 INFO - "basedir": "/builds/slave/test", 12:47:23 INFO - "project": "", 12:47:23 INFO - "platform": "yosemite_r7", 12:47:23 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 12:47:23 INFO - "slavebuilddir": "test", 12:47:23 INFO - "scheduler": "tests-fx-team-macosx64-talos", 12:47:23 INFO - "branch": "fx-team", 12:47:23 INFO - "repo_path": "integration/fx-team", 12:47:23 INFO - "stage_platform": "macosx64", 12:47:23 INFO - "builduid": "13d140bdac044294b4e815cf961efc82", 12:47:23 INFO - "revision": "924d421d766ad07c2e76a1a299ec3e05b7ad0b4f" 12:47:23 INFO - }, 12:47:23 INFO - "sourcestamp": { 12:47:23 INFO - "repository": "", 12:47:23 INFO - "hasPatch": false, 12:47:23 INFO - "project": "", 12:47:23 INFO - "branch": "fx-team-macosx64-talos", 12:47:23 INFO - "changes": [ 12:47:23 INFO - { 12:47:23 INFO - "category": null, 12:47:23 INFO - "files": [ 12:47:23 INFO - { 12:47:23 INFO - "url": null, 12:47:23 INFO - "name": "https://queue.taskcluster.net/v1/task/MdSlRE8ESpqsXU1pNGJNhw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 12:47:23 INFO - } 12:47:23 INFO - ], 12:47:23 INFO - "repository": "", 12:47:23 INFO - "rev": "924d421d766ad07c2e76a1a299ec3e05b7ad0b4f", 12:47:23 INFO - "who": "mconley@mozilla.com", 12:47:23 INFO - "when": 1448057752, 12:47:23 INFO - "number": 6690719, 12:47:23 INFO - "comments": "Bug 1209689 - Test forcing revived background tabs to restore on demand. r=felipe", 12:47:23 INFO - "project": "", 12:47:23 INFO - "at": "Fri 20 Nov 2015 14:15:52", 12:47:23 INFO - "branch": "fx-team-macosx64-talos", 12:47:23 INFO - "revlink": "", 12:47:23 INFO - "properties": [ 12:47:23 INFO - [ 12:47:23 INFO - "buildid", 12:47:23 INFO - "20151120125133", 12:47:23 INFO - "Change" 12:47:23 INFO - ], 12:47:23 INFO - [ 12:47:23 INFO - "builduid", 12:47:23 INFO - "13d140bdac044294b4e815cf961efc82", 12:47:23 INFO - "Change" 12:47:23 INFO - ], 12:47:23 INFO - [ 12:47:23 INFO - "pgo_build", 12:47:23 INFO - "False", 12:47:23 INFO - "Change" 12:47:23 INFO - ] 12:47:23 INFO - ], 12:47:23 INFO - "revision": "924d421d766ad07c2e76a1a299ec3e05b7ad0b4f" 12:47:23 INFO - } 12:47:23 INFO - ], 12:47:23 INFO - "revision": "924d421d766ad07c2e76a1a299ec3e05b7ad0b4f" 12:47:23 INFO - } 12:47:23 INFO - } 12:47:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/MdSlRE8ESpqsXU1pNGJNhw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 12:47:23 INFO - Running post-action listener: _resource_record_post_action 12:47:23 INFO - ##### 12:47:23 INFO - ##### Running download-and-extract step. 12:47:23 INFO - ##### 12:47:23 INFO - Running pre-action listener: _resource_record_pre_action 12:47:23 INFO - Running main action method: download_and_extract 12:47:23 INFO - mkdir: /builds/slave/test/build/tests 12:47:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:23 INFO - https://queue.taskcluster.net/v1/task/MdSlRE8ESpqsXU1pNGJNhw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:47:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdSlRE8ESpqsXU1pNGJNhw/artifacts/public/build/test_packages.json 12:47:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdSlRE8ESpqsXU1pNGJNhw/artifacts/public/build/test_packages.json 12:47:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdSlRE8ESpqsXU1pNGJNhw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 12:47:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdSlRE8ESpqsXU1pNGJNhw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 12:47:25 INFO - Downloaded 1149 bytes. 12:47:25 INFO - Reading from file /builds/slave/test/build/test_packages.json 12:47:25 INFO - Using the following test package requirements: 12:47:25 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 12:47:25 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:47:25 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 12:47:25 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:47:25 INFO - u'jsshell-mac.zip'], 12:47:25 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:47:25 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 12:47:25 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 12:47:25 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:47:25 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 12:47:25 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:47:25 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 12:47:25 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:47:25 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 12:47:25 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 12:47:25 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:47:25 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 12:47:25 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:47:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:25 INFO - https://queue.taskcluster.net/v1/task/MdSlRE8ESpqsXU1pNGJNhw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:47:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdSlRE8ESpqsXU1pNGJNhw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:47:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdSlRE8ESpqsXU1pNGJNhw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:47:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdSlRE8ESpqsXU1pNGJNhw/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 12:47:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdSlRE8ESpqsXU1pNGJNhw/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 12:47:26 INFO - Downloaded 17526773 bytes. 12:47:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 12:47:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:47:26 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 12:47:29 INFO - Return code: 0 12:47:29 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 12: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')]} 12:47:29 INFO - https://queue.taskcluster.net/v1/task/MdSlRE8ESpqsXU1pNGJNhw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:47:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdSlRE8ESpqsXU1pNGJNhw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:47:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdSlRE8ESpqsXU1pNGJNhw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:47:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdSlRE8ESpqsXU1pNGJNhw/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 12:47:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdSlRE8ESpqsXU1pNGJNhw/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 12:47:30 INFO - Downloaded 17526773 bytes. 12:47:30 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 12:47:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:47:30 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 12:47:33 INFO - Return code: 0 12:47:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:33 INFO - https://queue.taskcluster.net/v1/task/MdSlRE8ESpqsXU1pNGJNhw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 12:47:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdSlRE8ESpqsXU1pNGJNhw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 12:47:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdSlRE8ESpqsXU1pNGJNhw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 12:47:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdSlRE8ESpqsXU1pNGJNhw/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 12:47:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdSlRE8ESpqsXU1pNGJNhw/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 12:47:34 INFO - Downloaded 11130997 bytes. 12:47:34 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 12:47:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 12:47:34 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 12:47:34 INFO - Return code: 0 12:47:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:34 INFO - https://queue.taskcluster.net/v1/task/MdSlRE8ESpqsXU1pNGJNhw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 12:47:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdSlRE8ESpqsXU1pNGJNhw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 12:47:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdSlRE8ESpqsXU1pNGJNhw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 12:47:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdSlRE8ESpqsXU1pNGJNhw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 12:47:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MdSlRE8ESpqsXU1pNGJNhw/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 12:47:37 INFO - Downloaded 109416335 bytes. 12:47:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MdSlRE8ESpqsXU1pNGJNhw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 12:47:37 INFO - mkdir: /builds/slave/test/properties 12:47:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:47:37 INFO - Writing to file /builds/slave/test/properties/build_url 12:47:37 INFO - Contents: 12:47:37 INFO - build_url:https://queue.taskcluster.net/v1/task/MdSlRE8ESpqsXU1pNGJNhw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 12:47:37 INFO - Running post-action listener: _resource_record_post_action 12:47:37 INFO - Running post-action listener: set_extra_try_arguments 12:47:37 INFO - ##### 12:47:37 INFO - ##### Running populate-webroot step. 12:47:37 INFO - ##### 12:47:37 INFO - Running pre-action listener: _resource_record_pre_action 12:47:37 INFO - Running main action method: populate_webroot 12:47:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:47:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:47:37 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 12:47:37 INFO - '../fennec_ids.txt'], 12:47:37 INFO - 'tests': ['tcheck2']}, 12:47:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:47:37 INFO - '--tppagecycles', 12:47:37 INFO - '7'], 12:47:37 INFO - 'tests': ['tsvgm']}}, 12:47:37 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:47:37 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:47:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:47:37 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:47:37 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:47:37 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:47:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:47:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:47:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:47:37 INFO - 'talos_options': ['--e10s'], 12:47:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:47:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:47:37 INFO - 'tests': ['damp', 'tps']}, 12:47:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:47:37 INFO - 'talos_options': ['--e10s'], 12:47:37 INFO - 'tests': ['damp', 'tps']}, 12:47:37 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:47:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:47:37 INFO - 'other': {'tests': ['a11yr', 12:47:37 INFO - 'ts_paint', 12:47:37 INFO - 'tpaint', 12:47:37 INFO - 'sessionrestore', 12:47:37 INFO - 'sessionrestore_no_auto_restore']}, 12:47:37 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:47:37 INFO - 'tests': ['a11yr', 12:47:37 INFO - 'ts_paint', 12:47:37 INFO - 'tpaint', 12:47:37 INFO - 'sessionrestore', 12:47:37 INFO - 'sessionrestore_no_auto_restore']}, 12:47:37 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:47:37 INFO - 'tests': ['a11yr', 12:47:37 INFO - 'ts_paint', 12:47:37 INFO - 'tpaint', 12:47:37 INFO - 'sessionrestore', 12:47:37 INFO - 'sessionrestore_no_auto_restore']}, 12:47:37 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:47:37 INFO - 'tests': ['a11yr', 12:47:37 INFO - 'ts_paint', 12:47:37 INFO - 'tpaint', 12:47:37 INFO - 'sessionrestore', 12:47:37 INFO - 'sessionrestore_no_auto_restore']}, 12:47:37 INFO - 'other_l64': {'tests': ['a11yr', 12:47:37 INFO - 'ts_paint', 12:47:37 INFO - 'tpaint', 12:47:37 INFO - 'sessionrestore', 12:47:37 INFO - 'sessionrestore_no_auto_restore']}, 12:47:37 INFO - 'other_nol64': {'tests': ['a11yr', 12:47:37 INFO - 'ts_paint', 12:47:37 INFO - 'tpaint', 12:47:37 INFO - 'sessionrestore', 12:47:37 INFO - 'sessionrestore_no_auto_restore']}, 12:47:37 INFO - 'svgr': {'tests': ['tsvgx', 12:47:37 INFO - 'tsvgr_opacity', 12:47:37 INFO - 'tart', 12:47:37 INFO - 'tscrollx', 12:47:37 INFO - 'cart']}, 12:47:37 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:47:37 INFO - 'tests': ['tsvgx', 12:47:37 INFO - 'tsvgr_opacity', 12:47:37 INFO - 'tart', 12:47:37 INFO - 'tscrollx', 12:47:37 INFO - 'cart']}, 12:47:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:47:37 INFO - 'tests': ['tp5o']}, 12:47:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:47:37 INFO - 'talos_options': ['--e10s'], 12:47:37 INFO - 'tests': ['tp5o']}, 12:47:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:47:37 INFO - 'talos_options': ['--xperf_path', 12:47:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:47:37 INFO - 'tests': ['tp5n']}, 12:47:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:47:37 INFO - 'talos_options': ['--e10s', 12:47:37 INFO - '--xperf_path', 12:47:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:47:37 INFO - 'tests': ['tp5n']}}, 12:47:37 INFO - 'talos.zip': {'path': '', 12:47:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:47:37 INFO - Running post-action listener: _resource_record_post_action 12:47:37 INFO - ##### 12:47:37 INFO - ##### Running create-virtualenv step. 12:47:37 INFO - ##### 12:47:37 INFO - Running pre-action listener: _resource_record_pre_action 12:47:37 INFO - Running main action method: create_virtualenv 12:47:37 INFO - Creating virtualenv /builds/slave/test/build/venv 12:47:37 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 12:47:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:47:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:47:37 INFO - Using real prefix '/tools/python27' 12:47:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:47:38 INFO - Installing distribute.............................................................................................................................................................................................done. 12:47:41 INFO - Installing pip.................done. 12:47:41 INFO - Return code: 0 12:47:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:47:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:41 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 0x10f2e5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2c2228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb843485770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2099f0>, '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 0x10ef68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f1fc8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MUwXuQL6uA/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.rcVdDIaxbA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:47:41 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 12:47:41 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 12:47:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MUwXuQL6uA/Render', 12:47:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:47:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:47:41 INFO - 'HOME': '/Users/cltbld', 12:47:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:47:41 INFO - 'LOGNAME': 'cltbld', 12:47:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:41 INFO - 'MOZ_NO_REMOTE': '1', 12:47:41 INFO - 'NO_EM_RESTART': '1', 12:47:41 INFO - 'PAGER': '/bin/cat', 12:47:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:47:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:47:41 INFO - 'PWD': '/builds/slave/test', 12:47:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:47:41 INFO - 'SHELL': '/bin/bash', 12:47:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rcVdDIaxbA/Listeners', 12:47:41 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 12:47:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:47:41 INFO - 'USER': 'cltbld', 12:47:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:47:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:47:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:41 INFO - 'XPC_FLAGS': '0x0', 12:47:41 INFO - 'XPC_SERVICE_NAME': '0', 12:47:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:47:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:41 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 12:47:41 INFO - Cleaning up... 12:47:41 INFO - Return code: 0 12:47:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:47:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:41 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 0x10f2e5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2c2228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb843485770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2099f0>, '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 0x10ef68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f1fc8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MUwXuQL6uA/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.rcVdDIaxbA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:47:41 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 12:47:41 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 12:47:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MUwXuQL6uA/Render', 12:47:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:47:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:47:41 INFO - 'HOME': '/Users/cltbld', 12:47:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:47:41 INFO - 'LOGNAME': 'cltbld', 12:47:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:41 INFO - 'MOZ_NO_REMOTE': '1', 12:47:41 INFO - 'NO_EM_RESTART': '1', 12:47:41 INFO - 'PAGER': '/bin/cat', 12:47:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:47:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:47:41 INFO - 'PWD': '/builds/slave/test', 12:47:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:47:41 INFO - 'SHELL': '/bin/bash', 12:47:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rcVdDIaxbA/Listeners', 12:47:41 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 12:47:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:47:41 INFO - 'USER': 'cltbld', 12:47:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:47:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:47:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:41 INFO - 'XPC_FLAGS': '0x0', 12:47:41 INFO - 'XPC_SERVICE_NAME': '0', 12:47:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:47:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:41 INFO - Downloading/unpacking psutil>=0.7.1 12:47:41 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 12:47:41 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 12:47:41 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 12:47:41 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 12:47:41 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 12:47:41 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 12:47:44 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 12:47:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 12:47:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:47:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:47:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:47:44 INFO - Installing collected packages: psutil 12:47:44 INFO - Running setup.py install for psutil 12:47:44 INFO - building 'psutil._psutil_osx' extension 12:47:44 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 12:47:44 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 12:47:44 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 12:47:45 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 12:47:45 INFO - building 'psutil._psutil_posix' extension 12:47:45 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 12:47:45 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:47:45 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:47:45 INFO - ^ 12:47:45 INFO - 1 warning generated. 12:47:45 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 12:47:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:47:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:47:45 INFO - Successfully installed psutil 12:47:45 INFO - Cleaning up... 12:47:45 INFO - Return code: 0 12:47:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12: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')]} 12:47:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12: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')]} 12:47:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x10f2e5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2c2228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb843485770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2099f0>, '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 0x10ef68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f1fc8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MUwXuQL6uA/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.rcVdDIaxbA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:47:45 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 12:47:45 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 12:47:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MUwXuQL6uA/Render', 12:47:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:47:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:47:45 INFO - 'HOME': '/Users/cltbld', 12:47:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:47:45 INFO - 'LOGNAME': 'cltbld', 12:47:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:45 INFO - 'MOZ_NO_REMOTE': '1', 12:47:45 INFO - 'NO_EM_RESTART': '1', 12:47:45 INFO - 'PAGER': '/bin/cat', 12:47:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:47:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:47:45 INFO - 'PWD': '/builds/slave/test', 12:47:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:47:45 INFO - 'SHELL': '/bin/bash', 12:47:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rcVdDIaxbA/Listeners', 12:47:45 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 12:47:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:47:45 INFO - 'USER': 'cltbld', 12:47:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:47:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:47:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:45 INFO - 'XPC_FLAGS': '0x0', 12:47:45 INFO - 'XPC_SERVICE_NAME': '0', 12:47:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:47:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:47:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:47:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:47:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:47:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:47:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:47:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:47:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:47:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 12:47:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:47:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:47:47 INFO - Installing collected packages: mozsystemmonitor 12:47:47 INFO - Running setup.py install for mozsystemmonitor 12:47:48 INFO - Successfully installed mozsystemmonitor 12:47:48 INFO - Cleaning up... 12:47:48 INFO - Return code: 0 12:47:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:47:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f2e5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2c2228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb843485770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2099f0>, '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 0x10ef68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f1fc8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MUwXuQL6uA/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.rcVdDIaxbA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:47:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:47:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:47:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MUwXuQL6uA/Render', 12:47:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:47:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:47:48 INFO - 'HOME': '/Users/cltbld', 12:47:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:47:48 INFO - 'LOGNAME': 'cltbld', 12:47:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:48 INFO - 'MOZ_NO_REMOTE': '1', 12:47:48 INFO - 'NO_EM_RESTART': '1', 12:47:48 INFO - 'PAGER': '/bin/cat', 12:47:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:47:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:47:48 INFO - 'PWD': '/builds/slave/test', 12:47:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:47:48 INFO - 'SHELL': '/bin/bash', 12:47:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rcVdDIaxbA/Listeners', 12:47:48 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 12:47:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:47:48 INFO - 'USER': 'cltbld', 12:47:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:47:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:47:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:48 INFO - 'XPC_FLAGS': '0x0', 12:47:48 INFO - 'XPC_SERVICE_NAME': '0', 12:47:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:47:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:48 INFO - Downloading/unpacking blobuploader==1.2.4 12:47:48 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 12:47:48 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 12:47:48 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 12:47:48 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 12:47:48 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 12:47:48 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 12:47:50 INFO - Downloading blobuploader-1.2.4.tar.gz 12:47:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 12:47:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:47:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:47:50 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 12:47:50 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 12:47:50 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 12:47:50 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 12:47:50 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 12:47:50 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 12:47:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 12:47:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:47:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:47:51 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 12:47:51 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 12:47:51 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 12:47:51 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 12:47:51 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 12:47:51 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 12:47:51 INFO - Downloading docopt-0.6.1.tar.gz 12:47:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 12:47:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:47:51 INFO - Installing collected packages: blobuploader, requests, docopt 12:47:51 INFO - Running setup.py install for blobuploader 12:47:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:47:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:47:51 INFO - Running setup.py install for requests 12:47:52 INFO - Running setup.py install for docopt 12:47:52 INFO - Successfully installed blobuploader requests docopt 12:47:52 INFO - Cleaning up... 12:47:52 INFO - Return code: 0 12:47:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12: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')]} 12:47:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12: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')]} 12:47:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:52 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 0x10f2e5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2c2228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb843485770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2099f0>, '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 0x10ef68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f1fc8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MUwXuQL6uA/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.rcVdDIaxbA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:47:52 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 12:47:52 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 12:47:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MUwXuQL6uA/Render', 12:47:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:47:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:47:52 INFO - 'HOME': '/Users/cltbld', 12:47:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:47:52 INFO - 'LOGNAME': 'cltbld', 12:47:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:52 INFO - 'MOZ_NO_REMOTE': '1', 12:47:52 INFO - 'NO_EM_RESTART': '1', 12:47:52 INFO - 'PAGER': '/bin/cat', 12:47:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:47:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:47:52 INFO - 'PWD': '/builds/slave/test', 12:47:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:47:52 INFO - 'SHELL': '/bin/bash', 12:47:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rcVdDIaxbA/Listeners', 12:47:52 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 12:47:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:47:52 INFO - 'USER': 'cltbld', 12:47:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:47:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:47:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:52 INFO - 'XPC_FLAGS': '0x0', 12:47:52 INFO - 'XPC_SERVICE_NAME': '0', 12:47:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:47:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:47:52 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-Stg1KD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:47:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:47:52 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-XVnRB0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:47:53 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-CJ_NYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:47:53 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-Uqi8bl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:47:53 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-Xdsvga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:47:53 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-1EY7yF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:47:53 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-soXbZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:47:53 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-ZHd6IU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:47:53 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-f_mPPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:47:53 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-zq1iQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:47:53 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-RPhaWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:47:54 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-WS4E7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:47:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:47:54 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-P1uaJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:47:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:47:54 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-5T1gAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:47:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:47:54 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-39MxVH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:47:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:47:54 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-eo99_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:47:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:47:54 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-02qetS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:47:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:47:54 INFO - Running setup.py install for manifestparser 12:47:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:47:54 INFO - Running setup.py install for mozcrash 12:47:54 INFO - Running setup.py install for mozdebug 12:47:55 INFO - Running setup.py install for mozdevice 12:47:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:47:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:47:55 INFO - Running setup.py install for mozfile 12:47:55 INFO - Running setup.py install for mozhttpd 12:47:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:47:55 INFO - Running setup.py install for mozinfo 12:47:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:47:55 INFO - Running setup.py install for mozInstall 12:47:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:47:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:47:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:47:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:47:55 INFO - Running setup.py install for mozleak 12:47:55 INFO - Running setup.py install for mozlog 12:47:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:47:56 INFO - Running setup.py install for moznetwork 12:47:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:47:56 INFO - Running setup.py install for mozprocess 12:47:56 INFO - Running setup.py install for mozprofile 12:47:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:47:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:47:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:47:56 INFO - Running setup.py install for mozrunner 12:47:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:47:56 INFO - Running setup.py install for mozscreenshot 12:47:56 INFO - Running setup.py install for moztest 12:47:57 INFO - Running setup.py install for mozversion 12:47:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:47:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:47:57 INFO - Cleaning up... 12:47:57 INFO - Return code: 0 12:47:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:47:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:57 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 0x10f2e5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2c2228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb843485770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2099f0>, '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 0x10ef68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f1fc8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MUwXuQL6uA/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.rcVdDIaxbA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:47:57 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 12:47:57 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 12:47:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MUwXuQL6uA/Render', 12:47:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:47:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:47:57 INFO - 'HOME': '/Users/cltbld', 12:47:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:47:57 INFO - 'LOGNAME': 'cltbld', 12:47:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:57 INFO - 'MOZ_NO_REMOTE': '1', 12:47:57 INFO - 'NO_EM_RESTART': '1', 12:47:57 INFO - 'PAGER': '/bin/cat', 12:47:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:47:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:47:57 INFO - 'PWD': '/builds/slave/test', 12:47:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:47:57 INFO - 'SHELL': '/bin/bash', 12:47:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rcVdDIaxbA/Listeners', 12:47:57 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 12:47:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:47:57 INFO - 'USER': 'cltbld', 12:47:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:47:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:47:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:57 INFO - 'XPC_FLAGS': '0x0', 12:47:57 INFO - 'XPC_SERVICE_NAME': '0', 12:47:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:47:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:47:57 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-pfb_w2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:47:57 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)) 12:47:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:47:57 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-uNreJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:47:57 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)) 12:47:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:47:57 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-NtBRQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:47:57 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)) 12:47:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:47:57 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-6hD1dc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:47:57 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)) 12:47:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:47:57 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-fUIuPk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:47:58 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)) 12:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:47:58 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-A9CIYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:47:58 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)) 12:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:47:58 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-DqzEIV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:47:58 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)) 12:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:47:58 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-Y4IdKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:47:58 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)) 12:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:47:58 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-gblMqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:47:58 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)) 12:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:47:58 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-UAIrnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:47:58 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)) 12:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:47:58 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-eD9BLk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:47:58 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)) 12:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:47:58 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-NiLaqh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:47:58 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)) 12:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:47:58 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-Aju3Gj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:47:58 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)) 12:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:47:58 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-ll6zFM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:47:59 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)) 12:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:47:59 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-4SJsHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:47:59 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)) 12:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:47:59 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-FHestB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:47:59 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)) 12:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:47:59 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-jUiaD3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:47:59 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)) 12:47:59 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)) 12:47:59 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)) 12:47:59 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)) 12:47:59 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)) 12:47:59 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)) 12:47:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:47:59 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 12:47:59 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 12:47:59 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 12:47:59 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 12:47:59 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 12:47:59 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 12:48:01 INFO - Downloading blessings-1.5.1.tar.gz 12:48:01 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 12:48:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:48:01 INFO - Installing collected packages: blessings 12:48:01 INFO - Running setup.py install for blessings 12:48:01 INFO - Successfully installed blessings 12:48:01 INFO - Cleaning up... 12:48:01 INFO - Return code: 0 12:48:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:48:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:48:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:48:02 INFO - Reading from file tmpfile_stdout 12:48:02 INFO - Current package versions: 12:48:02 INFO - blessings == 1.5.1 12:48:02 INFO - blobuploader == 1.2.4 12:48:02 INFO - docopt == 0.6.1 12:48:02 INFO - manifestparser == 1.1 12:48:02 INFO - mozInstall == 1.12 12:48:02 INFO - mozcrash == 0.16 12:48:02 INFO - mozdebug == 0.1 12:48:02 INFO - mozdevice == 0.47 12:48:02 INFO - mozfile == 1.2 12:48:02 INFO - mozhttpd == 0.7 12:48:02 INFO - mozinfo == 0.9 12:48:02 INFO - mozleak == 0.1 12:48:02 INFO - mozlog == 3.0 12:48:02 INFO - moznetwork == 0.27 12:48:02 INFO - mozprocess == 0.22 12:48:02 INFO - mozprofile == 0.27 12:48:02 INFO - mozrunner == 6.11 12:48:02 INFO - mozscreenshot == 0.1 12:48:02 INFO - mozsystemmonitor == 0.0 12:48:02 INFO - moztest == 0.7 12:48:02 INFO - mozversion == 1.4 12:48:02 INFO - psutil == 3.1.1 12:48:02 INFO - requests == 1.2.3 12:48:02 INFO - wsgiref == 0.1.2 12:48:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:48:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:48:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x10f2e5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2c2228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb843485770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2099f0>, '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 0x10ef68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f1fc8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MUwXuQL6uA/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.rcVdDIaxbA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:48:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 12:48:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/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 12:48:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MUwXuQL6uA/Render', 12:48:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:48:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:48:02 INFO - 'HOME': '/Users/cltbld', 12:48:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:48:02 INFO - 'LOGNAME': 'cltbld', 12:48:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:02 INFO - 'MOZ_NO_REMOTE': '1', 12:48:02 INFO - 'NO_EM_RESTART': '1', 12:48:02 INFO - 'PAGER': '/bin/cat', 12:48:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:48:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:02 INFO - 'PWD': '/builds/slave/test', 12:48:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:48:02 INFO - 'SHELL': '/bin/bash', 12:48:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rcVdDIaxbA/Listeners', 12:48:02 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 12:48:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:48:02 INFO - 'USER': 'cltbld', 12:48:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:48:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:48:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:02 INFO - 'XPC_FLAGS': '0x0', 12:48:02 INFO - 'XPC_SERVICE_NAME': '0', 12:48:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:48:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:02 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)) 12:48:02 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)) 12:48:02 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)) 12:48:02 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)) 12:48:02 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)) 12:48:02 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)) 12:48:02 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)) 12:48:02 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)) 12:48:02 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)) 12:48:02 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)) 12:48:02 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)) 12:48:02 INFO - Cleaning up... 12:48:02 INFO - Return code: 0 12:48:02 INFO - Running post-action listener: _resource_record_post_action 12:48:02 INFO - Running post-action listener: _start_resource_monitoring 12:48:02 INFO - Starting resource monitoring. 12:48:02 INFO - ##### 12:48:02 INFO - ##### Running install step. 12:48:02 INFO - ##### 12:48:02 INFO - Running pre-action listener: _resource_record_pre_action 12:48:02 INFO - Running main action method: install 12:48:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:48:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:48:02 INFO - Reading from file tmpfile_stdout 12:48:02 INFO - Detecting whether we're running mozinstall >=1.0... 12:48:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:48:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:48:02 INFO - Reading from file tmpfile_stdout 12:48:02 INFO - Output received: 12:48:02 INFO - Usage: mozinstall [options] installer 12:48:02 INFO - Options: 12:48:02 INFO - -h, --help show this help message and exit 12:48:02 INFO - -d DEST, --destination=DEST 12:48:02 INFO - Directory to install application into. [default: 12:48:02 INFO - "/builds/slave/test"] 12:48:02 INFO - --app=APP Application being installed. [default: firefox] 12:48:02 INFO - mkdir: /builds/slave/test/build/application 12:48:02 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'] 12:48:02 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 12:48:33 INFO - Reading from file tmpfile_stdout 12:48:33 INFO - Output received: 12:48:33 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:48:33 INFO - Running post-action listener: _resource_record_post_action 12:48:33 INFO - ##### 12:48:33 INFO - ##### Running run-tests step. 12:48:33 INFO - ##### 12:48:33 INFO - Running pre-action listener: _resource_record_pre_action 12:48:33 INFO - Running main action method: run_tests 12:48:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:48:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:48:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:48:33 INFO - 2015-11-23 12:48:33.294 screenresolution[2523:125542] starting screenresolution argv=screenresolution get 12:48:33 INFO - 2015-11-23 12:48:33.297 screenresolution[2523:125542] Display 0: 1600x1200x32@60 12:48:33 INFO - 2015-11-23 12:48:33.303 screenresolution[2524:125544] starting screenresolution argv=screenresolution list 12:48:33 INFO - Available Modes on Display 0 12:48:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:48:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:48:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:48:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:48:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:48:33 INFO - Intel Iris: 12:48:33 INFO - Chipset Model: Intel Iris 12:48:33 INFO - Type: GPU 12:48:33 INFO - Bus: Built-In 12:48:33 INFO - VRAM (Dynamic, Max): 1536 MB 12:48:33 INFO - Vendor: Intel (0x8086) 12:48:33 INFO - Device ID: 0x0a2e 12:48:33 INFO - Revision ID: 0x0009 12:48:33 INFO - Displays: 12:48:33 INFO - Display: 12:48:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:48:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:48:33 INFO - Display Serial Number: 1600x1200 60 12:48:33 INFO - Main Display: Yes 12:48:33 INFO - Mirror: Off 12:48:33 INFO - Online: Yes 12:48:33 INFO - Rotation: Supported 12:48:33 INFO - Return code: 0 12:48:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:48:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:48:33 INFO - Python 2.7.3 12:48:33 INFO - Return code: 0 12:48:33 INFO - grabbing minidump binary from tooltool 12:48:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:48:33 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 0x10f2099f0>, '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 0x10ef68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f1fc8c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:48:33 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 12:48:33 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 12:48:33 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:48:33 INFO - Return code: 0 12:48:33 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:48:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:48:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:48:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:48:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:48:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MdSlRE8ESpqsXU1pNGJNhw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0051', '--webServer', 'localhost'] in /builds/slave/test/build 12:48:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MdSlRE8ESpqsXU1pNGJNhw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0051 --webServer localhost 12:48:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MUwXuQL6uA/Render', 12:48:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:48:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:48:33 INFO - 'HOME': '/Users/cltbld', 12:48:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:48:33 INFO - 'LOGNAME': 'cltbld', 12:48:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:48:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:48:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:33 INFO - 'MOZ_NO_REMOTE': '1', 12:48:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:48:33 INFO - 'NO_EM_RESTART': '1', 12:48:33 INFO - 'PAGER': '/bin/cat', 12:48:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:48:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:33 INFO - 'PWD': '/builds/slave/test', 12:48:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:48:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:48:33 INFO - 'SHELL': '/bin/bash', 12:48:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rcVdDIaxbA/Listeners', 12:48:33 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 12:48:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:48:33 INFO - 'USER': 'cltbld', 12:48:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:48:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:48:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:33 INFO - 'XPC_FLAGS': '0x0', 12:48:33 INFO - 'XPC_SERVICE_NAME': '0', 12:48:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:48:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MdSlRE8ESpqsXU1pNGJNhw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0051', '--webServer', 'localhost'] with output_timeout 3600 12:48:33 INFO - mozversion INFO | application_buildid: 20151120125133 12:48:33 INFO - mozversion INFO | application_changeset: 924d421d766ad07c2e76a1a299ec3e05b7ad0b4f 12:48:33 INFO - mozversion INFO | application_display_name: Nightly 12:48:33 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:48:33 INFO - mozversion INFO | application_name: Firefox 12:48:33 INFO - mozversion INFO | application_remotingname: firefox 12:48:33 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 12:48:33 INFO - mozversion INFO | application_vendor: Mozilla 12:48:33 INFO - mozversion INFO | application_version: 45.0a1 12:48:33 INFO - mozversion INFO | platform_buildid: 20151120125133 12:48:33 INFO - mozversion INFO | platform_changeset: 924d421d766ad07c2e76a1a299ec3e05b7ad0b4f 12:48:33 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 12:48:33 INFO - mozversion INFO | platform_version: 45.0a1 12:48:33 INFO - 2015-11-23 12:48:33,842 DEBUG : using testdate: 1448311713 12:48:33 INFO - 2015-11-23 12:48:33,842 DEBUG : actual date: 1448311713 12:48:34 INFO - 2015-11-23 12:48:34,233 INFO : starting webserver on 'localhost:57800' 12:48:34 INFO - 2015-11-23 12:48:34,234 INFO : Starting test suite t-yosemite-r7-0051 12:48:34 INFO - 2015-11-23 12:48:34,234 INFO : Starting test dromaeo_css 12:48:34 INFO - 2015-11-23 12:48:34,234 DEBUG : operating with platform_type : mac_ 12:48:34 INFO - 2015-11-23 12:48:34,235 INFO : Initialising browser for dromaeo_css test... 12:48:34 INFO - 2015-11-23 12:48:34,247 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/tmp4Zjoli/profile http://localhost:57800/getInfo.html 12:48:36 INFO - 2015-11-23 12:48:36,288 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:48:36 INFO - 2015-11-23 12:48:36,288 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:48:36 INFO - 2015-11-23 12:48:36,288 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 12:48:36 INFO - 2015-11-23 12:48:36,288 DEBUG : BROWSER_OUTPUT: __metrics 12:48:36 INFO - 2015-11-23 12:48:36,304 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:48:36 INFO - 2015-11-23 12:48:36,553 DEBUG : BROWSER_OUTPUT: console.error: 12:48:36 INFO - 2015-11-23 12:48:36,553 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 12:48:36 INFO - 2015-11-23 12:48:36,553 DEBUG : BROWSER_OUTPUT: Stack: 12:48:36 INFO - 2015-11-23 12:48:36,554 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 12:48:36 INFO - 2015-11-23 12:48:36,555 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 12:48:36 INFO - 2015-11-23 12:48:36,555 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 12:48:36 INFO - 2015-11-23 12:48:36,555 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 12:48:36 INFO - 2015-11-23 12:48:36,555 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 12:48:36 INFO - 2015-11-23 12:48:36,555 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 12:48:36 INFO - 2015-11-23 12:48:36,555 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 12:48:36 INFO - 2015-11-23 12:48:36,555 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 12:48:36 INFO - 2015-11-23 12:48:36,555 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 12:48:36 INFO - 2015-11-23 12:48:36,555 DEBUG : BROWSER_OUTPUT: 12:48:36 INFO - 2015-11-23 12:48:36,950 INFO : Browser initialized. 12:48:36 INFO - 2015-11-23 12:48:36,950 INFO : Running cycle 1/1 for dromaeo_css test... 12:48:36 INFO - 2015-11-23 12:48:36,951 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/tmp4Zjoli/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:48:48 INFO - 2015-11-23 12:48:48,807 DEBUG : BROWSER_OUTPUT: RSS: Main: 226140160 12:48:48 INFO - 2015-11-23 12:48:48,807 DEBUG : BROWSER_OUTPUT: 12:49:39 INFO - 2015-11-23 12:49:39,931 DEBUG : BROWSER_OUTPUT: 1448311779922 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] 12:51:51 INFO - 2015-11-23 12:51:51,196 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57800/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57800/tests/dromaeo/cssquery-ext.html) 12:51:52 INFO - 2015-11-23 12:51:52,471 DEBUG : BROWSER_OUTPUT: RSS: Main: 349212672 12:51:52 INFO - 2015-11-23 12:51:52,471 DEBUG : BROWSER_OUTPUT: 12:54:55 INFO - 2015-11-23 12:54:55,089 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57800/tests/dromaeo/cssquery-ext.html (next: http://localhost:57800/tests/dromaeo/cssquery-jquery.html) 12:54:55 INFO - 2015-11-23 12:54:55,673 DEBUG : BROWSER_OUTPUT: RSS: Main: 351760384 12:54:55 INFO - 2015-11-23 12:54:55,673 DEBUG : BROWSER_OUTPUT: 12:57:57 INFO - 2015-11-23 12:57:57,672 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57800/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57800/tests/dromaeo/cssquery-mootools.html) 12:57:58 INFO - 2015-11-23 12:57:58,259 DEBUG : BROWSER_OUTPUT: RSS: Main: 346075136 12:57:58 INFO - 2015-11-23 12:57:58,259 DEBUG : BROWSER_OUTPUT: 13:01:00 INFO - 2015-11-23 13:01:00,414 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57800/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57800/tests/dromaeo/cssquery-prototype.html) 13:01:00 INFO - 2015-11-23 13:01:00,996 DEBUG : BROWSER_OUTPUT: RSS: Main: 315932672 13:01:00 INFO - 2015-11-23 13:01:00,997 DEBUG : BROWSER_OUTPUT: 13:04:03 INFO - 2015-11-23 13:04:03,936 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57800/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57800/tests/dromaeo/cssquery-yui.html) 13:04:04 INFO - 2015-11-23 13:04:04,540 DEBUG : BROWSER_OUTPUT: RSS: Main: 319442944 13:04:04 INFO - 2015-11-23 13:04:04,540 DEBUG : BROWSER_OUTPUT: 13:07:07 INFO - 2015-11-23 13:07:07,140 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57800/tests/dromaeo/cssquery-yui.html (next: http://localhost:57800/tests/dromaeo/cssquery-dojo.html) 13:07:07 INFO - 2015-11-23 13:07:07,401 DEBUG : BROWSER_OUTPUT: RSS: Main: 362541056 13:07:07 INFO - 2015-11-23 13:07:07,402 DEBUG : BROWSER_OUTPUT: 13:07:07 INFO - 2015-11-23 13:07:07,402 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:07:07 INFO - 2015-11-23 13:07:07,402 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:07:07 INFO - 2015-11-23 13:07:07,402 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:07:07 INFO - 2015-11-23 13:07:07,402 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:07:07 INFO - 2015-11-23 13:07:07,402 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3393.236521782599;3469.548958635377;3487.2676737885045;3496.1084923344542;3535.1869070113867;5697.943020569793;5821.3305469870975;5829.242198514193;5887.970560147199;5906.37983011784;5839.240898683176;5925.762969481227;5950.107483877409;5972.701364931758;6088.765603328701;5247.86880327991;5277.868053298669;5302.284191634138;5312.76092575835;5402.216678581603;5407.648502847322;5411.18832175173;5450.236966824647;5464.808731694372;5484.506394424501;5190.299309593213;5277.86805329866;5294.947050529484;5308.681479111227;5406.621536492447;5219.686818790885;5327.3074500314715;5350.3312085989255;5350.946490535084;5369.677819330853;5260.184671375943;5311.760970756325;5322.600804939645;5384.326959130109;5389.78440862365;4853.490383509751;5629.831105066854;5818.767249310023;5909.9704501477645;5924.674142922137;5223.216517522402;6306.243250809886;6320.115183874262;6325.462335701471;6338.30278669346;6312.558120931537;6329.493640508748;6344.333844946306;6346.42882140605;6348.714307856158;5788.97105514474;5841.853953651108;5927;6053.515718742534;6054.909176362358;6270.811875643738;6376.33048529907;6436.8390790230615;6464.256610489854;6477.676116194171;6288.99376099831;6302.306746257908;6312.179416675895;6341.8731625368155;6350.364963503613;6115.296740874767;6139.640854992916;6253.53098517613;6330.208723909512;6363.936360636427;6147.262328520606;6250.718717657625;6284.717187726564;6284.748610055638;6300.086487459293;6281.528885333618;6286.49708023357;6292.339304373067;6302.401271879165;6304.464120549713;4856.927146092811;5064.620153488429;5074.744492051654;5080.263361812516;5120;4421.756803375781;4495.707778994421;4497.100579883971;4547.022390186125;4547.136044151601;6004.5496587755215;6008.399160084044;6039.245094363205;6043.456088952015;6048.909266361008;6148.661823599745;6352.142460767737;6363.172787537683;6365.267994180728;6368.14030105939;5882.058870580772;5934.080217566284;5945.4649081582;5965.045592705146;5975.790847320323;5526.364468086222;5528.5024347808085;5536.584756143306;5543.1408131739645;5559.499645031967;6301.590396624205;6346.873062538723;6363.809085727436;6369.235691716931;6383.680815959184;6196.504279657526;6298.779542715983;6304.432601065926;6312.084747711648;6316.62100273985;6422.004589288667;6441.5490915635455;6465.77369792055;6467.838304042437;6477.352264773485;6091.471641003366;6226.937730622636;6312.684365781784;6316.147320111726;6324.272708638566;5047.848564543069;5259.237410575522;6294.15028971083;6299.590526615755;6314.179156709598;6291.465225455888;6295.937040629535;6307.684615769102;6315.778947736807;6332.683365831598;6039.607425517327;6184.474319682878;6188.535859810622;6282.3089460158435;6308.589941653778;5922.526197904243;6037.366076562073;6060.090986352083;6064.666443345658;6132.938670613236;6138.386161383826;6165.414285642857;6172.135900973777;6172.290186628596;6186.721597528212;6141.938580614136;6143.508519318533;6157.384261573986;6161.784337548164;6176.042713379434 13:07:07 INFO - 2015-11-23 13:07:07,402 DEBUG : BROWSER_OUTPUT: |1;ext.html;541.3854893438561;560.6608002158694;592.422388171533;640.9070684750711;645.1194120026163;31436.214094647647;32015.67984320156;32138.839305803496;32150;41422.58577414225;44248;44556;44887.551124488746;44917.550824491744;45078.0984380313;8665.436746611482;9772.169365603932;9912.90087099127;9934.701958941243;9969.10278074973;8925;9069.31980101495;9684.12842844144;11932.880671193307;12066.336351500664;11827.526898924032;11893.64319070425;11897.52409903607;11912.987396071345;11940.462679179414;8778.868316975251;11811.99598034168;11852.407379630984;11874.881251187551;11911.880881191164;8759.2992560595;11696;11858.466369013415;11862.466189021514;11873.287602743863;34553.65446345555;41412.1717565647;41752.164956701;41768.582314177074;41815.95460113491;3372.15696075981;3395.8641654333796;3492.14442461596;3644.4715516249994;3649.197176621139;28773.85613071942;28866.85566572175;29529.557056644167;29735.391014392586;30181.849090754626;2780.569011803174;2850.9593998190717;2859.5567687008547;2878.409925965193;2984.880604775806;489318;555152;559009.2049539726;562405;562442;67300;67631.66184169146;67704.98442523366;68017;68076;64073.67963160248;71295.28704712886;71404.64297678479;71500;71606.64196678983;14629.487967921072;14802.815774737996;16463.423780167635;17001;17047.31810727557;12254.81617775734;12383.380830958416;12388.938055309665;12428.130030897932;12433.689157770947;21921.342359729235;21990.89004554999;22122;22183.889080554494;22227.888860555595;8826.470411775314;9043.638254469879;9343.719688409223;9625.759356016015;9723.513824308757;1005.7837564923576;1008.838585826279;1089.3844977587637;1129.249049382168;1198.7302856857311;26094.97418313029;29499.41001180007;29773.404531909673;30375.240618984702;30593;1053.346924906563;1095.3865835132192;1118.7426891814928;1158.5365853658604;1228.0666693312967;15027.774583381259;15355.410461741216;15462.149581772885;15750.133742644264;16082;539385;545644;545703;545941;546259;60846;61283.387166127766;61348.69325653343;61365.69317153386;61420.692896535234;1461.861123193295;1464.9818376228632;1479.1938393575526;1494.805675262209;1496.880249580031;29786.702132978393;29859.70140298569;29970.654975000045;29989.55015674723;30072.77194972099;52081;52432.737836310574;52601.473985259654;52682.209766852764;52768.73615631897;500365.476244043;501085;503177;503705;504058;29078.7092129076;46466.76766616145;46520.302195467775;46568;48677.75661121672;49315.50684493109;49580.50419495903;50104.99790004252;50402.99194016172;51673;39726.20547588974;40873.59126408698;41028;41650.791746041075;43284;34794.65205348015;40086.1982760349;42456.575434245264;43153.784231078644;43179.78410107929;38696.41955370615;39123.050795121286;39789.0052748672;40475.79762101288;40665.39001914914;31523.52714709327;34319.65680343265;35653;36354.636453635125;36524.0868978267;25575.232743016993;25766.742332576436;26655.933762649278;26949.326266843487;27308.31729206786 13:07:07 INFO - 2015-11-23 13:07:07,405 DEBUG : BROWSER_OUTPUT: |2;jquery.html;358.35138399496896;359.5721091900638;366.39727648019027;367.1738588176603;371.2556324569238;16101.194940252999;17417.564560885985;17904.194311255993;20905.790942090574;21901;21163.365099047052;21219;21403.785962140373;21421.57156856862;21422.464438389048;6549.410553050237;6744;6744.629045402501;6757.121574195372;6765.830854228659;4735;5235.528802407783;6685.2952497113165;7621.809454763647;7630.38956883448;7450.0687414073245;7503.437242206829;7511.887321690179;7561.962190189041;7587.20334364892;7502.737404190854;7531.058617672791;7536.057992750906;7537.397008239328;7553.622318884034;7012.123484564429;7207.351338379519;7214.567125972459;7221.602811845346;7244.166920804069;27050.57341792972;27322;27518.174454766387;28175.43649127006;28517.144485665256;2063.13348393675;2148.505843655952;2222.0667319725594;2248.1007596961344;2320.953580928389;9940.850887236697;10064.798704025952;12866.356682165855;14583.708325833424;15008.774868376873;1657.1714142928536;1695.8219386964438;1709.3419033672;1742.40758142231;1748.5191572317588;94046.47628189728;97846;98185;99711.50144249306;105478.94521054768;9116.58975346111;10707.946460267805;11069;11078.612248571262;11175.273607215506;13076.607701768962;13092;13098.345082745825;13101.148425352321;13123.737525249633;8261.669533218605;8327.167283271625;8368.41421100517;8409.032961209417;8409.032961209417;8550.657973680984;8582.485050896967;8587.742367728979;8640.783980400414;8666.090060543678;4072.0430698785763;4357.564243575681;4397.758123303249;4417.734935903856;4435.977820110878;1749.195370129729;1784.634149999247;1787.0975157545615;1792.050213386907;1794.0939825388095;968.5496244246459;1007.1690855044618;1044.770150566874;1045.7281106912105;1093.4642025407493;19623.313184038776;20057.699134512994;20509;20612.793872061087;20635.277765278443;930.2465003347311;933.9159475647224;976.5654283843621;1025.436010194405;1033.0908800255727;10180.490975451197;10473.372485816764;10549.678552012625;10552.419616921143;10557.102646275152;769830;775846;780768;789218;791859;123321.38339308425;126432;128939;128983.35508322399;131462;1149.2357582207737;1178.5403692559908;1186.5550418593027;1188.144535934126;1222.1750318534953;18139.365122220657;18328;18340.724889126406;18389.080545972916;18626.627467450846;43535.78232108819;48326.03347933092;49300;50432;50940.490595095056;72770.63614682104;72856.27143728494;72905;73126.63436682783;75966.24033759591;9701.70894873155;9750.561224745046;9887.55506002246;9918.652847150315;9927.40435573868;18884.43346699601;19166.945817979587;19231.230750769813;19850.60298794045;20068.297609583595;10585.9470702646;15613.921930390276;16127.274272657993;16130.435434759727;16152.434664786677;10959.338790525924;12408.56570020045;13287.534936277183;15576.37694492253;16022.038677679377;13228.735425291248;16000.839991599934;16026.358945642043;16434;16667;9537.904620953701;9684.983076777118;9781;9789;9803.460809655537;10155.796884062129;12965.35173241353;15270.847291526943;15906;16165.67668646644 13:07:07 INFO - 2015-11-23 13:07:07,407 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1461.9108763970844;1629.8125715542715;1904.8856418994887;1933.0338305741022;2004.098155829877;6601.570897891634;7523.623818809058;7969.322607578363;8095.554744489051;8138.511689298646;8205.548694821782;8273.17268273174;8352.498850069;8358.205970432798;8376.41365104443;2110.4301838503593;2158.57907707997;2372.21716833445;2396.508715713275;2405.050005247926;2374.323317854412;2421.6125419932814;2423.3578101803037;2424.866632335221;2430.4166999920067;2333.8132949364094;2379.0840526397374;2393.4854006388623;2401;2405.891734871926;2075.1180748182037;2138.337115494186;2144.9571008579896;2326.0695721711368;2333.614953532665;2384.248961577115;2385.5705972924866;2385.8449200802065;2387.7015373078366;2393.844400113987;8095.150009249061;8211.302039326665;8228.382871284617;8253.504789712637;8262.504249744974;5072.137736584789;5082.720450375228;5159.458256883011;5181.922271165936;5189.065968125774;3433.1760377509468;3466.480027995821;3517.3492903812876;3561.6972557332656;3563.1804684922613;1012.731626119079;1014.391365180893;1041.9062284394365;1042.5048102151493;1054.4833031814355;10919.508622112024;10949.616763413322;10999.23005389623;11007.449627518672;11025.44872756359;4540.863774086717;4660.04469083837;4711.552402521755;4715.764211789466;4726.291056341507;9590.136887680002;9598.992105828927;9612.66355677548;9631.470269135125;9675.080867317594;5218.739063046833;5231.456720267454;5234.18870075139;5234.581233501311;5236.869078273074;4698;4701.647376446712;4709.976450117728;4733.95266047342;4759.214729569651;3831.7317787755146;3854.4989151410136;3856.9228615427533;3879.8060096995036;3886.7862267575556;1108.6396921000708;1282.3780466473752;1283.6854970532092;1291.2381694800113;1293.1012946002627;1356.8778809907155;1367.5213675213595;1390.0339264211277;1429.671175629611;1434.0391937401967;7706.653200605986;7834.294913457702;7840.3727701784865;7865.803354916173;7871.055473343121;497.14739222234044;507.8628770232017;508.69732509156995;510.9335786347751;511.6035072818521;5643.181738647873;5793;5802.245708057925;6280.371962803683;6399.232092148972;9027.548622568846;9269.933957594963;9803.656872009446;9834.311598188058;9862.824967054037;8497.787555311166;9744.90255097454;9832.31173817826;9896.307258491981;9902.257330700082;7808;7808.68765249395;7813.3749300057;7828.608569571498;7842.490238134617;7662.846743064996;7781.610919454118;7822.061352637492;7824.882626760489;7831.647575858986;8634.56827158652;8768.473891566526;8904.821903561762;9090.36367454272;9094.136057074567;8839.204471597586;9219.723408297761;9353.438793672402;9367.437953722798;9374.906250937403;7461.701531938662;7801.4929029612895;7876.763697089096;7885.6845726172605;7917.643706033127;7089.539179953286;7578.583177925267;7942.563159026309;8047.637856296364;8053.597320133853;6872.41584465326;7182.928170718226;7448.590327532038;7500.512466689648;7556.546607203585;7039.19049309336;7284.635768211462;7298.233685463162;7481.850362992601;7483.027206463125;7430.814229644302;7502.437317201341;7509.4367922404945;7509.699612015676;7510.136334321623;6022.36765139654;6617.834554136185;6751.696173672099;6822.931770682429;6827.590344579341;6233.407826256498;6361.809145725636;6906.8618627626165;6936.514443988873;6946.305369463013 13:07:07 INFO - 2015-11-23 13:07:07,410 DEBUG : BROWSER_OUTPUT: |4;prototype.html;317.55066580788184;326.5884984919003;327.74927180706754;332.88848235841004;336.77604393078605;5454.481824226697;6587.934120658792;6736.090627765262;6789.762358317454;6795.796126116218;6520.478361731062;6651.933480665192;6672.332766723325;6678.332166783319;6697.330266973312;4912.508749125086;4985.725785081819;4988.052270068693;4993.600511959053;5027.019731152409;4692.41344831896;4749.59628431582;4851.442084160331;4987.576056035241;5004.774785134678;4892.070506603752;4908.116539022993;4914.459409464956;4933.679310844784;4937.481564435737;4887.2913427552985;4898.510148985109;4903.65674402792;4949.950500494985;4951.207806750938;4214.536400995888;4222.725522841036;4226.619604235603;4233.089885674564;4233.618974292298;6238.532110091761;6418.03729440583;6434.420902118832;6447.871042579122;6455.967720161416;4855.295982082614;5892.734826932799;5904.881902361972;5912.379200184005;5922.082077278029;7177;7181.856362872765;7187.101612298463;7187.3172048655815;7190.424766018706;4627.676062675614;4727.385439892826;4757.643176761757;4779.5220477951925;4799.352087468182;6629.834254143637;6895.758763422582;7627.580483073429;7648.464607477423;7651.885221721679;4806.399200099988;4806.735629540409;4807.567318941312;4810.63920205986;4813.735244561512;4767.6662633615315;4896.975515122473;4906.067847109038;4906.975465122651;4922.212446008622;5852.122181672783;5903.616264942765;5916.645001299936;5919.704014799243;5923.466887980103;7248.0939882514685;7248.746293879689;7252.311030452099;7256.818579535448;7264.455165862581;1718.1151706870971;1742.7908650961713;1744.0407775723302;1745.4065617690046;1750.2998800479656;1093.9835902461468;1113.1929351220301;1121.8261169518737;1135.6365962891796;1137.3573930729112;6808.8978665320055;6854.794356169323;6866.656667166621;6876.862462750717;6881.208661003949;7277.526960747535;7354.227806080392;7430.071241094864;7559.5464272143845;7575.924240757632;5874.295084589877;6800.8299792504595;6808.795736127924;6825.112735344473;6837.6581170942245;3823.044238940265;3945.6646185074014;3973.145773658677;3975.344068228768;3978.42312864633;6654.70053847578;7545.660445279976;7934.841303174019;7939.6030198491;7955.721549745731;7876.72431464896;7883.6058197089915;7884.960575197088;7901.407394445439;7903.920960790433;7775.805604859924;7895.131535531087;7901.130875603679;7906.7627971160955;7931.286184243446;6291.653959032297;6757.749816284003;7098.538594991309;7635.46551741395;7647.579383133981;6086.6348019119;7402.074740657418;7501.062367204099;7517.43619228571;7558;7685;7933.167017463315;7945.682172713026;7951.522908625501;7956.9602151988865;4730.455997560187;4778.187708089564;4779.450363208275;4781.187198176388;4804.471508134172;7601;7609.695612175451;7612.7716168515035;7623.932649429195;7624.237576242332;6569.901451478136;7258.564486130849;7315.926840731525;7335.816604584928;7359.1169059713175;7321.524100933422;7327.010853534704;7330.890036649561;7332;7333.156686981066;6920.204176519564;7115.928840711526;7130.322619351154;7131.2512186221775;7141.964290178724;5974.9402505974385;7318.707251710085;7320.1215854097845;7322.1579518356075;7323.963380183065;6003.489703375088;6854.760083397057;7107.324804143598;7162.641867906688;7167.7132914682825 13:07:07 INFO - 2015-11-23 13:07:07,411 DEBUG : BROWSER_OUTPUT: |5;yui.html;750.2160242546539;787.8306164174701;804.8551260773058;811.4684881402683;870.5212133326671;15159.166245856473;15165.848341516608;15501.84498155018;15504.534863954072;15510.457134000313;14264.572062838106;14498.492552760656;14554.854451455509;14592.343344549494;14616.488422905173;764.7208768799376;775.8176828445311;952.5284983932963;974.7368210583138;977.022977022977;772.382094324541;782.5500337306044;956.2732323434205;974.3082411487852;974.8001659659752;1007.4207330784791;1008.0423597582289;1019.3272440189477;1021.9693409197699;1022.115869772645;795.4233180943827;810.841885832263;1011.1960991012163;1019.1133713669118;1022.616518805448;597.447361190901;598.3687209993456;732.5494820685241;746.6751962896103;747.5066456138923;14948.32732527028;15177.24113794306;15189.848101518954;15191.62020949474;15253;12387;12568.74862502754;12764.744705105846;12874.678133046655;13161.868381316255;9925.652602158962;10208.183345332356;10348.689539313833;10354.79290414195;10365.79268414635;3533.982330088333;3581.212133330663;3583.516225309576;3590.030691713249;3590.5870824855215;82347.5882620583;82813.58593207055;83295.583522082;84326;84608.15391846064;9610.51947402627;9691.27315451344;9741.902580974242;9818.607255709834;10210.132138768287;21460.356189314345;21486.033128509254;22082.44793880166;22100.557988840454;22216.444588885406;7453.403727701771;7595.810104747426;7702.537847729154;7735.342495887912;7846.33306168982;4042.15114825884;4116.094459218967;4116.197341518375;4123.649489793401;4124.505059392832;3473.774204676688;3527.8941631750577;3529.7176225901867;3530.770499917497;3544.167120726627;570.5492660798006;607.7690477618477;623.4171050068201;624.4848000399688;647.5984889368622;486.3475300493321;591.6952769323801;597.3220394851875;616.5314361085607;655.1777519213452;8446.366522510836;8473.618687159093;8505.23452889243;8790.648374064966;9386.249100071978;523.8637954131877;543.614034035839;579.5508480927315;620.444701991724;635.9618422894641;3844.115853353688;4043.757374557536;4072.6131017553284;4115.794210289474;4224.746515209097;99952;100035.49982250042;100124;101975;102022.48988755008;79968.20031799607;80529.59735201286;80959;81137;82675.5866220665;72948.27051729521;73626.63186684033;74717.25282747211;76691.61654191693;77477.6126119377;8443.66225350979;8861.069587693457;8887.866681999645;8900.955495222483;9044.41211321262;50200.99598008092;50593;50917;51712;52843.73578132085;70376;72840;73925;75468.24531754832;75568;11022.944885275523;11082.113430925669;11278.702949160952;11368.261063030877;11511.251768635011;11872.762544748884;11967.880321196677;12003.63989080329;12006.459709313276;12028.699282518008;11424.82862757076;11668.824967625662;11788.351640659846;11818.40907954616;12074.45664945062;11517.308961462339;11554.42227888619;11673.824892626788;11790.646280611596;11954;9127.726168214964;10190.145083235067;11269.323840569592;11501.009737468152;11694.217353934868;9544.809103817746;9796.951015244878;9851.16265117473;9911.504424778876;10020.24848136378;8928.553572321487;9324.207442367204;9578.297954976444;9881.407115573089;9897.950510247403 13:07:07 INFO - 2015-11-23 13:07:07,411 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:07:07 INFO - 2015-11-23 13:07:07,411 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:07:07 INFO - 2015-11-23 13:07:07,411 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1051 13:07:07 INFO - 2015-11-23 13:07:07,411 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:07:07 INFO - 2015-11-23 13:07:07,411 DEBUG : BROWSER_OUTPUT: __startTimestamp1448312827397__endTimestamp 13:07:07 INFO - 2015-11-23 13:07:07,411 DEBUG : BROWSER_OUTPUT: 13:07:07 INFO - 2015-11-23 13:07:07,411 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:07:07 INFO - 2015-11-23 13:07:07,411 DEBUG : BROWSER_OUTPUT: Number of tests: 6 13:07:07 INFO - 2015-11-23 13:07:07,411 DEBUG : BROWSER_OUTPUT: 13:07:07 INFO - 2015-11-23 13:07:07,413 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5845.83 Median:6088.77 stddev:641.57 (10.5%) stddev-sans-first:614.02 13:07:07 INFO - 2015-11-23 13:07:07,413 DEBUG : BROWSER_OUTPUT: Values: 3393.2 3469.5 3487.3 3496.1 3535.2 5697.9 5821.3 5829.2 5888.0 5906.4 5839.2 5925.8 5950.1 5972.7 6088.8 5247.9 5277.9 5302.3 5312.8 5402.2 5407.6 5411.2 5450.2 5464.8 5484.5 5190.3 5277.9 5294.9 5308.7 5406.6 5219.7 5327.3 5350.3 5350.9 5369.7 5260.2 5311.8 5322.6 5384.3 5389.8 4853.5 5629.8 5818.8 5910.0 5924.7 5223.2 6306.2 6320.1 6325.5 6338.3 6312.6 6329.5 6344.3 6346.4 6348.7 5789.0 5841.9 5927.0 6053.5 6054.9 6270.8 6376.3 6436.8 6464.3 6477.7 6289.0 6302.3 6312.2 6341.9 6350.4 6115.3 6139.6 6253.5 6330.2 6363.9 6147.3 6250.7 6284.7 6284.7 6300.1 6281.5 6286.5 6292.3 6302.4 6304.5 4856.9 5064.6 5074.7 5080.3 5120.0 4421.8 4495.7 4497.1 4547.0 4547.1 6004.5 6008.4 6039.2 6043.5 6048.9 6148.7 6352.1 6363.2 6365.3 6368.1 5882.1 5934.1 5945.5 5965.0 5975.8 5526.4 5528.5 5536.6 5543.1 5559.5 6301.6 6346.9 6363.8 6369.2 6383.7 6196.5 6298.8 6304.4 6312.1 6316.6 6422.0 6441.5 6465.8 6467.8 6477.4 6091.5 6226.9 6312.7 6316.1 6324.3 5047.8 5259.2 6294.2 6299.6 6314.2 6291.5 6295.9 6307.7 6315.8 6332.7 6039.6 6184.5 6188.5 6282.3 6308.6 5922.5 6037.4 6060.1 6064.7 6132.9 6138.4 6165.4 6172.1 6172.3 6186.7 6141.9 6143.5 6157.4 6161.8 6176.0 13:07:07 INFO - 2015-11-23 13:07:07,413 DEBUG : BROWSER_OUTPUT: 13:07:07 INFO - 2015-11-23 13:07:07,413 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:68577.35 Median:20086.64 stddev:141315.05 (703.5%) stddev-sans-first:141619.15 13:07:07 INFO - 2015-11-23 13:07:07,415 DEBUG : BROWSER_OUTPUT: Values: 541.4 560.7 592.4 640.9 645.1 31436.2 32015.7 32138.8 32150.0 41422.6 44248.0 44556.0 44887.6 44917.6 45078.1 8665.4 9772.2 9912.9 9934.7 9969.1 8925.0 9069.3 9684.1 11932.9 12066.3 11827.5 11893.6 11897.5 11913.0 11940.5 8778.9 11812.0 11852.4 11874.9 11911.9 8759.3 11696.0 11858.5 11862.5 11873.3 34553.7 41412.2 41752.2 41768.6 41816.0 3372.2 3395.9 3492.1 3644.5 3649.2 28773.9 28866.9 29529.6 29735.4 30181.8 2780.6 2851.0 2859.6 2878.4 2984.9 489318.0 555152.0 559009.2 562405.0 562442.0 67300.0 67631.7 67705.0 68017.0 68076.0 64073.7 71295.3 71404.6 71500.0 71606.6 14629.5 14802.8 16463.4 17001.0 17047.3 12254.8 12383.4 12388.9 12428.1 12433.7 21921.3 21990.9 22122.0 22183.9 22227.9 8826.5 9043.6 9343.7 9625.8 9723.5 1005.8 1008.8 1089.4 1129.2 1198.7 26095.0 29499.4 29773.4 30375.2 30593.0 1053.3 1095.4 1118.7 1158.5 1228.1 15027.8 15355.4 15462.1 15750.1 16082.0 539385.0 545644.0 545703.0 545941.0 546259.0 60846.0 61283.4 61348.7 61365.7 61420.7 1461.9 1465.0 1479.2 1494.8 1496.9 29786.7 29859.7 29970.7 29989.6 30072.8 52081.0 52432.7 52601.5 52682.2 52768.7 500365.5 501085.0 503177.0 503705.0 504058.0 29078.7 46466.8 46520.3 46568.0 48677.8 49315.5 49580.5 50105.0 50403.0 51673.0 39726.2 40873.6 41028.0 41650.8 43284.0 34794.7 40086.2 42456.6 43153.8 43179.8 38696.4 39123.1 39789.0 40475.8 40665.4 31523.5 34319.7 35653.0 36354.6 36524.1 25575.2 25766.7 26655.9 26949.3 27308.3 13:07:07 INFO - 2015-11-23 13:07:07,415 DEBUG : BROWSER_OUTPUT: 13:07:07 INFO - 2015-11-23 13:07:07,415 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:40190.41 Median:12024.75 stddev:128524.19 (1068.8%) stddev-sans-first:128849.94 13:07:07 INFO - 2015-11-23 13:07:07,416 DEBUG : BROWSER_OUTPUT: Values: 358.4 359.6 366.4 367.2 371.3 16101.2 17417.6 17904.2 20905.8 21901.0 21163.4 21219.0 21403.8 21421.6 21422.5 6549.4 6744.0 6744.6 6757.1 6765.8 4735.0 5235.5 6685.3 7621.8 7630.4 7450.1 7503.4 7511.9 7562.0 7587.2 7502.7 7531.1 7536.1 7537.4 7553.6 7012.1 7207.4 7214.6 7221.6 7244.2 27050.6 27322.0 27518.2 28175.4 28517.1 2063.1 2148.5 2222.1 2248.1 2321.0 9940.9 10064.8 12866.4 14583.7 15008.8 1657.2 1695.8 1709.3 1742.4 1748.5 94046.5 97846.0 98185.0 99711.5 105478.9 9116.6 10707.9 11069.0 11078.6 11175.3 13076.6 13092.0 13098.3 13101.1 13123.7 8261.7 8327.2 8368.4 8409.0 8409.0 8550.7 8582.5 8587.7 8640.8 8666.1 4072.0 4357.6 4397.8 4417.7 4436.0 1749.2 1784.6 1787.1 1792.1 1794.1 968.5 1007.2 1044.8 1045.7 1093.5 19623.3 20057.7 20509.0 20612.8 20635.3 930.2 933.9 976.6 1025.4 1033.1 10180.5 10473.4 10549.7 10552.4 10557.1 769830.0 775846.0 780768.0 789218.0 791859.0 123321.4 126432.0 128939.0 128983.4 131462.0 1149.2 1178.5 1186.6 1188.1 1222.2 18139.4 18328.0 18340.7 18389.1 18626.6 43535.8 48326.0 49300.0 50432.0 50940.5 72770.6 72856.3 72905.0 73126.6 75966.2 9701.7 9750.6 9887.6 9918.7 9927.4 18884.4 19166.9 19231.2 19850.6 20068.3 10585.9 15613.9 16127.3 16130.4 16152.4 10959.3 12408.6 13287.5 15576.4 16022.0 13228.7 16000.8 16026.4 16434.0 16667.0 9537.9 9685.0 9781.0 9789.0 9803.5 10155.8 12965.4 15270.8 15906.0 16165.7 13:07:07 INFO - 2015-11-23 13:07:07,416 DEBUG : BROWSER_OUTPUT: 13:07:07 INFO - 2015-11-23 13:07:07,416 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5755.20 Median:6321.09 stddev:2971.58 (47.0%) stddev-sans-first:2962.39 13:07:07 INFO - 2015-11-23 13:07:07,417 DEBUG : BROWSER_OUTPUT: Values: 1461.9 1629.8 1904.9 1933.0 2004.1 6601.6 7523.6 7969.3 8095.6 8138.5 8205.5 8273.2 8352.5 8358.2 8376.4 2110.4 2158.6 2372.2 2396.5 2405.1 2374.3 2421.6 2423.4 2424.9 2430.4 2333.8 2379.1 2393.5 2401.0 2405.9 2075.1 2138.3 2145.0 2326.1 2333.6 2384.2 2385.6 2385.8 2387.7 2393.8 8095.2 8211.3 8228.4 8253.5 8262.5 5072.1 5082.7 5159.5 5181.9 5189.1 3433.2 3466.5 3517.3 3561.7 3563.2 1012.7 1014.4 1041.9 1042.5 1054.5 10919.5 10949.6 10999.2 11007.4 11025.4 4540.9 4660.0 4711.6 4715.8 4726.3 9590.1 9599.0 9612.7 9631.5 9675.1 5218.7 5231.5 5234.2 5234.6 5236.9 4698.0 4701.6 4710.0 4734.0 4759.2 3831.7 3854.5 3856.9 3879.8 3886.8 1108.6 1282.4 1283.7 1291.2 1293.1 1356.9 1367.5 1390.0 1429.7 1434.0 7706.7 7834.3 7840.4 7865.8 7871.1 497.1 507.9 508.7 510.9 511.6 5643.2 5793.0 5802.2 6280.4 6399.2 9027.5 9269.9 9803.7 9834.3 9862.8 8497.8 9744.9 9832.3 9896.3 9902.3 7808.0 7808.7 7813.4 7828.6 7842.5 7662.8 7781.6 7822.1 7824.9 7831.6 8634.6 8768.5 8904.8 9090.4 9094.1 8839.2 9219.7 9353.4 9367.4 9374.9 7461.7 7801.5 7876.8 7885.7 7917.6 7089.5 7578.6 7942.6 8047.6 8053.6 6872.4 7182.9 7448.6 7500.5 7556.5 7039.2 7284.6 7298.2 7481.9 7483.0 7430.8 7502.4 7509.4 7509.7 7510.1 6022.4 6617.8 6751.7 6822.9 6827.6 6233.4 6361.8 6906.9 6936.5 6946.3 13:07:07 INFO - 2015-11-23 13:07:07,418 DEBUG : BROWSER_OUTPUT: 13:07:07 INFO - 2015-11-23 13:07:07,418 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5907.91 Median:6653.32 stddev:1886.30 (28.4%) stddev-sans-first:1844.34 13:07:07 INFO - 2015-11-23 13:07:07,419 DEBUG : BROWSER_OUTPUT: Values: 317.6 326.6 327.7 332.9 336.8 5454.5 6587.9 6736.1 6789.8 6795.8 6520.5 6651.9 6672.3 6678.3 6697.3 4912.5 4985.7 4988.1 4993.6 5027.0 4692.4 4749.6 4851.4 4987.6 5004.8 4892.1 4908.1 4914.5 4933.7 4937.5 4887.3 4898.5 4903.7 4950.0 4951.2 4214.5 4222.7 4226.6 4233.1 4233.6 6238.5 6418.0 6434.4 6447.9 6456.0 4855.3 5892.7 5904.9 5912.4 5922.1 7177.0 7181.9 7187.1 7187.3 7190.4 4627.7 4727.4 4757.6 4779.5 4799.4 6629.8 6895.8 7627.6 7648.5 7651.9 4806.4 4806.7 4807.6 4810.6 4813.7 4767.7 4897.0 4906.1 4907.0 4922.2 5852.1 5903.6 5916.6 5919.7 5923.5 7248.1 7248.7 7252.3 7256.8 7264.5 1718.1 1742.8 1744.0 1745.4 1750.3 1094.0 1113.2 1121.8 1135.6 1137.4 6808.9 6854.8 6866.7 6876.9 6881.2 7277.5 7354.2 7430.1 7559.5 7575.9 5874.3 6800.8 6808.8 6825.1 6837.7 3823.0 3945.7 3973.1 3975.3 3978.4 6654.7 7545.7 7934.8 7939.6 7955.7 7876.7 7883.6 7885.0 7901.4 7903.9 7775.8 7895.1 7901.1 7906.8 7931.3 6291.7 6757.7 7098.5 7635.5 7647.6 6086.6 7402.1 7501.1 7517.4 7558.0 7685.0 7933.2 7945.7 7951.5 7957.0 4730.5 4778.2 4779.5 4781.2 4804.5 7601.0 7609.7 7612.8 7623.9 7624.2 6569.9 7258.6 7315.9 7335.8 7359.1 7321.5 7327.0 7330.9 7332.0 7333.2 6920.2 7115.9 7130.3 7131.3 7142.0 5974.9 7318.7 7320.1 7322.2 7324.0 6003.5 6854.8 7107.3 7162.6 7167.7 13:07:07 INFO - 2015-11-23 13:07:07,419 DEBUG : BROWSER_OUTPUT: 13:07:07 INFO - 2015-11-23 13:07:07,419 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:19147.25 Median:51314.50 stddev:27385.14 (53.4%) stddev-sans-first:27427.12 13:07:07 INFO - 2015-11-23 13:07:07,419 DEBUG : BROWSER_OUTPUT: Values: 750.2 787.8 804.9 811.5 870.5 15159.2 15165.8 15501.8 15504.5 15510.5 14264.6 14498.5 14554.9 14592.3 14616.5 764.7 775.8 952.5 974.7 977.0 772.4 782.6 956.3 974.3 974.8 1007.4 1008.0 1019.3 1022.0 1022.1 795.4 810.8 1011.2 1019.1 1022.6 597.4 598.4 732.5 746.7 747.5 14948.3 15177.2 15189.8 15191.6 15253.0 12387.0 12568.7 12764.7 12874.7 13161.9 9925.7 10208.2 10348.7 10354.8 10365.8 3534.0 3581.2 3583.5 3590.0 3590.6 82347.6 82813.6 83295.6 84326.0 84608.2 9610.5 9691.3 9741.9 9818.6 10210.1 21460.4 21486.0 22082.4 22100.6 22216.4 7453.4 7595.8 7702.5 7735.3 7846.3 4042.2 4116.1 4116.2 4123.6 4124.5 3473.8 3527.9 3529.7 3530.8 3544.2 570.5 607.8 623.4 624.5 647.6 486.3 591.7 597.3 616.5 655.2 8446.4 8473.6 8505.2 8790.6 9386.2 523.9 543.6 579.6 620.4 636.0 3844.1 4043.8 4072.6 4115.8 4224.7 99952.0 100035.5 100124.0 101975.0 102022.5 79968.2 80529.6 80959.0 81137.0 82675.6 72948.3 73626.6 74717.3 76691.6 77477.6 8443.7 8861.1 8887.9 8901.0 9044.4 50201.0 50593.0 50917.0 51712.0 52843.7 70376.0 72840.0 73925.0 75468.2 75568.0 11022.9 11082.1 11278.7 11368.3 11511.3 11872.8 11967.9 12003.6 12006.5 12028.7 11424.8 11668.8 11788.4 11818.4 12074.5 11517.3 11554.4 11673.8 11790.6 11954.0 9127.7 10190.1 11269.3 11501.0 11694.2 9544.8 9797.0 9851.2 9911.5 10020.2 8928.6 9324.2 9578.3 9881.4 9898.0 13:07:07 INFO - 2015-11-23 13:07:07,419 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:07:07 INFO - 2015-11-23 13:07:07,419 DEBUG : BROWSER_OUTPUT: 13:07:07 INFO - 2015-11-23 13:07:07,843 INFO : Browser exited with error code: 0 13:07:07 INFO - 2015-11-23 13:07:07,868 INFO : Completed test dromaeo_css (00:18:33) 13:07:07 INFO - 2015-11-23 13:07:07,868 INFO : Starting test kraken 13:07:07 INFO - 2015-11-23 13:07:07,868 DEBUG : operating with platform_type : mac_ 13:07:07 INFO - 2015-11-23 13:07:07,868 INFO : Initialising browser for kraken test... 13:07:07 INFO - 2015-11-23 13:07:07,881 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/tmpHRLcP9/profile http://localhost:57800/getInfo.html 13:07:09 INFO - 2015-11-23 13:07:09,827 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:07:09 INFO - 2015-11-23 13:07:09,827 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:07:09 INFO - 2015-11-23 13:07:09,827 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 13:07:09 INFO - 2015-11-23 13:07:09,827 DEBUG : BROWSER_OUTPUT: __metrics 13:07:09 INFO - 2015-11-23 13:07:09,842 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:07:10 INFO - 2015-11-23 13:07:10,519 INFO : Browser initialized. 13:07:10 INFO - 2015-11-23 13:07:10,519 INFO : Running cycle 1/1 for kraken test... 13:07:10 INFO - 2015-11-23 13:07:10,519 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/tmpHRLcP9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:07:22 INFO - 2015-11-23 13:07:22,402 DEBUG : BROWSER_OUTPUT: RSS: Main: 224284672 13:07:22 INFO - 2015-11-23 13:07:22,402 DEBUG : BROWSER_OUTPUT: 13:07:24 INFO - 2015-11-23 13:07:24,918 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57800/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57800/tests/kraken/driver.html?testName=audio-beat-detection) 13:07:25 INFO - 2015-11-23 13:07:25,523 DEBUG : BROWSER_OUTPUT: RSS: Main: 276254720 13:07:25 INFO - 2015-11-23 13:07:25,523 DEBUG : BROWSER_OUTPUT: 13:07:28 INFO - 2015-11-23 13:07:28,275 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57800/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57800/tests/kraken/driver.html?testName=audio-dft) 13:07:28 INFO - 2015-11-23 13:07:28,873 DEBUG : BROWSER_OUTPUT: RSS: Main: 289525760 13:07:28 INFO - 2015-11-23 13:07:28,874 DEBUG : BROWSER_OUTPUT: 13:07:32 INFO - 2015-11-23 13:07:32,189 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57800/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57800/tests/kraken/driver.html?testName=audio-fft) 13:07:32 INFO - 2015-11-23 13:07:32,769 DEBUG : BROWSER_OUTPUT: RSS: Main: 278212608 13:07:32 INFO - 2015-11-23 13:07:32,770 DEBUG : BROWSER_OUTPUT: 13:07:34 INFO - 2015-11-23 13:07:34,727 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57800/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57800/tests/kraken/driver.html?testName=audio-oscillator) 13:07:35 INFO - 2015-11-23 13:07:35,310 DEBUG : BROWSER_OUTPUT: RSS: Main: 280158208 13:07:35 INFO - 2015-11-23 13:07:35,310 DEBUG : BROWSER_OUTPUT: 13:07:37 INFO - 2015-11-23 13:07:37,310 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57800/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57800/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:07:37 INFO - 2015-11-23 13:07:37,891 DEBUG : BROWSER_OUTPUT: RSS: Main: 279240704 13:07:37 INFO - 2015-11-23 13:07:37,891 DEBUG : BROWSER_OUTPUT: 13:07:40 INFO - 2015-11-23 13:07:40,706 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57800/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57800/tests/kraken/driver.html?testName=imaging-darkroom) 13:07:41 INFO - 2015-11-23 13:07:41,296 DEBUG : BROWSER_OUTPUT: RSS: Main: 281350144 13:07:41 INFO - 2015-11-23 13:07:41,296 DEBUG : BROWSER_OUTPUT: 13:07:44 INFO - 2015-11-23 13:07:44,074 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57800/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57800/tests/kraken/driver.html?testName=imaging-desaturate) 13:07:44 INFO - 2015-11-23 13:07:44,665 DEBUG : BROWSER_OUTPUT: RSS: Main: 281681920 13:07:44 INFO - 2015-11-23 13:07:44,665 DEBUG : BROWSER_OUTPUT: 13:07:47 INFO - 2015-11-23 13:07:47,346 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57800/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57800/tests/kraken/driver.html?testName=json-parse-financial) 13:07:47 INFO - 2015-11-23 13:07:47,945 DEBUG : BROWSER_OUTPUT: RSS: Main: 280125440 13:07:47 INFO - 2015-11-23 13:07:47,945 DEBUG : BROWSER_OUTPUT: 13:07:49 INFO - 2015-11-23 13:07:49,470 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57800/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57800/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:07:50 INFO - 2015-11-23 13:07:50,053 DEBUG : BROWSER_OUTPUT: RSS: Main: 314019840 13:07:50 INFO - 2015-11-23 13:07:50,053 DEBUG : BROWSER_OUTPUT: 13:07:51 INFO - 2015-11-23 13:07:51,923 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57800/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57800/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:07:52 INFO - 2015-11-23 13:07:52,547 DEBUG : BROWSER_OUTPUT: RSS: Main: 315080704 13:07:52 INFO - 2015-11-23 13:07:52,548 DEBUG : BROWSER_OUTPUT: 13:07:54 INFO - 2015-11-23 13:07:54,574 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57800/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57800/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:07:55 INFO - 2015-11-23 13:07:55,162 DEBUG : BROWSER_OUTPUT: RSS: Main: 323842048 13:07:55 INFO - 2015-11-23 13:07:55,162 DEBUG : BROWSER_OUTPUT: 13:07:57 INFO - 2015-11-23 13:07:57,712 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57800/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57800/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:07:58 INFO - 2015-11-23 13:07:58,314 DEBUG : BROWSER_OUTPUT: RSS: Main: 324280320 13:07:58 INFO - 2015-11-23 13:07:58,315 DEBUG : BROWSER_OUTPUT: 13:08:00 INFO - 2015-11-23 13:08:00,724 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57800/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57800/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:08:01 INFO - 2015-11-23 13:08:01,325 DEBUG : BROWSER_OUTPUT: RSS: Main: 323317760 13:08:01 INFO - 2015-11-23 13:08:01,325 DEBUG : BROWSER_OUTPUT: 13:08:02 INFO - 2015-11-23 13:08:02,968 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57800/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57800/tests/kraken/driver.html?testName=ai-astar) 13:08:03 INFO - 2015-11-23 13:08:03,225 DEBUG : BROWSER_OUTPUT: RSS: Main: 383827968 13:08:03 INFO - 2015-11-23 13:08:03,225 DEBUG : BROWSER_OUTPUT: 13:08:03 INFO - 2015-11-23 13:08:03,225 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:08:03 INFO - 2015-11-23 13:08:03,225 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:08:03 INFO - 2015-11-23 13:08:03,225 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:08:03 INFO - 2015-11-23 13:08:03,225 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:08:03 INFO - 2015-11-23 13:08:03,225 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;109;105;110;110;111;99;110;110;109 13:08:03 INFO - 2015-11-23 13:08:03,225 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;155;132;172;151;121;164;163;143;163;143 13:08:03 INFO - 2015-11-23 13:08:03,225 DEBUG : BROWSER_OUTPUT: |2;audio-dft;186;184;182;185;185;185;187;190;194;258 13:08:03 INFO - 2015-11-23 13:08:03,225 DEBUG : BROWSER_OUTPUT: |3;audio-fft;69;67;77;72;80;46;53;71;94;74 13:08:03 INFO - 2015-11-23 13:08:03,225 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;82;84;123;74;76;74;114;74;74;114 13:08:03 INFO - 2015-11-23 13:08:03,226 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;89;87;87;89;87;130;128;89;88;88 13:08:03 INFO - 2015-11-23 13:08:03,226 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;96;95;95;96;96;96;94;95;95;94 13:08:03 INFO - 2015-11-23 13:08:03,226 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;85;87;85;87;85;86;85;85;87;84 13:08:03 INFO - 2015-11-23 13:08:03,226 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;56;55;57;56;54;54;53;65;53;55 13:08:03 INFO - 2015-11-23 13:08:03,226 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;55;88;97;79;65;68;72;70;66;69 13:08:03 INFO - 2015-11-23 13:08:03,226 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;79;83;83;80;83;83;82;83;82 13:08:03 INFO - 2015-11-23 13:08:03,226 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;123;130;122;123;130;126;125;132;125;122 13:08:03 INFO - 2015-11-23 13:08:03,226 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;132;134;134;134;137;131;135;133;134;122 13:08:03 INFO - 2015-11-23 13:08:03,226 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;63;65;64;65;67;65;64;68;64;65 13:08:03 INFO - 2015-11-23 13:08:03,226 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:08:03 INFO - 2015-11-23 13:08:03,227 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:08:03 INFO - 2015-11-23 13:08:03,227 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1034 13:08:03 INFO - 2015-11-23 13:08:03,227 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:08:03 INFO - 2015-11-23 13:08:03,227 DEBUG : BROWSER_OUTPUT: __startTimestamp1448312883222__endTimestamp 13:08:03 INFO - 2015-11-23 13:08:03,227 DEBUG : BROWSER_OUTPUT: 13:08:03 INFO - 2015-11-23 13:08:03,227 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:08:03 INFO - 2015-11-23 13:08:03,227 DEBUG : BROWSER_OUTPUT: Number of tests: 14 13:08:03 INFO - 2015-11-23 13:08:03,227 DEBUG : BROWSER_OUTPUT: 13:08:03 INFO - 2015-11-23 13:08:03,227 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.20 Median:110.00 stddev:3.61 (3.3%) stddev-sans-first:3.82 13:08:03 INFO - 2015-11-23 13:08:03,229 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 105.0 110.0 110.0 111.0 99.0 110.0 110.0 109.0 13:08:03 INFO - 2015-11-23 13:08:03,229 DEBUG : BROWSER_OUTPUT: 13:08:03 INFO - 2015-11-23 13:08:03,229 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.70 Median:159.00 stddev:15.99 (10.1%) stddev-sans-first:16.89 13:08:03 INFO - 2015-11-23 13:08:03,229 DEBUG : BROWSER_OUTPUT: Values: 155.0 132.0 172.0 151.0 121.0 164.0 163.0 143.0 163.0 143.0 13:08:03 INFO - 2015-11-23 13:08:03,229 DEBUG : BROWSER_OUTPUT: 13:08:03 INFO - 2015-11-23 13:08:03,230 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:193.60 Median:186.50 stddev:22.88 (12.3%) stddev-sans-first:24.10 13:08:03 INFO - 2015-11-23 13:08:03,230 DEBUG : BROWSER_OUTPUT: Values: 186.0 184.0 182.0 185.0 185.0 185.0 187.0 190.0 194.0 258.0 13:08:03 INFO - 2015-11-23 13:08:03,230 DEBUG : BROWSER_OUTPUT: 13:08:03 INFO - 2015-11-23 13:08:03,230 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:70.30 Median:73.00 stddev:13.42 (18.4%) stddev-sans-first:14.22 13:08:03 INFO - 2015-11-23 13:08:03,230 DEBUG : BROWSER_OUTPUT: Values: 69.0 67.0 77.0 72.0 80.0 46.0 53.0 71.0 94.0 74.0 13:08:03 INFO - 2015-11-23 13:08:03,230 DEBUG : BROWSER_OUTPUT: 13:08:03 INFO - 2015-11-23 13:08:03,230 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:88.90 Median:74.00 stddev:19.86 (26.8%) stddev-sans-first:20.90 13:08:03 INFO - 2015-11-23 13:08:03,230 DEBUG : BROWSER_OUTPUT: Values: 82.0 84.0 123.0 74.0 76.0 74.0 114.0 74.0 74.0 114.0 13:08:03 INFO - 2015-11-23 13:08:03,230 DEBUG : BROWSER_OUTPUT: 13:08:03 INFO - 2015-11-23 13:08:03,231 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:96.20 Median:88.00 stddev:17.31 (19.7%) stddev-sans-first:18.17 13:08:03 INFO - 2015-11-23 13:08:03,231 DEBUG : BROWSER_OUTPUT: Values: 89.0 87.0 87.0 89.0 87.0 130.0 128.0 89.0 88.0 88.0 13:08:03 INFO - 2015-11-23 13:08:03,231 DEBUG : BROWSER_OUTPUT: 13:08:03 INFO - 2015-11-23 13:08:03,231 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:95.20 Median:95.50 stddev:0.79 (0.8%) stddev-sans-first:0.78 13:08:03 INFO - 2015-11-23 13:08:03,231 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 96.0 96.0 96.0 94.0 95.0 95.0 94.0 13:08:03 INFO - 2015-11-23 13:08:03,231 DEBUG : BROWSER_OUTPUT: 13:08:03 INFO - 2015-11-23 13:08:03,231 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:85.60 Median:85.50 stddev:1.07 (1.3%) stddev-sans-first:1.12 13:08:03 INFO - 2015-11-23 13:08:03,231 DEBUG : BROWSER_OUTPUT: Values: 85.0 87.0 85.0 87.0 85.0 86.0 85.0 85.0 87.0 84.0 13:08:03 INFO - 2015-11-23 13:08:03,231 DEBUG : BROWSER_OUTPUT: 13:08:03 INFO - 2015-11-23 13:08:03,231 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:55.80 Median:55.50 stddev:3.49 (6.3%) stddev-sans-first:3.70 13:08:03 INFO - 2015-11-23 13:08:03,231 DEBUG : BROWSER_OUTPUT: Values: 56.0 55.0 57.0 56.0 54.0 54.0 53.0 65.0 53.0 55.0 13:08:03 INFO - 2015-11-23 13:08:03,231 DEBUG : BROWSER_OUTPUT: 13:08:03 INFO - 2015-11-23 13:08:03,231 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:72.90 Median:71.00 stddev:12.13 (17.1%) stddev-sans-first:11.01 13:08:03 INFO - 2015-11-23 13:08:03,231 DEBUG : BROWSER_OUTPUT: Values: 55.0 88.0 97.0 79.0 65.0 68.0 72.0 70.0 66.0 69.0 13:08:03 INFO - 2015-11-23 13:08:03,232 DEBUG : BROWSER_OUTPUT: 13:08:03 INFO - 2015-11-23 13:08:03,232 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:83.00 stddev:1.45 (1.7%) stddev-sans-first:1.50 13:08:03 INFO - 2015-11-23 13:08:03,232 DEBUG : BROWSER_OUTPUT: Values: 81.0 79.0 83.0 83.0 80.0 83.0 83.0 82.0 83.0 82.0 13:08:03 INFO - 2015-11-23 13:08:03,232 DEBUG : BROWSER_OUTPUT: 13:08:03 INFO - 2015-11-23 13:08:03,232 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.80 Median:125.50 stddev:3.65 (2.9%) stddev-sans-first:3.72 13:08:03 INFO - 2015-11-23 13:08:03,232 DEBUG : BROWSER_OUTPUT: Values: 123.0 130.0 122.0 123.0 130.0 126.0 125.0 132.0 125.0 122.0 13:08:03 INFO - 2015-11-23 13:08:03,232 DEBUG : BROWSER_OUTPUT: 13:08:03 INFO - 2015-11-23 13:08:03,232 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:132.60 Median:134.00 stddev:4.06 (3.0%) stddev-sans-first:4.30 13:08:03 INFO - 2015-11-23 13:08:03,232 DEBUG : BROWSER_OUTPUT: Values: 132.0 134.0 134.0 134.0 137.0 131.0 135.0 133.0 134.0 122.0 13:08:03 INFO - 2015-11-23 13:08:03,232 DEBUG : BROWSER_OUTPUT: 13:08:03 INFO - 2015-11-23 13:08:03,232 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:65.00 stddev:1.49 (2.3%) stddev-sans-first:1.39 13:08:03 INFO - 2015-11-23 13:08:03,232 DEBUG : BROWSER_OUTPUT: Values: 63.0 65.0 64.0 65.0 67.0 65.0 64.0 68.0 64.0 65.0 13:08:03 INFO - 2015-11-23 13:08:03,232 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:08:03 INFO - 2015-11-23 13:08:03,232 DEBUG : BROWSER_OUTPUT: 13:08:03 INFO - 2015-11-23 13:08:03,849 INFO : Browser exited with error code: 0 13:08:03 INFO - 2015-11-23 13:08:03,897 INFO : Completed test kraken (00:00:56) 13:08:03 INFO - 2015-11-23 13:08:03,897 INFO : Starting test v8_7 13:08:03 INFO - 2015-11-23 13:08:03,897 DEBUG : operating with platform_type : mac_ 13:08:03 INFO - 2015-11-23 13:08:03,897 INFO : Initialising browser for v8_7 test... 13:08:03 INFO - 2015-11-23 13:08:03,910 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/tmpA6b2x2/profile http://localhost:57800/getInfo.html 13:08:05 INFO - 2015-11-23 13:08:05,967 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:08:05 INFO - 2015-11-23 13:08:05,967 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:08:05 INFO - 2015-11-23 13:08:05,967 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 13:08:05 INFO - 2015-11-23 13:08:05,967 DEBUG : BROWSER_OUTPUT: __metrics 13:08:05 INFO - 2015-11-23 13:08:05,983 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:08:06 INFO - 2015-11-23 13:08:06,723 INFO : Browser initialized. 13:08:06 INFO - 2015-11-23 13:08:06,724 INFO : Running cycle 1/1 for v8_7 test... 13:08:06 INFO - 2015-11-23 13:08:06,724 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/tmpA6b2x2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:08:18 INFO - 2015-11-23 13:08:18,630 DEBUG : BROWSER_OUTPUT: RSS: Main: 226414592 13:08:18 INFO - 2015-11-23 13:08:18,630 DEBUG : BROWSER_OUTPUT: 13:08:40 INFO - 2015-11-23 13:08:40,169 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57800/tests/v8_7/run.html (next: http://localhost:57800/tests/v8_7/run.html) 13:08:40 INFO - 2015-11-23 13:08:40,419 DEBUG : BROWSER_OUTPUT: RSS: Main: 674590720 13:08:40 INFO - 2015-11-23 13:08:40,419 DEBUG : BROWSER_OUTPUT: 13:08:40 INFO - 2015-11-23 13:08:40,419 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:08:40 INFO - 2015-11-23 13:08:40,419 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:08:40 INFO - 2015-11-23 13:08:40,420 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:08:40 INFO - 2015-11-23 13:08:40,420 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:08:40 INFO - 2015-11-23 13:08:40,420 DEBUG : BROWSER_OUTPUT: |0;Richards;148.54426619132502 13:08:40 INFO - 2015-11-23 13:08:40,420 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;161.86468112657818 13:08:40 INFO - 2015-11-23 13:08:40,420 DEBUG : BROWSER_OUTPUT: |2;Encrypt;309.2145949288806 13:08:40 INFO - 2015-11-23 13:08:40,420 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4784.688995215311 13:08:40 INFO - 2015-11-23 13:08:40,420 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1696.6101694915253 13:08:40 INFO - 2015-11-23 13:08:40,420 DEBUG : BROWSER_OUTPUT: |5;Earley;792.3930269413629 13:08:40 INFO - 2015-11-23 13:08:40,420 DEBUG : BROWSER_OUTPUT: |6;Boyer;12612.5 13:08:40 INFO - 2015-11-23 13:08:40,420 DEBUG : BROWSER_OUTPUT: |7;RegExp;26973.684210526317 13:08:40 INFO - 2015-11-23 13:08:40,420 DEBUG : BROWSER_OUTPUT: |8;Splay;613.0012150668286 13:08:40 INFO - 2015-11-23 13:08:40,420 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4504.504504504504 13:08:40 INFO - 2015-11-23 13:08:40,420 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:08:40 INFO - 2015-11-23 13:08:40,421 DEBUG : BROWSER_OUTPUT: __startTimestamp1448312920418__endTimestamp 13:08:40 INFO - 2015-11-23 13:08:40,421 DEBUG : BROWSER_OUTPUT: 13:08:40 INFO - 2015-11-23 13:08:40,422 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:08:40 INFO - 2015-11-23 13:08:40,422 DEBUG : BROWSER_OUTPUT: Number of tests: 10 13:08:40 INFO - 2015-11-23 13:08:40,422 DEBUG : BROWSER_OUTPUT: 13:08:40 INFO - 2015-11-23 13:08:40,422 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:148.54 Median:148.54 stddev:0.00 (0.0%) 13:08:40 INFO - 2015-11-23 13:08:40,422 DEBUG : BROWSER_OUTPUT: Values: 148.5 13:08:40 INFO - 2015-11-23 13:08:40,422 DEBUG : BROWSER_OUTPUT: 13:08:40 INFO - 2015-11-23 13:08:40,422 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:161.86 Median:161.86 stddev:0.00 (0.0%) 13:08:40 INFO - 2015-11-23 13:08:40,422 DEBUG : BROWSER_OUTPUT: Values: 161.9 13:08:40 INFO - 2015-11-23 13:08:40,422 DEBUG : BROWSER_OUTPUT: 13:08:40 INFO - 2015-11-23 13:08:40,423 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:309.21 Median:309.21 stddev:0.00 (0.0%) 13:08:40 INFO - 2015-11-23 13:08:40,423 DEBUG : BROWSER_OUTPUT: Values: 309.2 13:08:40 INFO - 2015-11-23 13:08:40,423 DEBUG : BROWSER_OUTPUT: 13:08:40 INFO - 2015-11-23 13:08:40,423 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4784.69 Median:4784.69 stddev:0.00 (0.0%) 13:08:40 INFO - 2015-11-23 13:08:40,423 DEBUG : BROWSER_OUTPUT: Values: 4784.7 13:08:40 INFO - 2015-11-23 13:08:40,423 DEBUG : BROWSER_OUTPUT: 13:08:40 INFO - 2015-11-23 13:08:40,423 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1696.61 Median:1696.61 stddev:0.00 (0.0%) 13:08:40 INFO - 2015-11-23 13:08:40,423 DEBUG : BROWSER_OUTPUT: Values: 1696.6 13:08:40 INFO - 2015-11-23 13:08:40,423 DEBUG : BROWSER_OUTPUT: 13:08:40 INFO - 2015-11-23 13:08:40,423 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:792.39 Median:792.39 stddev:0.00 (0.0%) 13:08:40 INFO - 2015-11-23 13:08:40,423 DEBUG : BROWSER_OUTPUT: Values: 792.4 13:08:40 INFO - 2015-11-23 13:08:40,423 DEBUG : BROWSER_OUTPUT: 13:08:40 INFO - 2015-11-23 13:08:40,423 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12612.50 Median:12612.50 stddev:0.00 (0.0%) 13:08:40 INFO - 2015-11-23 13:08:40,424 DEBUG : BROWSER_OUTPUT: Values: 12612.5 13:08:40 INFO - 2015-11-23 13:08:40,424 DEBUG : BROWSER_OUTPUT: 13:08:40 INFO - 2015-11-23 13:08:40,424 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26973.68 Median:26973.68 stddev:0.00 (0.0%) 13:08:40 INFO - 2015-11-23 13:08:40,424 DEBUG : BROWSER_OUTPUT: Values: 26973.7 13:08:40 INFO - 2015-11-23 13:08:40,424 DEBUG : BROWSER_OUTPUT: 13:08:40 INFO - 2015-11-23 13:08:40,424 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:613.00 Median:613.00 stddev:0.00 (0.0%) 13:08:40 INFO - 2015-11-23 13:08:40,424 DEBUG : BROWSER_OUTPUT: Values: 613.0 13:08:40 INFO - 2015-11-23 13:08:40,424 DEBUG : BROWSER_OUTPUT: 13:08:40 INFO - 2015-11-23 13:08:40,424 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4504.50 Median:4504.50 stddev:0.00 (0.0%) 13:08:40 INFO - 2015-11-23 13:08:40,424 DEBUG : BROWSER_OUTPUT: Values: 4504.5 13:08:40 INFO - 2015-11-23 13:08:40,424 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:08:40 INFO - 2015-11-23 13:08:40,424 DEBUG : BROWSER_OUTPUT: 13:08:41 INFO - 2015-11-23 13:08:41,024 INFO : Browser exited with error code: 0 13:08:41 INFO - 2015-11-23 13:08:41,041 INFO : Completed test v8_7 (00:00:37) 13:08:41 INFO - 2015-11-23 13:08:41,395 INFO : Completed test suite (00:20:07) 13:08:41 INFO - 2015-11-23 13:08:41,395 DEBUG : Working with test: dromaeo_css 13:08:41 INFO - 2015-11-23 13:08:41,396 DEBUG : Generating results file: dromaeo_css 13:08:41 INFO - 2015-11-23 13:08:41,396 DEBUG : Working with test: kraken 13:08:41 INFO - 2015-11-23 13:08:41,396 DEBUG : Generating results file: kraken 13:08:41 INFO - 2015-11-23 13:08:41,397 INFO : javascript benchmark 13:08:41 INFO - 2015-11-23 13:08:41,397 DEBUG : Working with test: v8_7 13:08:41 INFO - 2015-11-23 13:08:41,397 DEBUG : Generating results file: v8_7 13:08:41 INFO - 2015-11-23 13:08:41,397 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:08:41 INFO - 2015-11-23 13:08:41,921 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 13:08:41 INFO - 2015-11-23 13:08:41,921 DEBUG : process_Request line: dromaeo_css 7775.69 graph.html#tests=[[72,64,59]] 13:08:41 INFO - 2015-11-23 13:08:41,921 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:08:41 INFO - 2015-11-23 13:08:41,946 DEBUG : process_Request line: kraken 1422.70 graph.html#tests=[[232,64,59]] 13:08:41 INFO - 2015-11-23 13:08:41,946 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:08:41 INFO - 2015-11-23 13:08:41,972 DEBUG : process_Request line: v8_7 20614.93 graph.html#tests=[[230,64,59]] 13:08:41 INFO - 2015-11-23 13:08:41,973 INFO : javascript benchmark 13:08:42 INFO - 2015-11-23 13:08:41,975 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3393.236521782599, 3469.548958635377, 3487.2676737885045, 3496.1084923344542, 3535.1869070113867, 5697.943020569793, 5821.3305469870975, 5829.242198514193, 5887.970560147199, 5906.37983011784, 5839.240898683176, 5925.762969481227, 5950.107483877409, 5972.701364931758, 6088.765603328701, 5247.86880327991, 5277.868053298669, 5302.284191634138, 5312.76092575835, 5402.216678581603, 5407.648502847322, 5411.18832175173, 5450.236966824647, 5464.808731694372, 5484.506394424501, 5190.299309593213, 5277.86805329866, 5294.947050529484, 5308.681479111227, 5406.621536492447, 5219.686818790885, 5327.3074500314715, 5350.3312085989255, 5350.946490535084, 5369.677819330853, 5260.184671375943, 5311.760970756325, 5322.600804939645, 5384.326959130109, 5389.78440862365, 4853.490383509751, 5629.831105066854, 5818.767249310023, 5909.9704501477645, 5924.674142922137, 5223.216517522402, 6306.243250809886, 6320.115183874262, 6325.462335701471, 6338.30278669346, 6312.558120931537, 6329.493640508748, 6344.333844946306, 6346.42882140605, 6348.714307856158, 5788.97105514474, 5841.853953651108, 5927.0, 6053.515718742534, 6054.909176362358, 6270.811875643738, 6376.33048529907, 6436.8390790230615, 6464.256610489854, 6477.676116194171, 6288.99376099831, 6302.306746257908, 6312.179416675895, 6341.8731625368155, 6350.364963503613, 6115.296740874767, 6139.640854992916, 6253.53098517613, 6330.208723909512, 6363.936360636427, 6147.262328520606, 6250.718717657625, 6284.717187726564, 6284.748610055638, 6300.086487459293, 6281.528885333618, 6286.49708023357, 6292.339304373067, 6302.401271879165, 6304.464120549713, 4856.927146092811, 5064.620153488429, 5074.744492051654, 5080.263361812516, 5120.0, 4421.756803375781, 4495.707778994421, 4497.100579883971, 4547.022390186125, 4547.136044151601, 6004.5496587755215, 6008.399160084044, 6039.245094363205, 6043.456088952015, 6048.909266361008, 6148.661823599745, 6352.142460767737, 6363.172787537683, 6365.267994180728, 6368.14030105939, 5882.058870580772, 5934.080217566284, 5945.4649081582, 5965.045592705146, 5975.790847320323, 5526.364468086222, 5528.5024347808085, 5536.584756143306, 5543.1408131739645, 5559.499645031967, 6301.590396624205, 6346.873062538723, 6363.809085727436, 6369.235691716931, 6383.680815959184, 6196.504279657526, 6298.779542715983, 6304.432601065926, 6312.084747711648, 6316.62100273985, 6422.004589288667, 6441.5490915635455, 6465.77369792055, 6467.838304042437, 6477.352264773485, 6091.471641003366, 6226.937730622636, 6312.684365781784, 6316.147320111726, 6324.272708638566, 5047.848564543069, 5259.237410575522, 6294.15028971083, 6299.590526615755, 6314.179156709598, 6291.465225455888, 6295.937040629535, 6307.684615769102, 6315.778947736807, 6332.683365831598, 6039.607425517327, 6184.474319682878, 6188.535859810622, 6282.3089460158435, 6308.589941653778, 5922.526197904243, 6037.366076562073, 6060.090986352083, 6064.666443345658, 6132.938670613236, 6138.386161383826, 6165.414285642857, 6172.135900973777, 6172.290186628596, 6186.721597528212, 6141.938580614136, 6143.508519318533, 6157.384261573986, 6161.784337548164, 6176.042713379434], "unit": "ms", "name": "dojo.html", "value": 5806.432121219609}, {"lowerIsBetter": false, "replicates": [541.3854893438561, 560.6608002158694, 592.422388171533, 640.9070684750711, 645.1194120026163, 31436.214094647647, 32015.67984320156, 32138.839305803496, 32150.0, 41422.58577414225, 44248.0, 44556.0, 44887.551124488746, 44917.550824491744, 45078.0984380313, 8665.436746611482, 9772.169365603932, 9912.90087099127, 9934.701958941243, 9969.10278074973, 8925.0, 9069.31980101495, 9684.12842844144, 11932.880671193307, 12066.336351500664, 11827.526898924032, 11893.64319070425, 11897.52409903607, 11912.987396071345, 11940.462679179414, 8778.868316975251, 11811.99598034168, 11852.407379630984, 11874.881251187551, 11911.880881191164, 8759.2992560595, 11696.0, 11858.466369013415, 11862.466189021514, 11873.287602743863, 34553.65446345555, 41412.1717565647, 41752.164956701, 41768.582314177074, 41815.95460113491, 3372.15696075981, 3395.8641654333796, 3492.14442461596, 3644.4715516249994, 3649.197176621139, 28773.85613071942, 28866.85566572175, 29529.557056644167, 29735.391014392586, 30181.849090754626, 2780.569011803174, 2850.9593998190717, 2859.5567687008547, 2878.409925965193, 2984.880604775806, 489318.0, 555152.0, 559009.2049539726, 562405.0, 562442.0, 67300.0, 67631.66184169146, 67704.98442523366, 68017.0, 68076.0, 64073.67963160248, 71295.28704712886, 71404.64297678479, 71500.0, 71606.64196678983, 14629.487967921072, 14802.815774737996, 16463.423780167635, 17001.0, 17047.31810727557, 12254.81617775734, 12383.380830958416, 12388.938055309665, 12428.130030897932, 12433.689157770947, 21921.342359729235, 21990.89004554999, 22122.0, 22183.889080554494, 22227.888860555595, 8826.470411775314, 9043.638254469879, 9343.719688409223, 9625.759356016015, 9723.513824308757, 1005.7837564923576, 1008.838585826279, 1089.3844977587637, 1129.249049382168, 1198.7302856857311, 26094.97418313029, 29499.41001180007, 29773.404531909673, 30375.240618984702, 30593.0, 1053.346924906563, 1095.3865835132192, 1118.7426891814928, 1158.5365853658604, 1228.0666693312967, 15027.774583381259, 15355.410461741216, 15462.149581772885, 15750.133742644264, 16082.0, 539385.0, 545644.0, 545703.0, 545941.0, 546259.0, 60846.0, 61283.387166127766, 61348.69325653343, 61365.69317153386, 61420.692896535234, 1461.861123193295, 1464.9818376228632, 1479.1938393575526, 1494.805675262209, 1496.880249580031, 29786.702132978393, 29859.70140298569, 29970.654975000045, 29989.55015674723, 30072.77194972099, 52081.0, 52432.737836310574, 52601.473985259654, 52682.209766852764, 52768.73615631897, 500365.476244043, 501085.0, 503177.0, 503705.0, 504058.0, 29078.7092129076, 46466.76766616145, 46520.302195467775, 46568.0, 48677.75661121672, 49315.50684493109, 49580.50419495903, 50104.99790004252, 50402.99194016172, 51673.0, 39726.20547588974, 40873.59126408698, 41028.0, 41650.791746041075, 43284.0, 34794.65205348015, 40086.1982760349, 42456.575434245264, 43153.784231078644, 43179.78410107929, 38696.41955370615, 39123.050795121286, 39789.0052748672, 40475.79762101288, 40665.39001914914, 31523.52714709327, 34319.65680343265, 35653.0, 36354.636453635125, 36524.0868978267, 25575.232743016993, 25766.742332576436, 26655.933762649278, 26949.326266843487, 27308.31729206786], "unit": "ms", "name": "ext.html", "value": 21133.127483992983}, {"lowerIsBetter": false, "replicates": [358.35138399496896, 359.5721091900638, 366.39727648019027, 367.1738588176603, 371.2556324569238, 16101.194940252999, 17417.564560885985, 17904.194311255993, 20905.790942090574, 21901.0, 21163.365099047052, 21219.0, 21403.785962140373, 21421.57156856862, 21422.464438389048, 6549.410553050237, 6744.0, 6744.629045402501, 6757.121574195372, 6765.830854228659, 4735.0, 5235.528802407783, 6685.2952497113165, 7621.809454763647, 7630.38956883448, 7450.0687414073245, 7503.437242206829, 7511.887321690179, 7561.962190189041, 7587.20334364892, 7502.737404190854, 7531.058617672791, 7536.057992750906, 7537.397008239328, 7553.622318884034, 7012.123484564429, 7207.351338379519, 7214.567125972459, 7221.602811845346, 7244.166920804069, 27050.57341792972, 27322.0, 27518.174454766387, 28175.43649127006, 28517.144485665256, 2063.13348393675, 2148.505843655952, 2222.0667319725594, 2248.1007596961344, 2320.953580928389, 9940.850887236697, 10064.798704025952, 12866.356682165855, 14583.708325833424, 15008.774868376873, 1657.1714142928536, 1695.8219386964438, 1709.3419033672, 1742.40758142231, 1748.5191572317588, 94046.47628189728, 97846.0, 98185.0, 99711.50144249306, 105478.94521054768, 9116.58975346111, 10707.946460267805, 11069.0, 11078.612248571262, 11175.273607215506, 13076.607701768962, 13092.0, 13098.345082745825, 13101.148425352321, 13123.737525249633, 8261.669533218605, 8327.167283271625, 8368.41421100517, 8409.032961209417, 8409.032961209417, 8550.657973680984, 8582.485050896967, 8587.742367728979, 8640.783980400414, 8666.090060543678, 4072.0430698785763, 4357.564243575681, 4397.758123303249, 4417.734935903856, 4435.977820110878, 1749.195370129729, 1784.634149999247, 1787.0975157545615, 1792.050213386907, 1794.0939825388095, 968.5496244246459, 1007.1690855044618, 1044.770150566874, 1045.7281106912105, 1093.4642025407493, 19623.313184038776, 20057.699134512994, 20509.0, 20612.793872061087, 20635.277765278443, 930.2465003347311, 933.9159475647224, 976.5654283843621, 1025.436010194405, 1033.0908800255727, 10180.490975451197, 10473.372485816764, 10549.678552012625, 10552.419616921143, 10557.102646275152, 769830.0, 775846.0, 780768.0, 789218.0, 791859.0, 123321.38339308425, 126432.0, 128939.0, 128983.35508322399, 131462.0, 1149.2357582207737, 1178.5403692559908, 1186.5550418593027, 1188.144535934126, 1222.1750318534953, 18139.365122220657, 18328.0, 18340.724889126406, 18389.080545972916, 18626.627467450846, 43535.78232108819, 48326.03347933092, 49300.0, 50432.0, 50940.490595095056, 72770.63614682104, 72856.27143728494, 72905.0, 73126.63436682783, 75966.24033759591, 9701.70894873155, 9750.561224745046, 9887.55506002246, 9918.652847150315, 9927.40435573868, 18884.43346699601, 19166.945817979587, 19231.230750769813, 19850.60298794045, 20068.297609583595, 10585.9470702646, 15613.921930390276, 16127.274272657993, 16130.435434759727, 16152.434664786677, 10959.338790525924, 12408.56570020045, 13287.534936277183, 15576.37694492253, 16022.038677679377, 13228.735425291248, 16000.839991599934, 16026.358945642043, 16434.0, 16667.0, 9537.904620953701, 9684.983076777118, 9781.0, 9789.0, 9803.460809655537, 10155.796884062129, 12965.35173241353, 15270.847291526943, 15906.0, 16165.67668646644], "unit": "ms", "name": "jquery.html", "value": 10359.69090102588}, {"lowerIsBetter": false, "replicates": [1461.9108763970844, 1629.8125715542715, 1904.8856418994887, 1933.0338305741022, 2004.098155829877, 6601.570897891634, 7523.623818809058, 7969.322607578363, 8095.554744489051, 8138.511689298646, 8205.548694821782, 8273.17268273174, 8352.498850069, 8358.205970432798, 8376.41365104443, 2110.4301838503593, 2158.57907707997, 2372.21716833445, 2396.508715713275, 2405.050005247926, 2374.323317854412, 2421.6125419932814, 2423.3578101803037, 2424.866632335221, 2430.4166999920067, 2333.8132949364094, 2379.0840526397374, 2393.4854006388623, 2401.0, 2405.891734871926, 2075.1180748182037, 2138.337115494186, 2144.9571008579896, 2326.0695721711368, 2333.614953532665, 2384.248961577115, 2385.5705972924866, 2385.8449200802065, 2387.7015373078366, 2393.844400113987, 8095.150009249061, 8211.302039326665, 8228.382871284617, 8253.504789712637, 8262.504249744974, 5072.137736584789, 5082.720450375228, 5159.458256883011, 5181.922271165936, 5189.065968125774, 3433.1760377509468, 3466.480027995821, 3517.3492903812876, 3561.6972557332656, 3563.1804684922613, 1012.731626119079, 1014.391365180893, 1041.9062284394365, 1042.5048102151493, 1054.4833031814355, 10919.508622112024, 10949.616763413322, 10999.23005389623, 11007.449627518672, 11025.44872756359, 4540.863774086717, 4660.04469083837, 4711.552402521755, 4715.764211789466, 4726.291056341507, 9590.136887680002, 9598.992105828927, 9612.66355677548, 9631.470269135125, 9675.080867317594, 5218.739063046833, 5231.456720267454, 5234.18870075139, 5234.581233501311, 5236.869078273074, 4698.0, 4701.647376446712, 4709.976450117728, 4733.95266047342, 4759.214729569651, 3831.7317787755146, 3854.4989151410136, 3856.9228615427533, 3879.8060096995036, 3886.7862267575556, 1108.6396921000708, 1282.3780466473752, 1283.6854970532092, 1291.2381694800113, 1293.1012946002627, 1356.8778809907155, 1367.5213675213595, 1390.0339264211277, 1429.671175629611, 1434.0391937401967, 7706.653200605986, 7834.294913457702, 7840.3727701784865, 7865.803354916173, 7871.055473343121, 497.14739222234044, 507.8628770232017, 508.69732509156995, 510.9335786347751, 511.6035072818521, 5643.181738647873, 5793.0, 5802.245708057925, 6280.371962803683, 6399.232092148972, 9027.548622568846, 9269.933957594963, 9803.656872009446, 9834.311598188058, 9862.824967054037, 8497.787555311166, 9744.90255097454, 9832.31173817826, 9896.307258491981, 9902.257330700082, 7808.0, 7808.68765249395, 7813.3749300057, 7828.608569571498, 7842.490238134617, 7662.846743064996, 7781.610919454118, 7822.061352637492, 7824.882626760489, 7831.647575858986, 8634.56827158652, 8768.473891566526, 8904.821903561762, 9090.36367454272, 9094.136057074567, 8839.204471597586, 9219.723408297761, 9353.438793672402, 9367.437953722798, 9374.906250937403, 7461.701531938662, 7801.4929029612895, 7876.763697089096, 7885.6845726172605, 7917.643706033127, 7089.539179953286, 7578.583177925267, 7942.563159026309, 8047.637856296364, 8053.597320133853, 6872.41584465326, 7182.928170718226, 7448.590327532038, 7500.512466689648, 7556.546607203585, 7039.19049309336, 7284.635768211462, 7298.233685463162, 7481.850362992601, 7483.027206463125, 7430.814229644302, 7502.437317201341, 7509.4367922404945, 7509.699612015676, 7510.136334321623, 6022.36765139654, 6617.834554136185, 6751.696173672099, 6822.931770682429, 6827.590344579341, 6233.407826256498, 6361.809145725636, 6906.8618627626165, 6936.514443988873, 6946.305369463013], "unit": "ms", "name": "mootools.html", "value": 4660.022208767131}, {"lowerIsBetter": false, "replicates": [317.55066580788184, 326.5884984919003, 327.74927180706754, 332.88848235841004, 336.77604393078605, 5454.481824226697, 6587.934120658792, 6736.090627765262, 6789.762358317454, 6795.796126116218, 6520.478361731062, 6651.933480665192, 6672.332766723325, 6678.332166783319, 6697.330266973312, 4912.508749125086, 4985.725785081819, 4988.052270068693, 4993.600511959053, 5027.019731152409, 4692.41344831896, 4749.59628431582, 4851.442084160331, 4987.576056035241, 5004.774785134678, 4892.070506603752, 4908.116539022993, 4914.459409464956, 4933.679310844784, 4937.481564435737, 4887.2913427552985, 4898.510148985109, 4903.65674402792, 4949.950500494985, 4951.207806750938, 4214.536400995888, 4222.725522841036, 4226.619604235603, 4233.089885674564, 4233.618974292298, 6238.532110091761, 6418.03729440583, 6434.420902118832, 6447.871042579122, 6455.967720161416, 4855.295982082614, 5892.734826932799, 5904.881902361972, 5912.379200184005, 5922.082077278029, 7177.0, 7181.856362872765, 7187.101612298463, 7187.3172048655815, 7190.424766018706, 4627.676062675614, 4727.385439892826, 4757.643176761757, 4779.5220477951925, 4799.352087468182, 6629.834254143637, 6895.758763422582, 7627.580483073429, 7648.464607477423, 7651.885221721679, 4806.399200099988, 4806.735629540409, 4807.567318941312, 4810.63920205986, 4813.735244561512, 4767.6662633615315, 4896.975515122473, 4906.067847109038, 4906.975465122651, 4922.212446008622, 5852.122181672783, 5903.616264942765, 5916.645001299936, 5919.704014799243, 5923.466887980103, 7248.0939882514685, 7248.746293879689, 7252.311030452099, 7256.818579535448, 7264.455165862581, 1718.1151706870971, 1742.7908650961713, 1744.0407775723302, 1745.4065617690046, 1750.2998800479656, 1093.9835902461468, 1113.1929351220301, 1121.8261169518737, 1135.6365962891796, 1137.3573930729112, 6808.8978665320055, 6854.794356169323, 6866.656667166621, 6876.862462750717, 6881.208661003949, 7277.526960747535, 7354.227806080392, 7430.071241094864, 7559.5464272143845, 7575.924240757632, 5874.295084589877, 6800.8299792504595, 6808.795736127924, 6825.112735344473, 6837.6581170942245, 3823.044238940265, 3945.6646185074014, 3973.145773658677, 3975.344068228768, 3978.42312864633, 6654.70053847578, 7545.660445279976, 7934.841303174019, 7939.6030198491, 7955.721549745731, 7876.72431464896, 7883.6058197089915, 7884.960575197088, 7901.407394445439, 7903.920960790433, 7775.805604859924, 7895.131535531087, 7901.130875603679, 7906.7627971160955, 7931.286184243446, 6291.653959032297, 6757.749816284003, 7098.538594991309, 7635.46551741395, 7647.579383133981, 6086.6348019119, 7402.074740657418, 7501.062367204099, 7517.43619228571, 7558.0, 7685.0, 7933.167017463315, 7945.682172713026, 7951.522908625501, 7956.9602151988865, 4730.455997560187, 4778.187708089564, 4779.450363208275, 4781.187198176388, 4804.471508134172, 7601.0, 7609.695612175451, 7612.7716168515035, 7623.932649429195, 7624.237576242332, 6569.901451478136, 7258.564486130849, 7315.926840731525, 7335.816604584928, 7359.1169059713175, 7321.524100933422, 7327.010853534704, 7330.890036649561, 7332.0, 7333.156686981066, 6920.204176519564, 7115.928840711526, 7130.322619351154, 7131.2512186221775, 7141.964290178724, 5974.9402505974385, 7318.707251710085, 7320.1215854097845, 7322.1579518356075, 7323.963380183065, 6003.489703375088, 6854.760083397057, 7107.324804143598, 7162.641867906688, 7167.7132914682825], "unit": "ms", "name": "prototype.html", "value": 5279.885054729003}, {"lowerIsBetter": false, "replicates": [750.2160242546539, 787.8306164174701, 804.8551260773058, 811.4684881402683, 870.5212133326671, 15159.166245856473, 15165.848341516608, 15501.84498155018, 15504.534863954072, 15510.457134000313, 14264.572062838106, 14498.492552760656, 14554.854451455509, 14592.343344549494, 14616.488422905173, 764.7208768799376, 775.8176828445311, 952.5284983932963, 974.7368210583138, 977.022977022977, 772.382094324541, 782.5500337306044, 956.2732323434205, 974.3082411487852, 974.8001659659752, 1007.4207330784791, 1008.0423597582289, 1019.3272440189477, 1021.9693409197699, 1022.115869772645, 795.4233180943827, 810.841885832263, 1011.1960991012163, 1019.1133713669118, 1022.616518805448, 597.447361190901, 598.3687209993456, 732.5494820685241, 746.6751962896103, 747.5066456138923, 14948.32732527028, 15177.24113794306, 15189.848101518954, 15191.62020949474, 15253.0, 12387.0, 12568.74862502754, 12764.744705105846, 12874.678133046655, 13161.868381316255, 9925.652602158962, 10208.183345332356, 10348.689539313833, 10354.79290414195, 10365.79268414635, 3533.982330088333, 3581.212133330663, 3583.516225309576, 3590.030691713249, 3590.5870824855215, 82347.5882620583, 82813.58593207055, 83295.583522082, 84326.0, 84608.15391846064, 9610.51947402627, 9691.27315451344, 9741.902580974242, 9818.607255709834, 10210.132138768287, 21460.356189314345, 21486.033128509254, 22082.44793880166, 22100.557988840454, 22216.444588885406, 7453.403727701771, 7595.810104747426, 7702.537847729154, 7735.342495887912, 7846.33306168982, 4042.15114825884, 4116.094459218967, 4116.197341518375, 4123.649489793401, 4124.505059392832, 3473.774204676688, 3527.8941631750577, 3529.7176225901867, 3530.770499917497, 3544.167120726627, 570.5492660798006, 607.7690477618477, 623.4171050068201, 624.4848000399688, 647.5984889368622, 486.3475300493321, 591.6952769323801, 597.3220394851875, 616.5314361085607, 655.1777519213452, 8446.366522510836, 8473.618687159093, 8505.23452889243, 8790.648374064966, 9386.249100071978, 523.8637954131877, 543.614034035839, 579.5508480927315, 620.444701991724, 635.9618422894641, 3844.115853353688, 4043.757374557536, 4072.6131017553284, 4115.794210289474, 4224.746515209097, 99952.0, 100035.49982250042, 100124.0, 101975.0, 102022.48988755008, 79968.20031799607, 80529.59735201286, 80959.0, 81137.0, 82675.5866220665, 72948.27051729521, 73626.63186684033, 74717.25282747211, 76691.61654191693, 77477.6126119377, 8443.66225350979, 8861.069587693457, 8887.866681999645, 8900.955495222483, 9044.41211321262, 50200.99598008092, 50593.0, 50917.0, 51712.0, 52843.73578132085, 70376.0, 72840.0, 73925.0, 75468.24531754832, 75568.0, 11022.944885275523, 11082.113430925669, 11278.702949160952, 11368.261063030877, 11511.251768635011, 11872.762544748884, 11967.880321196677, 12003.63989080329, 12006.459709313276, 12028.699282518008, 11424.82862757076, 11668.824967625662, 11788.351640659846, 11818.40907954616, 12074.45664945062, 11517.308961462339, 11554.42227888619, 11673.824892626788, 11790.646280611596, 11954.0, 9127.726168214964, 10190.145083235067, 11269.323840569592, 11501.009737468152, 11694.217353934868, 9544.809103817746, 9796.951015244878, 9851.16265117473, 9911.504424778876, 10020.24848136378, 8928.553572321487, 9324.207442367204, 9578.297954976444, 9881.407115573089, 9897.950510247403], "unit": "ms", "name": "yui.html", "value": 7065.818651465002}], "name": "dromaeo_css", "value": 7775.690874522929}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 109.0, 105.0, 110.0, 110.0, 111.0, 99.0, 110.0, 110.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 108.2}, {"lowerIsBetter": true, "replicates": [155.0, 132.0, 172.0, 151.0, 121.0, 164.0, 163.0, 143.0, 163.0, 143.0], "unit": "ms", "name": "audio-beat-detection", "value": 150.7}, {"lowerIsBetter": true, "replicates": [186.0, 184.0, 182.0, 185.0, 185.0, 185.0, 187.0, 190.0, 194.0, 258.0], "unit": "ms", "name": "audio-dft", "value": 193.6}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 77.0, 72.0, 80.0, 46.0, 53.0, 71.0, 94.0, 74.0], "unit": "ms", "name": "audio-fft", "value": 70.3}, {"lowerIsBetter": true, "replicates": [82.0, 84.0, 123.0, 74.0, 76.0, 74.0, 114.0, 74.0, 74.0, 114.0], "unit": "ms", "name": "audio-oscillator", "value": 88.9}, {"lowerIsBetter": true, "replicates": [89.0, 87.0, 87.0, 89.0, 87.0, 130.0, 128.0, 89.0, 88.0, 88.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 96.2}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 94.0, 95.0, 95.0, 94.0], "unit": "ms", "name": "imaging-darkroom", "value": 95.2}, {"lowerIsBetter": true, "replicates": [85.0, 87.0, 85.0, 87.0, 85.0, 86.0, 85.0, 85.0, 87.0, 84.0], "unit": "ms", "name": "imaging-desaturate", "value": 85.6}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 57.0, 56.0, 54.0, 54.0, 53.0, 65.0, 53.0, 55.0], "unit": "ms", "name": "json-parse-financial", "value": 55.8}, {"lowerIsBetter": true, "replicates": [55.0, 88.0, 97.0, 79.0, 65.0, 68.0, 72.0, 70.0, 66.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 72.9}, {"lowerIsBetter": true, "replicates": [81.0, 79.0, 83.0, 83.0, 80.0, 83.0, 83.0, 82.0, 83.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 81.9}, {"lowerIsBetter": true, "replicates": [123.0, 130.0, 122.0, 123.0, 130.0, 126.0, 125.0, 132.0, 125.0, 122.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 125.8}, {"lowerIsBetter": true, "replicates": [132.0, 134.0, 134.0, 134.0, 137.0, 131.0, 135.0, 133.0, 134.0, 122.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 132.6}, {"lowerIsBetter": true, "replicates": [63.0, 65.0, 64.0, 65.0, 67.0, 65.0, 64.0, 68.0, 64.0, 65.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 65.0}], "name": "kraken", "value": 1422.6999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [148.54426619132502], "unit": "score", "name": "Richards", "value": 237.653064}, {"lowerIsBetter": false, "replicates": [161.86468112657818], "unit": "score", "name": "DeltaBlue", "value": 408.47700399999985}, {"lowerIsBetter": false, "replicates": [309.2145949288806], "unit": "score", "name": "Encrypt", "value": 860.829354}, {"lowerIsBetter": false, "replicates": [4784.688995215311], "unit": "score", "name": "Decrypt", "value": 55.63182899999996}, {"lowerIsBetter": false, "replicates": [1696.6101694915253], "unit": "score", "name": "RayTrace", "value": 436.15735264735275}, {"lowerIsBetter": false, "replicates": [792.3930269413629], "unit": "score", "name": "Earley", "value": 841.0763060000003}, {"lowerIsBetter": false, "replicates": [12612.5], "unit": "score", "name": "Boyer", "value": 52.84146679881068}, {"lowerIsBetter": false, "replicates": [26973.684210526317], "unit": "score", "name": "RegExp", "value": 33.77310243902437}, {"lowerIsBetter": false, "replicates": [613.0012150668286], "unit": "score", "name": "Splay", "value": 132.937746283449}, {"lowerIsBetter": false, "replicates": [4504.504504504504], "unit": "score", "name": "NavierStokes", "value": 329.44800000000015}], "name": "v8_7", "value": 20614.927010469382}]} 13:08:42 INFO - RETURN: dromaeo_css: 7775.69 13:08:42 INFO - RETURN: kraken: 1422.70 13:08:42 INFO - RETURN: v8_7: 20614.93 13:08:42 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,59]]", "result": "20614.93"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1422.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7775.69"}}} 13:08:42 INFO - Return code: 0 13:08:42 INFO - # TBPL SUCCESS # 13:08:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:08:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:08:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:08:42 INFO - 2015-11-23 13:08:42.094 screenresolution[2547:127905] starting screenresolution argv=screenresolution get 13:08:42 INFO - 2015-11-23 13:08:42.097 screenresolution[2547:127905] Display 0: 1600x1200x32@60 13:08:42 INFO - 2015-11-23 13:08:42.103 screenresolution[2548:127908] starting screenresolution argv=screenresolution list 13:08:42 INFO - Available Modes on Display 0 13:08:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:08:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:08:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:08:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:08:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:08:42 INFO - Intel Iris: 13:08:42 INFO - Chipset Model: Intel Iris 13:08:42 INFO - Type: GPU 13:08:42 INFO - Bus: Built-In 13:08:42 INFO - VRAM (Dynamic, Max): 1536 MB 13:08:42 INFO - Vendor: Intel (0x8086) 13:08:42 INFO - Device ID: 0x0a2e 13:08:42 INFO - Revision ID: 0x0009 13:08:42 INFO - Displays: 13:08:42 INFO - Display: 13:08:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:08:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:08:42 INFO - Display Serial Number: 1600x1200 60 13:08:42 INFO - Main Display: Yes 13:08:42 INFO - Mirror: Off 13:08:42 INFO - Online: Yes 13:08:42 INFO - Rotation: Supported 13:08:42 INFO - Return code: 0 13:08:42 INFO - Running post-action listener: _resource_record_post_action 13:08:42 INFO - Running post-run listener: _resource_record_post_run 13:08:43 INFO - Total resource usage - Wall time: 1239s; CPU: 53.0%; Read bytes: 12288; Write bytes: 687527424; Read time: 0; Write time: 2023 13:08:43 INFO - install - Wall time: 31s; CPU: 55.0%; Read bytes: 334744064; Write bytes: 337623040; Read time: 26054; Write time: 639 13:08:43 INFO - run-tests - Wall time: 1209s; CPU: 53.0%; Read bytes: 12288; Write bytes: 339537408; Read time: 0; Write time: 1351 13:08:43 INFO - Running post-run listener: _upload_blobber_files 13:08:43 INFO - Blob upload gear active. 13:08:43 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 13:08:43 INFO - Copying logs to upload dir... 13:08:43 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1281.869211 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2015-11-23 13:08:43.463826) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 13:08:43.467274) ========= 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.MUwXuQL6uA/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.rcVdDIaxbA/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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:0:0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/MdSlRE8ESpqsXU1pNGJNhw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009711 build_url: 'https://queue.taskcluster.net/v1/task/MdSlRE8ESpqsXU1pNGJNhw/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-23 13:08:43.497728) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 13:08:43.498257) ========= 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.MUwXuQL6uA/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.rcVdDIaxbA/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005458 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 13:08:43.549970) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 13:08:43.550526) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 13:08:43.551155) ========= ========= Total master_lag: 0.23 =========