builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0061 starttime: 1448359713.55 results: success (0) buildid: 20151124000443 builduid: cc3120ac02d24544bb21c3199fbe8540 revision: 01d196350d2430972143290226fb0d7866aece78 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 02:08:33.551846) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 02:08:33.552283) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 02:08:33.552613) ========= 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.pb3QlLg0g4/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.Dh0JYUoKlh/Listeners TMPDIR=/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/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.005180 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 02:08:33.573767) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 02:08:33.574111) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 02:08:33.590507) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 02:08:33.590911) ========= 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.pb3QlLg0g4/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.Dh0JYUoKlh/Listeners TMPDIR=/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/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.006312 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 02:08:33.639570) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 02:08:33.639880) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 02:08:33.640221) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 02:08:33.640486) ========= 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.pb3QlLg0g4/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.Dh0JYUoKlh/Listeners TMPDIR=/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/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-24 02:08:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 14.3M=0.001s 2015-11-24 02:08:33 (14.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.187620 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 02:08:33.841205) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 02:08:33.841540) ========= 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.pb3QlLg0g4/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.Dh0JYUoKlh/Listeners TMPDIR=/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/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.025509 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 02:08:33.889244) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-24 02:08:33.889594) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 01d196350d2430972143290226fb0d7866aece78 --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 01d196350d2430972143290226fb0d7866aece78 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.pb3QlLg0g4/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.Dh0JYUoKlh/Listeners TMPDIR=/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/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-24 02:08:33,970 truncating revision to first 12 chars 2015-11-24 02:08:33,970 Setting DEBUG logging. 2015-11-24 02:08:33,970 attempt 1/10 2015-11-24 02:08:33,970 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/01d196350d24?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-24 02:08:35,559 unpacking tar archive at: fx-team-01d196350d24/testing/mozharness/ program finished with exit code 0 elapsedTime=1.827774 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-24 02:08:35.731304) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 02:08:35.731680) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 02:08:35.742415) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 02:08:35.742745) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 02:08:35.743239) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2015-11-24 02:08:35.743534) ========= /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.pb3QlLg0g4/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.Dh0JYUoKlh/Listeners TMPDIR=/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/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 02:08:35 INFO - MultiFileLogger online at 20151124 02:08:35 in /builds/slave/test 02:08:35 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 02:08:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:08:35 INFO - {'append_to_log': False, 02:08:35 INFO - 'base_work_dir': '/builds/slave/test', 02:08:35 INFO - 'blob_upload_branch': 'Fx-Team', 02:08:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:08:35 INFO - 'branch': 'Fx-Team', 02:08:35 INFO - 'buildbot_json_path': 'buildprops.json', 02:08:35 INFO - 'config_files': ('talos/mac_config.py',), 02:08:35 INFO - 'default_actions': ('clobber', 02:08:35 INFO - 'read-buildbot-config', 02:08:35 INFO - 'download-and-extract', 02:08:35 INFO - 'populate-webroot', 02:08:35 INFO - 'create-virtualenv', 02:08:35 INFO - 'install', 02:08:35 INFO - 'run-tests'), 02:08:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:08:35 INFO - 'download_minidump_stackwalk': True, 02:08:35 INFO - 'download_symbols': 'ondemand', 02:08:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:08:35 INFO - 'tooltool.py': '/tools/tooltool.py', 02:08:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:08:35 INFO - '/tools/misc-python/virtualenv.py')}, 02:08:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:08:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:08:35 INFO - 'installer_path': 'installer.exe', 02:08:35 INFO - 'log_level': 'info', 02:08:35 INFO - 'log_name': 'talos', 02:08:35 INFO - 'log_to_console': True, 02:08:35 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:08:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:08:35 INFO - 'opt_config_files': (), 02:08:35 INFO - 'pip_index': False, 02:08:35 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:08:35 INFO - 'cmd': ('bash', 02:08:35 INFO - '-c', 02:08:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:08:35 INFO - 'enabled': True, 02:08:35 INFO - 'halt_on_failure': False, 02:08:35 INFO - 'name': 'check_screen_resolution'},), 02:08:35 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:08:35 INFO - 'cmd': ('bash', 02:08:35 INFO - '-c', 02:08:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:08:35 INFO - 'enabled': True, 02:08:35 INFO - 'halt_on_failure': False, 02:08:35 INFO - 'name': 'check_screen_resolution'},), 02:08:35 INFO - 'run_cmd_checks_enabled': True, 02:08:35 INFO - 'sps_profile': False, 02:08:35 INFO - 'sps_profile_interval': 0, 02:08:35 INFO - 'suite': 'dromaeojs', 02:08:35 INFO - 'system_bits': '64', 02:08:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:08:35 INFO - 'title': 't-yosemite-r7-0061', 02:08:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:08:35 INFO - 'use_talos_json': True, 02:08:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:08:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:08:35 INFO - 'work_dir': 'build'} 02:08:35 INFO - ##### 02:08:35 INFO - ##### Running clobber step. 02:08:35 INFO - ##### 02:08:35 INFO - Running pre-action listener: _resource_record_pre_action 02:08:35 INFO - Running main action method: clobber 02:08:35 INFO - rmtree: /builds/slave/test/build 02:08:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:08:37 INFO - Running post-action listener: _resource_record_post_action 02:08:37 INFO - ##### 02:08:37 INFO - ##### Running read-buildbot-config step. 02:08:37 INFO - ##### 02:08:37 INFO - Running pre-action listener: _resource_record_pre_action 02:08:37 INFO - Running main action method: read_buildbot_config 02:08:37 INFO - Using buildbot properties: 02:08:37 INFO - { 02:08:37 INFO - "properties": { 02:08:37 INFO - "buildnumber": 24, 02:08:37 INFO - "product": "firefox", 02:08:37 INFO - "script_repo_revision": "production", 02:08:37 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 02:08:37 INFO - "repository": "", 02:08:37 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 02:08:37 INFO - "buildid": "20151124000443", 02:08:37 INFO - "slavename": "t-yosemite-r7-0061", 02:08:37 INFO - "pgo_build": "False", 02:08:37 INFO - "basedir": "/builds/slave/test", 02:08:37 INFO - "project": "", 02:08:37 INFO - "platform": "yosemite_r7", 02:08:37 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 02:08:37 INFO - "slavebuilddir": "test", 02:08:37 INFO - "scheduler": "tests-fx-team-macosx64-talos", 02:08:37 INFO - "branch": "fx-team", 02:08:37 INFO - "repo_path": "integration/fx-team", 02:08:37 INFO - "stage_platform": "macosx64", 02:08:37 INFO - "builduid": "cc3120ac02d24544bb21c3199fbe8540", 02:08:37 INFO - "revision": "01d196350d2430972143290226fb0d7866aece78" 02:08:37 INFO - }, 02:08:37 INFO - "sourcestamp": { 02:08:37 INFO - "repository": "", 02:08:37 INFO - "hasPatch": false, 02:08:37 INFO - "project": "", 02:08:37 INFO - "branch": "fx-team-macosx64-talos", 02:08:37 INFO - "changes": [ 02:08:37 INFO - { 02:08:37 INFO - "category": null, 02:08:37 INFO - "files": [ 02:08:37 INFO - { 02:08:37 INFO - "url": null, 02:08:37 INFO - "name": "https://queue.taskcluster.net/v1/task/hta-UQZgQceAG-88cW9C6w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 02:08:37 INFO - } 02:08:37 INFO - ], 02:08:37 INFO - "repository": "", 02:08:37 INFO - "rev": "01d196350d2430972143290226fb0d7866aece78", 02:08:37 INFO - "who": "cbook@mozilla.com", 02:08:37 INFO - "when": 1448359150, 02:08:37 INFO - "number": 6699532, 02:08:37 INFO - "comments": "Bug 1209341 - allow loading unsigned restartless add-ons at runtime. r=mossop", 02:08:37 INFO - "project": "", 02:08:37 INFO - "at": "Tue 24 Nov 2015 01:59:10", 02:08:37 INFO - "branch": "fx-team-macosx64-talos", 02:08:37 INFO - "revlink": "", 02:08:37 INFO - "properties": [ 02:08:37 INFO - [ 02:08:37 INFO - "buildid", 02:08:37 INFO - "20151124000443", 02:08:37 INFO - "Change" 02:08:37 INFO - ], 02:08:37 INFO - [ 02:08:37 INFO - "builduid", 02:08:37 INFO - "cc3120ac02d24544bb21c3199fbe8540", 02:08:37 INFO - "Change" 02:08:37 INFO - ], 02:08:37 INFO - [ 02:08:37 INFO - "pgo_build", 02:08:37 INFO - "False", 02:08:37 INFO - "Change" 02:08:37 INFO - ] 02:08:37 INFO - ], 02:08:37 INFO - "revision": "01d196350d2430972143290226fb0d7866aece78" 02:08:37 INFO - } 02:08:37 INFO - ], 02:08:37 INFO - "revision": "01d196350d2430972143290226fb0d7866aece78" 02:08:37 INFO - } 02:08:37 INFO - } 02:08:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/hta-UQZgQceAG-88cW9C6w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 02:08:37 INFO - Running post-action listener: _resource_record_post_action 02:08:37 INFO - ##### 02:08:37 INFO - ##### Running download-and-extract step. 02:08:37 INFO - ##### 02:08:37 INFO - Running pre-action listener: _resource_record_pre_action 02:08:37 INFO - Running main action method: download_and_extract 02:08:37 INFO - mkdir: /builds/slave/test/build/tests 02:08:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:08:37 INFO - https://queue.taskcluster.net/v1/task/hta-UQZgQceAG-88cW9C6w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:08:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hta-UQZgQceAG-88cW9C6w/artifacts/public/build/test_packages.json 02:08:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hta-UQZgQceAG-88cW9C6w/artifacts/public/build/test_packages.json 02:08:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hta-UQZgQceAG-88cW9C6w/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 02:08:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hta-UQZgQceAG-88cW9C6w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 02:08:38 INFO - Downloaded 1149 bytes. 02:08:38 INFO - Reading from file /builds/slave/test/build/test_packages.json 02:08:38 INFO - Using the following test package requirements: 02:08:38 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 02:08:38 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 02:08:38 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 02:08:38 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 02:08:38 INFO - u'jsshell-mac.zip'], 02:08:38 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 02:08:38 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 02:08:38 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 02:08:38 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 02:08:38 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 02:08:38 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 02:08:38 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 02:08:38 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 02:08:38 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 02:08:38 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 02:08:38 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 02:08:38 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 02:08:38 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 02:08:38 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')]} 02:08:38 INFO - https://queue.taskcluster.net/v1/task/hta-UQZgQceAG-88cW9C6w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:08:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hta-UQZgQceAG-88cW9C6w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 02:08:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hta-UQZgQceAG-88cW9C6w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 02:08:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hta-UQZgQceAG-88cW9C6w/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 02:08:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hta-UQZgQceAG-88cW9C6w/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 02:08:39 INFO - Downloaded 17527016 bytes. 02:08:39 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 02:08:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 02:08:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 02:08:42 INFO - Return code: 0 02:08:42 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 02:08:42 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')]} 02:08:42 INFO - https://queue.taskcluster.net/v1/task/hta-UQZgQceAG-88cW9C6w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:08:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hta-UQZgQceAG-88cW9C6w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 02:08:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hta-UQZgQceAG-88cW9C6w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 02:08:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hta-UQZgQceAG-88cW9C6w/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 02:08:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hta-UQZgQceAG-88cW9C6w/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 02:08:43 INFO - Downloaded 17527016 bytes. 02:08:43 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 02:08:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 02:08:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 02:08:46 INFO - Return code: 0 02:08:46 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')]} 02:08:46 INFO - https://queue.taskcluster.net/v1/task/hta-UQZgQceAG-88cW9C6w/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:08:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hta-UQZgQceAG-88cW9C6w/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 02:08:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hta-UQZgQceAG-88cW9C6w/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 02:08:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hta-UQZgQceAG-88cW9C6w/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 02:08:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hta-UQZgQceAG-88cW9C6w/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 02:08:47 INFO - Downloaded 11130997 bytes. 02:08:47 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 02:08:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 02:08:47 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 02:08:47 INFO - Return code: 0 02:08:47 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')]} 02:08:47 INFO - https://queue.taskcluster.net/v1/task/hta-UQZgQceAG-88cW9C6w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 02:08:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hta-UQZgQceAG-88cW9C6w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 02:08:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hta-UQZgQceAG-88cW9C6w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 02:08:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hta-UQZgQceAG-88cW9C6w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 02:08:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hta-UQZgQceAG-88cW9C6w/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 02:08:50 INFO - Downloaded 109915660 bytes. 02:08:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/hta-UQZgQceAG-88cW9C6w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 02:08:50 INFO - mkdir: /builds/slave/test/properties 02:08:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:08:50 INFO - Writing to file /builds/slave/test/properties/build_url 02:08:50 INFO - Contents: 02:08:50 INFO - build_url:https://queue.taskcluster.net/v1/task/hta-UQZgQceAG-88cW9C6w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 02:08:50 INFO - Running post-action listener: _resource_record_post_action 02:08:50 INFO - Running post-action listener: set_extra_try_arguments 02:08:50 INFO - ##### 02:08:50 INFO - ##### Running populate-webroot step. 02:08:50 INFO - ##### 02:08:50 INFO - Running pre-action listener: _resource_record_pre_action 02:08:50 INFO - Running main action method: populate_webroot 02:08:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:08:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:08:50 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 02:08:50 INFO - '../fennec_ids.txt'], 02:08:50 INFO - 'tests': ['tcheck2']}, 02:08:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:08:50 INFO - '--tppagecycles', 02:08:50 INFO - '7'], 02:08:50 INFO - 'tests': ['tsvgm']}}, 02:08:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:08:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:08:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:08:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:08:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:08:50 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:08:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:08:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:08:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:08:50 INFO - 'talos_options': ['--e10s'], 02:08:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:08:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:08:50 INFO - 'tests': ['damp', 'tps']}, 02:08:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:08:50 INFO - 'talos_options': ['--e10s'], 02:08:50 INFO - 'tests': ['damp', 'tps']}, 02:08:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:08:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:08:50 INFO - 'other': {'tests': ['a11yr', 02:08:50 INFO - 'ts_paint', 02:08:50 INFO - 'tpaint', 02:08:50 INFO - 'sessionrestore', 02:08:50 INFO - 'sessionrestore_no_auto_restore']}, 02:08:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:08:50 INFO - 'tests': ['a11yr', 02:08:50 INFO - 'ts_paint', 02:08:50 INFO - 'tpaint', 02:08:50 INFO - 'sessionrestore', 02:08:50 INFO - 'sessionrestore_no_auto_restore']}, 02:08:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:08:50 INFO - 'tests': ['a11yr', 02:08:50 INFO - 'ts_paint', 02:08:50 INFO - 'tpaint', 02:08:50 INFO - 'sessionrestore', 02:08:50 INFO - 'sessionrestore_no_auto_restore']}, 02:08:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:08:50 INFO - 'tests': ['a11yr', 02:08:50 INFO - 'ts_paint', 02:08:50 INFO - 'tpaint', 02:08:50 INFO - 'sessionrestore', 02:08:50 INFO - 'sessionrestore_no_auto_restore']}, 02:08:50 INFO - 'other_l64': {'tests': ['a11yr', 02:08:50 INFO - 'ts_paint', 02:08:50 INFO - 'tpaint', 02:08:50 INFO - 'sessionrestore', 02:08:50 INFO - 'sessionrestore_no_auto_restore']}, 02:08:50 INFO - 'other_nol64': {'tests': ['a11yr', 02:08:50 INFO - 'ts_paint', 02:08:50 INFO - 'tpaint', 02:08:50 INFO - 'sessionrestore', 02:08:50 INFO - 'sessionrestore_no_auto_restore']}, 02:08:50 INFO - 'svgr': {'tests': ['tsvgx', 02:08:50 INFO - 'tsvgr_opacity', 02:08:50 INFO - 'tart', 02:08:50 INFO - 'tscrollx', 02:08:50 INFO - 'cart']}, 02:08:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:08:50 INFO - 'tests': ['tsvgx', 02:08:50 INFO - 'tsvgr_opacity', 02:08:50 INFO - 'tart', 02:08:50 INFO - 'tscrollx', 02:08:50 INFO - 'cart']}, 02:08:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:08:50 INFO - 'tests': ['tp5o']}, 02:08:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:08:50 INFO - 'talos_options': ['--e10s'], 02:08:50 INFO - 'tests': ['tp5o']}, 02:08:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:08:50 INFO - 'talos_options': ['--xperf_path', 02:08:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:08:50 INFO - 'tests': ['tp5n']}, 02:08:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:08:50 INFO - 'talos_options': ['--e10s', 02:08:50 INFO - '--xperf_path', 02:08:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:08:50 INFO - 'tests': ['tp5n']}}, 02:08:50 INFO - 'talos.zip': {'path': '', 02:08:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:08:50 INFO - Running post-action listener: _resource_record_post_action 02:08:50 INFO - ##### 02:08:50 INFO - ##### Running create-virtualenv step. 02:08:50 INFO - ##### 02:08:50 INFO - Running pre-action listener: _resource_record_pre_action 02:08:50 INFO - Running main action method: create_virtualenv 02:08:50 INFO - Creating virtualenv /builds/slave/test/build/venv 02:08:50 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 02:08:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:08:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:08:51 INFO - Using real prefix '/tools/python27' 02:08:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:08:51 INFO - Installing distribute.............................................................................................................................................................................................done. 02:08:54 INFO - Installing pip.................done. 02:08:54 INFO - Return code: 0 02:08:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:08:54 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')]} 02:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:54 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')]} 02:08:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:54 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 0x102e56490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e33228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd68db3900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d7a9f0>, '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 0x102ad9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d6d8c8>, '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.pb3QlLg0g4/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.Dh0JYUoKlh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/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 02:08:54 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 02:08:54 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 02:08:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pb3QlLg0g4/Render', 02:08:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:08:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:08:54 INFO - 'HOME': '/Users/cltbld', 02:08:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:08:54 INFO - 'LOGNAME': 'cltbld', 02:08:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:54 INFO - 'MOZ_NO_REMOTE': '1', 02:08:54 INFO - 'NO_EM_RESTART': '1', 02:08:54 INFO - 'PAGER': '/bin/cat', 02:08:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:08:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:54 INFO - 'PWD': '/builds/slave/test', 02:08:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:08:54 INFO - 'SHELL': '/bin/bash', 02:08:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Dh0JYUoKlh/Listeners', 02:08:54 INFO - 'TMPDIR': '/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/', 02:08:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:08:54 INFO - 'USER': 'cltbld', 02:08:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:08:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:08:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:54 INFO - 'XPC_FLAGS': '0x0', 02:08:54 INFO - 'XPC_SERVICE_NAME': '0', 02:08:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:08:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:54 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 02:08:54 INFO - Cleaning up... 02:08:54 INFO - Return code: 0 02:08:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:08:54 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')]} 02:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:54 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')]} 02:08:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:54 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 0x102e56490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e33228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd68db3900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d7a9f0>, '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 0x102ad9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d6d8c8>, '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.pb3QlLg0g4/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.Dh0JYUoKlh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/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 02:08:54 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 02:08:54 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 02:08:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pb3QlLg0g4/Render', 02:08:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:08:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:08:55 INFO - 'HOME': '/Users/cltbld', 02:08:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:08:55 INFO - 'LOGNAME': 'cltbld', 02:08:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:55 INFO - 'MOZ_NO_REMOTE': '1', 02:08:55 INFO - 'NO_EM_RESTART': '1', 02:08:55 INFO - 'PAGER': '/bin/cat', 02:08:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:08:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:55 INFO - 'PWD': '/builds/slave/test', 02:08:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:08:55 INFO - 'SHELL': '/bin/bash', 02:08:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Dh0JYUoKlh/Listeners', 02:08:55 INFO - 'TMPDIR': '/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/', 02:08:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:08:55 INFO - 'USER': 'cltbld', 02:08:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:08:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:08:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:55 INFO - 'XPC_FLAGS': '0x0', 02:08:55 INFO - 'XPC_SERVICE_NAME': '0', 02:08:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:08:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:55 INFO - Downloading/unpacking psutil>=0.7.1 02:08:55 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 02:08:55 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 02:08:55 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 02:08:55 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 02:08:55 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 02:08:55 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 02:08:57 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 02:08:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 02:08:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:08:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:08:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:08:57 INFO - Installing collected packages: psutil 02:08:57 INFO - Running setup.py install for psutil 02:08:57 INFO - building 'psutil._psutil_osx' extension 02:08:57 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 02:08:58 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 02:08:58 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 02:08:58 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 02:08:58 INFO - building 'psutil._psutil_posix' extension 02:08:58 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 02:08:58 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:08:58 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:08:58 INFO - ^ 02:08:58 INFO - 1 warning generated. 02:08:58 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 02:08:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:08:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:08:58 INFO - Successfully installed psutil 02:08:58 INFO - Cleaning up... 02:08:58 INFO - Return code: 0 02:08:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:08:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:08:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x102e56490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e33228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd68db3900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d7a9f0>, '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 0x102ad9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d6d8c8>, '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.pb3QlLg0g4/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.Dh0JYUoKlh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/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 02:08:58 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 02:08:58 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 02:08:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pb3QlLg0g4/Render', 02:08:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:08:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:08:58 INFO - 'HOME': '/Users/cltbld', 02:08:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:08:58 INFO - 'LOGNAME': 'cltbld', 02:08:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:58 INFO - 'MOZ_NO_REMOTE': '1', 02:08:58 INFO - 'NO_EM_RESTART': '1', 02:08:58 INFO - 'PAGER': '/bin/cat', 02:08:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:08:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:58 INFO - 'PWD': '/builds/slave/test', 02:08:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:08:58 INFO - 'SHELL': '/bin/bash', 02:08:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Dh0JYUoKlh/Listeners', 02:08:58 INFO - 'TMPDIR': '/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/', 02:08:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:08:58 INFO - 'USER': 'cltbld', 02:08:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:08:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:08:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:58 INFO - 'XPC_FLAGS': '0x0', 02:08:58 INFO - 'XPC_SERVICE_NAME': '0', 02:08:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:08:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:08: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 02:08: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 02:08: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 02:08: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 02:08: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 02:08: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 02:09:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:09:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 02:09:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:09:01 INFO - Installing collected packages: mozsystemmonitor 02:09:01 INFO - Running setup.py install for mozsystemmonitor 02:09:01 INFO - Successfully installed mozsystemmonitor 02:09:01 INFO - Cleaning up... 02:09:01 INFO - Return code: 0 02:09:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:09:01 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')]} 02:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:01 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')]} 02:09:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:01 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 0x102e56490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e33228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd68db3900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d7a9f0>, '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 0x102ad9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d6d8c8>, '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.pb3QlLg0g4/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.Dh0JYUoKlh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/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 02:09:01 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 02:09:01 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 02:09:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pb3QlLg0g4/Render', 02:09:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:09:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:09:01 INFO - 'HOME': '/Users/cltbld', 02:09:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:09:01 INFO - 'LOGNAME': 'cltbld', 02:09:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:01 INFO - 'MOZ_NO_REMOTE': '1', 02:09:01 INFO - 'NO_EM_RESTART': '1', 02:09:01 INFO - 'PAGER': '/bin/cat', 02:09:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:09:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:01 INFO - 'PWD': '/builds/slave/test', 02:09:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:09:01 INFO - 'SHELL': '/bin/bash', 02:09:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Dh0JYUoKlh/Listeners', 02:09:01 INFO - 'TMPDIR': '/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/', 02:09:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:09:01 INFO - 'USER': 'cltbld', 02:09:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:09:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:09:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:01 INFO - 'XPC_FLAGS': '0x0', 02:09:01 INFO - 'XPC_SERVICE_NAME': '0', 02:09:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:09:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:01 INFO - Downloading/unpacking blobuploader==1.2.4 02:09:01 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 02:09:01 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 02:09:01 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 02:09:01 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 02:09:01 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 02:09:01 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 02:09:03 INFO - Downloading blobuploader-1.2.4.tar.gz 02:09:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 02:09:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:09:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:09:04 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 02:09:04 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 02:09:04 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 02:09:04 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 02:09:04 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 02:09:04 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 02:09:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 02:09:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:09:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:09:04 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 02:09:04 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 02:09:04 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 02:09:04 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 02:09:04 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 02:09:04 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 02:09:05 INFO - Downloading docopt-0.6.1.tar.gz 02:09:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 02:09:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:09:05 INFO - Installing collected packages: blobuploader, requests, docopt 02:09:05 INFO - Running setup.py install for blobuploader 02:09:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:09:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:09:05 INFO - Running setup.py install for requests 02:09:05 INFO - Running setup.py install for docopt 02:09:05 INFO - Successfully installed blobuploader requests docopt 02:09:05 INFO - Cleaning up... 02:09:05 INFO - Return code: 0 02:09:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:09:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:09:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:05 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 0x102e56490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e33228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd68db3900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d7a9f0>, '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 0x102ad9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d6d8c8>, '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.pb3QlLg0g4/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.Dh0JYUoKlh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/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 02:09:05 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 02:09:05 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 02:09:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pb3QlLg0g4/Render', 02:09:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:09:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:09:05 INFO - 'HOME': '/Users/cltbld', 02:09:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:09:05 INFO - 'LOGNAME': 'cltbld', 02:09:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:05 INFO - 'MOZ_NO_REMOTE': '1', 02:09:05 INFO - 'NO_EM_RESTART': '1', 02:09:05 INFO - 'PAGER': '/bin/cat', 02:09:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:09:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:05 INFO - 'PWD': '/builds/slave/test', 02:09:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:09:05 INFO - 'SHELL': '/bin/bash', 02:09:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Dh0JYUoKlh/Listeners', 02:09:05 INFO - 'TMPDIR': '/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/', 02:09:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:09:05 INFO - 'USER': 'cltbld', 02:09:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:09:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:09:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:05 INFO - 'XPC_FLAGS': '0x0', 02:09:05 INFO - 'XPC_SERVICE_NAME': '0', 02:09:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:09:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:09:06 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-GML36S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:09:06 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-etpui9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:09:06 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-q8Xvli-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:09:06 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-Q5VCHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:09:06 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-b_qNfz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:09:06 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-Ew0B4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:09:06 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-njXR9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:09:06 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-VXfNQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:09:07 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-mu83bJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:09:07 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-0vvxal-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:09:07 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-Azaazv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:09:07 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-LHm1J1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:09:07 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-meFbhN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:09:07 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-EOSCJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:09:07 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-kBfrAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:09:07 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-Liwnxm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:09:07 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-DXIMlP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:09:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:09:07 INFO - Running setup.py install for manifestparser 02:09:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:09:08 INFO - Running setup.py install for mozcrash 02:09:08 INFO - Running setup.py install for mozdebug 02:09:08 INFO - Running setup.py install for mozdevice 02:09:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:09:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:09:08 INFO - Running setup.py install for mozfile 02:09:08 INFO - Running setup.py install for mozhttpd 02:09:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:09:08 INFO - Running setup.py install for mozinfo 02:09:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:09:09 INFO - Running setup.py install for mozInstall 02:09:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:09:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:09:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:09:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:09:09 INFO - Running setup.py install for mozleak 02:09:09 INFO - Running setup.py install for mozlog 02:09:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:09:09 INFO - Running setup.py install for moznetwork 02:09:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:09:09 INFO - Running setup.py install for mozprocess 02:09:09 INFO - Running setup.py install for mozprofile 02:09:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:09:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:09:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:09:09 INFO - Running setup.py install for mozrunner 02:09:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:09:10 INFO - Running setup.py install for mozscreenshot 02:09:10 INFO - Running setup.py install for moztest 02:09:10 INFO - Running setup.py install for mozversion 02:09:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:09:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:09:10 INFO - Cleaning up... 02:09:10 INFO - Return code: 0 02:09:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:09:10 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')]} 02:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:10 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')]} 02:09:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:10 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 0x102e56490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e33228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd68db3900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d7a9f0>, '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 0x102ad9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d6d8c8>, '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.pb3QlLg0g4/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.Dh0JYUoKlh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/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 02:09:10 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 02:09:10 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 02:09:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pb3QlLg0g4/Render', 02:09:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:09:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:09:10 INFO - 'HOME': '/Users/cltbld', 02:09:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:09:10 INFO - 'LOGNAME': 'cltbld', 02:09:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:10 INFO - 'MOZ_NO_REMOTE': '1', 02:09:10 INFO - 'NO_EM_RESTART': '1', 02:09:10 INFO - 'PAGER': '/bin/cat', 02:09:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:09:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:10 INFO - 'PWD': '/builds/slave/test', 02:09:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:09:10 INFO - 'SHELL': '/bin/bash', 02:09:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Dh0JYUoKlh/Listeners', 02:09:10 INFO - 'TMPDIR': '/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/', 02:09:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:09:10 INFO - 'USER': 'cltbld', 02:09:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:09:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:09:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:10 INFO - 'XPC_FLAGS': '0x0', 02:09:10 INFO - 'XPC_SERVICE_NAME': '0', 02:09:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:09:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:09:10 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-uk9_MI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:09:10 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)) 02:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:09:10 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-t8xlIm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:09:11 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)) 02:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:09:11 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-u_8IxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:09:11 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)) 02:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:09:11 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-eLliys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:09:11 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)) 02:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:09:11 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-Su_DMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:09:11 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)) 02:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:09:11 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-dQeybu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:09:11 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)) 02:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:09:11 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-Pk4OUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:09:11 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)) 02:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:09:11 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-WKhwWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:09:11 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)) 02:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:09:11 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-FNgXOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:09:11 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)) 02:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:09:11 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-QVk0X5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:09:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 02:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:09:11 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-ZkNdNq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:09:12 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)) 02:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:09:12 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-RxlSzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:09:12 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)) 02:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:09:12 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-rZjx9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:09:12 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)) 02:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:09:12 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-o9WKDA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:09:12 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)) 02:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:09:12 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-6u7Ka5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:09:12 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)) 02:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:09:12 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-eeaimw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:09:12 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)) 02:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:09:12 INFO - Running setup.py (path:/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/pip-j0RjNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:09:12 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)) 02:09:12 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)) 02:09:12 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)) 02:09:12 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)) 02:09:12 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)) 02:09:12 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)) 02:09:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:09:12 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 02:09:12 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 02:09:12 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 02:09:12 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 02:09:12 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 02:09:12 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 02:09:14 INFO - Downloading blessings-1.5.1.tar.gz 02:09:14 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 02:09:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:09:15 INFO - Installing collected packages: blessings 02:09:15 INFO - Running setup.py install for blessings 02:09:15 INFO - Successfully installed blessings 02:09:15 INFO - Cleaning up... 02:09:15 INFO - Return code: 0 02:09:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:09:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:09:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:09:15 INFO - Reading from file tmpfile_stdout 02:09:15 INFO - Current package versions: 02:09:15 INFO - blessings == 1.5.1 02:09:15 INFO - blobuploader == 1.2.4 02:09:15 INFO - docopt == 0.6.1 02:09:15 INFO - manifestparser == 1.1 02:09:15 INFO - mozInstall == 1.12 02:09:15 INFO - mozcrash == 0.16 02:09:15 INFO - mozdebug == 0.1 02:09:15 INFO - mozdevice == 0.47 02:09:15 INFO - mozfile == 1.2 02:09:15 INFO - mozhttpd == 0.7 02:09:15 INFO - mozinfo == 0.9 02:09:15 INFO - mozleak == 0.1 02:09:15 INFO - mozlog == 3.1 02:09:15 INFO - moznetwork == 0.27 02:09:15 INFO - mozprocess == 0.22 02:09:15 INFO - mozprofile == 0.27 02:09:15 INFO - mozrunner == 6.11 02:09:15 INFO - mozscreenshot == 0.1 02:09:15 INFO - mozsystemmonitor == 0.0 02:09:15 INFO - moztest == 0.7 02:09:15 INFO - mozversion == 1.4 02:09:15 INFO - psutil == 3.1.1 02:09:15 INFO - requests == 1.2.3 02:09:15 INFO - wsgiref == 0.1.2 02:09:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:09:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:09:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:15 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 0x102e56490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e33228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd68db3900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d7a9f0>, '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 0x102ad9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d6d8c8>, '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.pb3QlLg0g4/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.Dh0JYUoKlh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/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 02:09:15 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 02:09:15 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 02:09:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pb3QlLg0g4/Render', 02:09:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:09:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:09:15 INFO - 'HOME': '/Users/cltbld', 02:09:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:09:15 INFO - 'LOGNAME': 'cltbld', 02:09:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:15 INFO - 'MOZ_NO_REMOTE': '1', 02:09:15 INFO - 'NO_EM_RESTART': '1', 02:09:15 INFO - 'PAGER': '/bin/cat', 02:09:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:09:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:15 INFO - 'PWD': '/builds/slave/test', 02:09:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:09:15 INFO - 'SHELL': '/bin/bash', 02:09:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Dh0JYUoKlh/Listeners', 02:09:15 INFO - 'TMPDIR': '/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/', 02:09:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:09:15 INFO - 'USER': 'cltbld', 02:09:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:09:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:09:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:15 INFO - 'XPC_FLAGS': '0x0', 02:09:15 INFO - 'XPC_SERVICE_NAME': '0', 02:09:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:09:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:15 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)) 02:09:15 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)) 02:09:15 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)) 02:09:15 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)) 02:09:15 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)) 02:09:15 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)) 02:09:15 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)) 02:09:15 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)) 02:09:15 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)) 02:09:15 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)) 02:09:15 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)) 02:09:15 INFO - Cleaning up... 02:09:15 INFO - Return code: 0 02:09:15 INFO - Running post-action listener: _resource_record_post_action 02:09:15 INFO - Running post-action listener: _start_resource_monitoring 02:09:15 INFO - Starting resource monitoring. 02:09:15 INFO - ##### 02:09:15 INFO - ##### Running install step. 02:09:15 INFO - ##### 02:09:15 INFO - Running pre-action listener: _resource_record_pre_action 02:09:15 INFO - Running main action method: install 02:09:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:09:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:09:16 INFO - Reading from file tmpfile_stdout 02:09:16 INFO - Detecting whether we're running mozinstall >=1.0... 02:09:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:09:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:09:16 INFO - Reading from file tmpfile_stdout 02:09:16 INFO - Output received: 02:09:16 INFO - Usage: mozinstall [options] installer 02:09:16 INFO - Options: 02:09:16 INFO - -h, --help show this help message and exit 02:09:16 INFO - -d DEST, --destination=DEST 02:09:16 INFO - Directory to install application into. [default: 02:09:16 INFO - "/builds/slave/test"] 02:09:16 INFO - --app=APP Application being installed. [default: firefox] 02:09:16 INFO - mkdir: /builds/slave/test/build/application 02:09:16 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'] 02:09:16 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 02:09:46 INFO - Reading from file tmpfile_stdout 02:09:46 INFO - Output received: 02:09:46 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 02:09:46 INFO - Running post-action listener: _resource_record_post_action 02:09:46 INFO - ##### 02:09:46 INFO - ##### Running run-tests step. 02:09:46 INFO - ##### 02:09:46 INFO - Running pre-action listener: _resource_record_pre_action 02:09:46 INFO - Running main action method: run_tests 02:09:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:09:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:09:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:09:46 INFO - 2015-11-24 02:09:46.994 screenresolution[1644:7526] starting screenresolution argv=screenresolution get 02:09:46 INFO - 2015-11-24 02:09:46.996 screenresolution[1644:7526] Display 0: 1600x1200x32@60 02:09:47 INFO - 2015-11-24 02:09:47.002 screenresolution[1645:7528] starting screenresolution argv=screenresolution list 02:09:47 INFO - Available Modes on Display 0 02:09:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:09:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:09:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:09:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:09:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:09:47 INFO - Intel Iris: 02:09:47 INFO - Chipset Model: Intel Iris 02:09:47 INFO - Type: GPU 02:09:47 INFO - Bus: Built-In 02:09:47 INFO - VRAM (Dynamic, Max): 1536 MB 02:09:47 INFO - Vendor: Intel (0x8086) 02:09:47 INFO - Device ID: 0x0a2e 02:09:47 INFO - Revision ID: 0x0009 02:09:47 INFO - Displays: 02:09:47 INFO - Display: 02:09:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:09:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:09:47 INFO - Display Serial Number: 1600x1200 60 02:09:47 INFO - Main Display: Yes 02:09:47 INFO - Mirror: Off 02:09:47 INFO - Online: Yes 02:09:47 INFO - Rotation: Supported 02:09:47 INFO - Return code: 0 02:09:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:09:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:09:47 INFO - Python 2.7.3 02:09:47 INFO - Return code: 0 02:09:47 INFO - grabbing minidump binary from tooltool 02:09:47 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')]} 02:09:47 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 0x102d7a9f0>, '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 0x102ad9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d6d8c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:09:47 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 02:09:47 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 02:09:47 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:09:47 INFO - Return code: 0 02:09:47 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:09:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:09:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:09:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:09:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:09:47 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/hta-UQZgQceAG-88cW9C6w/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0061', '--webServer', 'localhost'] in /builds/slave/test/build 02:09:47 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/hta-UQZgQceAG-88cW9C6w/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0061 --webServer localhost 02:09:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pb3QlLg0g4/Render', 02:09:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:09:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:09:47 INFO - 'HOME': '/Users/cltbld', 02:09:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:09:47 INFO - 'LOGNAME': 'cltbld', 02:09:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:09:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:09:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:47 INFO - 'MOZ_NO_REMOTE': '1', 02:09:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:09:47 INFO - 'NO_EM_RESTART': '1', 02:09:47 INFO - 'PAGER': '/bin/cat', 02:09:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:09:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:47 INFO - 'PWD': '/builds/slave/test', 02:09:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:09:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:09:47 INFO - 'SHELL': '/bin/bash', 02:09:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Dh0JYUoKlh/Listeners', 02:09:47 INFO - 'TMPDIR': '/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/', 02:09:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:09:47 INFO - 'USER': 'cltbld', 02:09:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:09:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:09:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:47 INFO - 'XPC_FLAGS': '0x0', 02:09:47 INFO - 'XPC_SERVICE_NAME': '0', 02:09:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:09:47 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/hta-UQZgQceAG-88cW9C6w/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0061', '--webServer', 'localhost'] with output_timeout 3600 02:09:47 INFO - mozversion INFO | application_buildid: 20151124000443 02:09:47 INFO - mozversion INFO | application_changeset: 01d196350d2430972143290226fb0d7866aece78 02:09:47 INFO - mozversion INFO | application_display_name: Nightly 02:09:47 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:09:47 INFO - mozversion INFO | application_name: Firefox 02:09:47 INFO - mozversion INFO | application_remotingname: firefox 02:09:47 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 02:09:47 INFO - mozversion INFO | application_vendor: Mozilla 02:09:47 INFO - mozversion INFO | application_version: 45.0a1 02:09:47 INFO - mozversion INFO | platform_buildid: 20151124000443 02:09:47 INFO - mozversion INFO | platform_changeset: 01d196350d2430972143290226fb0d7866aece78 02:09:47 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 02:09:47 INFO - mozversion INFO | platform_version: 45.0a1 02:09:47 INFO - 2015-11-24 02:09:47,551 DEBUG : using testdate: 1448359787 02:09:47 INFO - 2015-11-24 02:09:47,551 DEBUG : actual date: 1448359787 02:09:47 INFO - 2015-11-24 02:09:47,560 INFO : starting webserver on 'localhost:49264' 02:09:47 INFO - 2015-11-24 02:09:47,561 INFO : Starting test suite t-yosemite-r7-0061 02:09:47 INFO - 2015-11-24 02:09:47,561 INFO : Starting test dromaeo_css 02:09:47 INFO - 2015-11-24 02:09:47,561 DEBUG : operating with platform_type : mac_ 02:09:47 INFO - 2015-11-24 02:09:47,562 INFO : Initialising browser for dromaeo_css test... 02:09:47 INFO - 2015-11-24 02:09:47,574 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/tmpxs_6sM/profile http://localhost:49264/getInfo.html 02:09:49 INFO - 2015-11-24 02:09:49,886 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:09:49 INFO - 2015-11-24 02:09:49,887 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:09:49 INFO - 2015-11-24 02:09:49,887 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 02:09:49 INFO - 2015-11-24 02:09:49,887 DEBUG : BROWSER_OUTPUT: __metrics 02:09:49 INFO - 2015-11-24 02:09:49,903 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:09:50 INFO - 2015-11-24 02:09:50,195 DEBUG : BROWSER_OUTPUT: console.error: 02:09:50 INFO - 2015-11-24 02:09:50,199 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 02:09:50 INFO - 2015-11-24 02:09:50,199 DEBUG : BROWSER_OUTPUT: Stack: 02:09:50 INFO - 2015-11-24 02:09:50,199 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 02:09:50 INFO - 2015-11-24 02:09:50,199 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 02:09:50 INFO - 2015-11-24 02:09:50,199 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 02:09:50 INFO - 2015-11-24 02:09:50,199 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 02:09:50 INFO - 2015-11-24 02:09:50,199 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 02:09:50 INFO - 2015-11-24 02:09:50,200 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 02:09:50 INFO - 2015-11-24 02:09:50,200 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 02:09:50 INFO - 2015-11-24 02:09:50,200 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 02:09:50 INFO - 2015-11-24 02:09:50,200 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 02:09:50 INFO - 2015-11-24 02:09:50,200 DEBUG : BROWSER_OUTPUT: 02:09:50 INFO - 2015-11-24 02:09:50,747 INFO : Browser initialized. 02:09:50 INFO - 2015-11-24 02:09:50,747 INFO : Running cycle 1/1 for dromaeo_css test... 02:09:50 INFO - 2015-11-24 02:09:50,747 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/tmpxs_6sM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:10:02 INFO - 2015-11-24 02:10:02,595 DEBUG : BROWSER_OUTPUT: RSS: Main: 226942976 02:10:02 INFO - 2015-11-24 02:10:02,596 DEBUG : BROWSER_OUTPUT: 02:10:53 INFO - 2015-11-24 02:10:53,642 DEBUG : BROWSER_OUTPUT: 1448359853639 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] 02:13:04 INFO - 2015-11-24 02:13:04,398 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49264/tests/dromaeo/cssquery-ext.html) 02:13:06 INFO - 2015-11-24 02:13:06,017 DEBUG : BROWSER_OUTPUT: RSS: Main: 367570944 02:13:06 INFO - 2015-11-24 02:13:06,017 DEBUG : BROWSER_OUTPUT: 02:16:08 INFO - 2015-11-24 02:16:08,738 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-ext.html (next: http://localhost:49264/tests/dromaeo/cssquery-jquery.html) 02:16:09 INFO - 2015-11-24 02:16:09,331 DEBUG : BROWSER_OUTPUT: RSS: Main: 363298816 02:16:09 INFO - 2015-11-24 02:16:09,331 DEBUG : BROWSER_OUTPUT: 02:19:11 INFO - 2015-11-24 02:19:11,335 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49264/tests/dromaeo/cssquery-mootools.html) 02:19:11 INFO - 2015-11-24 02:19:11,922 DEBUG : BROWSER_OUTPUT: RSS: Main: 340791296 02:19:11 INFO - 2015-11-24 02:19:11,922 DEBUG : BROWSER_OUTPUT: 02:22:13 INFO - 2015-11-24 02:22:13,911 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49264/tests/dromaeo/cssquery-prototype.html) 02:22:14 INFO - 2015-11-24 02:22:14,511 DEBUG : BROWSER_OUTPUT: RSS: Main: 321429504 02:22:14 INFO - 2015-11-24 02:22:14,511 DEBUG : BROWSER_OUTPUT: 02:25:17 INFO - 2015-11-24 02:25:17,420 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49264/tests/dromaeo/cssquery-yui.html) 02:25:18 INFO - 2015-11-24 02:25:18,059 DEBUG : BROWSER_OUTPUT: RSS: Main: 319823872 02:25:18 INFO - 2015-11-24 02:25:18,059 DEBUG : BROWSER_OUTPUT: 02:28:20 INFO - 2015-11-24 02:28:20,796 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-yui.html (next: http://localhost:49264/tests/dromaeo/cssquery-dojo.html) 02:28:21 INFO - 2015-11-24 02:28:21,056 DEBUG : BROWSER_OUTPUT: RSS: Main: 368607232 02:28:21 INFO - 2015-11-24 02:28:21,056 DEBUG : BROWSER_OUTPUT: 02:28:21 INFO - 2015-11-24 02:28:21,056 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:28:21 INFO - 2015-11-24 02:28:21,056 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:28:21 INFO - 2015-11-24 02:28:21,056 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:28:21 INFO - 2015-11-24 02:28:21,056 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:28:21 INFO - 2015-11-24 02:28:21,056 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3401.7618766686332;3497.772644778091;3533.6643018913196;3537.363274610571;3567.732420068495;5559.916601250974;5690.4025077366905;5758.769649214031;5769.682667453289;5794.710264486775;5706.201131841545;5708.77164913404;5716.39977802331;5850.297964244286;5854.473097421232;5014.2979982802435;5129.358830146241;5139.6659217150955;5154.994776018678;5186.974065129688;4752.144613969484;5280.5247527722495;5292.311999440087;5308.681479111266;5347.59893008024;5082.3138876251605;5161.793528258865;5191.454897235773;5232.3459567554055;5248;5051.621128415383;5157.767900444489;5192.818251361222;5199.4800519948085;5212.270282160501;5188.143956247215;5192.896142077175;5210.218467229908;5226;5232.764525596357;5519.2824932758485;5631.831045068655;5727.742251598646;5753;5759;5273.736313184364;6108.572399932006;6175.505959523227;6190.752369905198;6192.349803270682;5302.310699609065;6331.746730130789;6353.618782872996;6357.554971152022;6361.363863613602;5921.378255283219;5924.4667979882015;5939.4357536034;5943.465088142045;5945.346011938684;5299.205119232146;6198.132261483396;6318.08387783778;6332.651704156316;6338.968305158537;6028.668423236676;6199.3490683477585;6215.254169499599;6221.440070393596;6231.937680623136;6312.5265605078885;6325.557210995278;6344.429001389804;6349.301576826545;6355.809325720235;4987.950120498821;5194.4805519447755;6162.137300777895;6302.401271879165;6302.527310451735;6106.39999602577;6196.10156527301;6217.906731398942;6241.095041218998;6245.968770156211;5012.649114562018;5026.145555255615;5026.29631851541;5026.547610715053;5041.6470847040355;4396.978015109904;4490.57339552742;4495.056038231943;4503.054358584734;4530.320451932236;5561.026820306431;5663.433656634386;5723.3418156912485;5767.106098554731;5774.364819869811;4947.554720075139;6290.8427289317215;6308.653024083719;6330.620162790247;6368.490520758328;5614.63504872182;5714.599978001583;5747.5114615257335;5755.136729490526;5779.595428319977;5390.703511306916;5424.918626220609;5436.864078398072;5457.454254574511;5479.6164268500825;6370.1718776558755;6418.069379939976;6429.196350456193;6433;6433;6120.994312659307;6277.937220627735;6328.177336946352;6343.52423568225;6348.460380867493;6264.154339164337;6288.496920246278;6295.307516173309;6310.495160387066;6321.841953951188;6079.148919151411;6172.444479996821;6239.313675495601;6247.219097612799;6258.123862659322;6325.557210995186;6329.430351268408;6332.841678958063;6334.8733025338315;6340.144080549251;6005.279366476051;6202.4417802398;6209.534284928558;6221.4089661482085;6244.219472565929;5993.250843644544;6076.422739839708;6140.964409184605;6161;6180.258368995749;5335.626506144533;5659.151127330769;6027.517798576191;6074.817755467343;6087.512998960161;5391.541718953933;6168.224299065492;6184.103305020837;6202.627842329474;6207.751689932533;4987.925181122214;5944.138099975393;5978.611390259619;5984.850378740566;5988.431099045583 02:28:21 INFO - 2015-11-24 02:28:21,058 DEBUG : BROWSER_OUTPUT: |1;ext.html;519.7915132394795;572.6020415811013;598.5301538292441;630.5428564290889;649.9568193050158;31831.840840795794;32408.18979525513;32561.185970350754;40658.7967060165;41357.793211033975;43937.7803110984;44076.3388549172;44202.778986105106;44313;44456.55543444565;9804.509774511282;9991.650292239772;9993.950030249838;10000.099991000809;10041.698749037541;8851.734447966539;8906.198442140207;8920.509371984539;8921.01868794432;8936.910630893706;12174.513019479211;12234.93882530586;12255.632331030083;12258;12259.203151795105;11988.160828741991;12026.098042646749;12026.977706894924;12048.277103373826;12098.334591597459;8893.510856902867;8989.775255618597;8994.505302208376;11826.940865295704;11988.220765650205;32155.035348939335;41409.378859317134;41701.1659766806;41755.7912210437;41760.58239417628;2622.3706310485536;3189.5056266278766;3240.96759032409;3803.1633040730994;3923.764014335504;23638.527229455485;28354.574681379796;28693.856530717214;28795.712042879513;29435.558466623017;2675.5786212701614;2729.6314997475283;2855.129185598392;2959.3785305085744;2984.68660790616;417768;481577.59211204073;481595;484284;486109.569452154;65953.34046659568;66811;67044;67055.32944670589;67066.32933670601;65291.673541631986;66376.6681166591;66384.00423993645;66533;66615;15471.839612029144;15634.296456659478;15637.765433518507;15666;15677.843221567638;12033.157678962389;12104.455299511543;12138.817917731241;12218.938905305416;12259.570915017932;20202.797972020093;20386.757456679752;20443.4889127773;20457.89771051135;20463.38609841707;8799.824003520022;9013.278937684969;9050.728478145666;9056.003839577641;9131.223845973167;899.7480705402497;916.9037251088673;1046.6964580271635;1124.7300647844459;1159.3160035579049;24271;25218.360806547516;29039.85480072586;29681.554776678367;31316.53025204624;915.455304094063;1073.5437439088357;1078.8435676826816;1085.630885498934;1190.3334132885611;14069.71860562783;14078.85921140796;14412.495562655256;14432.422703091968;14467;505025;517341;522724;524199;524388;56247;56600;56640.43359566434;56655.71672141695;56713.43286567164;1330.035724100039;1345.2264947654942;1455.6651970046948;1475.6458449971929;1620.473346162502;24445.38886527851;29245.85377073101;29275.70724292815;29562.408751825275;29661.25846853846;54895;55297;55311.44688553063;55363.723181385445;55390;488539;489584;493772;537455;544546;32490.02529924106;32807.507887382184;33001.50497742488;33004.50493242555;33017.50473742848;40184.19631607293;40691;40699.3895091568;41100.972475688344;41286;31720.841395792875;34035.80874669375;34261;34640.30719385548;34774.47931768955;34298;34861.9541413758;34944.126396840285;34976.65023349836;35134;34338.48492272568;35166.94499165029;35189.82405087958;35347.82326088353;35371;30865.919692810643;31792.68207317897;31828;31843.36313273675;31867.521987169748;24260.87869560641;24783.50432991366;24868.502629947663;25149.497010060062;25304.74695253024 02:28:21 INFO - 2015-11-24 02:28:21,061 DEBUG : BROWSER_OUTPUT: |2;jquery.html;356.3016487684139;356.6504825271234;364.05709213137965;364.2369236449637;368.5062016897357;16088.356465741386;16634.417795377165;19358.516037099063;20332.59334813303;21073;11257.099432045437;11546.36494992775;11546.53813847445;19813.801861981377;20267;5099.2606072119615;5239.10935141025;5247.055530004598;5254.31693879797;5262.236975638531;3929.7445666031617;4038.838446462138;4058.553559108496;5286.4449232830575;5752.108423194411;5854.29748430189;5911.733971971272;5920.141579470996;5920.348761636216;5923.229980102581;5677.943220567803;5769.9711501442225;5780.161876527901;5780.797672081499;5808.2449281593545;5550.16747487876;5551.361593416768;5551.833444996657;5560.388357280696;5562.7774889004395;23849.403764906016;24167.395815104588;24497.387565311008;24680;24826.751732482626;1966.3412756726514;1999.5600967787063;2017.384697667211;2098.9790102098937;2113.6301147299314;9656.90343096567;9683.90316096837;9691.127798498099;9933.3543319684;9990.35062720928;1696.3384280130758;1703.4634090261527;1732.3936622182262;1752.229019231534;1779.80422153563;85596.74890914763;86421.56789216014;87501;99138.504307478;99408;10951.288166269167;11070.169737269736;11098.889011109946;11112.944435277772;11200.551977920792;13019.414126364336;13052.216866987821;13059.804102938464;13067.150635208682;13071.869281307256;6993;8047.913531673149;8236.8352632947;8329.416940814206;8373.916260837435;8311.667533298722;8315.085340612528;8326.25063744266;8382.538960357238;8402.621882015203;3850.7304488685522;4185.660588611615;4382.671299652538;4384.802683879233;4391.714538554984;1710.9914450427668;1760.375066851275;1765.7969333526553;1768.5667011582245;1817.790954040276;839.9496030238205;930.2743859789375;955.2883102088988;1051.2010871737534;1091.9789996353277;14729.705405892037;15949.963252388558;16281.430149944696;21539.56920861574;21629;906.7642412972542;937.3672770879629;951.3530799056708;985.605757696927;1021.3004092196869;11106.944465277622;11301.208915375844;11459.77080458386;11463.968242858184;11507.252028618113;779604;782604;793687.2840722181;797572;800290;104090.95909040813;110191;110874;113049;116832;1185.7213554814612;1190.7853988931242;1201.7476329970805;1203.1938601137258;1224.6938265433641;18190.090495475437;18352.348010778696;18608.16263268129;18778.624427511648;19041.714374284118;48966;50830;51098;51201.23198152105;51674.22488662748;58843.70578147082;62375.68812156092;68000.6599966997;68446.63106737738;72425.27574724186;9864.704058878246;9905.207583393456;10150.187984961332;10170.593176272867;10183.643572474928;19757.20971161195;19815.60368792587;19896.70154947706;20451.79548204499;20583;11002.449877506253;15627.14050727221;16116.355345786038;16118.113503757406;16141.838581614034;15191.012584181994;15278.083315001135;15465.226738663247;15496.535103946899;16292.18539073018;15423.922880385526;15614.843851561793;15824.60438489047;16122.355105796107;16585.50243492697;9584.616615335588;9689.370190937567;9762.951185244028;9796.461194634363;9843.704688859345;10012.648292480422;10208.948955255177;11424.371659558805;15871.047737135346;16291.837081629506 02:28:21 INFO - 2015-11-24 02:28:21,062 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1539.9538013859587;1550.9612259693513;1668.4077152610814;1902.1250224896546;1925.1625542888842;7829.647665855036;8071.838563228732;8220.91779082209;8560.657573697044;8572.14278572144;7028.402585780214;8452.746417607466;8488.151184881508;8491.980962284519;8503.574821258942;2380.1669415704496;2396.113438027923;2396.2332053742807;2399.9880000599974;2404.591219492682;2406.5066661334386;2433.561958847407;2451.742567030463;2457.7542245775458;2459.4589190378088;2376.489054853206;2405.434722840131;2407.313915534073;2407.350015495815;2412.1557454890735;2373.4422410733464;2396.376941995085;2408.277516744978;2410.0480310277517;2411.807055435561;2398.5442765874604;2413.5655581995234;2434.42790944128;2434.6834911461574;2435.5737745894576;7743.9158517807555;8447.577621118919;8468;8484.151584841527;8492.872606910902;4392.824287028515;4669.159551280768;5024.422191447994;5181.145111056671;5190.4031036430915;2859.642544681915;2872.5116730155924;3501.2997400519744;3556.4309710446464;3612.7832330060282;1068.7595291059527;1638.2709694186092;1649.397969741048;1665.925033373501;1712.4177779554886;11109.944450277697;11221.607243746512;11245.381504017358;11253.212275140744;11277.436128193558;4529.818807247739;4537.977310113428;4603.562661547215;4626.653001024936;4639.489656137822;9140.04029576885;9144.451332920045;9145.862812057825;9157.862632060524;9158.954205229065;5124.743762811844;5138.100832354323;5139.7687104080405;5144.382674079135;5154.974225128851;4719.4100737407825;4723.267893476516;4726.172919739032;4738.64460165489;4742.928856067162;3530.1527633367805;3602.495650608917;3635.345637785224;3641.927161456756;3644.0889777555612;1121.243160866412;1134.0304040045808;1142.7485953090472;1143.7941170589208;1145.873953865074;1350.6623344163959;1359.7484465373936;1380.2615600653603;1380.9861901380857;1415.7027024325007;7825.804354891174;7927.484713493604;7964.044314682275;7973.282404583615;7976.800579985431;490.9533594308535;505.5626882746398;506.0839879817542;509.8317555206773;511.0366958283662;6067.605605635619;6173.41352571505;6183.783567575113;6274.623522588659;6277.497800175975;9184.403013804082;10191;10333.638322658671;10335.948320258502;10355.534000969974;9998.250131240186;10219.182465402899;10219.284650074573;10255.692329230134;10311.639092631873;7832.843343133105;7907.169747176578;7978.202179781975;7996.480228785111;7997;7771.766846994599;7899.0126234220725;7926.167752386147;7927.563983980705;7954.522728636301;7530.887036694345;9038.728838134866;9092.318076144184;9174.174324310845;9250.444973301623;9195.954020229856;9428.151466367786;9495.477748723886;9503.049695030442;9537.14165725088;6843.726250950105;6849.452043836382;6855.931440685529;6907.309269073254;6940.826479338057;8066.959665201636;8124.471909325875;8139.1453897339925;8151.225633565039;8156.796080098045;6263.686815659108;7490.1386340571535;7570.242975702386;7723.961380193063;7730.652120654471;7321.963390183015;7389.261073892568;7440.516366436164;7469.775906722807;7508.812279693051;7587.468877178544;7642.8089297768;7649.388048955959;7653.425993050432;7667.079950405987;6862.078617986772;6889.586624802528;6947.270536593787;6953.374196322356;6964.6517674115075;7001.124859392576;7023.262557431601;7049.929500704928;7059.929400705927;7065.752698655522 02:28:21 INFO - 2015-11-24 02:28:21,065 DEBUG : BROWSER_OUTPUT: |4;prototype.html;318.9027346659269;326.0950861359726;328.87667124828187;329.01624143810017;331.97676162668625;6656.434203092736;6681.0980517630105;6693.832654183654;6700.26297107319;6808.080909077273;5351.438098999607;6601.669916504167;6669.133012708353;6686.598804071759;6692.732290708366;4906.116898958177;4920.311156438083;4924.655274130794;4924.901501969958;4927.6550641455115;4688.5545873142;4811.182099043153;4814.640825995255;4816.903661926777;4936.456989731127;4832.420109586855;4837.863102170987;4847.2971419144205;4848;4859.416869975608;4564.634829213688;4715.24556071027;4716.985848042653;4844.830430934918;4852.587530059932;3236.5307030480685;3269.836508174582;4100.17996400718;4114.362273847559;4135.9172816543805;6314.210723659543;6326.367363263636;6344.238691357021;6373.808785736435;6382.968085159545;5436.184572314145;5635.8591035224035;5729.054705973509;5785.768569257225;5787.102999035114;6587.934120658828;6886.827829304308;7052.541584796972;7076.646167691595;7145.6784444700115;3795.411711184771;4615;4621.560951709582;4626.467956185048;4629.282461218517;7501.24987501251;7590.620468976585;7603.961980190119;7608.923910760932;7619.885701714478;4517.638588912879;4686.437627484655;4688.46082700487;4726.763661816895;4736.597389221886;4798.640101992295;4806.903861922812;4814.9518504814505;4817.855464336076;4821.9035619287415;4611.262198048296;5727.627704199213;5730.226419433407;5742.799002034909;5750.396208398058;7006.229314775371;7273.054502914693;7277.636118194069;7281.599512026889;7287.927120728831;1644.745064515002;1660.8671306295466;1662.9002259864446;1664.0015990405902;1667.733162693963;1048.3238311289176;1053.9736506587396;1058.7564860082225;1064.9094826939797;1074.3070719385953;6696.06255124283;6699.02864084705;6699.162604674319;6703.463722902254;6739.966300168468;7493.138289096714;7504.061992250969;7527.548347099191;7535.962320188473;7562.243775622504;6385.393387628168;6639.601623902581;6647.069410282565;6653.933460665428;6680.5991640501725;3833.21419109082;3960.3663413853646;3990.3216453203027;3994.021464741099;4005.599440055971;6167.321594624587;7672.347850432776;7678.577678227751;7682.308592226726;7690.346320562815;6286.308506064329;7686.116096648845;7744.612769361509;7878.212178782076;7880.527168369917;6204.317525072239;6975.709493743674;7326.084239470067;7869.449138560246;7889.4082943780595;6087.05650624154;7252.854942901218;7615.581143036965;7620.161782203842;7625.3137217648455;7462.253774622494;7467.626618668936;7476.4018878488505;7477.177510473953;7481.738139165103;7597.6581053851605;7829.177936316605;7829.686812527435;7838.412119090977;7854.332381747616;4721.055788842176;4724.433068031858;4728.40894888139;4731.952680473289;4741.146593613183;7344.803692896367;7524.2851929066655;7526.548407095592;7533.2466753324225;7553.433492488195;7204.71181152748;7304.269573042653;7313.67088481009;7316.195218526064;7316.634168291458;7234.3127402898745;7285.927140728525;7290.5625662460425;7309.597972111585;7316.378107860892;6920.100386949664;7103.431725462054;7112.964435177791;7131.8573628528175;7139.535930164523;7270.345668889825;7290.453216008927;7292.197858235484;7297.7889728519285;7301.671424785791;7124.323189297009;7144.3927266182955;7144.749933752294;7147.85704285901;7148.892766608609 02:28:21 INFO - 2015-11-24 02:28:21,067 DEBUG : BROWSER_OUTPUT: |5;yui.html;727.6870945493438;766.8082979255187;776.8601651702693;803.5018288661028;834.3367023216542;15145.545633630982;15458.381664733412;15487;15491.69016619667;15513.534593962186;13947.930260348685;14097.295135243223;14109.717805643906;14115.223662698547;14125.081869678464;731.0386841303682;747.8915557244196;748.9888650322076;932.9393589416666;948.2461443152675;932.5150921520805;933.5099072986702;943.9244860411151;945.8864936207631;946.5267366316841;779.8128449172215;981.543582234261;996.7856910764184;997.0627610046533;998.5057396588699;632.2697284636253;782.1904329019466;784.3842583571869;785.783909424907;810.5096416667949;732.0190944134885;733.8825787873968;734.5886303669962;734.9485536012481;735.9337659610608;14624.049436786681;14785.038972466755;14785.486467300585;14790.63023424423;14796.964212505129;9973.601055957753;12323.815142772866;12630.368481575884;12743.235405875585;12973.805392919114;10196.592136314539;10215.881657510161;10352.430616316175;10353.430561319125;10359.585616575328;3518.8064656443885;3534.5581802274714;3535.505029295901;3536.522569453117;3550.2721942001826;73203;74229.25770742277;74365.84512323141;74535;75846.62076689636;9368.203702685212;9507.57215925285;9608.519574021271;9649;9723.805523889483;21244;21257.89371053135;21276.255331063647;21288;21293.89353053225;7308.415326773846;7396.593187374746;7410.851782964311;7466.738664146729;7656.9234307657325;3949.3681011038097;3978.224246272007;4030.979845100756;4085.9591404086173;4123.0310876943895;3564.4475106358555;3621.9637803622154;3623.4202527595985;3623.9637603624155;3632.4369722693023;672.2873753820966;689.7068745783022;691.9273476284917;693.9236683964759;700.9439244860399;457.93588897554366;478.5262590035909;509.4421608338863;524.3262407805951;542.7883125581027;8965.266683587908;9254.4910029949;9310.53447327631;9347.439153650803;9356.251499879992;439.3475688602423;578.945000224978;598.9550783691241;606.4087514673247;608.975640974365;3422.281320922584;3789.6778773803985;4078.469798926121;4126.938095928564;4233.30150525166;86235.56882215549;86242.13757862341;86864.56567717121;91196;91930;74810.50378992499;75120.24879751242;75407.24592754002;76319.85520217201;78333.60833195798;67493.66253168801;68758;69592;71651.64174179095;72972.63513682397;8813.735587932373;8916.821663566821;9011.972306231046;9094.499802510662;9271.397359171902;51958.48041519688;52170;52278.47721522736;53359.46640533545;54135.10527131532;73823.26176738164;76395;76814;76949.2305076942;76952.23047769675;10667.306625069346;10932.453377331261;10944.398058106563;11143.2199746017;11194.608188713355;12111.939440302742;12267.447964841782;12492.125551211328;12552.05859560555;12746;11581.826272606086;11799.646010619696;11823.881761182622;11851.525938962344;12035.518579257083;11583.189176757545;11807.916614964635;11919.582814601446;11936.880631193577;12006.519739210684;10972.396518191576;11147.498362573542;11153.553857845594;11535.826962595736;12062.396880155782;9281.211097056826;9383.483908385104;9430.3398762086;9494.620215191315;10118.898811011795;9090.318615817238;9254.074592540961;9768.511574421109;9787.657431989846;9789.65736199258 02:28:21 INFO - 2015-11-24 02:28:21,067 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:28:21 INFO - 2015-11-24 02:28:21,067 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:28:21 INFO - 2015-11-24 02:28:21,067 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1434 02:28:21 INFO - 2015-11-24 02:28:21,067 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:28:21 INFO - 2015-11-24 02:28:21,067 DEBUG : BROWSER_OUTPUT: __startTimestamp1448360901053__endTimestamp 02:28:21 INFO - 2015-11-24 02:28:21,067 DEBUG : BROWSER_OUTPUT: 02:28:21 INFO - 2015-11-24 02:28:21,067 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:28:21 INFO - 2015-11-24 02:28:21,067 DEBUG : BROWSER_OUTPUT: Number of tests: 6 02:28:21 INFO - 2015-11-24 02:28:21,067 DEBUG : BROWSER_OUTPUT: 02:28:21 INFO - 2015-11-24 02:28:21,067 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5730.06 Median:5939.44 stddev:644.91 (10.9%) stddev-sans-first:620.48 02:28:21 INFO - 2015-11-24 02:28:21,069 DEBUG : BROWSER_OUTPUT: Values: 3401.8 3497.8 3533.7 3537.4 3567.7 5559.9 5690.4 5758.8 5769.7 5794.7 5706.2 5708.8 5716.4 5850.3 5854.5 5014.3 5129.4 5139.7 5155.0 5187.0 4752.1 5280.5 5292.3 5308.7 5347.6 5082.3 5161.8 5191.5 5232.3 5248.0 5051.6 5157.8 5192.8 5199.5 5212.3 5188.1 5192.9 5210.2 5226.0 5232.8 5519.3 5631.8 5727.7 5753.0 5759.0 5273.7 6108.6 6175.5 6190.8 6192.3 5302.3 6331.7 6353.6 6357.6 6361.4 5921.4 5924.5 5939.4 5943.5 5945.3 5299.2 6198.1 6318.1 6332.7 6339.0 6028.7 6199.3 6215.3 6221.4 6231.9 6312.5 6325.6 6344.4 6349.3 6355.8 4988.0 5194.5 6162.1 6302.4 6302.5 6106.4 6196.1 6217.9 6241.1 6246.0 5012.6 5026.1 5026.3 5026.5 5041.6 4397.0 4490.6 4495.1 4503.1 4530.3 5561.0 5663.4 5723.3 5767.1 5774.4 4947.6 6290.8 6308.7 6330.6 6368.5 5614.6 5714.6 5747.5 5755.1 5779.6 5390.7 5424.9 5436.9 5457.5 5479.6 6370.2 6418.1 6429.2 6433.0 6433.0 6121.0 6277.9 6328.2 6343.5 6348.5 6264.2 6288.5 6295.3 6310.5 6321.8 6079.1 6172.4 6239.3 6247.2 6258.1 6325.6 6329.4 6332.8 6334.9 6340.1 6005.3 6202.4 6209.5 6221.4 6244.2 5993.3 6076.4 6141.0 6161.0 6180.3 5335.6 5659.2 6027.5 6074.8 6087.5 5391.5 6168.2 6184.1 6202.6 6207.8 4987.9 5944.1 5978.6 5984.9 5988.4 02:28:21 INFO - 2015-11-24 02:28:21,069 DEBUG : BROWSER_OUTPUT: 02:28:21 INFO - 2015-11-24 02:28:21,069 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:64376.09 Median:34279.50 stddev:133211.09 (388.6%) stddev-sans-first:133498.50 02:28:21 INFO - 2015-11-24 02:28:21,070 DEBUG : BROWSER_OUTPUT: Values: 519.8 572.6 598.5 630.5 650.0 31831.8 32408.2 32561.2 40658.8 41357.8 43937.8 44076.3 44202.8 44313.0 44456.6 9804.5 9991.7 9994.0 10000.1 10041.7 8851.7 8906.2 8920.5 8921.0 8936.9 12174.5 12234.9 12255.6 12258.0 12259.2 11988.2 12026.1 12027.0 12048.3 12098.3 8893.5 8989.8 8994.5 11826.9 11988.2 32155.0 41409.4 41701.2 41755.8 41760.6 2622.4 3189.5 3241.0 3803.2 3923.8 23638.5 28354.6 28693.9 28795.7 29435.6 2675.6 2729.6 2855.1 2959.4 2984.7 417768.0 481577.6 481595.0 484284.0 486109.6 65953.3 66811.0 67044.0 67055.3 67066.3 65291.7 66376.7 66384.0 66533.0 66615.0 15471.8 15634.3 15637.8 15666.0 15677.8 12033.2 12104.5 12138.8 12218.9 12259.6 20202.8 20386.8 20443.5 20457.9 20463.4 8799.8 9013.3 9050.7 9056.0 9131.2 899.7 916.9 1046.7 1124.7 1159.3 24271.0 25218.4 29039.9 29681.6 31316.5 915.5 1073.5 1078.8 1085.6 1190.3 14069.7 14078.9 14412.5 14432.4 14467.0 505025.0 517341.0 522724.0 524199.0 524388.0 56247.0 56600.0 56640.4 56655.7 56713.4 1330.0 1345.2 1455.7 1475.6 1620.5 24445.4 29245.9 29275.7 29562.4 29661.3 54895.0 55297.0 55311.4 55363.7 55390.0 488539.0 489584.0 493772.0 537455.0 544546.0 32490.0 32807.5 33001.5 33004.5 33017.5 40184.2 40691.0 40699.4 41101.0 41286.0 31720.8 34035.8 34261.0 34640.3 34774.5 34298.0 34862.0 34944.1 34976.7 35134.0 34338.5 35166.9 35189.8 35347.8 35371.0 30865.9 31792.7 31828.0 31843.4 31867.5 24260.9 24783.5 24868.5 25149.5 25304.7 02:28:21 INFO - 2015-11-24 02:28:21,070 DEBUG : BROWSER_OUTPUT: 02:28:21 INFO - 2015-11-24 02:28:21,070 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:39051.12 Median:22739.20 stddev:129716.22 (570.5%) stddev-sans-first:130047.56 02:28:21 INFO - 2015-11-24 02:28:21,071 DEBUG : BROWSER_OUTPUT: Values: 356.3 356.7 364.1 364.2 368.5 16088.4 16634.4 19358.5 20332.6 21073.0 11257.1 11546.4 11546.5 19813.8 20267.0 5099.3 5239.1 5247.1 5254.3 5262.2 3929.7 4038.8 4058.6 5286.4 5752.1 5854.3 5911.7 5920.1 5920.3 5923.2 5677.9 5770.0 5780.2 5780.8 5808.2 5550.2 5551.4 5551.8 5560.4 5562.8 23849.4 24167.4 24497.4 24680.0 24826.8 1966.3 1999.6 2017.4 2099.0 2113.6 9656.9 9683.9 9691.1 9933.4 9990.4 1696.3 1703.5 1732.4 1752.2 1779.8 85596.7 86421.6 87501.0 99138.5 99408.0 10951.3 11070.2 11098.9 11112.9 11200.6 13019.4 13052.2 13059.8 13067.2 13071.9 6993.0 8047.9 8236.8 8329.4 8373.9 8311.7 8315.1 8326.3 8382.5 8402.6 3850.7 4185.7 4382.7 4384.8 4391.7 1711.0 1760.4 1765.8 1768.6 1817.8 839.9 930.3 955.3 1051.2 1092.0 14729.7 15950.0 16281.4 21539.6 21629.0 906.8 937.4 951.4 985.6 1021.3 11106.9 11301.2 11459.8 11464.0 11507.3 779604.0 782604.0 793687.3 797572.0 800290.0 104091.0 110191.0 110874.0 113049.0 116832.0 1185.7 1190.8 1201.7 1203.2 1224.7 18190.1 18352.3 18608.2 18778.6 19041.7 48966.0 50830.0 51098.0 51201.2 51674.2 58843.7 62375.7 68000.7 68446.6 72425.3 9864.7 9905.2 10150.2 10170.6 10183.6 19757.2 19815.6 19896.7 20451.8 20583.0 11002.4 15627.1 16116.4 16118.1 16141.8 15191.0 15278.1 15465.2 15496.5 16292.2 15423.9 15614.8 15824.6 16122.4 16585.5 9584.6 9689.4 9763.0 9796.5 9843.7 10012.6 10208.9 11424.4 15871.0 16291.8 02:28:21 INFO - 2015-11-24 02:28:21,071 DEBUG : BROWSER_OUTPUT: 02:28:21 INFO - 2015-11-24 02:28:21,072 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5822.75 Median:5168.06 stddev:3029.21 (58.6%) stddev-sans-first:3020.61 02:28:21 INFO - 2015-11-24 02:28:21,072 DEBUG : BROWSER_OUTPUT: Values: 1540.0 1551.0 1668.4 1902.1 1925.2 7829.6 8071.8 8220.9 8560.7 8572.1 7028.4 8452.7 8488.2 8492.0 8503.6 2380.2 2396.1 2396.2 2400.0 2404.6 2406.5 2433.6 2451.7 2457.8 2459.5 2376.5 2405.4 2407.3 2407.4 2412.2 2373.4 2396.4 2408.3 2410.0 2411.8 2398.5 2413.6 2434.4 2434.7 2435.6 7743.9 8447.6 8468.0 8484.2 8492.9 4392.8 4669.2 5024.4 5181.1 5190.4 2859.6 2872.5 3501.3 3556.4 3612.8 1068.8 1638.3 1649.4 1665.9 1712.4 11109.9 11221.6 11245.4 11253.2 11277.4 4529.8 4538.0 4603.6 4626.7 4639.5 9140.0 9144.5 9145.9 9157.9 9159.0 5124.7 5138.1 5139.8 5144.4 5155.0 4719.4 4723.3 4726.2 4738.6 4742.9 3530.2 3602.5 3635.3 3641.9 3644.1 1121.2 1134.0 1142.7 1143.8 1145.9 1350.7 1359.7 1380.3 1381.0 1415.7 7825.8 7927.5 7964.0 7973.3 7976.8 491.0 505.6 506.1 509.8 511.0 6067.6 6173.4 6183.8 6274.6 6277.5 9184.4 10191.0 10333.6 10335.9 10355.5 9998.3 10219.2 10219.3 10255.7 10311.6 7832.8 7907.2 7978.2 7996.5 7997.0 7771.8 7899.0 7926.2 7927.6 7954.5 7530.9 9038.7 9092.3 9174.2 9250.4 9196.0 9428.2 9495.5 9503.0 9537.1 6843.7 6849.5 6855.9 6907.3 6940.8 8067.0 8124.5 8139.1 8151.2 8156.8 6263.7 7490.1 7570.2 7724.0 7730.7 7322.0 7389.3 7440.5 7469.8 7508.8 7587.5 7642.8 7649.4 7653.4 7667.1 6862.1 6889.6 6947.3 6953.4 6964.7 7001.1 7023.3 7049.9 7059.9 7065.8 02:28:21 INFO - 2015-11-24 02:28:21,072 DEBUG : BROWSER_OUTPUT: 02:28:21 INFO - 2015-11-24 02:28:21,074 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5839.43 Median:6655.18 stddev:1907.37 (28.7%) stddev-sans-first:1867.17 02:28:21 INFO - 2015-11-24 02:28:21,074 DEBUG : BROWSER_OUTPUT: Values: 318.9 326.1 328.9 329.0 332.0 6656.4 6681.1 6693.8 6700.3 6808.1 5351.4 6601.7 6669.1 6686.6 6692.7 4906.1 4920.3 4924.7 4924.9 4927.7 4688.6 4811.2 4814.6 4816.9 4936.5 4832.4 4837.9 4847.3 4848.0 4859.4 4564.6 4715.2 4717.0 4844.8 4852.6 3236.5 3269.8 4100.2 4114.4 4135.9 6314.2 6326.4 6344.2 6373.8 6383.0 5436.2 5635.9 5729.1 5785.8 5787.1 6587.9 6886.8 7052.5 7076.6 7145.7 3795.4 4615.0 4621.6 4626.5 4629.3 7501.2 7590.6 7604.0 7608.9 7619.9 4517.6 4686.4 4688.5 4726.8 4736.6 4798.6 4806.9 4815.0 4817.9 4821.9 4611.3 5727.6 5730.2 5742.8 5750.4 7006.2 7273.1 7277.6 7281.6 7287.9 1644.7 1660.9 1662.9 1664.0 1667.7 1048.3 1054.0 1058.8 1064.9 1074.3 6696.1 6699.0 6699.2 6703.5 6740.0 7493.1 7504.1 7527.5 7536.0 7562.2 6385.4 6639.6 6647.1 6653.9 6680.6 3833.2 3960.4 3990.3 3994.0 4005.6 6167.3 7672.3 7678.6 7682.3 7690.3 6286.3 7686.1 7744.6 7878.2 7880.5 6204.3 6975.7 7326.1 7869.4 7889.4 6087.1 7252.9 7615.6 7620.2 7625.3 7462.3 7467.6 7476.4 7477.2 7481.7 7597.7 7829.2 7829.7 7838.4 7854.3 4721.1 4724.4 4728.4 4732.0 4741.1 7344.8 7524.3 7526.5 7533.2 7553.4 7204.7 7304.3 7313.7 7316.2 7316.6 7234.3 7285.9 7290.6 7309.6 7316.4 6920.1 7103.4 7113.0 7131.9 7139.5 7270.3 7290.5 7292.2 7297.8 7301.7 7124.3 7144.4 7144.7 7147.9 7148.9 02:28:21 INFO - 2015-11-24 02:28:21,074 DEBUG : BROWSER_OUTPUT: 02:28:21 INFO - 2015-11-24 02:28:21,074 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:18350.57 Median:652.28 stddev:25427.72 (3898.3%) stddev-sans-first:25464.62 02:28:21 INFO - 2015-11-24 02:28:21,075 DEBUG : BROWSER_OUTPUT: Values: 727.7 766.8 776.9 803.5 834.3 15145.5 15458.4 15487.0 15491.7 15513.5 13947.9 14097.3 14109.7 14115.2 14125.1 731.0 747.9 749.0 932.9 948.2 932.5 933.5 943.9 945.9 946.5 779.8 981.5 996.8 997.1 998.5 632.3 782.2 784.4 785.8 810.5 732.0 733.9 734.6 734.9 735.9 14624.0 14785.0 14785.5 14790.6 14797.0 9973.6 12323.8 12630.4 12743.2 12973.8 10196.6 10215.9 10352.4 10353.4 10359.6 3518.8 3534.6 3535.5 3536.5 3550.3 73203.0 74229.3 74365.8 74535.0 75846.6 9368.2 9507.6 9608.5 9649.0 9723.8 21244.0 21257.9 21276.3 21288.0 21293.9 7308.4 7396.6 7410.9 7466.7 7656.9 3949.4 3978.2 4031.0 4086.0 4123.0 3564.4 3622.0 3623.4 3624.0 3632.4 672.3 689.7 691.9 693.9 700.9 457.9 478.5 509.4 524.3 542.8 8965.3 9254.5 9310.5 9347.4 9356.3 439.3 578.9 599.0 606.4 609.0 3422.3 3789.7 4078.5 4126.9 4233.3 86235.6 86242.1 86864.6 91196.0 91930.0 74810.5 75120.2 75407.2 76319.9 78333.6 67493.7 68758.0 69592.0 71651.6 72972.6 8813.7 8916.8 9012.0 9094.5 9271.4 51958.5 52170.0 52278.5 53359.5 54135.1 73823.3 76395.0 76814.0 76949.2 76952.2 10667.3 10932.5 10944.4 11143.2 11194.6 12111.9 12267.4 12492.1 12552.1 12746.0 11581.8 11799.6 11823.9 11851.5 12035.5 11583.2 11807.9 11919.6 11936.9 12006.5 10972.4 11147.5 11153.6 11535.8 12062.4 9281.2 9383.5 9430.3 9494.6 10118.9 9090.3 9254.1 9768.5 9787.7 9789.7 02:28:21 INFO - 2015-11-24 02:28:21,075 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:28:21 INFO - 2015-11-24 02:28:21,075 DEBUG : BROWSER_OUTPUT: 02:28:21 INFO - 2015-11-24 02:28:21,499 INFO : Browser exited with error code: 0 02:28:21 INFO - 2015-11-24 02:28:21,524 INFO : Completed test dromaeo_css (00:18:33) 02:28:21 INFO - 2015-11-24 02:28:21,524 INFO : Starting test kraken 02:28:21 INFO - 2015-11-24 02:28:21,524 DEBUG : operating with platform_type : mac_ 02:28:21 INFO - 2015-11-24 02:28:21,524 INFO : Initialising browser for kraken test... 02:28:21 INFO - 2015-11-24 02:28:21,537 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/tmpuzCyvs/profile http://localhost:49264/getInfo.html 02:28:23 INFO - 2015-11-24 02:28:23,622 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:28:23 INFO - 2015-11-24 02:28:23,622 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:28:23 INFO - 2015-11-24 02:28:23,622 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 02:28:23 INFO - 2015-11-24 02:28:23,622 DEBUG : BROWSER_OUTPUT: __metrics 02:28:23 INFO - 2015-11-24 02:28:23,638 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:28:24 INFO - 2015-11-24 02:28:24,307 INFO : Browser initialized. 02:28:24 INFO - 2015-11-24 02:28:24,307 INFO : Running cycle 1/1 for kraken test... 02:28:24 INFO - 2015-11-24 02:28:24,308 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/tmpuzCyvs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:28:36 INFO - 2015-11-24 02:28:36,304 DEBUG : BROWSER_OUTPUT: RSS: Main: 225169408 02:28:36 INFO - 2015-11-24 02:28:36,305 DEBUG : BROWSER_OUTPUT: 02:28:38 INFO - 2015-11-24 02:28:38,819 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-beat-detection) 02:28:39 INFO - 2015-11-24 02:28:39,419 DEBUG : BROWSER_OUTPUT: RSS: Main: 275283968 02:28:39 INFO - 2015-11-24 02:28:39,419 DEBUG : BROWSER_OUTPUT: 02:28:42 INFO - 2015-11-24 02:28:42,123 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-dft) 02:28:42 INFO - 2015-11-24 02:28:42,716 DEBUG : BROWSER_OUTPUT: RSS: Main: 293048320 02:28:42 INFO - 2015-11-24 02:28:42,716 DEBUG : BROWSER_OUTPUT: 02:28:45 INFO - 2015-11-24 02:28:45,891 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-fft) 02:28:46 INFO - 2015-11-24 02:28:46,476 DEBUG : BROWSER_OUTPUT: RSS: Main: 277684224 02:28:46 INFO - 2015-11-24 02:28:46,476 DEBUG : BROWSER_OUTPUT: 02:28:48 INFO - 2015-11-24 02:28:48,321 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-oscillator) 02:28:48 INFO - 2015-11-24 02:28:48,910 DEBUG : BROWSER_OUTPUT: RSS: Main: 280363008 02:28:48 INFO - 2015-11-24 02:28:48,910 DEBUG : BROWSER_OUTPUT: 02:28:50 INFO - 2015-11-24 02:28:50,926 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49264/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:28:51 INFO - 2015-11-24 02:28:51,505 DEBUG : BROWSER_OUTPUT: RSS: Main: 281100288 02:28:51 INFO - 2015-11-24 02:28:51,505 DEBUG : BROWSER_OUTPUT: 02:28:54 INFO - 2015-11-24 02:28:54,309 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49264/tests/kraken/driver.html?testName=imaging-darkroom) 02:28:54 INFO - 2015-11-24 02:28:54,897 DEBUG : BROWSER_OUTPUT: RSS: Main: 281706496 02:28:54 INFO - 2015-11-24 02:28:54,897 DEBUG : BROWSER_OUTPUT: 02:28:57 INFO - 2015-11-24 02:28:57,681 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49264/tests/kraken/driver.html?testName=imaging-desaturate) 02:28:58 INFO - 2015-11-24 02:28:58,262 DEBUG : BROWSER_OUTPUT: RSS: Main: 282742784 02:28:58 INFO - 2015-11-24 02:28:58,262 DEBUG : BROWSER_OUTPUT: 02:29:00 INFO - 2015-11-24 02:29:00,984 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49264/tests/kraken/driver.html?testName=json-parse-financial) 02:29:01 INFO - 2015-11-24 02:29:01,577 DEBUG : BROWSER_OUTPUT: RSS: Main: 281731072 02:29:01 INFO - 2015-11-24 02:29:01,577 DEBUG : BROWSER_OUTPUT: 02:29:03 INFO - 2015-11-24 02:29:03,289 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49264/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:29:03 INFO - 2015-11-24 02:29:03,867 DEBUG : BROWSER_OUTPUT: RSS: Main: 315510784 02:29:03 INFO - 2015-11-24 02:29:03,867 DEBUG : BROWSER_OUTPUT: 02:29:05 INFO - 2015-11-24 02:29:05,627 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:29:06 INFO - 2015-11-24 02:29:06,252 DEBUG : BROWSER_OUTPUT: RSS: Main: 318042112 02:29:06 INFO - 2015-11-24 02:29:06,252 DEBUG : BROWSER_OUTPUT: 02:29:08 INFO - 2015-11-24 02:29:08,411 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:29:09 INFO - 2015-11-24 02:29:09,005 DEBUG : BROWSER_OUTPUT: RSS: Main: 324915200 02:29:09 INFO - 2015-11-24 02:29:09,005 DEBUG : BROWSER_OUTPUT: 02:29:11 INFO - 2015-11-24 02:29:11,530 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:29:12 INFO - 2015-11-24 02:29:12,123 DEBUG : BROWSER_OUTPUT: RSS: Main: 325095424 02:29:12 INFO - 2015-11-24 02:29:12,123 DEBUG : BROWSER_OUTPUT: 02:29:14 INFO - 2015-11-24 02:29:14,693 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:29:15 INFO - 2015-11-24 02:29:15,287 DEBUG : BROWSER_OUTPUT: RSS: Main: 325341184 02:29:15 INFO - 2015-11-24 02:29:15,287 DEBUG : BROWSER_OUTPUT: 02:29:16 INFO - 2015-11-24 02:29:16,946 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49264/tests/kraken/driver.html?testName=ai-astar) 02:29:17 INFO - 2015-11-24 02:29:17,195 DEBUG : BROWSER_OUTPUT: RSS: Main: 383819776 02:29:17 INFO - 2015-11-24 02:29:17,195 DEBUG : BROWSER_OUTPUT: 02:29:17 INFO - 2015-11-24 02:29:17,195 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:29:17 INFO - 2015-11-24 02:29:17,195 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:29:17 INFO - 2015-11-24 02:29:17,195 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:29:17 INFO - 2015-11-24 02:29:17,195 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:29:17 INFO - 2015-11-24 02:29:17,195 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;110;102;110;110;109;99;108;111;104 02:29:17 INFO - 2015-11-24 02:29:17,196 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;171;150;141;156;127;174;176;135;153;114 02:29:17 INFO - 2015-11-24 02:29:17,196 DEBUG : BROWSER_OUTPUT: |2;audio-dft;182;182;181;183;182;183;184;180;182;177 02:29:17 INFO - 2015-11-24 02:29:17,196 DEBUG : BROWSER_OUTPUT: |3;audio-fft;63;70;80;75;55;57;56;71;72;54 02:29:17 INFO - 2015-11-24 02:29:17,196 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;82;84;114;76;75;75;113;76;74;111 02:29:17 INFO - 2015-11-24 02:29:17,196 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;85;85;85;85;85;89;132;118;87;87 02:29:17 INFO - 2015-11-24 02:29:17,196 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;93;95;94;94;93;94;94;94;94;93 02:29:17 INFO - 2015-11-24 02:29:17,196 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;84;83;84;84;85;83;85;97;124;83 02:29:17 INFO - 2015-11-24 02:29:17,196 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;56;69;73;77;82;84;73;64;52;53 02:29:17 INFO - 2015-11-24 02:29:17,197 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;62;63;65;65;66;65;66;66;68 02:29:17 INFO - 2015-11-24 02:29:17,197 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;82;82;98;105;102;99;79;83;83 02:29:17 INFO - 2015-11-24 02:29:17,197 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;125;121;121;121;131;120;124;131;120;119 02:29:17 INFO - 2015-11-24 02:29:17,197 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;119;157;172;172;151;137;134;133;126 02:29:17 INFO - 2015-11-24 02:29:17,197 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;63;65;64;64;63;64;63;64;68;64 02:29:17 INFO - 2015-11-24 02:29:17,197 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:29:17 INFO - 2015-11-24 02:29:17,197 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:29:17 INFO - 2015-11-24 02:29:17,197 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1041 02:29:17 INFO - 2015-11-24 02:29:17,197 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:29:17 INFO - 2015-11-24 02:29:17,197 DEBUG : BROWSER_OUTPUT: __startTimestamp1448360957194__endTimestamp 02:29:17 INFO - 2015-11-24 02:29:17,197 DEBUG : BROWSER_OUTPUT: 02:29:17 INFO - 2015-11-24 02:29:17,199 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:29:17 INFO - 2015-11-24 02:29:17,199 DEBUG : BROWSER_OUTPUT: Number of tests: 14 02:29:17 INFO - 2015-11-24 02:29:17,199 DEBUG : BROWSER_OUTPUT: 02:29:17 INFO - 2015-11-24 02:29:17,199 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.20 Median:110.00 stddev:4.08 (3.7%) stddev-sans-first:4.27 02:29:17 INFO - 2015-11-24 02:29:17,199 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 102.0 110.0 110.0 109.0 99.0 108.0 111.0 104.0 02:29:17 INFO - 2015-11-24 02:29:17,199 DEBUG : BROWSER_OUTPUT: 02:29:17 INFO - 2015-11-24 02:29:17,199 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.70 Median:154.50 stddev:20.73 (13.4%) stddev-sans-first:20.51 02:29:17 INFO - 2015-11-24 02:29:17,199 DEBUG : BROWSER_OUTPUT: Values: 171.0 150.0 141.0 156.0 127.0 174.0 176.0 135.0 153.0 114.0 02:29:17 INFO - 2015-11-24 02:29:17,199 DEBUG : BROWSER_OUTPUT: 02:29:17 INFO - 2015-11-24 02:29:17,199 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:181.60 Median:182.00 stddev:1.96 (1.1%) stddev-sans-first:2.07 02:29:17 INFO - 2015-11-24 02:29:17,200 DEBUG : BROWSER_OUTPUT: Values: 182.0 182.0 181.0 183.0 182.0 183.0 184.0 180.0 182.0 177.0 02:29:17 INFO - 2015-11-24 02:29:17,200 DEBUG : BROWSER_OUTPUT: 02:29:17 INFO - 2015-11-24 02:29:17,200 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:65.30 Median:70.50 stddev:9.45 (13.4%) stddev-sans-first:9.99 02:29:17 INFO - 2015-11-24 02:29:17,200 DEBUG : BROWSER_OUTPUT: Values: 63.0 70.0 80.0 75.0 55.0 57.0 56.0 71.0 72.0 54.0 02:29:17 INFO - 2015-11-24 02:29:17,200 DEBUG : BROWSER_OUTPUT: 02:29:17 INFO - 2015-11-24 02:29:17,200 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:88.00 Median:75.50 stddev:17.33 (23.0%) stddev-sans-first:18.25 02:29:17 INFO - 2015-11-24 02:29:17,200 DEBUG : BROWSER_OUTPUT: Values: 82.0 84.0 114.0 76.0 75.0 75.0 113.0 76.0 74.0 111.0 02:29:17 INFO - 2015-11-24 02:29:17,200 DEBUG : BROWSER_OUTPUT: 02:29:17 INFO - 2015-11-24 02:29:17,200 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:93.80 Median:85.00 stddev:16.82 (19.8%) stddev-sans-first:17.54 02:29:17 INFO - 2015-11-24 02:29:17,200 DEBUG : BROWSER_OUTPUT: Values: 85.0 85.0 85.0 85.0 85.0 89.0 132.0 118.0 87.0 87.0 02:29:17 INFO - 2015-11-24 02:29:17,200 DEBUG : BROWSER_OUTPUT: 02:29:17 INFO - 2015-11-24 02:29:17,202 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:93.80 Median:94.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 02:29:17 INFO - 2015-11-24 02:29:17,202 DEBUG : BROWSER_OUTPUT: Values: 93.0 95.0 94.0 94.0 93.0 94.0 94.0 94.0 94.0 93.0 02:29:17 INFO - 2015-11-24 02:29:17,202 DEBUG : BROWSER_OUTPUT: 02:29:17 INFO - 2015-11-24 02:29:17,202 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:89.20 Median:84.00 stddev:12.93 (15.4%) stddev-sans-first:13.57 02:29:17 INFO - 2015-11-24 02:29:17,202 DEBUG : BROWSER_OUTPUT: Values: 84.0 83.0 84.0 84.0 85.0 83.0 85.0 97.0 124.0 83.0 02:29:17 INFO - 2015-11-24 02:29:17,202 DEBUG : BROWSER_OUTPUT: 02:29:17 INFO - 2015-11-24 02:29:17,202 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:68.30 Median:73.00 stddev:11.66 (16.0%) stddev-sans-first:11.49 02:29:17 INFO - 2015-11-24 02:29:17,202 DEBUG : BROWSER_OUTPUT: Values: 56.0 69.0 73.0 77.0 82.0 84.0 73.0 64.0 52.0 53.0 02:29:17 INFO - 2015-11-24 02:29:17,202 DEBUG : BROWSER_OUTPUT: 02:29:17 INFO - 2015-11-24 02:29:17,202 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:65.50 stddev:1.79 (2.7%) stddev-sans-first:1.76 02:29:17 INFO - 2015-11-24 02:29:17,202 DEBUG : BROWSER_OUTPUT: Values: 63.0 62.0 63.0 65.0 65.0 66.0 65.0 66.0 66.0 68.0 02:29:17 INFO - 2015-11-24 02:29:17,203 DEBUG : BROWSER_OUTPUT: 02:29:17 INFO - 2015-11-24 02:29:17,203 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:89.50 Median:82.50 stddev:10.12 (12.3%) stddev-sans-first:10.37 02:29:17 INFO - 2015-11-24 02:29:17,203 DEBUG : BROWSER_OUTPUT: Values: 82.0 82.0 82.0 98.0 105.0 102.0 99.0 79.0 83.0 83.0 02:29:17 INFO - 2015-11-24 02:29:17,203 DEBUG : BROWSER_OUTPUT: 02:29:17 INFO - 2015-11-24 02:29:17,203 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.30 Median:122.50 stddev:4.45 (3.6%) stddev-sans-first:4.68 02:29:17 INFO - 2015-11-24 02:29:17,203 DEBUG : BROWSER_OUTPUT: Values: 125.0 121.0 121.0 121.0 131.0 120.0 124.0 131.0 120.0 119.0 02:29:17 INFO - 2015-11-24 02:29:17,203 DEBUG : BROWSER_OUTPUT: 02:29:17 INFO - 2015-11-24 02:29:17,203 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.90 Median:144.50 stddev:18.38 (12.7%) stddev-sans-first:19.37 02:29:17 INFO - 2015-11-24 02:29:17,203 DEBUG : BROWSER_OUTPUT: Values: 138.0 119.0 157.0 172.0 172.0 151.0 137.0 134.0 133.0 126.0 02:29:17 INFO - 2015-11-24 02:29:17,203 DEBUG : BROWSER_OUTPUT: 02:29:17 INFO - 2015-11-24 02:29:17,203 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:64.00 stddev:1.48 (2.3%) stddev-sans-first:1.50 02:29:17 INFO - 2015-11-24 02:29:17,203 DEBUG : BROWSER_OUTPUT: Values: 63.0 65.0 64.0 64.0 63.0 64.0 63.0 64.0 68.0 64.0 02:29:17 INFO - 2015-11-24 02:29:17,203 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:29:17 INFO - 2015-11-24 02:29:17,204 DEBUG : BROWSER_OUTPUT: 02:29:17 INFO - 2015-11-24 02:29:17,915 INFO : Browser exited with error code: 0 02:29:17 INFO - 2015-11-24 02:29:17,963 INFO : Completed test kraken (00:00:56) 02:29:17 INFO - 2015-11-24 02:29:17,963 INFO : Starting test v8_7 02:29:17 INFO - 2015-11-24 02:29:17,963 DEBUG : operating with platform_type : mac_ 02:29:17 INFO - 2015-11-24 02:29:17,963 INFO : Initialising browser for v8_7 test... 02:29:17 INFO - 2015-11-24 02:29:17,975 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/tmpfrtcAj/profile http://localhost:49264/getInfo.html 02:29:19 INFO - 2015-11-24 02:29:19,970 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:29:19 INFO - 2015-11-24 02:29:19,970 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:29:19 INFO - 2015-11-24 02:29:19,970 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 02:29:19 INFO - 2015-11-24 02:29:19,970 DEBUG : BROWSER_OUTPUT: __metrics 02:29:19 INFO - 2015-11-24 02:29:19,987 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:29:20 INFO - 2015-11-24 02:29:20,616 INFO : Browser initialized. 02:29:20 INFO - 2015-11-24 02:29:20,617 INFO : Running cycle 1/1 for v8_7 test... 02:29:20 INFO - 2015-11-24 02:29:20,617 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/T/tmpfrtcAj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:29:32 INFO - 2015-11-24 02:29:32,389 DEBUG : BROWSER_OUTPUT: RSS: Main: 225390592 02:29:32 INFO - 2015-11-24 02:29:32,389 DEBUG : BROWSER_OUTPUT: 02:29:53 INFO - 2015-11-24 02:29:53,793 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/v8_7/run.html (next: http://localhost:49264/tests/v8_7/run.html) 02:29:54 INFO - 2015-11-24 02:29:54,049 DEBUG : BROWSER_OUTPUT: RSS: Main: 698392576 02:29:54 INFO - 2015-11-24 02:29:54,049 DEBUG : BROWSER_OUTPUT: 02:29:54 INFO - 2015-11-24 02:29:54,049 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:29:54 INFO - 2015-11-24 02:29:54,049 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:29:54 INFO - 2015-11-24 02:29:54,049 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:29:54 INFO - 2015-11-24 02:29:54,049 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:29:54 INFO - 2015-11-24 02:29:54,049 DEBUG : BROWSER_OUTPUT: |0;Richards;174.79461632581717 02:29:54 INFO - 2015-11-24 02:29:54,049 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;160.66838046272494 02:29:54 INFO - 2015-11-24 02:29:54,049 DEBUG : BROWSER_OUTPUT: |2;Encrypt;283.12570781426956 02:29:54 INFO - 2015-11-24 02:29:54,050 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4694.835680751174 02:29:54 INFO - 2015-11-24 02:29:54,050 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1715.2658662092624 02:29:54 INFO - 2015-11-24 02:29:54,050 DEBUG : BROWSER_OUTPUT: |5;Earley;797.4481658692185 02:29:54 INFO - 2015-11-24 02:29:54,050 DEBUG : BROWSER_OUTPUT: |6;Boyer;13194.805194805194 02:29:54 INFO - 2015-11-24 02:29:54,050 DEBUG : BROWSER_OUTPUT: |7;RegExp;28055.555555555555 02:29:54 INFO - 2015-11-24 02:29:54,050 DEBUG : BROWSER_OUTPUT: |8;Splay;865.8008658008658 02:29:54 INFO - 2015-11-24 02:29:54,050 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4522.522522522522 02:29:54 INFO - 2015-11-24 02:29:54,050 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:29:54 INFO - 2015-11-24 02:29:54,050 DEBUG : BROWSER_OUTPUT: __startTimestamp1448360994044__endTimestamp 02:29:54 INFO - 2015-11-24 02:29:54,050 DEBUG : BROWSER_OUTPUT: 02:29:54 INFO - 2015-11-24 02:29:54,050 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:29:54 INFO - 2015-11-24 02:29:54,050 DEBUG : BROWSER_OUTPUT: Number of tests: 10 02:29:54 INFO - 2015-11-24 02:29:54,050 DEBUG : BROWSER_OUTPUT: 02:29:54 INFO - 2015-11-24 02:29:54,051 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:174.79 Median:174.79 stddev:0.00 (0.0%) 02:29:54 INFO - 2015-11-24 02:29:54,051 DEBUG : BROWSER_OUTPUT: Values: 174.8 02:29:54 INFO - 2015-11-24 02:29:54,051 DEBUG : BROWSER_OUTPUT: 02:29:54 INFO - 2015-11-24 02:29:54,051 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:160.67 Median:160.67 stddev:0.00 (0.0%) 02:29:54 INFO - 2015-11-24 02:29:54,051 DEBUG : BROWSER_OUTPUT: Values: 160.7 02:29:54 INFO - 2015-11-24 02:29:54,051 DEBUG : BROWSER_OUTPUT: 02:29:54 INFO - 2015-11-24 02:29:54,051 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:283.13 Median:283.13 stddev:0.00 (0.0%) 02:29:54 INFO - 2015-11-24 02:29:54,051 DEBUG : BROWSER_OUTPUT: Values: 283.1 02:29:54 INFO - 2015-11-24 02:29:54,051 DEBUG : BROWSER_OUTPUT: 02:29:54 INFO - 2015-11-24 02:29:54,051 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4694.84 Median:4694.84 stddev:0.00 (0.0%) 02:29:54 INFO - 2015-11-24 02:29:54,051 DEBUG : BROWSER_OUTPUT: Values: 4694.8 02:29:54 INFO - 2015-11-24 02:29:54,051 DEBUG : BROWSER_OUTPUT: 02:29:54 INFO - 2015-11-24 02:29:54,051 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1715.27 Median:1715.27 stddev:0.00 (0.0%) 02:29:54 INFO - 2015-11-24 02:29:54,052 DEBUG : BROWSER_OUTPUT: Values: 1715.3 02:29:54 INFO - 2015-11-24 02:29:54,052 DEBUG : BROWSER_OUTPUT: 02:29:54 INFO - 2015-11-24 02:29:54,052 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:797.45 Median:797.45 stddev:0.00 (0.0%) 02:29:54 INFO - 2015-11-24 02:29:54,052 DEBUG : BROWSER_OUTPUT: Values: 797.4 02:29:54 INFO - 2015-11-24 02:29:54,052 DEBUG : BROWSER_OUTPUT: 02:29:54 INFO - 2015-11-24 02:29:54,052 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:13194.81 Median:13194.81 stddev:0.00 (0.0%) 02:29:54 INFO - 2015-11-24 02:29:54,052 DEBUG : BROWSER_OUTPUT: Values: 13194.8 02:29:54 INFO - 2015-11-24 02:29:54,052 DEBUG : BROWSER_OUTPUT: 02:29:54 INFO - 2015-11-24 02:29:54,052 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:28055.56 Median:28055.56 stddev:0.00 (0.0%) 02:29:54 INFO - 2015-11-24 02:29:54,052 DEBUG : BROWSER_OUTPUT: Values: 28055.6 02:29:54 INFO - 2015-11-24 02:29:54,052 DEBUG : BROWSER_OUTPUT: 02:29:54 INFO - 2015-11-24 02:29:54,052 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:865.80 Median:865.80 stddev:0.00 (0.0%) 02:29:54 INFO - 2015-11-24 02:29:54,052 DEBUG : BROWSER_OUTPUT: Values: 865.8 02:29:54 INFO - 2015-11-24 02:29:54,052 DEBUG : BROWSER_OUTPUT: 02:29:54 INFO - 2015-11-24 02:29:54,053 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4522.52 Median:4522.52 stddev:0.00 (0.0%) 02:29:54 INFO - 2015-11-24 02:29:54,053 DEBUG : BROWSER_OUTPUT: Values: 4522.5 02:29:54 INFO - 2015-11-24 02:29:54,053 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:29:54 INFO - 2015-11-24 02:29:54,053 DEBUG : BROWSER_OUTPUT: 02:29:54 INFO - 2015-11-24 02:29:54,867 INFO : Browser exited with error code: 0 02:29:54 INFO - 2015-11-24 02:29:54,885 INFO : Completed test v8_7 (00:00:36) 02:29:55 INFO - 2015-11-24 02:29:55,135 INFO : Completed test suite (00:20:07) 02:29:55 INFO - 2015-11-24 02:29:55,135 DEBUG : Working with test: dromaeo_css 02:29:55 INFO - 2015-11-24 02:29:55,135 DEBUG : Generating results file: dromaeo_css 02:29:55 INFO - 2015-11-24 02:29:55,136 DEBUG : Working with test: kraken 02:29:55 INFO - 2015-11-24 02:29:55,136 DEBUG : Generating results file: kraken 02:29:55 INFO - 2015-11-24 02:29:55,136 INFO : javascript benchmark 02:29:55 INFO - 2015-11-24 02:29:55,137 DEBUG : Working with test: v8_7 02:29:55 INFO - 2015-11-24 02:29:55,137 DEBUG : Generating results file: v8_7 02:29:55 INFO - 2015-11-24 02:29:55,137 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:29:55 INFO - 2015-11-24 02:29:55,599 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 02:29:55 INFO - 2015-11-24 02:29:55,599 DEBUG : process_Request line: dromaeo_css 7562.31 graph.html#tests=[[72,64,59]] 02:29:55 INFO - 2015-11-24 02:29:55,599 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:29:55 INFO - 2015-11-24 02:29:55,622 DEBUG : process_Request line: kraken 1422.70 graph.html#tests=[[232,64,59]] 02:29:55 INFO - 2015-11-24 02:29:55,622 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:29:55 INFO - 2015-11-24 02:29:55,648 DEBUG : process_Request line: v8_7 19616.83 graph.html#tests=[[230,64,59]] 02:29:55 INFO - 2015-11-24 02:29:55,649 INFO : javascript benchmark 02:29:55 INFO - 2015-11-24 02:29:55,651 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3401.7618766686332, 3497.772644778091, 3533.6643018913196, 3537.363274610571, 3567.732420068495, 5559.916601250974, 5690.4025077366905, 5758.769649214031, 5769.682667453289, 5794.710264486775, 5706.201131841545, 5708.77164913404, 5716.39977802331, 5850.297964244286, 5854.473097421232, 5014.2979982802435, 5129.358830146241, 5139.6659217150955, 5154.994776018678, 5186.974065129688, 4752.144613969484, 5280.5247527722495, 5292.311999440087, 5308.681479111266, 5347.59893008024, 5082.3138876251605, 5161.793528258865, 5191.454897235773, 5232.3459567554055, 5248.0, 5051.621128415383, 5157.767900444489, 5192.818251361222, 5199.4800519948085, 5212.270282160501, 5188.143956247215, 5192.896142077175, 5210.218467229908, 5226.0, 5232.764525596357, 5519.2824932758485, 5631.831045068655, 5727.742251598646, 5753.0, 5759.0, 5273.736313184364, 6108.572399932006, 6175.505959523227, 6190.752369905198, 6192.349803270682, 5302.310699609065, 6331.746730130789, 6353.618782872996, 6357.554971152022, 6361.363863613602, 5921.378255283219, 5924.4667979882015, 5939.4357536034, 5943.465088142045, 5945.346011938684, 5299.205119232146, 6198.132261483396, 6318.08387783778, 6332.651704156316, 6338.968305158537, 6028.668423236676, 6199.3490683477585, 6215.254169499599, 6221.440070393596, 6231.937680623136, 6312.5265605078885, 6325.557210995278, 6344.429001389804, 6349.301576826545, 6355.809325720235, 4987.950120498821, 5194.4805519447755, 6162.137300777895, 6302.401271879165, 6302.527310451735, 6106.39999602577, 6196.10156527301, 6217.906731398942, 6241.095041218998, 6245.968770156211, 5012.649114562018, 5026.145555255615, 5026.29631851541, 5026.547610715053, 5041.6470847040355, 4396.978015109904, 4490.57339552742, 4495.056038231943, 4503.054358584734, 4530.320451932236, 5561.026820306431, 5663.433656634386, 5723.3418156912485, 5767.106098554731, 5774.364819869811, 4947.554720075139, 6290.8427289317215, 6308.653024083719, 6330.620162790247, 6368.490520758328, 5614.63504872182, 5714.599978001583, 5747.5114615257335, 5755.136729490526, 5779.595428319977, 5390.703511306916, 5424.918626220609, 5436.864078398072, 5457.454254574511, 5479.6164268500825, 6370.1718776558755, 6418.069379939976, 6429.196350456193, 6433.0, 6433.0, 6120.994312659307, 6277.937220627735, 6328.177336946352, 6343.52423568225, 6348.460380867493, 6264.154339164337, 6288.496920246278, 6295.307516173309, 6310.495160387066, 6321.841953951188, 6079.148919151411, 6172.444479996821, 6239.313675495601, 6247.219097612799, 6258.123862659322, 6325.557210995186, 6329.430351268408, 6332.841678958063, 6334.8733025338315, 6340.144080549251, 6005.279366476051, 6202.4417802398, 6209.534284928558, 6221.4089661482085, 6244.219472565929, 5993.250843644544, 6076.422739839708, 6140.964409184605, 6161.0, 6180.258368995749, 5335.626506144533, 5659.151127330769, 6027.517798576191, 6074.817755467343, 6087.512998960161, 5391.541718953933, 6168.224299065492, 6184.103305020837, 6202.627842329474, 6207.751689932533, 4987.925181122214, 5944.138099975393, 5978.611390259619, 5984.850378740566, 5988.431099045583], "unit": "ms", "name": "dojo.html", "value": 5692.865584634089}, {"lowerIsBetter": false, "replicates": [519.7915132394795, 572.6020415811013, 598.5301538292441, 630.5428564290889, 649.9568193050158, 31831.840840795794, 32408.18979525513, 32561.185970350754, 40658.7967060165, 41357.793211033975, 43937.7803110984, 44076.3388549172, 44202.778986105106, 44313.0, 44456.55543444565, 9804.509774511282, 9991.650292239772, 9993.950030249838, 10000.099991000809, 10041.698749037541, 8851.734447966539, 8906.198442140207, 8920.509371984539, 8921.01868794432, 8936.910630893706, 12174.513019479211, 12234.93882530586, 12255.632331030083, 12258.0, 12259.203151795105, 11988.160828741991, 12026.098042646749, 12026.977706894924, 12048.277103373826, 12098.334591597459, 8893.510856902867, 8989.775255618597, 8994.505302208376, 11826.940865295704, 11988.220765650205, 32155.035348939335, 41409.378859317134, 41701.1659766806, 41755.7912210437, 41760.58239417628, 2622.3706310485536, 3189.5056266278766, 3240.96759032409, 3803.1633040730994, 3923.764014335504, 23638.527229455485, 28354.574681379796, 28693.856530717214, 28795.712042879513, 29435.558466623017, 2675.5786212701614, 2729.6314997475283, 2855.129185598392, 2959.3785305085744, 2984.68660790616, 417768.0, 481577.59211204073, 481595.0, 484284.0, 486109.569452154, 65953.34046659568, 66811.0, 67044.0, 67055.32944670589, 67066.32933670601, 65291.673541631986, 66376.6681166591, 66384.00423993645, 66533.0, 66615.0, 15471.839612029144, 15634.296456659478, 15637.765433518507, 15666.0, 15677.843221567638, 12033.157678962389, 12104.455299511543, 12138.817917731241, 12218.938905305416, 12259.570915017932, 20202.797972020093, 20386.757456679752, 20443.4889127773, 20457.89771051135, 20463.38609841707, 8799.824003520022, 9013.278937684969, 9050.728478145666, 9056.003839577641, 9131.223845973167, 899.7480705402497, 916.9037251088673, 1046.6964580271635, 1124.7300647844459, 1159.3160035579049, 24271.0, 25218.360806547516, 29039.85480072586, 29681.554776678367, 31316.53025204624, 915.455304094063, 1073.5437439088357, 1078.8435676826816, 1085.630885498934, 1190.3334132885611, 14069.71860562783, 14078.85921140796, 14412.495562655256, 14432.422703091968, 14467.0, 505025.0, 517341.0, 522724.0, 524199.0, 524388.0, 56247.0, 56600.0, 56640.43359566434, 56655.71672141695, 56713.43286567164, 1330.035724100039, 1345.2264947654942, 1455.6651970046948, 1475.6458449971929, 1620.473346162502, 24445.38886527851, 29245.85377073101, 29275.70724292815, 29562.408751825275, 29661.25846853846, 54895.0, 55297.0, 55311.44688553063, 55363.723181385445, 55390.0, 488539.0, 489584.0, 493772.0, 537455.0, 544546.0, 32490.02529924106, 32807.507887382184, 33001.50497742488, 33004.50493242555, 33017.50473742848, 40184.19631607293, 40691.0, 40699.3895091568, 41100.972475688344, 41286.0, 31720.841395792875, 34035.80874669375, 34261.0, 34640.30719385548, 34774.47931768955, 34298.0, 34861.9541413758, 34944.126396840285, 34976.65023349836, 35134.0, 34338.48492272568, 35166.94499165029, 35189.82405087958, 35347.82326088353, 35371.0, 30865.919692810643, 31792.68207317897, 31828.0, 31843.36313273675, 31867.521987169748, 24260.87869560641, 24783.50432991366, 24868.502629947663, 25149.497010060062, 25304.74695253024], "unit": "ms", "name": "ext.html", "value": 19946.27283798158}, {"lowerIsBetter": false, "replicates": [356.3016487684139, 356.6504825271234, 364.05709213137965, 364.2369236449637, 368.5062016897357, 16088.356465741386, 16634.417795377165, 19358.516037099063, 20332.59334813303, 21073.0, 11257.099432045437, 11546.36494992775, 11546.53813847445, 19813.801861981377, 20267.0, 5099.2606072119615, 5239.10935141025, 5247.055530004598, 5254.31693879797, 5262.236975638531, 3929.7445666031617, 4038.838446462138, 4058.553559108496, 5286.4449232830575, 5752.108423194411, 5854.29748430189, 5911.733971971272, 5920.141579470996, 5920.348761636216, 5923.229980102581, 5677.943220567803, 5769.9711501442225, 5780.161876527901, 5780.797672081499, 5808.2449281593545, 5550.16747487876, 5551.361593416768, 5551.833444996657, 5560.388357280696, 5562.7774889004395, 23849.403764906016, 24167.395815104588, 24497.387565311008, 24680.0, 24826.751732482626, 1966.3412756726514, 1999.5600967787063, 2017.384697667211, 2098.9790102098937, 2113.6301147299314, 9656.90343096567, 9683.90316096837, 9691.127798498099, 9933.3543319684, 9990.35062720928, 1696.3384280130758, 1703.4634090261527, 1732.3936622182262, 1752.229019231534, 1779.80422153563, 85596.74890914763, 86421.56789216014, 87501.0, 99138.504307478, 99408.0, 10951.288166269167, 11070.169737269736, 11098.889011109946, 11112.944435277772, 11200.551977920792, 13019.414126364336, 13052.216866987821, 13059.804102938464, 13067.150635208682, 13071.869281307256, 6993.0, 8047.913531673149, 8236.8352632947, 8329.416940814206, 8373.916260837435, 8311.667533298722, 8315.085340612528, 8326.25063744266, 8382.538960357238, 8402.621882015203, 3850.7304488685522, 4185.660588611615, 4382.671299652538, 4384.802683879233, 4391.714538554984, 1710.9914450427668, 1760.375066851275, 1765.7969333526553, 1768.5667011582245, 1817.790954040276, 839.9496030238205, 930.2743859789375, 955.2883102088988, 1051.2010871737534, 1091.9789996353277, 14729.705405892037, 15949.963252388558, 16281.430149944696, 21539.56920861574, 21629.0, 906.7642412972542, 937.3672770879629, 951.3530799056708, 985.605757696927, 1021.3004092196869, 11106.944465277622, 11301.208915375844, 11459.77080458386, 11463.968242858184, 11507.252028618113, 779604.0, 782604.0, 793687.2840722181, 797572.0, 800290.0, 104090.95909040813, 110191.0, 110874.0, 113049.0, 116832.0, 1185.7213554814612, 1190.7853988931242, 1201.7476329970805, 1203.1938601137258, 1224.6938265433641, 18190.090495475437, 18352.348010778696, 18608.16263268129, 18778.624427511648, 19041.714374284118, 48966.0, 50830.0, 51098.0, 51201.23198152105, 51674.22488662748, 58843.70578147082, 62375.68812156092, 68000.6599966997, 68446.63106737738, 72425.27574724186, 9864.704058878246, 9905.207583393456, 10150.187984961332, 10170.593176272867, 10183.643572474928, 19757.20971161195, 19815.60368792587, 19896.70154947706, 20451.79548204499, 20583.0, 11002.449877506253, 15627.14050727221, 16116.355345786038, 16118.113503757406, 16141.838581614034, 15191.012584181994, 15278.083315001135, 15465.226738663247, 15496.535103946899, 16292.18539073018, 15423.922880385526, 15614.843851561793, 15824.60438489047, 16122.355105796107, 16585.50243492697, 9584.616615335588, 9689.370190937567, 9762.951185244028, 9796.461194634363, 9843.704688859345, 10012.648292480422, 10208.948955255177, 11424.371659558805, 15871.047737135346, 16291.837081629506], "unit": "ms", "name": "jquery.html", "value": 9673.541603877331}, {"lowerIsBetter": false, "replicates": [1539.9538013859587, 1550.9612259693513, 1668.4077152610814, 1902.1250224896546, 1925.1625542888842, 7829.647665855036, 8071.838563228732, 8220.91779082209, 8560.657573697044, 8572.14278572144, 7028.402585780214, 8452.746417607466, 8488.151184881508, 8491.980962284519, 8503.574821258942, 2380.1669415704496, 2396.113438027923, 2396.2332053742807, 2399.9880000599974, 2404.591219492682, 2406.5066661334386, 2433.561958847407, 2451.742567030463, 2457.7542245775458, 2459.4589190378088, 2376.489054853206, 2405.434722840131, 2407.313915534073, 2407.350015495815, 2412.1557454890735, 2373.4422410733464, 2396.376941995085, 2408.277516744978, 2410.0480310277517, 2411.807055435561, 2398.5442765874604, 2413.5655581995234, 2434.42790944128, 2434.6834911461574, 2435.5737745894576, 7743.9158517807555, 8447.577621118919, 8468.0, 8484.151584841527, 8492.872606910902, 4392.824287028515, 4669.159551280768, 5024.422191447994, 5181.145111056671, 5190.4031036430915, 2859.642544681915, 2872.5116730155924, 3501.2997400519744, 3556.4309710446464, 3612.7832330060282, 1068.7595291059527, 1638.2709694186092, 1649.397969741048, 1665.925033373501, 1712.4177779554886, 11109.944450277697, 11221.607243746512, 11245.381504017358, 11253.212275140744, 11277.436128193558, 4529.818807247739, 4537.977310113428, 4603.562661547215, 4626.653001024936, 4639.489656137822, 9140.04029576885, 9144.451332920045, 9145.862812057825, 9157.862632060524, 9158.954205229065, 5124.743762811844, 5138.100832354323, 5139.7687104080405, 5144.382674079135, 5154.974225128851, 4719.4100737407825, 4723.267893476516, 4726.172919739032, 4738.64460165489, 4742.928856067162, 3530.1527633367805, 3602.495650608917, 3635.345637785224, 3641.927161456756, 3644.0889777555612, 1121.243160866412, 1134.0304040045808, 1142.7485953090472, 1143.7941170589208, 1145.873953865074, 1350.6623344163959, 1359.7484465373936, 1380.2615600653603, 1380.9861901380857, 1415.7027024325007, 7825.804354891174, 7927.484713493604, 7964.044314682275, 7973.282404583615, 7976.800579985431, 490.9533594308535, 505.5626882746398, 506.0839879817542, 509.8317555206773, 511.0366958283662, 6067.605605635619, 6173.41352571505, 6183.783567575113, 6274.623522588659, 6277.497800175975, 9184.403013804082, 10191.0, 10333.638322658671, 10335.948320258502, 10355.534000969974, 9998.250131240186, 10219.182465402899, 10219.284650074573, 10255.692329230134, 10311.639092631873, 7832.843343133105, 7907.169747176578, 7978.202179781975, 7996.480228785111, 7997.0, 7771.766846994599, 7899.0126234220725, 7926.167752386147, 7927.563983980705, 7954.522728636301, 7530.887036694345, 9038.728838134866, 9092.318076144184, 9174.174324310845, 9250.444973301623, 9195.954020229856, 9428.151466367786, 9495.477748723886, 9503.049695030442, 9537.14165725088, 6843.726250950105, 6849.452043836382, 6855.931440685529, 6907.309269073254, 6940.826479338057, 8066.959665201636, 8124.471909325875, 8139.1453897339925, 8151.225633565039, 8156.796080098045, 6263.686815659108, 7490.1386340571535, 7570.242975702386, 7723.961380193063, 7730.652120654471, 7321.963390183015, 7389.261073892568, 7440.516366436164, 7469.775906722807, 7508.812279693051, 7587.468877178544, 7642.8089297768, 7649.388048955959, 7653.425993050432, 7667.079950405987, 6862.078617986772, 6889.586624802528, 6947.270536593787, 6953.374196322356, 6964.6517674115075, 7001.124859392576, 7023.262557431601, 7049.929500704928, 7059.929400705927, 7065.752698655522], "unit": "ms", "name": "mootools.html", "value": 4727.0272756203185}, {"lowerIsBetter": false, "replicates": [318.9027346659269, 326.0950861359726, 328.87667124828187, 329.01624143810017, 331.97676162668625, 6656.434203092736, 6681.0980517630105, 6693.832654183654, 6700.26297107319, 6808.080909077273, 5351.438098999607, 6601.669916504167, 6669.133012708353, 6686.598804071759, 6692.732290708366, 4906.116898958177, 4920.311156438083, 4924.655274130794, 4924.901501969958, 4927.6550641455115, 4688.5545873142, 4811.182099043153, 4814.640825995255, 4816.903661926777, 4936.456989731127, 4832.420109586855, 4837.863102170987, 4847.2971419144205, 4848.0, 4859.416869975608, 4564.634829213688, 4715.24556071027, 4716.985848042653, 4844.830430934918, 4852.587530059932, 3236.5307030480685, 3269.836508174582, 4100.17996400718, 4114.362273847559, 4135.9172816543805, 6314.210723659543, 6326.367363263636, 6344.238691357021, 6373.808785736435, 6382.968085159545, 5436.184572314145, 5635.8591035224035, 5729.054705973509, 5785.768569257225, 5787.102999035114, 6587.934120658828, 6886.827829304308, 7052.541584796972, 7076.646167691595, 7145.6784444700115, 3795.411711184771, 4615.0, 4621.560951709582, 4626.467956185048, 4629.282461218517, 7501.24987501251, 7590.620468976585, 7603.961980190119, 7608.923910760932, 7619.885701714478, 4517.638588912879, 4686.437627484655, 4688.46082700487, 4726.763661816895, 4736.597389221886, 4798.640101992295, 4806.903861922812, 4814.9518504814505, 4817.855464336076, 4821.9035619287415, 4611.262198048296, 5727.627704199213, 5730.226419433407, 5742.799002034909, 5750.396208398058, 7006.229314775371, 7273.054502914693, 7277.636118194069, 7281.599512026889, 7287.927120728831, 1644.745064515002, 1660.8671306295466, 1662.9002259864446, 1664.0015990405902, 1667.733162693963, 1048.3238311289176, 1053.9736506587396, 1058.7564860082225, 1064.9094826939797, 1074.3070719385953, 6696.06255124283, 6699.02864084705, 6699.162604674319, 6703.463722902254, 6739.966300168468, 7493.138289096714, 7504.061992250969, 7527.548347099191, 7535.962320188473, 7562.243775622504, 6385.393387628168, 6639.601623902581, 6647.069410282565, 6653.933460665428, 6680.5991640501725, 3833.21419109082, 3960.3663413853646, 3990.3216453203027, 3994.021464741099, 4005.599440055971, 6167.321594624587, 7672.347850432776, 7678.577678227751, 7682.308592226726, 7690.346320562815, 6286.308506064329, 7686.116096648845, 7744.612769361509, 7878.212178782076, 7880.527168369917, 6204.317525072239, 6975.709493743674, 7326.084239470067, 7869.449138560246, 7889.4082943780595, 6087.05650624154, 7252.854942901218, 7615.581143036965, 7620.161782203842, 7625.3137217648455, 7462.253774622494, 7467.626618668936, 7476.4018878488505, 7477.177510473953, 7481.738139165103, 7597.6581053851605, 7829.177936316605, 7829.686812527435, 7838.412119090977, 7854.332381747616, 4721.055788842176, 4724.433068031858, 4728.40894888139, 4731.952680473289, 4741.146593613183, 7344.803692896367, 7524.2851929066655, 7526.548407095592, 7533.2466753324225, 7553.433492488195, 7204.71181152748, 7304.269573042653, 7313.67088481009, 7316.195218526064, 7316.634168291458, 7234.3127402898745, 7285.927140728525, 7290.5625662460425, 7309.597972111585, 7316.378107860892, 6920.100386949664, 7103.431725462054, 7112.964435177791, 7131.8573628528175, 7139.535930164523, 7270.345668889825, 7290.453216008927, 7292.197858235484, 7297.7889728519285, 7301.671424785791, 7124.323189297009, 7144.3927266182955, 7144.749933752294, 7147.85704285901, 7148.892766608609], "unit": "ms", "name": "prototype.html", "value": 5199.779330904112}, {"lowerIsBetter": false, "replicates": [727.6870945493438, 766.8082979255187, 776.8601651702693, 803.5018288661028, 834.3367023216542, 15145.545633630982, 15458.381664733412, 15487.0, 15491.69016619667, 15513.534593962186, 13947.930260348685, 14097.295135243223, 14109.717805643906, 14115.223662698547, 14125.081869678464, 731.0386841303682, 747.8915557244196, 748.9888650322076, 932.9393589416666, 948.2461443152675, 932.5150921520805, 933.5099072986702, 943.9244860411151, 945.8864936207631, 946.5267366316841, 779.8128449172215, 981.543582234261, 996.7856910764184, 997.0627610046533, 998.5057396588699, 632.2697284636253, 782.1904329019466, 784.3842583571869, 785.783909424907, 810.5096416667949, 732.0190944134885, 733.8825787873968, 734.5886303669962, 734.9485536012481, 735.9337659610608, 14624.049436786681, 14785.038972466755, 14785.486467300585, 14790.63023424423, 14796.964212505129, 9973.601055957753, 12323.815142772866, 12630.368481575884, 12743.235405875585, 12973.805392919114, 10196.592136314539, 10215.881657510161, 10352.430616316175, 10353.430561319125, 10359.585616575328, 3518.8064656443885, 3534.5581802274714, 3535.505029295901, 3536.522569453117, 3550.2721942001826, 73203.0, 74229.25770742277, 74365.84512323141, 74535.0, 75846.62076689636, 9368.203702685212, 9507.57215925285, 9608.519574021271, 9649.0, 9723.805523889483, 21244.0, 21257.89371053135, 21276.255331063647, 21288.0, 21293.89353053225, 7308.415326773846, 7396.593187374746, 7410.851782964311, 7466.738664146729, 7656.9234307657325, 3949.3681011038097, 3978.224246272007, 4030.979845100756, 4085.9591404086173, 4123.0310876943895, 3564.4475106358555, 3621.9637803622154, 3623.4202527595985, 3623.9637603624155, 3632.4369722693023, 672.2873753820966, 689.7068745783022, 691.9273476284917, 693.9236683964759, 700.9439244860399, 457.93588897554366, 478.5262590035909, 509.4421608338863, 524.3262407805951, 542.7883125581027, 8965.266683587908, 9254.4910029949, 9310.53447327631, 9347.439153650803, 9356.251499879992, 439.3475688602423, 578.945000224978, 598.9550783691241, 606.4087514673247, 608.975640974365, 3422.281320922584, 3789.6778773803985, 4078.469798926121, 4126.938095928564, 4233.30150525166, 86235.56882215549, 86242.13757862341, 86864.56567717121, 91196.0, 91930.0, 74810.50378992499, 75120.24879751242, 75407.24592754002, 76319.85520217201, 78333.60833195798, 67493.66253168801, 68758.0, 69592.0, 71651.64174179095, 72972.63513682397, 8813.735587932373, 8916.821663566821, 9011.972306231046, 9094.499802510662, 9271.397359171902, 51958.48041519688, 52170.0, 52278.47721522736, 53359.46640533545, 54135.10527131532, 73823.26176738164, 76395.0, 76814.0, 76949.2305076942, 76952.23047769675, 10667.306625069346, 10932.453377331261, 10944.398058106563, 11143.2199746017, 11194.608188713355, 12111.939440302742, 12267.447964841782, 12492.125551211328, 12552.05859560555, 12746.0, 11581.826272606086, 11799.646010619696, 11823.881761182622, 11851.525938962344, 12035.518579257083, 11583.189176757545, 11807.916614964635, 11919.582814601446, 11936.880631193577, 12006.519739210684, 10972.396518191576, 11147.498362573542, 11153.553857845594, 11535.826962595736, 12062.396880155782, 9281.211097056826, 9383.483908385104, 9430.3398762086, 9494.620215191315, 10118.898811011795, 9090.318615817238, 9254.074592540961, 9768.511574421109, 9787.657431989846, 9789.65736199258], "unit": "ms", "name": "yui.html", "value": 6926.894928183921}], "name": "dromaeo_css", "value": 7562.30831569754}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 102.0, 110.0, 110.0, 109.0, 99.0, 108.0, 111.0, 104.0], "unit": "ms", "name": "ai-astar", "value": 107.2}, {"lowerIsBetter": true, "replicates": [171.0, 150.0, 141.0, 156.0, 127.0, 174.0, 176.0, 135.0, 153.0, 114.0], "unit": "ms", "name": "audio-beat-detection", "value": 149.7}, {"lowerIsBetter": true, "replicates": [182.0, 182.0, 181.0, 183.0, 182.0, 183.0, 184.0, 180.0, 182.0, 177.0], "unit": "ms", "name": "audio-dft", "value": 181.6}, {"lowerIsBetter": true, "replicates": [63.0, 70.0, 80.0, 75.0, 55.0, 57.0, 56.0, 71.0, 72.0, 54.0], "unit": "ms", "name": "audio-fft", "value": 65.3}, {"lowerIsBetter": true, "replicates": [82.0, 84.0, 114.0, 76.0, 75.0, 75.0, 113.0, 76.0, 74.0, 111.0], "unit": "ms", "name": "audio-oscillator", "value": 88.0}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 85.0, 85.0, 85.0, 89.0, 132.0, 118.0, 87.0, 87.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 93.8}, {"lowerIsBetter": true, "replicates": [93.0, 95.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 93.0], "unit": "ms", "name": "imaging-darkroom", "value": 93.8}, {"lowerIsBetter": true, "replicates": [84.0, 83.0, 84.0, 84.0, 85.0, 83.0, 85.0, 97.0, 124.0, 83.0], "unit": "ms", "name": "imaging-desaturate", "value": 89.2}, {"lowerIsBetter": true, "replicates": [56.0, 69.0, 73.0, 77.0, 82.0, 84.0, 73.0, 64.0, 52.0, 53.0], "unit": "ms", "name": "json-parse-financial", "value": 68.3}, {"lowerIsBetter": true, "replicates": [63.0, 62.0, 63.0, 65.0, 65.0, 66.0, 65.0, 66.0, 66.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 64.9}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 82.0, 98.0, 105.0, 102.0, 99.0, 79.0, 83.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 89.5}, {"lowerIsBetter": true, "replicates": [125.0, 121.0, 121.0, 121.0, 131.0, 120.0, 124.0, 131.0, 120.0, 119.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 123.3}, {"lowerIsBetter": true, "replicates": [138.0, 119.0, 157.0, 172.0, 172.0, 151.0, 137.0, 134.0, 133.0, 126.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 143.9}, {"lowerIsBetter": true, "replicates": [63.0, 65.0, 64.0, 64.0, 63.0, 64.0, 63.0, 64.0, 68.0, 64.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 64.2}], "name": "kraken", "value": 1422.6999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [174.79461632581717], "unit": "score", "name": "Richards", "value": 201.96274200000002}, {"lowerIsBetter": false, "replicates": [160.66838046272494], "unit": "score", "name": "DeltaBlue", "value": 411.51843200000013}, {"lowerIsBetter": false, "replicates": [283.12570781426956], "unit": "score", "name": "Encrypt", "value": 940.1512919999999}, {"lowerIsBetter": false, "replicates": [4694.835680751174], "unit": "score", "name": "Decrypt", "value": 56.69655300000001}, {"lowerIsBetter": false, "replicates": [1715.2658662092624], "unit": "score", "name": "RayTrace", "value": 431.413587}, {"lowerIsBetter": false, "replicates": [797.4481658692185], "unit": "score", "name": "Earley", "value": 835.7446020000003}, {"lowerIsBetter": false, "replicates": [13194.805194805194], "unit": "score", "name": "Boyer", "value": 50.509499015748034}, {"lowerIsBetter": false, "replicates": [28055.555555555555], "unit": "score", "name": "RegExp", "value": 32.470752475247544}, {"lowerIsBetter": false, "replicates": [865.8008658008658], "unit": "score", "name": "Splay", "value": 94.12210500000002}, {"lowerIsBetter": false, "replicates": [4522.522522522522], "unit": "score", "name": "NavierStokes", "value": 328.13545816733085}], "name": "v8_7", "value": 19616.826586398758}]} 02:29:55 INFO - RETURN: dromaeo_css: 7562.31 02:29:55 INFO - RETURN: kraken: 1422.70 02:29:55 INFO - RETURN: v8_7: 19616.83 02:29:55 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,59]]", "result": "19616.83"}, "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": "7562.31"}}} 02:29:55 INFO - Return code: 0 02:29:55 INFO - # TBPL SUCCESS # 02:29:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:29:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:29:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:29:55 INFO - 2015-11-24 02:29:55.750 screenresolution[1675:10023] starting screenresolution argv=screenresolution get 02:29:55 INFO - 2015-11-24 02:29:55.753 screenresolution[1675:10023] Display 0: 1600x1200x32@60 02:29:55 INFO - 2015-11-24 02:29:55.758 screenresolution[1676:10026] starting screenresolution argv=screenresolution list 02:29:55 INFO - Available Modes on Display 0 02:29:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:29:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:29:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:29:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:29:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:29:55 INFO - Intel Iris: 02:29:55 INFO - Chipset Model: Intel Iris 02:29:55 INFO - Type: GPU 02:29:55 INFO - Bus: Built-In 02:29:55 INFO - VRAM (Dynamic, Max): 1536 MB 02:29:55 INFO - Vendor: Intel (0x8086) 02:29:55 INFO - Device ID: 0x0a2e 02:29:55 INFO - Revision ID: 0x0009 02:29:55 INFO - Displays: 02:29:55 INFO - Display: 02:29:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:29:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:29:55 INFO - Display Serial Number: 1600x1200 60 02:29:55 INFO - Main Display: Yes 02:29:55 INFO - Mirror: Off 02:29:55 INFO - Online: Yes 02:29:55 INFO - Rotation: Supported 02:29:55 INFO - Return code: 0 02:29:55 INFO - Running post-action listener: _resource_record_post_action 02:29:55 INFO - Running post-run listener: _resource_record_post_run 02:29:57 INFO - Total resource usage - Wall time: 1239s; CPU: 52.0%; Read bytes: 39093760; Write bytes: 688132608; Read time: 423; Write time: 2341 02:29:57 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 344871424; Write bytes: 347420672; Read time: 27263; Write time: 673 02:29:57 INFO - run-tests - Wall time: 1209s; CPU: 52.0%; Read bytes: 36705792; Write bytes: 338713088; Read time: 395; Write time: 1660 02:29:57 INFO - Running post-run listener: _upload_blobber_files 02:29:57 INFO - Blob upload gear active. 02:29:57 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 02:29:57 INFO - Copying logs to upload dir... 02:29:57 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1281.340035 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2015-11-24 02:29:57.117640) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 02:29:57.121050) ========= 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.pb3QlLg0g4/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.Dh0JYUoKlh/Listeners TMPDIR=/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/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/hta-UQZgQceAG-88cW9C6w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009159 build_url: 'https://queue.taskcluster.net/v1/task/hta-UQZgQceAG-88cW9C6w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 02:29:57.144256) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 02:29:57.144627) ========= 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.pb3QlLg0g4/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.Dh0JYUoKlh/Listeners TMPDIR=/var/folders/8t/6p6b80p55nj0lqqjf8jm8cx400000w/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.005072 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 02:29:57.194074) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 02:29:57.194432) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 02:29:57.194956) ========= ========= Total master_lag: 0.20 =========