builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0023 starttime: 1448359759.01 results: success (0) buildid: 20151124000443 builduid: cc3120ac02d24544bb21c3199fbe8540 revision: 01d196350d2430972143290226fb0d7866aece78 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 02:09:19.015205) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 02:09:19.015730) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 02:09:19.016031) ========= 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.CTFymuWQmD/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.HrisXIEcBp/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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.005707 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 02:09:19.037039) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 02:09:19.037376) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 02:09:19.052378) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 02:09:19.053047) ========= 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.CTFymuWQmD/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.HrisXIEcBp/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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.005333 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 02:09:19.105605) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 02:09:19.106110) ========= 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:09:19.106633) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 02:09:19.107046) ========= 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.CTFymuWQmD/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.HrisXIEcBp/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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:09:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 44.7M=0s 2015-11-24 02:09:19 (44.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.173729 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 02:09:19.295502) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 02:09:19.295821) ========= 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.CTFymuWQmD/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.HrisXIEcBp/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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.019643 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 02:09:19.344414) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2015-11-24 02:09:19.344768) ========= 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.CTFymuWQmD/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.HrisXIEcBp/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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:09:19,423 truncating revision to first 12 chars 2015-11-24 02:09:19,423 Setting DEBUG logging. 2015-11-24 02:09:19,423 attempt 1/10 2015-11-24 02:09:19,423 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:09:21,456 unpacking tar archive at: fx-team-01d196350d24/testing/mozharness/ program finished with exit code 0 elapsedTime=2.274873 ========= master_lag: 3.22 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2015-11-24 02:09:24.838880) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 02:09:24.839203) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 02:09:24.851968) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 02:09:24.852281) ========= 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:09:24.853385) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2015-11-24 02:09:24.853664) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.CTFymuWQmD/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.HrisXIEcBp/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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:09:25 INFO - MultiFileLogger online at 20151124 02:09:25 in /builds/slave/test 02:09:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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:09:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:09:25 INFO - {'append_to_log': False, 02:09:25 INFO - 'base_work_dir': '/builds/slave/test', 02:09:25 INFO - 'blob_upload_branch': 'Fx-Team', 02:09:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:09:25 INFO - 'branch': 'Fx-Team', 02:09:25 INFO - 'buildbot_json_path': 'buildprops.json', 02:09:25 INFO - 'config_files': ('talos/mac_config.py',), 02:09:25 INFO - 'default_actions': ('clobber', 02:09:25 INFO - 'read-buildbot-config', 02:09:25 INFO - 'download-and-extract', 02:09:25 INFO - 'populate-webroot', 02:09:25 INFO - 'create-virtualenv', 02:09:25 INFO - 'install', 02:09:25 INFO - 'run-tests'), 02:09:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:09:25 INFO - 'download_minidump_stackwalk': True, 02:09:25 INFO - 'download_symbols': 'ondemand', 02:09:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:09:25 INFO - 'tooltool.py': '/tools/tooltool.py', 02:09:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:09:25 INFO - '/tools/misc-python/virtualenv.py')}, 02:09:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:09:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:09:25 INFO - 'installer_path': 'installer.exe', 02:09:25 INFO - 'log_level': 'info', 02:09:25 INFO - 'log_name': 'talos', 02:09:25 INFO - 'log_to_console': True, 02:09:25 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:09:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:09:25 INFO - 'opt_config_files': (), 02:09:25 INFO - 'pip_index': False, 02:09:25 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:09:25 INFO - 'cmd': ('bash', 02:09:25 INFO - '-c', 02:09:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:09:25 INFO - 'enabled': True, 02:09:25 INFO - 'halt_on_failure': False, 02:09:25 INFO - 'name': 'check_screen_resolution'},), 02:09:25 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:09:25 INFO - 'cmd': ('bash', 02:09:25 INFO - '-c', 02:09:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:09:25 INFO - 'enabled': True, 02:09:25 INFO - 'halt_on_failure': False, 02:09:25 INFO - 'name': 'check_screen_resolution'},), 02:09:25 INFO - 'run_cmd_checks_enabled': True, 02:09:25 INFO - 'sps_profile': False, 02:09:25 INFO - 'sps_profile_interval': 0, 02:09:25 INFO - 'suite': 'dromaeojs-e10s', 02:09:25 INFO - 'system_bits': '64', 02:09:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:09:25 INFO - 'title': 't-yosemite-r7-0023', 02:09:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:09:25 INFO - 'use_talos_json': True, 02:09:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:09:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:09:25 INFO - 'work_dir': 'build'} 02:09:25 INFO - ##### 02:09:25 INFO - ##### Running clobber step. 02:09:25 INFO - ##### 02:09:25 INFO - Running pre-action listener: _resource_record_pre_action 02:09:25 INFO - Running main action method: clobber 02:09:25 INFO - rmtree: /builds/slave/test/build 02:09:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:09:25 INFO - Running post-action listener: _resource_record_post_action 02:09:25 INFO - ##### 02:09:25 INFO - ##### Running read-buildbot-config step. 02:09:25 INFO - ##### 02:09:25 INFO - Running pre-action listener: _resource_record_pre_action 02:09:25 INFO - Running main action method: read_buildbot_config 02:09:25 INFO - Using buildbot properties: 02:09:25 INFO - { 02:09:25 INFO - "properties": { 02:09:25 INFO - "buildnumber": 24, 02:09:25 INFO - "product": "firefox", 02:09:25 INFO - "script_repo_revision": "production", 02:09:25 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 02:09:25 INFO - "repository": "", 02:09:25 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 02:09:25 INFO - "buildid": "20151124000443", 02:09:25 INFO - "slavename": "t-yosemite-r7-0023", 02:09:25 INFO - "pgo_build": "False", 02:09:25 INFO - "basedir": "/builds/slave/test", 02:09:25 INFO - "project": "", 02:09:25 INFO - "platform": "yosemite_r7", 02:09:25 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 02:09:25 INFO - "slavebuilddir": "test", 02:09:25 INFO - "scheduler": "tests-fx-team-macosx64-talos", 02:09:25 INFO - "branch": "fx-team", 02:09:25 INFO - "repo_path": "integration/fx-team", 02:09:25 INFO - "stage_platform": "macosx64", 02:09:25 INFO - "builduid": "cc3120ac02d24544bb21c3199fbe8540", 02:09:25 INFO - "revision": "01d196350d2430972143290226fb0d7866aece78" 02:09:25 INFO - }, 02:09:25 INFO - "sourcestamp": { 02:09:25 INFO - "repository": "", 02:09:25 INFO - "hasPatch": false, 02:09:25 INFO - "project": "", 02:09:25 INFO - "branch": "fx-team-macosx64-talos", 02:09:25 INFO - "changes": [ 02:09:25 INFO - { 02:09:25 INFO - "category": null, 02:09:25 INFO - "files": [ 02:09:25 INFO - { 02:09:25 INFO - "url": null, 02:09:25 INFO - "name": "https://queue.taskcluster.net/v1/task/hta-UQZgQceAG-88cW9C6w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 02:09:25 INFO - } 02:09:25 INFO - ], 02:09:25 INFO - "repository": "", 02:09:25 INFO - "rev": "01d196350d2430972143290226fb0d7866aece78", 02:09:25 INFO - "who": "cbook@mozilla.com", 02:09:25 INFO - "when": 1448359150, 02:09:25 INFO - "number": 6699532, 02:09:25 INFO - "comments": "Bug 1209341 - allow loading unsigned restartless add-ons at runtime. r=mossop", 02:09:25 INFO - "project": "", 02:09:25 INFO - "at": "Tue 24 Nov 2015 01:59:10", 02:09:25 INFO - "branch": "fx-team-macosx64-talos", 02:09:25 INFO - "revlink": "", 02:09:25 INFO - "properties": [ 02:09:25 INFO - [ 02:09:25 INFO - "buildid", 02:09:25 INFO - "20151124000443", 02:09:25 INFO - "Change" 02:09:25 INFO - ], 02:09:25 INFO - [ 02:09:25 INFO - "builduid", 02:09:25 INFO - "cc3120ac02d24544bb21c3199fbe8540", 02:09:25 INFO - "Change" 02:09:25 INFO - ], 02:09:25 INFO - [ 02:09:25 INFO - "pgo_build", 02:09:25 INFO - "False", 02:09:25 INFO - "Change" 02:09:25 INFO - ] 02:09:25 INFO - ], 02:09:25 INFO - "revision": "01d196350d2430972143290226fb0d7866aece78" 02:09:25 INFO - } 02:09:25 INFO - ], 02:09:25 INFO - "revision": "01d196350d2430972143290226fb0d7866aece78" 02:09:25 INFO - } 02:09:25 INFO - } 02:09:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/hta-UQZgQceAG-88cW9C6w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 02:09:25 INFO - Running post-action listener: _resource_record_post_action 02:09:25 INFO - ##### 02:09:25 INFO - ##### Running download-and-extract step. 02:09:25 INFO - ##### 02:09:25 INFO - Running pre-action listener: _resource_record_pre_action 02:09:25 INFO - Running main action method: download_and_extract 02:09:25 INFO - mkdir: /builds/slave/test/build/tests 02:09:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:09:25 INFO - https://queue.taskcluster.net/v1/task/hta-UQZgQceAG-88cW9C6w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:09:25 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:09:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hta-UQZgQceAG-88cW9C6w/artifacts/public/build/test_packages.json 02:09:25 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:09:25 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:09:27 INFO - Downloaded 1149 bytes. 02:09:27 INFO - Reading from file /builds/slave/test/build/test_packages.json 02:09:27 INFO - Using the following test package requirements: 02:09:27 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 02:09:27 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 02:09:27 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 02:09:27 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 02:09:27 INFO - u'jsshell-mac.zip'], 02:09:27 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 02:09:27 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 02:09:27 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 02:09:27 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 02:09:27 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 02:09:27 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 02:09:27 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 02:09:27 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 02:09:27 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 02:09:27 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 02:09:27 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 02:09:27 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 02:09:27 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 02:09:27 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:27 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:09:27 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:09:27 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:09:27 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:09:27 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:09:28 INFO - Downloaded 17527016 bytes. 02:09:28 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:09:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 02:09:28 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 02:09:30 INFO - Return code: 0 02:09:30 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:09:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:09:30 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:09:30 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:09:30 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:09:30 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:09:30 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:09:32 INFO - Downloaded 17527016 bytes. 02:09:32 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:09:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 02:09:32 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 02:09:35 INFO - Return code: 0 02:09:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:09:35 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:09:35 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:09:35 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:09:35 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:09:35 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:09:36 INFO - Downloaded 11130997 bytes. 02:09:36 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:09:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 02:09:36 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 02:09:36 INFO - Return code: 0 02:09:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:09:36 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:09:36 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:09:36 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:09:36 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:09:36 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:09:39 INFO - Downloaded 109915660 bytes. 02:09:39 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:09:39 INFO - mkdir: /builds/slave/test/properties 02:09:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:09:39 INFO - Writing to file /builds/slave/test/properties/build_url 02:09:39 INFO - Contents: 02:09:39 INFO - build_url:https://queue.taskcluster.net/v1/task/hta-UQZgQceAG-88cW9C6w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 02:09:39 INFO - Running post-action listener: _resource_record_post_action 02:09:39 INFO - Running post-action listener: set_extra_try_arguments 02:09:39 INFO - ##### 02:09:39 INFO - ##### Running populate-webroot step. 02:09:39 INFO - ##### 02:09:39 INFO - Running pre-action listener: _resource_record_pre_action 02:09:39 INFO - Running main action method: populate_webroot 02:09:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:09:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:09:39 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 02:09:39 INFO - '../fennec_ids.txt'], 02:09:39 INFO - 'tests': ['tcheck2']}, 02:09:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:09:39 INFO - '--tppagecycles', 02:09:39 INFO - '7'], 02:09:39 INFO - 'tests': ['tsvgm']}}, 02:09:39 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:09:39 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:09:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:09:39 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:09:39 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:09:39 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:09:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:09:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:09:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:09:39 INFO - 'talos_options': ['--e10s'], 02:09:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:09:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:09:39 INFO - 'tests': ['damp', 'tps']}, 02:09:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:09:39 INFO - 'talos_options': ['--e10s'], 02:09:39 INFO - 'tests': ['damp', 'tps']}, 02:09:39 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:09:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:09:39 INFO - 'other': {'tests': ['a11yr', 02:09:39 INFO - 'ts_paint', 02:09:39 INFO - 'tpaint', 02:09:39 INFO - 'sessionrestore', 02:09:39 INFO - 'sessionrestore_no_auto_restore']}, 02:09:39 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:09:39 INFO - 'tests': ['a11yr', 02:09:39 INFO - 'ts_paint', 02:09:39 INFO - 'tpaint', 02:09:39 INFO - 'sessionrestore', 02:09:39 INFO - 'sessionrestore_no_auto_restore']}, 02:09:39 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:09:39 INFO - 'tests': ['a11yr', 02:09:39 INFO - 'ts_paint', 02:09:39 INFO - 'tpaint', 02:09:39 INFO - 'sessionrestore', 02:09:39 INFO - 'sessionrestore_no_auto_restore']}, 02:09:39 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:09:39 INFO - 'tests': ['a11yr', 02:09:39 INFO - 'ts_paint', 02:09:39 INFO - 'tpaint', 02:09:39 INFO - 'sessionrestore', 02:09:39 INFO - 'sessionrestore_no_auto_restore']}, 02:09:39 INFO - 'other_l64': {'tests': ['a11yr', 02:09:39 INFO - 'ts_paint', 02:09:39 INFO - 'tpaint', 02:09:39 INFO - 'sessionrestore', 02:09:39 INFO - 'sessionrestore_no_auto_restore']}, 02:09:39 INFO - 'other_nol64': {'tests': ['a11yr', 02:09:39 INFO - 'ts_paint', 02:09:39 INFO - 'tpaint', 02:09:39 INFO - 'sessionrestore', 02:09:39 INFO - 'sessionrestore_no_auto_restore']}, 02:09:39 INFO - 'svgr': {'tests': ['tsvgx', 02:09:39 INFO - 'tsvgr_opacity', 02:09:39 INFO - 'tart', 02:09:39 INFO - 'tscrollx', 02:09:39 INFO - 'cart']}, 02:09:39 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:09:39 INFO - 'tests': ['tsvgx', 02:09:39 INFO - 'tsvgr_opacity', 02:09:39 INFO - 'tart', 02:09:39 INFO - 'tscrollx', 02:09:39 INFO - 'cart']}, 02:09:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:09:39 INFO - 'tests': ['tp5o']}, 02:09:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:09:39 INFO - 'talos_options': ['--e10s'], 02:09:39 INFO - 'tests': ['tp5o']}, 02:09:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:09:39 INFO - 'talos_options': ['--xperf_path', 02:09:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:09:39 INFO - 'tests': ['tp5n']}, 02:09:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:09:39 INFO - 'talos_options': ['--e10s', 02:09:39 INFO - '--xperf_path', 02:09:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:09:39 INFO - 'tests': ['tp5n']}}, 02:09:39 INFO - 'talos.zip': {'path': '', 02:09:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:09:39 INFO - Running post-action listener: _resource_record_post_action 02:09:39 INFO - ##### 02:09:39 INFO - ##### Running create-virtualenv step. 02:09:39 INFO - ##### 02:09:39 INFO - Running pre-action listener: _resource_record_pre_action 02:09:39 INFO - Running main action method: create_virtualenv 02:09:39 INFO - Creating virtualenv /builds/slave/test/build/venv 02:09:39 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:09:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:09:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:09:39 INFO - Using real prefix '/tools/python27' 02:09:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:09:40 INFO - Installing distribute.............................................................................................................................................................................................done. 02:09:43 INFO - Installing pip.................done. 02:09:43 INFO - Return code: 0 02:09:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:09:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:09:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:43 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 0x1029a3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102980228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83ea6bc6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028c79f0>, '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 0x102626db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1028ba8c8>, '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.CTFymuWQmD/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.HrisXIEcBp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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:43 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:09:43 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:09:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CTFymuWQmD/Render', 02:09:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:09:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:09:43 INFO - 'HOME': '/Users/cltbld', 02:09:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:09:43 INFO - 'LOGNAME': 'cltbld', 02:09:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:43 INFO - 'MOZ_NO_REMOTE': '1', 02:09:43 INFO - 'NO_EM_RESTART': '1', 02:09:43 INFO - 'PAGER': '/bin/cat', 02:09:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:09:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:43 INFO - 'PWD': '/builds/slave/test', 02:09:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:09:43 INFO - 'SHELL': '/bin/bash', 02:09:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HrisXIEcBp/Listeners', 02:09:43 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 02:09:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:09:43 INFO - 'USER': 'cltbld', 02:09:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:09:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:09:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:43 INFO - 'XPC_FLAGS': '0x0', 02:09:43 INFO - 'XPC_SERVICE_NAME': '0', 02:09:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:09:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:43 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:09:43 INFO - Cleaning up... 02:09:43 INFO - Return code: 0 02:09:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:09:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:09:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:43 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 0x1029a3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102980228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83ea6bc6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028c79f0>, '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 0x102626db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1028ba8c8>, '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.CTFymuWQmD/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.HrisXIEcBp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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:43 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:09:43 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:09:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CTFymuWQmD/Render', 02:09:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:09:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:09:43 INFO - 'HOME': '/Users/cltbld', 02:09:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:09:43 INFO - 'LOGNAME': 'cltbld', 02:09:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:43 INFO - 'MOZ_NO_REMOTE': '1', 02:09:43 INFO - 'NO_EM_RESTART': '1', 02:09:43 INFO - 'PAGER': '/bin/cat', 02:09:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:09:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:43 INFO - 'PWD': '/builds/slave/test', 02:09:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:09:43 INFO - 'SHELL': '/bin/bash', 02:09:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HrisXIEcBp/Listeners', 02:09:43 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 02:09:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:09:43 INFO - 'USER': 'cltbld', 02:09:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:09:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:09:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:43 INFO - 'XPC_FLAGS': '0x0', 02:09:43 INFO - 'XPC_SERVICE_NAME': '0', 02:09:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:09:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:43 INFO - Downloading/unpacking psutil>=0.7.1 02:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:46 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 02:09:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 02:09:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:09:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:09:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:09:46 INFO - Installing collected packages: psutil 02:09:46 INFO - Running setup.py install for psutil 02:09:46 INFO - building 'psutil._psutil_osx' extension 02:09:46 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:09:46 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:09:46 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:09:46 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:09:46 INFO - building 'psutil._psutil_posix' extension 02:09:46 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:09:47 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:09:47 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:09:47 INFO - ^ 02:09:47 INFO - 1 warning generated. 02:09:47 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:09:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:09:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:09:47 INFO - Successfully installed psutil 02:09:47 INFO - Cleaning up... 02:09:47 INFO - Return code: 0 02:09:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 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 - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 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 - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:47 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 0x1029a3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102980228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83ea6bc6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028c79f0>, '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 0x102626db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1028ba8c8>, '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.CTFymuWQmD/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.HrisXIEcBp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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:47 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:09:47 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:09:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CTFymuWQmD/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 - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:47 INFO - 'MOZ_NO_REMOTE': '1', 02:09:47 INFO - 'NO_EM_RESTART': '1', 02:09:47 INFO - 'PAGER': '/bin/cat', 02:09:47 INFO - 'PATH': '/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 - '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.HrisXIEcBp/Listeners', 02:09:47 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 - Ignoring indexes: https://pypi.python.org/simple/ 02:09:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:09:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 02:09:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:09:49 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:49 INFO - Installing collected packages: mozsystemmonitor 02:09:49 INFO - Running setup.py install for mozsystemmonitor 02:09:49 INFO - Successfully installed mozsystemmonitor 02:09:49 INFO - Cleaning up... 02:09:49 INFO - Return code: 0 02:09:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:09:49 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:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:49 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:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:49 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 0x1029a3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102980228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83ea6bc6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028c79f0>, '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 0x102626db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1028ba8c8>, '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.CTFymuWQmD/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.HrisXIEcBp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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:49 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:49 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:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CTFymuWQmD/Render', 02:09:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:09:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:09:49 INFO - 'HOME': '/Users/cltbld', 02:09:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:09:49 INFO - 'LOGNAME': 'cltbld', 02:09:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:49 INFO - 'MOZ_NO_REMOTE': '1', 02:09:49 INFO - 'NO_EM_RESTART': '1', 02:09:49 INFO - 'PAGER': '/bin/cat', 02:09:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:09:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:49 INFO - 'PWD': '/builds/slave/test', 02:09:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:09:49 INFO - 'SHELL': '/bin/bash', 02:09:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HrisXIEcBp/Listeners', 02:09:49 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 02:09:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:09:49 INFO - 'USER': 'cltbld', 02:09:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:09:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:09:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:49 INFO - 'XPC_FLAGS': '0x0', 02:09:49 INFO - 'XPC_SERVICE_NAME': '0', 02:09:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:09:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:50 INFO - Downloading/unpacking blobuploader==1.2.4 02:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:52 INFO - Downloading blobuploader-1.2.4.tar.gz 02:09:52 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:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:09:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:09:52 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:52 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:52 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:52 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:52 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:52 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:53 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:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:09:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:09:53 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:53 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:53 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:53 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:53 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:53 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:53 INFO - Downloading docopt-0.6.1.tar.gz 02:09:53 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:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:09:53 INFO - Installing collected packages: blobuploader, requests, docopt 02:09:53 INFO - Running setup.py install for blobuploader 02:09:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:09:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:09:53 INFO - Running setup.py install for requests 02:09:54 INFO - Running setup.py install for docopt 02:09:54 INFO - Successfully installed blobuploader requests docopt 02:09:54 INFO - Cleaning up... 02:09:54 INFO - Return code: 0 02:09:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:09: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:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09: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:09:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:54 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 0x1029a3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102980228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83ea6bc6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028c79f0>, '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 0x102626db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1028ba8c8>, '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.CTFymuWQmD/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.HrisXIEcBp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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:54 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:54 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:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CTFymuWQmD/Render', 02:09:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:09:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:09:54 INFO - 'HOME': '/Users/cltbld', 02:09:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:09:54 INFO - 'LOGNAME': 'cltbld', 02:09:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:54 INFO - 'MOZ_NO_REMOTE': '1', 02:09:54 INFO - 'NO_EM_RESTART': '1', 02:09:54 INFO - 'PAGER': '/bin/cat', 02:09:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:09:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:54 INFO - 'PWD': '/builds/slave/test', 02:09:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:09:54 INFO - 'SHELL': '/bin/bash', 02:09:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HrisXIEcBp/Listeners', 02:09:54 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 02:09:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:09:54 INFO - 'USER': 'cltbld', 02:09:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:09:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:09:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:54 INFO - 'XPC_FLAGS': '0x0', 02:09:54 INFO - 'XPC_SERVICE_NAME': '0', 02:09:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:09:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:09:54 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-swLWCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:09:54 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-CwdHbO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:09:55 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-ZJFb3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:09:55 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-XnF3cS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:09:55 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-EM_J4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:09:55 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-2VeOQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:09:55 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-4LaNik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:09:55 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-VCCxMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:09:55 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-cjNNWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:09:55 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-WpmwZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:09:55 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-AK4oA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:09:55 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-n9VwH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:09:56 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-T19Deu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:09:56 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-zKTb58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:09:56 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-wjszta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:09:56 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-0uA_kD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:09:56 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-f5CQfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:09:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:09:56 INFO - Running setup.py install for manifestparser 02:09:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:09:56 INFO - Running setup.py install for mozcrash 02:09:56 INFO - Running setup.py install for mozdebug 02:09:56 INFO - Running setup.py install for mozdevice 02:09:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:09:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:09:57 INFO - Running setup.py install for mozfile 02:09:57 INFO - Running setup.py install for mozhttpd 02:09:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:09:57 INFO - Running setup.py install for mozinfo 02:09:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:09:57 INFO - Running setup.py install for mozInstall 02:09:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:09:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:09:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:09:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:09:57 INFO - Running setup.py install for mozleak 02:09:57 INFO - Running setup.py install for mozlog 02:09:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:09:58 INFO - Running setup.py install for moznetwork 02:09:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:09:58 INFO - Running setup.py install for mozprocess 02:09:58 INFO - Running setup.py install for mozprofile 02:09:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:09:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:09:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:09:58 INFO - Running setup.py install for mozrunner 02:09:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:09:58 INFO - Running setup.py install for mozscreenshot 02:09:58 INFO - Running setup.py install for moztest 02:09:58 INFO - Running setup.py install for mozversion 02:09:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:09:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:09:59 INFO - Cleaning up... 02:09:59 INFO - Return code: 0 02:09:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:09:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:09:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:09:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:59 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 0x1029a3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102980228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83ea6bc6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028c79f0>, '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 0x102626db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1028ba8c8>, '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.CTFymuWQmD/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.HrisXIEcBp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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:59 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:59 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:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CTFymuWQmD/Render', 02:09:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:09:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:09:59 INFO - 'HOME': '/Users/cltbld', 02:09:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:09:59 INFO - 'LOGNAME': 'cltbld', 02:09:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:59 INFO - 'MOZ_NO_REMOTE': '1', 02:09:59 INFO - 'NO_EM_RESTART': '1', 02:09:59 INFO - 'PAGER': '/bin/cat', 02:09:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:09:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:59 INFO - 'PWD': '/builds/slave/test', 02:09:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:09:59 INFO - 'SHELL': '/bin/bash', 02:09:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HrisXIEcBp/Listeners', 02:09:59 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 02:09:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:09:59 INFO - 'USER': 'cltbld', 02:09:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:09:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:09:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:59 INFO - 'XPC_FLAGS': '0x0', 02:09:59 INFO - 'XPC_SERVICE_NAME': '0', 02:09:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:09:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:09:59 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-I2_V8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:09:59 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:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:09:59 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-80vH9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:09:59 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:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:09:59 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-epx3kc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:09:59 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:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:09:59 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-hZIhav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:09:59 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:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:09:59 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-wc8wDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:09:59 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:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:09:59 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-jc8Qdm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:10:00 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:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:10:00 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-vInG6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:10:00 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:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:10:00 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-5cRC0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:10:00 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:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:10:00 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-VDDcVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:10:00 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:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:10:00 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-4aZguq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:10:00 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:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:10:00 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-ef8jde-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:10:00 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:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:10:00 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-WbOuwb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:10:00 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:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:10:00 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-7fLgy0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:10:00 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:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:10:00 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-n4iBwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:10:00 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:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:10:00 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-Vl_m43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:10:00 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:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:10:01 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-sn9B9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:10:01 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:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:10:01 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-fZWnMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:10:01 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:10:01 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:10:01 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:10:01 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:10:01 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:10:01 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:10:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:10: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:10: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:10: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:10: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:10: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:10: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:10:03 INFO - Downloading blessings-1.5.1.tar.gz 02:10:03 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:10:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:10:03 INFO - Installing collected packages: blessings 02:10:03 INFO - Running setup.py install for blessings 02:10:03 INFO - Successfully installed blessings 02:10:03 INFO - Cleaning up... 02:10:03 INFO - Return code: 0 02:10:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:10:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:10:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:10:04 INFO - Reading from file tmpfile_stdout 02:10:04 INFO - Current package versions: 02:10:04 INFO - blessings == 1.5.1 02:10:04 INFO - blobuploader == 1.2.4 02:10:04 INFO - docopt == 0.6.1 02:10:04 INFO - manifestparser == 1.1 02:10:04 INFO - mozInstall == 1.12 02:10:04 INFO - mozcrash == 0.16 02:10:04 INFO - mozdebug == 0.1 02:10:04 INFO - mozdevice == 0.47 02:10:04 INFO - mozfile == 1.2 02:10:04 INFO - mozhttpd == 0.7 02:10:04 INFO - mozinfo == 0.9 02:10:04 INFO - mozleak == 0.1 02:10:04 INFO - mozlog == 3.1 02:10:04 INFO - moznetwork == 0.27 02:10:04 INFO - mozprocess == 0.22 02:10:04 INFO - mozprofile == 0.27 02:10:04 INFO - mozrunner == 6.11 02:10:04 INFO - mozscreenshot == 0.1 02:10:04 INFO - mozsystemmonitor == 0.0 02:10:04 INFO - moztest == 0.7 02:10:04 INFO - mozversion == 1.4 02:10:04 INFO - psutil == 3.1.1 02:10:04 INFO - requests == 1.2.3 02:10:04 INFO - wsgiref == 0.1.2 02:10:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:10:04 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:10:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:04 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:10:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:04 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 0x1029a3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102980228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83ea6bc6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028c79f0>, '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 0x102626db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1028ba8c8>, '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.CTFymuWQmD/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.HrisXIEcBp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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:10:04 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:10:04 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:10:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CTFymuWQmD/Render', 02:10:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:10:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:10:04 INFO - 'HOME': '/Users/cltbld', 02:10:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:10:04 INFO - 'LOGNAME': 'cltbld', 02:10:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:04 INFO - 'MOZ_NO_REMOTE': '1', 02:10:04 INFO - 'NO_EM_RESTART': '1', 02:10:04 INFO - 'PAGER': '/bin/cat', 02:10:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:10:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:04 INFO - 'PWD': '/builds/slave/test', 02:10:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:10:04 INFO - 'SHELL': '/bin/bash', 02:10:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HrisXIEcBp/Listeners', 02:10:04 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 02:10:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:10:04 INFO - 'USER': 'cltbld', 02:10:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:10:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:10:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:04 INFO - 'XPC_FLAGS': '0x0', 02:10:04 INFO - 'XPC_SERVICE_NAME': '0', 02:10:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:10:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:04 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:10:04 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:10:04 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:10:04 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:10:04 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:10:04 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:10:04 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:10:04 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:10:04 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:10:04 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:10:04 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:10:04 INFO - Cleaning up... 02:10:04 INFO - Return code: 0 02:10:04 INFO - Running post-action listener: _resource_record_post_action 02:10:04 INFO - Running post-action listener: _start_resource_monitoring 02:10:04 INFO - Starting resource monitoring. 02:10:04 INFO - ##### 02:10:04 INFO - ##### Running install step. 02:10:04 INFO - ##### 02:10:04 INFO - Running pre-action listener: _resource_record_pre_action 02:10:04 INFO - Running main action method: install 02:10:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:10:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:10:04 INFO - Reading from file tmpfile_stdout 02:10:04 INFO - Detecting whether we're running mozinstall >=1.0... 02:10:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:10:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:10:04 INFO - Reading from file tmpfile_stdout 02:10:04 INFO - Output received: 02:10:04 INFO - Usage: mozinstall [options] installer 02:10:04 INFO - Options: 02:10:04 INFO - -h, --help show this help message and exit 02:10:04 INFO - -d DEST, --destination=DEST 02:10:04 INFO - Directory to install application into. [default: 02:10:04 INFO - "/builds/slave/test"] 02:10:04 INFO - --app=APP Application being installed. [default: firefox] 02:10:04 INFO - mkdir: /builds/slave/test/build/application 02:10:04 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:10:04 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:10:35 INFO - Reading from file tmpfile_stdout 02:10:35 INFO - Output received: 02:10:35 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 02:10:35 INFO - Running post-action listener: _resource_record_post_action 02:10:35 INFO - ##### 02:10:35 INFO - ##### Running run-tests step. 02:10:35 INFO - ##### 02:10:35 INFO - Running pre-action listener: _resource_record_pre_action 02:10:35 INFO - Running main action method: run_tests 02:10:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:10:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:10:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:10:35 INFO - 2015-11-24 02:10:35.087 screenresolution[2539:27414] starting screenresolution argv=screenresolution get 02:10:35 INFO - 2015-11-24 02:10:35.089 screenresolution[2539:27414] Display 0: 1600x1200x32@60 02:10:35 INFO - 2015-11-24 02:10:35.096 screenresolution[2540:27418] starting screenresolution argv=screenresolution list 02:10:35 INFO - Available Modes on Display 0 02:10:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:10:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:10:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:10:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:10:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:10:35 INFO - Intel Iris: 02:10:35 INFO - Chipset Model: Intel Iris 02:10:35 INFO - Type: GPU 02:10:35 INFO - Bus: Built-In 02:10:35 INFO - VRAM (Dynamic, Max): 1536 MB 02:10:35 INFO - Vendor: Intel (0x8086) 02:10:35 INFO - Device ID: 0x0a2e 02:10:35 INFO - Revision ID: 0x0009 02:10:35 INFO - Displays: 02:10:35 INFO - Display: 02:10:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:10:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:10:35 INFO - Display Serial Number: 1600x1200 60 02:10:35 INFO - Main Display: Yes 02:10:35 INFO - Mirror: Off 02:10:35 INFO - Online: Yes 02:10:35 INFO - Rotation: Supported 02:10:35 INFO - Return code: 0 02:10:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:10:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:10:35 INFO - Python 2.7.3 02:10:35 INFO - Return code: 0 02:10:35 INFO - grabbing minidump binary from tooltool 02:10:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:35 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 0x1028c79f0>, '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 0x102626db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1028ba8c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:10:35 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:10:35 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:10:35 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:10:35 INFO - Return code: 0 02:10:35 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:10:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:10:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:10:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:10:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:10:35 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-e10s', '--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-0023', '--webServer', 'localhost'] in /builds/slave/test/build 02:10:35 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-e10s --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-0023 --webServer localhost 02:10:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CTFymuWQmD/Render', 02:10:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:10:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:10:35 INFO - 'HOME': '/Users/cltbld', 02:10:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:10:35 INFO - 'LOGNAME': 'cltbld', 02:10:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:10:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:10:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:35 INFO - 'MOZ_NO_REMOTE': '1', 02:10:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:10:35 INFO - 'NO_EM_RESTART': '1', 02:10:35 INFO - 'PAGER': '/bin/cat', 02:10:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:10:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:35 INFO - 'PWD': '/builds/slave/test', 02:10:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:10:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:10:35 INFO - 'SHELL': '/bin/bash', 02:10:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HrisXIEcBp/Listeners', 02:10:35 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 02:10:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:10:35 INFO - 'USER': 'cltbld', 02:10:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:10:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:10:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:35 INFO - 'XPC_FLAGS': '0x0', 02:10:35 INFO - 'XPC_SERVICE_NAME': '0', 02:10:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:10:35 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-e10s', '--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-0023', '--webServer', 'localhost'] with output_timeout 3600 02:10:35 INFO - mozversion INFO | application_buildid: 20151124000443 02:10:35 INFO - mozversion INFO | application_changeset: 01d196350d2430972143290226fb0d7866aece78 02:10:35 INFO - mozversion INFO | application_display_name: Nightly 02:10:35 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:10:35 INFO - mozversion INFO | application_name: Firefox 02:10:35 INFO - mozversion INFO | application_remotingname: firefox 02:10:35 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 02:10:35 INFO - mozversion INFO | application_vendor: Mozilla 02:10:35 INFO - mozversion INFO | application_version: 45.0a1 02:10:35 INFO - mozversion INFO | platform_buildid: 20151124000443 02:10:35 INFO - mozversion INFO | platform_changeset: 01d196350d2430972143290226fb0d7866aece78 02:10:35 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 02:10:35 INFO - mozversion INFO | platform_version: 45.0a1 02:10:35 INFO - 2015-11-24 02:10:35,649 DEBUG : using testdate: 1448359835 02:10:35 INFO - 2015-11-24 02:10:35,650 DEBUG : actual date: 1448359835 02:10:35 INFO - 2015-11-24 02:10:35,746 INFO : starting webserver on 'localhost:59493' 02:10:35 INFO - 2015-11-24 02:10:35,747 INFO : Starting test suite t-yosemite-r7-0023.e 02:10:35 INFO - 2015-11-24 02:10:35,747 INFO : Starting test dromaeo_css 02:10:35 INFO - 2015-11-24 02:10:35,747 DEBUG : operating with platform_type : mac_ 02:10:35 INFO - 2015-11-24 02:10:35,749 INFO : Initialising browser for dromaeo_css test... 02:10:35 INFO - 2015-11-24 02:10:35,765 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmpsjhCuw/profile http://localhost:59493/getInfo.html 02:10:38 INFO - 2015-11-24 02:10:38,384 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:10:38 INFO - 2015-11-24 02:10:38,384 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:10:38 INFO - 2015-11-24 02:10:38,384 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 02:10:38 INFO - 2015-11-24 02:10:38,384 DEBUG : BROWSER_OUTPUT: __metrics 02:10:38 INFO - 2015-11-24 02:10:38,940 INFO : Browser initialized. 02:10:38 INFO - 2015-11-24 02:10:38,940 INFO : Running cycle 1/1 for dromaeo_css test... 02:10:38 INFO - 2015-11-24 02:10:38,940 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmpsjhCuw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:10:50 INFO - 2015-11-24 02:10:50,790 DEBUG : BROWSER_OUTPUT: RSS: Main: 236515328 02:10:50 INFO - 2015-11-24 02:10:50,790 DEBUG : BROWSER_OUTPUT: 02:11:40 INFO - 2015-11-24 02:11:40,461 DEBUG : BROWSER_OUTPUT: 1448359900460 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:51 INFO - 2015-11-24 02:13:51,416 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59493/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59493/tests/dromaeo/cssquery-ext.html) 02:13:52 INFO - 2015-11-24 02:13:52,543 DEBUG : BROWSER_OUTPUT: RSS: Main: 252518400 02:13:52 INFO - 2015-11-24 02:13:52,543 DEBUG : BROWSER_OUTPUT: 02:16:54 INFO - 2015-11-24 02:16:54,530 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59493/tests/dromaeo/cssquery-ext.html (next: http://localhost:59493/tests/dromaeo/cssquery-jquery.html) 02:16:55 INFO - 2015-11-24 02:16:55,131 DEBUG : BROWSER_OUTPUT: RSS: Main: 263254016 02:16:55 INFO - 2015-11-24 02:16:55,131 DEBUG : BROWSER_OUTPUT: 02:19:56 INFO - 2015-11-24 02:19:56,786 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59493/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59493/tests/dromaeo/cssquery-mootools.html) 02:19:57 INFO - 2015-11-24 02:19:57,382 DEBUG : BROWSER_OUTPUT: RSS: Main: 265564160 02:19:57 INFO - 2015-11-24 02:19:57,382 DEBUG : BROWSER_OUTPUT: 02:22:58 INFO - 2015-11-24 02:22:58,983 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59493/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59493/tests/dromaeo/cssquery-prototype.html) 02:22:59 INFO - 2015-11-24 02:22:59,590 DEBUG : BROWSER_OUTPUT: RSS: Main: 266399744 02:22:59 INFO - 2015-11-24 02:22:59,590 DEBUG : BROWSER_OUTPUT: 02:26:02 INFO - 2015-11-24 02:26:02,104 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59493/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59493/tests/dromaeo/cssquery-yui.html) 02:26:02 INFO - 2015-11-24 02:26:02,705 DEBUG : BROWSER_OUTPUT: RSS: Main: 269389824 02:26:02 INFO - 2015-11-24 02:26:02,705 DEBUG : BROWSER_OUTPUT: 02:29:05 INFO - 2015-11-24 02:29:05,093 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59493/tests/dromaeo/cssquery-yui.html (next: http://localhost:59493/tests/dromaeo/cssquery-dojo.html) 02:29:05 INFO - 2015-11-24 02:29:05,352 DEBUG : BROWSER_OUTPUT: RSS: Main: 272289792 02:29:05 INFO - 2015-11-24 02:29:05,352 DEBUG : BROWSER_OUTPUT: 02:29:05 INFO - 2015-11-24 02:29:05,352 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:29:05 INFO - 2015-11-24 02:29:05,352 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:29:05 INFO - 2015-11-24 02:29:05,352 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:29:05 INFO - 2015-11-24 02:29:05,352 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:29:05 INFO - 2015-11-24 02:29:05,352 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3467.4625433057877;3513.9121521961965;3533.1520435095586;3568.4468907319374;3577.2487777566703;5963.910541341883;6023.307319658241;6028.4574388305045;6043.4560889519935;6074.908876366852;5473.233747275384;5501.762103526705;5771.643663739029;5948.524118070544;6002.219711437518;5280.735963201824;5322.281491998579;5356.892862142755;5428.37573679028;5444.8366549003595;4404.537523560028;4597.770111494428;5479.698616576086;5485.780568777264;5493.121100623901;5185.274061631375;5224.63427560071;5318.282031925679;5387.299651045359;5430.5384042356445;5364.1149210380245;5368.32895888014;5386.245925570423;5391;5400.513953744143;5329.413764485904;5336.573074154058;5388.838334849922;5405.593328929655;5414.7834086636485;5279.63042587019;5283.731904342969;5624.5781566382275;5904.232449781501;6037.124616930564;6248.9062664060075;6297.0554416837385;6298.905516417258;6303.338149494329;6308.2430108386825;6299.968500157515;6304.495640348807;6321.810345689637;6328.303886572473;6333.778317758903;5944.97027514864;6015.248093988252;6031.638101713911;6083.087536869417;6107.0228763397645;6435.131257280301;6443.7744678936015;6455.61266324022;6462.903056454157;6469.741210351627;6137.8060289513105;6241.625502469867;6316.842078948063;6328.019157030668;6328.6519241442165;6275.121482992385;6275.905861412082;6388.840278993062;6419.646919419477;6451.161349024596;6251.593646412968;6277.591956522811;6288.685565721696;6292.2134733158355;6297.779577714758;5343.545798607084;6144.15675297409;6263;6267.467265282411;6304.05439184126;5016.623753218523;5048.192289233779;5049.545540901263;5055.747212639353;5090.796368145233;4523.5024147343765;4596.6092882105395;4606.861794146181;4623.53764623535;4647.326137710081;4930.013997200503;5599.860003499945;5895.64626122434;6054.122152287893;6070.514358851281;6342.429181373698;6343.714532846033;6344.68276586178;6348.333424990402;6351.523635727339;6003.21958145447;6014.458698717049;6019.578629495893;6025.186599809057;6027.638341699512;5433;5512.4211957744665;5530.032244357221;5597.692126932976;5621.128725047624;6458.903116453163;6493.415592596594;6550.344965503412;6550.6069635822005;6705.564138330993;6389.52078594098;6394.1687580614225;6407.038944158414;6411.326810684811;6427.421532062137;6280;6325.96837015812;6450.193725784277;6534.542582019213;6549.083128362128;5217.34783152106;5232.738363081907;6159.414855588712;6173.290071641639;6297.4017468340435;5222.55608273301;6302.117703521419;6306.905396418965;6309.148264984168;6320.5891617044745;6024.397560244116;6138.32709113608;6203.06953956892;6219.47134493555;6223.937760622336;6133.172021777003;6201.131841542097;6213;6213.502919766317;6249;5939.287285525765;6016.608920420159;6130.938690613037;6165.969170154121;6221.4089661482085;6202.81391558254;6262.279837818709;6275.215598050244;6275.37246275387;6303.338149494237;6134.9079763804475;6179.598326108789;6187.504999599932;6195.783147589813;6202.41077097675 02:29:05 INFO - 2015-11-24 02:29:05,352 DEBUG : BROWSER_OUTPUT: |1;ext.html;540.5378401466749;572.3732512898376;576.2796504369538;583.1602492410925;606.7936901453505;41398.17203655925;41601.37597936026;41766.79116604417;41804;41841.58158418415;43477.78261108698;43552.34671479923;43737.343939840925;44062.55937440625;44113.558864411345;8994.325425593073;9640.662576809813;9763;9797.020297970217;9804.068613481708;9567.473788941605;9668.274879384038;9701.320907536476;9715.368501047446;9727.805443891119;9709.174720148796;9763.853542196874;9768.267379946497;9775.706728798148;9796.951015244913;9692.418454892693;9738.172255358302;9763.902360976406;9767.120959113678;9785.021497850157;9599.616015359377;9770.853437198448;9772;9782;9811.166050885684;40814.79592602047;40938.59061409377;41033.35866565334;41040.58959410398;41462.37806432906;3294.7528935329947;3324.1357247115925;3339.532465454838;3571.3035957988204;3807.333716599584;28926.421471570662;29170.854145729347;29204;29256;29337.533123343746;2342.8242881783763;2689.9865500672568;2809.859507024661;2825.5055365311196;2840.8863645454157;512434;516758;516775.41612292075;516975;517988;58185.70907145522;59424.702876486204;74014;74989.62505187439;75161.24838751652;71465.2853471469;72176.63911680409;72293.63853180701;72681;72860.63569682118;16003.759943600855;16194.67610647804;16306.184690765414;16379.344826206818;16383;12331.938340308421;12438.440270187682;12449.190802597803;12470.314132722788;12486.313252771002;21729.67405488919;21880.45298867541;22211.111555537598;22213.666794998087;22229.333120006424;7832.960835195788;9109;9367.531623418938;9379.202767764817;9396.90603093974;953.1785913695539;955.9856602150974;1012.6860673191187;1021.3871676993745;1122.5846436818267;30001.39997200044;30096;30251;30294.84852575723;30838;1090.907272881798;1152.6772503698978;1153.6654370232707;1214.2350319298962;1245.0910835090253;15261.542153735405;15348.769768453481;15393.538193854203;15558.9222053889;15573.221338933008;530663;540617;549120;551771;551911;59216.70391648014;59640.70179649074;59737.701311494035;59868;59987.800243994876;1225.7487215121057;1299.4996926183487;1404.4241860837008;1431.6349330920548;1434.1036851967729;29838.85080574583;29987.237776182745;30073;30090.84954575213;30095.097147085624;50960.235596466824;51243.2313515305;51549;51828.222576662134;51936.18223362164;478538;483800;487384;490028;490759;34083.65916340805;43629.63703629738;45143.54856451525;45290.773546132055;45396.092078158916;37693;46476.767616161706;46694.53305467038;47564.810879728284;47642;26593;30506.389872202875;31456.84271578719;33992.13043282643;35000;31155.06534803869;37263.6273637271;37890.43164352592;38126;38850.80574597109;40000.599994000855;40117.79941100276;41238.58761412348;41399.7930010348;41410.1717965645;32623;33153;33906.8304658485;33920.491192632624;34805.1298717524;25868.22881322082;26010.349741255865;26149.328359689403;26240.868795656665;26518 02:29:05 INFO - 2015-11-24 02:29:05,352 DEBUG : BROWSER_OUTPUT: |2;jquery.html;361.1278761790277;365.8024666679993;368.41422138799305;369.1804194687794;369.9815009249537;15926;19653.901730491347;20873.37379878604;21277.468063298424;21483.785162148375;12006.519739210422;17178.312867485285;18577.071146442693;20878.686819697716;20883.895580522116;5195.19474481455;5244.79020839166;5324.41431442541;5349.7592608332525;5367.275417818583;5282.3925248596515;5327.387350454689;5524.751386187611;5709.172170035343;5733.598648094635;4492.7528985905765;5227.137522308814;5252.8161514347;5607.43925607438;5686.772529098831;5542.334919809628;5556;5589.832305030835;5602.467765562265;5621.831345059655;5004.949950500485;5349.598780091509;5425.511703946664;5573.303337082864;5613.410591887834;12672;12903.935480322538;20146.899265503725;23904;24070;1971.7732460767052;1972.8618996670239;1997.7502812148482;2105.536781907978;2194.8902554872193;9836.704898852975;10019.148372388356;10028.548715307756;12844.807327890088;14428;1676.7317229243386;1777.25355350753;1784.4022252545412;1804.3955274982766;1805.2959345855127;73648.63175684141;84694.57652711697;96659;97394.51302743441;98783;9222;10958.726031849108;10987.450627468595;11029.227954043301;11165.325201219719;13159.53941612058;13199.538016169388;13262.403191856389;13262.469501219843;13299.867001329863;7962.32320252785;8181.181881811771;8350.373721970876;8357.540335281617;8387.370947178986;6721.345068697935;8391.909051823346;8422.368322375847;8510.106438823834;8553.401261911731;3986.4418981342637;4408.338749187584;4408.501109622744;4452.465704115527;4502.752348620857;1500.1524138861507;1856.3873921605837;1870.4949663590755;1903.6287923854716;1904.2478221102588;396.64896566538243;399.15578551364234;404.8218783735147;422.2589355680761;430.66838534328394;20632.793672063388;20930.058147383403;21009.78990210109;21335.359939201848;22500.874956252123;900.945893304835;963.7686955130719;964.5081008685621;968.8692026576463;988.253868329421;8809.823803523894;10546.41994690284;10755;10800.837987430195;10882.673519794418;751645;751851;764276;765244;780820;130395;130925;132728;134685;140053;1154.5958914380067;1177.2995067934564;1186.0867132308247;1189.8631657359342;1192;18049.368272110412;18271.543211419288;18276.268949241883;18319.35882244115;18474.907625461787;43441.131177376905;53916.460835391146;54377;54514.999999998414;54752.631184220714;76176.23823761691;76978;77256;77311;79510;7949.523028618301;9585.376950498196;9699.369540979813;9767.413955162712;9777.608895644378;17874.46376608704;19341.323053693053;19570.804291956898;19809.801901981373;19963.900180499004;13331.800022999856;15080.095194288378;15594;15887.443939462064;15937.203139843194;15240.618984525476;15284.235788210768;15306.387744490541;15477.922610386877;15618.45335413255;15936.840631593535;16108;16211.51365459038;16216.432424865074;16298.67402651964;9619.134277915022;9640.132388085107;9747.853782193131;9871.210303175585;9885.011498850345;10773.838392423962;15652.37390504367;16124.435644752377;16276.43032493857;16308.510744677678 02:29:05 INFO - 2015-11-24 02:29:05,354 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1559.2437667731142;1564.0381165583162;1896.9905150474242;1917.3481016454402;1939.7769256535498;7732.536047837134;7878.566678832662;8181.91818081819;8563.486190828555;8611.311095112384;8196.590170491481;8364.665413383458;8455.450395724274;8475.32197424206;8490.10853860345;2349.0721165139844;2349.224755830576;2381.9761802381927;2388.868612226327;2393.56915755164;2341.9648705269433;2356.6582845487396;2375.3467796355967;2389.916352927648;2402.1832576923844;2342.5783358995373;2361.515889242701;2378.607529757588;2396.772306630867;2404.831661783676;2069.7619773725914;2363.3264519612;2374.905003799846;2401.8438801477846;2401.8678972656407;2051;2403.3390817525146;2421.1889017179265;2423.6849209602638;2439.4511234972165;8475.788105297417;8541.701040463617;8545.145485451467;8558.743237702878;8589.613467393981;5185.688858668492;5277.12927366984;5285.709285989269;5308.9469105308835;5328.387235467932;3457.0493114393494;3536.929261414757;3563.2160924596546;3563.2160924596546;3570.696490798285;1056.334509259162;1069.1767339148812;1073.0128281980597;1083.756154865157;1084.604119496386;11302.547898084067;11335.659930202108;11360.091192704482;11370.147238957112;11387.772244555146;4649.651276154302;4671.15919134559;4714.010057887814;4719.2685133803625;4720.12677654635;8088.150744171778;9627.470489123165;9632.75918102039;9648.083432073941;9715.46564938921;4468.821247150077;5196.168613021899;5209.843704688866;5214.713190774544;5258.92111618326;4298.656107511391;4372.934405983913;4597.816087356468;4703.223968045303;4737.715737055788;3831.7126215533945;3846.2307538492414;3884.902877428087;3898.2788184186015;3905.5313362396696;1303.6349822049842;1311.5278499740086;1314.6910476038124;1322.107577385261;1322.6707159304838;1374.17549470319;1395.0443945897093;1398.5734351023036;1417.5818133650598;1427.3862239237228;7886.684532618631;7904.130545639975;7906.288434040964;7948.403869709679;7952.1650226726515;504.1026971989864;515.0394514231007;516.4860963341424;516.7648719832467;519.4597618476741;5991.221141251609;6152.323244443108;6165.229346331708;6172.783952561639;6193.659348735772;9978.351407158512;10255.487225638837;10267.640632577974;10289.176865850714;10295.691129266133;9203.493807840632;10056.74858128538;10096.798064038678;10104.74738131538;10135.493225338703;6792.626405547643;7875.960620196977;7916.208379162153;7933;7950.840983180304;7390.260973902567;7437.0331856858265;7455.4035677146785;7491.138519070377;7524.699012039676;8924.196822286025;9009.009009008872;9048.230900373543;9076.27389808827;9110;9190.770230744285;9222.584983675617;9316.767080823034;9328.02055784133;9364.672236471692;6626.27111017778;6888.552244104118;7087.964560177166;7261;7279.8544029120185;7816.843663126592;7904.644291007034;7919;7924.564148971862;7958.920410795818;7365.705371785069;7454.888176677463;7460.104787425326;7541.208173141741;7602.505837120791;7310.59791711461;7318.377937875341;7337.816554585965;7428.480006399716;7441.776746697607;7425.331720144996;7499.812504687427;7522.247775222434;7529.87051942213;7545.396368290633;5767.990601644779;6750.25747167821;6832.385085342343;6858.725650973905;6875.449964002768;6951.687174077279;6980.05769221169;7034.47241456903;7048.013278140962;7050.15398152225 02:29:05 INFO - 2015-11-24 02:29:05,355 DEBUG : BROWSER_OUTPUT: |4;prototype.html;329.1146815067468;337.5999440662813;339.568747690433;339.87084907735056;348.0463529927998;6852.2462529121885;6982.79051628452;7028.402585780208;7066.576005439677;7078.186008609018;5052.964142350818;6005.549583781212;6987.0916780818425;7013.929860701392;7042.683079261433;4718.221493453576;4722.268048452478;5068.645194836363;5098.515641014116;5110.488951104879;4076.7350122242105;5003.120085864759;5080.949190508085;5101.948980510185;5111.361079865017;4053.351463765798;4982.850514484553;5003.074431230216;5020.221865610818;5050.545450909417;5039.622028347871;5041.470645582216;5057.494250574931;5058;5070.264811602297;4365.5416181300825;4365.738055716667;4371.14762621289;4372.234858899712;4394.60448559628;5884.087966365178;6142.662153581551;6439.549231553793;6670.199576050905;6674.199096108449;5879.7648094076185;5882.529397648178;5893.823185304448;5895.616784908967;5898.8230353089475;7443.2556744325675;7462.962685186593;7472.0286362772495;7480;7516.736914207976;4698.812047518095;4700.952990470086;4701.177293973541;4702.27114797207;4732;7639;7928;7931.762047138595;7945.960270198612;7958.283754462068;4671.32265821454;4718.127146477913;4721.5750582447745;4722.433308003062;4735.1240020595615;4024.5170579530645;4170.791460426966;4757.048590281957;4804.783784729626;4828.082664293773;5743.310802703702;5788.218590490314;5813.7383817728305;5867.178594996704;5893;7508.249175082448;7509.249075092447;7525.2098529654695;7531.397488200931;7552.169261381244;1597.400974634512;1651.6944365292459;1661.775660285846;1708.880378373502;1714.4256674014346;1068.551208492435;1077.3751224289892;1080.8324709670014;1082.604849230041;1092.1481244629201;6801.047853300542;6807.115075040312;6818.4886133540185;6842.04211410403;6867.901135818345;7608.2011388804485;7640.121386040565;7645.961770191225;7652.502587331805;7679;6767.729290828312;6788.49086318528;6802.897956530656;6815.148106486689;7064.646767661597;4093.508778946486;4135;4141.751494910315;4146.91706165875;4157.230912281238;8120.593970301461;8123.4313598047565;8140.267375936194;8150;8158.469699469634;7926.960365198137;8152.6331315090965;8168.959155204305;8177.509349439053;8184.549849758201;8106.63520141595;8116.472429292196;8128.63421146038;8131.918680813116;8143.6742530298125;7592.088949326117;7835.333996610352;7851.254130857559;7851.9214807851195;7875.1731068239305;7681.807954800951;7685.346745526693;7700.075990881131;7708.691652333844;7753.340966017726;7134.608751293656;7564.621768911643;8075.596220189084;8105.148959359418;8129.227723366271;4545.431821022372;4673;4733.290006498915;4750.548697873696;4776.426828780569;6398.87202255943;7381.151167615578;7546.132194797449;7751.263629955145;7759.961200193963;7322.963385183253;7489.325960663567;7506.662200201114;7507.399408047452;7538.849223015619;7485.850282994201;7495.550266983998;7508.324250817453;7508.474406791691;7524.548527088174;7095.574265544084;7271.600061996641;7308.199736137285;7335.083114610674;7338.743143990148;7487.363574096263;7493.925060749323;7495.175530691728;7497.175310715926;7509.586972716553;7183.7615509876305;7249.601271930094;7335.413166946525;7351.228121047213;7395.482316237812 02:29:05 INFO - 2015-11-24 02:29:05,358 DEBUG : BROWSER_OUTPUT: |5;yui.html;598.8862116197919;704.982375440614;731.480648739395;797.1032588338118;856.3192262151592;12152.513899444022;15195.696086078271;15346.769798453031;15367.23163841809;15389.769153462694;14016.439342426316;14135.78796318056;14166.220857852813;14558.199299038548;14573;709.7622296530643;781.308541940384;954.9570269337879;975.8585005174245;979.4906648542753;966.9854952175723;968.1528662420383;974.9171320437771;975.765816204113;991.5637119667359;1019.9796004079914;1040.9895901040968;1041.4896700616719;1042.8696412948382;1043.1498328861992;975.7902051058985;1000.7698229407241;1017.4912543728136;1022.2128960700294;1030.6598822388594;729.6971756720955;735.6799792090458;743.9330460258549;754.2871985973258;762.4777027735963;14986.325615347336;15149.091054536762;15206.16366099875;15281.847181528154;15369.231538423033;12572.937135314356;12665.556705515262;12743.936280318632;12921;12972.935135324356;10048.748781280454;10225.642102526375;10334.534945927451;10567.418791966438;10912.672619821418;3475.391806433889;3499.7025252853537;3567.1438854674952;3608.566971963355;3739.7943113128767;72290.27709722889;72819.63590182015;73555.52888942245;82870;83720.16279837185;9365.344425890258;9520.523973801282;9562.665306714232;9795.853062204073;10181.287309888237;21513.784862151177;21855.125794968342;21873.562528749335;21908;21977;7446.441516886255;7477.401807855358;7580;7596.164421913585;7647.464677472523;4048.919021619551;4054.0675644601906;4061.1674606705556;4117.197146556453;4132.297509423405;3399.7620166588595;3407.744419168572;3410.7612467127065;3411.4882767584563;3424.828758562062;612.3478495402383;618.4650277510011;623.76297007137;633.6483251795206;636.7134789344814;479.30740080583917;485.75954902323576;520.7240162713767;541;574.6121368076615;8024.879626805603;8155.836883262302;8513.787155321166;8620.267277281377;8693.261072808755;605.4671888737882;618.6411881108946;623.1649589550025;628.9371062893765;636.0808631527399;3784.7350685452307;4019.3970904363996;4050.2911990401562;4120.320147175682;4147.709660323749;100620;102360.46459303117;102553;103809.48095259626;104595.4770226144;81966;85004.57497712472;85597.57201213954;85734.57132714421;87100.56449717711;75359.62320188365;76175;76361.2363876354;77377.22622773812;78061;8298.87551686713;8306.83704281389;8378.916210838057;8453.450525715809;8530.556327681314;53847.73076134594;54819;55199;55959.72020139873;56055.71972140113;55771.72114139403;67155.64955226543;69310.65344673244;70369.64815176096;74961.62519187588;9989.204102441026;10821.513031913426;11399.715007124889;11448.656540303804;11516.349173954974;9979.700608981742;11913.22564033335;12510.49874015124;12583.748325033264;13044.086913915935;11959.162858599815;11993;12023.939880300892;12058.095642826647;12067.215630983957;10711.517981690688;11630.069594432594;12042;12045.698857528632;12125.090618203494;11398.259113157617;11556.768864622492;11923.880761192624;11930.522779088738;12241.510339586317;9779.119879210904;9822.607095716377;9864.704058878246;10132.645357412455;10457.47712614351;9305.488198149167;9696.466694331879;10242.846357304796;10260.281780275309;10317.432541210006 02:29:05 INFO - 2015-11-24 02:29:05,358 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:29:05 INFO - 2015-11-24 02:29:05,359 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:29:05 INFO - 2015-11-24 02:29:05,359 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,328 02:29:05 INFO - 2015-11-24 02:29:05,359 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:29:05 INFO - 2015-11-24 02:29:05,359 DEBUG : BROWSER_OUTPUT: __startTimestamp1448360945343__endTimestamp 02:29:05 INFO - 2015-11-24 02:29:05,359 DEBUG : BROWSER_OUTPUT: 02:29:05 INFO - 2015-11-24 02:29:05,359 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:29:05 INFO - 2015-11-24 02:29:05,359 DEBUG : BROWSER_OUTPUT: Number of tests: 6 02:29:05 INFO - 2015-11-24 02:29:05,359 DEBUG : BROWSER_OUTPUT: 02:29:05 INFO - 2015-11-24 02:29:05,359 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5848.12 Median:6130.94 stddev:654.24 (10.7%) stddev-sans-first:629.02 02:29:05 INFO - 2015-11-24 02:29:05,360 DEBUG : BROWSER_OUTPUT: Values: 3467.5 3513.9 3533.2 3568.4 3577.2 5963.9 6023.3 6028.5 6043.5 6074.9 5473.2 5501.8 5771.6 5948.5 6002.2 5280.7 5322.3 5356.9 5428.4 5444.8 4404.5 4597.8 5479.7 5485.8 5493.1 5185.3 5224.6 5318.3 5387.3 5430.5 5364.1 5368.3 5386.2 5391.0 5400.5 5329.4 5336.6 5388.8 5405.6 5414.8 5279.6 5283.7 5624.6 5904.2 6037.1 6248.9 6297.1 6298.9 6303.3 6308.2 6300.0 6304.5 6321.8 6328.3 6333.8 5945.0 6015.2 6031.6 6083.1 6107.0 6435.1 6443.8 6455.6 6462.9 6469.7 6137.8 6241.6 6316.8 6328.0 6328.7 6275.1 6275.9 6388.8 6419.6 6451.2 6251.6 6277.6 6288.7 6292.2 6297.8 5343.5 6144.2 6263.0 6267.5 6304.1 5016.6 5048.2 5049.5 5055.7 5090.8 4523.5 4596.6 4606.9 4623.5 4647.3 4930.0 5599.9 5895.6 6054.1 6070.5 6342.4 6343.7 6344.7 6348.3 6351.5 6003.2 6014.5 6019.6 6025.2 6027.6 5433.0 5512.4 5530.0 5597.7 5621.1 6458.9 6493.4 6550.3 6550.6 6705.6 6389.5 6394.2 6407.0 6411.3 6427.4 6280.0 6326.0 6450.2 6534.5 6549.1 5217.3 5232.7 6159.4 6173.3 6297.4 5222.6 6302.1 6306.9 6309.1 6320.6 6024.4 6138.3 6203.1 6219.5 6223.9 6133.2 6201.1 6213.0 6213.5 6249.0 5939.3 6016.6 6130.9 6166.0 6221.4 6202.8 6262.3 6275.2 6275.4 6303.3 6134.9 6179.6 6187.5 6195.8 6202.4 02:29:05 INFO - 2015-11-24 02:29:05,360 DEBUG : BROWSER_OUTPUT: 02:29:05 INFO - 2015-11-24 02:29:05,360 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:66826.15 Median:41531.88 stddev:137265.99 (330.5%) stddev-sans-first:137560.83 02:29:05 INFO - 2015-11-24 02:29:05,360 DEBUG : BROWSER_OUTPUT: Values: 540.5 572.4 576.3 583.2 606.8 41398.2 41601.4 41766.8 41804.0 41841.6 43477.8 43552.3 43737.3 44062.6 44113.6 8994.3 9640.7 9763.0 9797.0 9804.1 9567.5 9668.3 9701.3 9715.4 9727.8 9709.2 9763.9 9768.3 9775.7 9797.0 9692.4 9738.2 9763.9 9767.1 9785.0 9599.6 9770.9 9772.0 9782.0 9811.2 40814.8 40938.6 41033.4 41040.6 41462.4 3294.8 3324.1 3339.5 3571.3 3807.3 28926.4 29170.9 29204.0 29256.0 29337.5 2342.8 2690.0 2809.9 2825.5 2840.9 512434.0 516758.0 516775.4 516975.0 517988.0 58185.7 59424.7 74014.0 74989.6 75161.2 71465.3 72176.6 72293.6 72681.0 72860.6 16003.8 16194.7 16306.2 16379.3 16383.0 12331.9 12438.4 12449.2 12470.3 12486.3 21729.7 21880.5 22211.1 22213.7 22229.3 7833.0 9109.0 9367.5 9379.2 9396.9 953.2 956.0 1012.7 1021.4 1122.6 30001.4 30096.0 30251.0 30294.8 30838.0 1090.9 1152.7 1153.7 1214.2 1245.1 15261.5 15348.8 15393.5 15558.9 15573.2 530663.0 540617.0 549120.0 551771.0 551911.0 59216.7 59640.7 59737.7 59868.0 59987.8 1225.7 1299.5 1404.4 1431.6 1434.1 29838.9 29987.2 30073.0 30090.8 30095.1 50960.2 51243.2 51549.0 51828.2 51936.2 478538.0 483800.0 487384.0 490028.0 490759.0 34083.7 43629.6 45143.5 45290.8 45396.1 37693.0 46476.8 46694.5 47564.8 47642.0 26593.0 30506.4 31456.8 33992.1 35000.0 31155.1 37263.6 37890.4 38126.0 38850.8 40000.6 40117.8 41238.6 41399.8 41410.2 32623.0 33153.0 33906.8 33920.5 34805.1 25868.2 26010.3 26149.3 26240.9 26518.0 02:29:05 INFO - 2015-11-24 02:29:05,360 DEBUG : BROWSER_OUTPUT: 02:29:05 INFO - 2015-11-24 02:29:05,360 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:39294.66 Median:23987.00 stddev:125680.29 (524.0%) stddev-sans-first:125998.85 02:29:05 INFO - 2015-11-24 02:29:05,361 DEBUG : BROWSER_OUTPUT: Values: 361.1 365.8 368.4 369.2 370.0 15926.0 19653.9 20873.4 21277.5 21483.8 12006.5 17178.3 18577.1 20878.7 20883.9 5195.2 5244.8 5324.4 5349.8 5367.3 5282.4 5327.4 5524.8 5709.2 5733.6 4492.8 5227.1 5252.8 5607.4 5686.8 5542.3 5556.0 5589.8 5602.5 5621.8 5004.9 5349.6 5425.5 5573.3 5613.4 12672.0 12903.9 20146.9 23904.0 24070.0 1971.8 1972.9 1997.8 2105.5 2194.9 9836.7 10019.1 10028.5 12844.8 14428.0 1676.7 1777.3 1784.4 1804.4 1805.3 73648.6 84694.6 96659.0 97394.5 98783.0 9222.0 10958.7 10987.5 11029.2 11165.3 13159.5 13199.5 13262.4 13262.5 13299.9 7962.3 8181.2 8350.4 8357.5 8387.4 6721.3 8391.9 8422.4 8510.1 8553.4 3986.4 4408.3 4408.5 4452.5 4502.8 1500.2 1856.4 1870.5 1903.6 1904.2 396.6 399.2 404.8 422.3 430.7 20632.8 20930.1 21009.8 21335.4 22500.9 900.9 963.8 964.5 968.9 988.3 8809.8 10546.4 10755.0 10800.8 10882.7 751645.0 751851.0 764276.0 765244.0 780820.0 130395.0 130925.0 132728.0 134685.0 140053.0 1154.6 1177.3 1186.1 1189.9 1192.0 18049.4 18271.5 18276.3 18319.4 18474.9 43441.1 53916.5 54377.0 54515.0 54752.6 76176.2 76978.0 77256.0 77311.0 79510.0 7949.5 9585.4 9699.4 9767.4 9777.6 17874.5 19341.3 19570.8 19809.8 19963.9 13331.8 15080.1 15594.0 15887.4 15937.2 15240.6 15284.2 15306.4 15477.9 15618.5 15936.8 16108.0 16211.5 16216.4 16298.7 9619.1 9640.1 9747.9 9871.2 9885.0 10773.8 15652.4 16124.4 16276.4 16308.5 02:29:05 INFO - 2015-11-24 02:29:05,361 DEBUG : BROWSER_OUTPUT: 02:29:05 INFO - 2015-11-24 02:29:05,362 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5813.27 Median:5297.33 stddev:3029.62 (57.2%) stddev-sans-first:3021.25 02:29:05 INFO - 2015-11-24 02:29:05,363 DEBUG : BROWSER_OUTPUT: Values: 1559.2 1564.0 1897.0 1917.3 1939.8 7732.5 7878.6 8181.9 8563.5 8611.3 8196.6 8364.7 8455.5 8475.3 8490.1 2349.1 2349.2 2382.0 2388.9 2393.6 2342.0 2356.7 2375.3 2389.9 2402.2 2342.6 2361.5 2378.6 2396.8 2404.8 2069.8 2363.3 2374.9 2401.8 2401.9 2051.0 2403.3 2421.2 2423.7 2439.5 8475.8 8541.7 8545.1 8558.7 8589.6 5185.7 5277.1 5285.7 5308.9 5328.4 3457.0 3536.9 3563.2 3563.2 3570.7 1056.3 1069.2 1073.0 1083.8 1084.6 11302.5 11335.7 11360.1 11370.1 11387.8 4649.7 4671.2 4714.0 4719.3 4720.1 8088.2 9627.5 9632.8 9648.1 9715.5 4468.8 5196.2 5209.8 5214.7 5258.9 4298.7 4372.9 4597.8 4703.2 4737.7 3831.7 3846.2 3884.9 3898.3 3905.5 1303.6 1311.5 1314.7 1322.1 1322.7 1374.2 1395.0 1398.6 1417.6 1427.4 7886.7 7904.1 7906.3 7948.4 7952.2 504.1 515.0 516.5 516.8 519.5 5991.2 6152.3 6165.2 6172.8 6193.7 9978.4 10255.5 10267.6 10289.2 10295.7 9203.5 10056.7 10096.8 10104.7 10135.5 6792.6 7876.0 7916.2 7933.0 7950.8 7390.3 7437.0 7455.4 7491.1 7524.7 8924.2 9009.0 9048.2 9076.3 9110.0 9190.8 9222.6 9316.8 9328.0 9364.7 6626.3 6888.6 7088.0 7261.0 7279.9 7816.8 7904.6 7919.0 7924.6 7958.9 7365.7 7454.9 7460.1 7541.2 7602.5 7310.6 7318.4 7337.8 7428.5 7441.8 7425.3 7499.8 7522.2 7529.9 7545.4 5768.0 6750.3 6832.4 6858.7 6875.4 6951.7 6980.1 7034.5 7048.0 7050.2 02:29:05 INFO - 2015-11-24 02:29:05,363 DEBUG : BROWSER_OUTPUT: 02:29:05 INFO - 2015-11-24 02:29:05,363 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:6048.01 Median:6847.14 stddev:1998.54 (29.2%) stddev-sans-first:1957.51 02:29:05 INFO - 2015-11-24 02:29:05,364 DEBUG : BROWSER_OUTPUT: Values: 329.1 337.6 339.6 339.9 348.0 6852.2 6982.8 7028.4 7066.6 7078.2 5053.0 6005.5 6987.1 7013.9 7042.7 4718.2 4722.3 5068.6 5098.5 5110.5 4076.7 5003.1 5080.9 5101.9 5111.4 4053.4 4982.9 5003.1 5020.2 5050.5 5039.6 5041.5 5057.5 5058.0 5070.3 4365.5 4365.7 4371.1 4372.2 4394.6 5884.1 6142.7 6439.5 6670.2 6674.2 5879.8 5882.5 5893.8 5895.6 5898.8 7443.3 7463.0 7472.0 7480.0 7516.7 4698.8 4701.0 4701.2 4702.3 4732.0 7639.0 7928.0 7931.8 7946.0 7958.3 4671.3 4718.1 4721.6 4722.4 4735.1 4024.5 4170.8 4757.0 4804.8 4828.1 5743.3 5788.2 5813.7 5867.2 5893.0 7508.2 7509.2 7525.2 7531.4 7552.2 1597.4 1651.7 1661.8 1708.9 1714.4 1068.6 1077.4 1080.8 1082.6 1092.1 6801.0 6807.1 6818.5 6842.0 6867.9 7608.2 7640.1 7646.0 7652.5 7679.0 6767.7 6788.5 6802.9 6815.1 7064.6 4093.5 4135.0 4141.8 4146.9 4157.2 8120.6 8123.4 8140.3 8150.0 8158.5 7927.0 8152.6 8169.0 8177.5 8184.5 8106.6 8116.5 8128.6 8131.9 8143.7 7592.1 7835.3 7851.3 7851.9 7875.2 7681.8 7685.3 7700.1 7708.7 7753.3 7134.6 7564.6 8075.6 8105.1 8129.2 4545.4 4673.0 4733.3 4750.5 4776.4 6398.9 7381.2 7546.1 7751.3 7760.0 7323.0 7489.3 7506.7 7507.4 7538.8 7485.9 7495.6 7508.3 7508.5 7524.5 7095.6 7271.6 7308.2 7335.1 7338.7 7487.4 7493.9 7495.2 7497.2 7509.6 7183.8 7249.6 7335.4 7351.2 7395.5 02:29:05 INFO - 2015-11-24 02:29:05,364 DEBUG : BROWSER_OUTPUT: 02:29:05 INFO - 2015-11-24 02:29:05,364 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:19119.78 Median:4126.31 stddev:27350.02 (662.8%) stddev-sans-first:27391.39 02:29:05 INFO - 2015-11-24 02:29:05,366 DEBUG : BROWSER_OUTPUT: Values: 598.9 705.0 731.5 797.1 856.3 12152.5 15195.7 15346.8 15367.2 15389.8 14016.4 14135.8 14166.2 14558.2 14573.0 709.8 781.3 955.0 975.9 979.5 967.0 968.2 974.9 975.8 991.6 1020.0 1041.0 1041.5 1042.9 1043.1 975.8 1000.8 1017.5 1022.2 1030.7 729.7 735.7 743.9 754.3 762.5 14986.3 15149.1 15206.2 15281.8 15369.2 12572.9 12665.6 12743.9 12921.0 12972.9 10048.7 10225.6 10334.5 10567.4 10912.7 3475.4 3499.7 3567.1 3608.6 3739.8 72290.3 72819.6 73555.5 82870.0 83720.2 9365.3 9520.5 9562.7 9795.9 10181.3 21513.8 21855.1 21873.6 21908.0 21977.0 7446.4 7477.4 7580.0 7596.2 7647.5 4048.9 4054.1 4061.2 4117.2 4132.3 3399.8 3407.7 3410.8 3411.5 3424.8 612.3 618.5 623.8 633.6 636.7 479.3 485.8 520.7 541.0 574.6 8024.9 8155.8 8513.8 8620.3 8693.3 605.5 618.6 623.2 628.9 636.1 3784.7 4019.4 4050.3 4120.3 4147.7 100620.0 102360.5 102553.0 103809.5 104595.5 81966.0 85004.6 85597.6 85734.6 87100.6 75359.6 76175.0 76361.2 77377.2 78061.0 8298.9 8306.8 8378.9 8453.5 8530.6 53847.7 54819.0 55199.0 55959.7 56055.7 55771.7 67155.6 69310.7 70369.6 74961.6 9989.2 10821.5 11399.7 11448.7 11516.3 9979.7 11913.2 12510.5 12583.7 13044.1 11959.2 11993.0 12023.9 12058.1 12067.2 10711.5 11630.1 12042.0 12045.7 12125.1 11398.3 11556.8 11923.9 11930.5 12241.5 9779.1 9822.6 9864.7 10132.6 10457.5 9305.5 9696.5 10242.8 10260.3 10317.4 02:29:05 INFO - 2015-11-24 02:29:05,366 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:29:05 INFO - 2015-11-24 02:29:05,366 DEBUG : BROWSER_OUTPUT: 02:29:05 INFO - 2015-11-24 02:29:05,735 INFO : Browser exited with error code: 0 02:29:05 INFO - 2015-11-24 02:29:05,761 INFO : Completed test dromaeo_css (00:18:30) 02:29:05 INFO - 2015-11-24 02:29:05,761 INFO : Starting test kraken 02:29:05 INFO - 2015-11-24 02:29:05,761 DEBUG : operating with platform_type : mac_ 02:29:05 INFO - 2015-11-24 02:29:05,761 INFO : Initialising browser for kraken test... 02:29:05 INFO - 2015-11-24 02:29:05,774 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmp5DY1Dm/profile http://localhost:59493/getInfo.html 02:29:08 INFO - 2015-11-24 02:29:08,409 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:29:08 INFO - 2015-11-24 02:29:08,409 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:29:08 INFO - 2015-11-24 02:29:08,409 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 02:29:08 INFO - 2015-11-24 02:29:08,409 DEBUG : BROWSER_OUTPUT: __metrics 02:29:09 INFO - 2015-11-24 02:29:09,007 INFO : Browser initialized. 02:29:09 INFO - 2015-11-24 02:29:09,007 INFO : Running cycle 1/1 for kraken test... 02:29:09 INFO - 2015-11-24 02:29:09,007 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmp5DY1Dm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:29:21 INFO - 2015-11-24 02:29:21,037 DEBUG : BROWSER_OUTPUT: RSS: Main: 238485504 02:29:21 INFO - 2015-11-24 02:29:21,037 DEBUG : BROWSER_OUTPUT: 02:29:23 INFO - 2015-11-24 02:29:23,606 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59493/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59493/tests/kraken/driver.html?testName=audio-beat-detection) 02:29:24 INFO - 2015-11-24 02:29:24,217 DEBUG : BROWSER_OUTPUT: RSS: Main: 249810944 02:29:24 INFO - 2015-11-24 02:29:24,217 DEBUG : BROWSER_OUTPUT: 02:29:26 INFO - 2015-11-24 02:29:26,936 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59493/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59493/tests/kraken/driver.html?testName=audio-dft) 02:29:27 INFO - 2015-11-24 02:29:27,540 DEBUG : BROWSER_OUTPUT: RSS: Main: 259715072 02:29:27 INFO - 2015-11-24 02:29:27,540 DEBUG : BROWSER_OUTPUT: 02:29:30 INFO - 2015-11-24 02:29:30,716 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59493/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59493/tests/kraken/driver.html?testName=audio-fft) 02:29:31 INFO - 2015-11-24 02:29:31,299 DEBUG : BROWSER_OUTPUT: RSS: Main: 261922816 02:29:31 INFO - 2015-11-24 02:29:31,299 DEBUG : BROWSER_OUTPUT: 02:29:33 INFO - 2015-11-24 02:29:33,149 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59493/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59493/tests/kraken/driver.html?testName=audio-oscillator) 02:29:33 INFO - 2015-11-24 02:29:33,735 DEBUG : BROWSER_OUTPUT: RSS: Main: 263979008 02:29:33 INFO - 2015-11-24 02:29:33,735 DEBUG : BROWSER_OUTPUT: 02:29:35 INFO - 2015-11-24 02:29:35,694 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59493/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59493/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:29:36 INFO - 2015-11-24 02:29:36,274 DEBUG : BROWSER_OUTPUT: RSS: Main: 264912896 02:29:36 INFO - 2015-11-24 02:29:36,274 DEBUG : BROWSER_OUTPUT: 02:29:39 INFO - 2015-11-24 02:29:39,249 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59493/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59493/tests/kraken/driver.html?testName=imaging-darkroom) 02:29:39 INFO - 2015-11-24 02:29:39,837 DEBUG : BROWSER_OUTPUT: RSS: Main: 266194944 02:29:39 INFO - 2015-11-24 02:29:39,837 DEBUG : BROWSER_OUTPUT: 02:29:42 INFO - 2015-11-24 02:29:42,710 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59493/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59493/tests/kraken/driver.html?testName=imaging-desaturate) 02:29:43 INFO - 2015-11-24 02:29:43,300 DEBUG : BROWSER_OUTPUT: RSS: Main: 266166272 02:29:43 INFO - 2015-11-24 02:29:43,300 DEBUG : BROWSER_OUTPUT: 02:29:46 INFO - 2015-11-24 02:29:46,334 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59493/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59493/tests/kraken/driver.html?testName=json-parse-financial) 02:29:46 INFO - 2015-11-24 02:29:46,926 DEBUG : BROWSER_OUTPUT: RSS: Main: 264482816 02:29:46 INFO - 2015-11-24 02:29:46,926 DEBUG : BROWSER_OUTPUT: 02:29:48 INFO - 2015-11-24 02:29:48,440 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59493/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59493/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:29:49 INFO - 2015-11-24 02:29:49,033 DEBUG : BROWSER_OUTPUT: RSS: Main: 264126464 02:29:49 INFO - 2015-11-24 02:29:49,033 DEBUG : BROWSER_OUTPUT: 02:29:50 INFO - 2015-11-24 02:29:50,875 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59493/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59493/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:29:51 INFO - 2015-11-24 02:29:51,506 DEBUG : BROWSER_OUTPUT: RSS: Main: 265080832 02:29:51 INFO - 2015-11-24 02:29:51,507 DEBUG : BROWSER_OUTPUT: 02:29:53 INFO - 2015-11-24 02:29:53,532 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59493/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59493/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:29:54 INFO - 2015-11-24 02:29:54,134 DEBUG : BROWSER_OUTPUT: RSS: Main: 265510912 02:29:54 INFO - 2015-11-24 02:29:54,134 DEBUG : BROWSER_OUTPUT: 02:29:56 INFO - 2015-11-24 02:29:56,723 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59493/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59493/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:29:57 INFO - 2015-11-24 02:29:57,326 DEBUG : BROWSER_OUTPUT: RSS: Main: 264921088 02:29:57 INFO - 2015-11-24 02:29:57,326 DEBUG : BROWSER_OUTPUT: 02:29:59 INFO - 2015-11-24 02:29:59,736 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59493/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59493/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:30:00 INFO - 2015-11-24 02:30:00,325 DEBUG : BROWSER_OUTPUT: RSS: Main: 265211904 02:30:00 INFO - 2015-11-24 02:30:00,325 DEBUG : BROWSER_OUTPUT: 02:30:02 INFO - 2015-11-24 02:30:02,186 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59493/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59493/tests/kraken/driver.html?testName=ai-astar) 02:30:02 INFO - 2015-11-24 02:30:02,443 DEBUG : BROWSER_OUTPUT: RSS: Main: 264560640 02:30:02 INFO - 2015-11-24 02:30:02,443 DEBUG : BROWSER_OUTPUT: 02:30:02 INFO - 2015-11-24 02:30:02,443 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:30:02 INFO - 2015-11-24 02:30:02,443 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:30:02 INFO - 2015-11-24 02:30:02,444 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:30:02 INFO - 2015-11-24 02:30:02,444 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:30:02 INFO - 2015-11-24 02:30:02,444 DEBUG : BROWSER_OUTPUT: |0;ai-astar;115;107;114;112;114;123;111;113;119;127 02:30:02 INFO - 2015-11-24 02:30:02,444 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;160;118;178;185;156;144;170;107;151;135 02:30:02 INFO - 2015-11-24 02:30:02,444 DEBUG : BROWSER_OUTPUT: |2;audio-dft;192;189;192;192;202;217;199;198;202;196 02:30:02 INFO - 2015-11-24 02:30:02,444 DEBUG : BROWSER_OUTPUT: |3;audio-fft;56;67;59;64;122;55;57;58;60;95 02:30:02 INFO - 2015-11-24 02:30:02,444 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;77;76;109;74;77;76;112;86;93;105 02:30:02 INFO - 2015-11-24 02:30:02,444 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;118;134;85;133;134;87;105;112;87;95 02:30:02 INFO - 2015-11-24 02:30:02,444 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;116;124;96;104;95;96;105;140;94;95 02:30:02 INFO - 2015-11-24 02:30:02,444 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;89;119;145;82;141;76;150;140;103;92 02:30:02 INFO - 2015-11-24 02:30:02,444 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;60;56;55;56;58;62;56;53;77 02:30:02 INFO - 2015-11-24 02:30:02,444 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;77;99;96;66;65;68;67;68;58;68 02:30:02 INFO - 2015-11-24 02:30:02,444 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;86;86;85;83;84;84;84;87;83 02:30:02 INFO - 2015-11-24 02:30:02,444 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;128;128;128;132;131;132;144;124;142;125 02:30:02 INFO - 2015-11-24 02:30:02,444 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;134;140;145;137;137;141;139;140;139 02:30:02 INFO - 2015-11-24 02:30:02,445 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;85;83;101;76;62;96;101;92;97 02:30:02 INFO - 2015-11-24 02:30:02,445 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:30:02 INFO - 2015-11-24 02:30:02,445 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:30:02 INFO - 2015-11-24 02:30:02,445 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,808 02:30:02 INFO - 2015-11-24 02:30:02,445 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:30:02 INFO - 2015-11-24 02:30:02,445 DEBUG : BROWSER_OUTPUT: __startTimestamp1448361002437__endTimestamp 02:30:02 INFO - 2015-11-24 02:30:02,445 DEBUG : BROWSER_OUTPUT: 02:30:02 INFO - 2015-11-24 02:30:02,445 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:30:02 INFO - 2015-11-24 02:30:02,445 DEBUG : BROWSER_OUTPUT: Number of tests: 14 02:30:02 INFO - 2015-11-24 02:30:02,445 DEBUG : BROWSER_OUTPUT: 02:30:02 INFO - 2015-11-24 02:30:02,445 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:115.50 Median:114.50 stddev:5.93 (5.2%) stddev-sans-first:6.29 02:30:02 INFO - 2015-11-24 02:30:02,445 DEBUG : BROWSER_OUTPUT: Values: 115.0 107.0 114.0 112.0 114.0 123.0 111.0 113.0 119.0 127.0 02:30:02 INFO - 2015-11-24 02:30:02,445 DEBUG : BROWSER_OUTPUT: 02:30:02 INFO - 2015-11-24 02:30:02,445 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.40 Median:158.00 stddev:25.12 (15.9%) stddev-sans-first:26.40 02:30:02 INFO - 2015-11-24 02:30:02,446 DEBUG : BROWSER_OUTPUT: Values: 160.0 118.0 178.0 185.0 156.0 144.0 170.0 107.0 151.0 135.0 02:30:02 INFO - 2015-11-24 02:30:02,446 DEBUG : BROWSER_OUTPUT: 02:30:02 INFO - 2015-11-24 02:30:02,446 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:197.90 Median:198.50 stddev:8.08 (4.1%) stddev-sans-first:8.28 02:30:02 INFO - 2015-11-24 02:30:02,446 DEBUG : BROWSER_OUTPUT: Values: 192.0 189.0 192.0 192.0 202.0 217.0 199.0 198.0 202.0 196.0 02:30:02 INFO - 2015-11-24 02:30:02,446 DEBUG : BROWSER_OUTPUT: 02:30:02 INFO - 2015-11-24 02:30:02,446 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:69.30 Median:59.50 stddev:21.92 (36.8%) stddev-sans-first:22.71 02:30:02 INFO - 2015-11-24 02:30:02,446 DEBUG : BROWSER_OUTPUT: Values: 56.0 67.0 59.0 64.0 122.0 55.0 57.0 58.0 60.0 95.0 02:30:02 INFO - 2015-11-24 02:30:02,446 DEBUG : BROWSER_OUTPUT: 02:30:02 INFO - 2015-11-24 02:30:02,446 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:88.50 Median:76.50 stddev:15.12 (19.8%) stddev-sans-first:15.46 02:30:02 INFO - 2015-11-24 02:30:02,446 DEBUG : BROWSER_OUTPUT: Values: 77.0 76.0 109.0 74.0 77.0 76.0 112.0 86.0 93.0 105.0 02:30:02 INFO - 2015-11-24 02:30:02,446 DEBUG : BROWSER_OUTPUT: 02:30:02 INFO - 2015-11-24 02:30:02,446 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.50 stddev:20.20 (18.4%) stddev-sans-first:21.16 02:30:02 INFO - 2015-11-24 02:30:02,446 DEBUG : BROWSER_OUTPUT: Values: 118.0 134.0 85.0 133.0 134.0 87.0 105.0 112.0 87.0 95.0 02:30:02 INFO - 2015-11-24 02:30:02,447 DEBUG : BROWSER_OUTPUT: 02:30:02 INFO - 2015-11-24 02:30:02,447 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:106.50 Median:94.50 stddev:15.52 (16.4%) stddev-sans-first:16.08 02:30:02 INFO - 2015-11-24 02:30:02,447 DEBUG : BROWSER_OUTPUT: Values: 116.0 124.0 96.0 104.0 95.0 96.0 105.0 140.0 94.0 95.0 02:30:02 INFO - 2015-11-24 02:30:02,447 DEBUG : BROWSER_OUTPUT: 02:30:02 INFO - 2015-11-24 02:30:02,447 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:113.70 Median:113.00 stddev:28.64 (25.3%) stddev-sans-first:28.95 02:30:02 INFO - 2015-11-24 02:30:02,447 DEBUG : BROWSER_OUTPUT: Values: 89.0 119.0 145.0 82.0 141.0 76.0 150.0 140.0 103.0 92.0 02:30:02 INFO - 2015-11-24 02:30:02,447 DEBUG : BROWSER_OUTPUT: 02:30:02 INFO - 2015-11-24 02:30:02,447 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.10 Median:58.00 stddev:6.79 (11.7%) stddev-sans-first:7.19 02:30:02 INFO - 2015-11-24 02:30:02,447 DEBUG : BROWSER_OUTPUT: Values: 58.0 60.0 56.0 55.0 56.0 58.0 62.0 56.0 53.0 77.0 02:30:02 INFO - 2015-11-24 02:30:02,447 DEBUG : BROWSER_OUTPUT: 02:30:02 INFO - 2015-11-24 02:30:02,447 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:73.20 Median:68.00 stddev:13.62 (20.0%) stddev-sans-first:14.38 02:30:02 INFO - 2015-11-24 02:30:02,447 DEBUG : BROWSER_OUTPUT: Values: 77.0 99.0 96.0 66.0 65.0 68.0 67.0 68.0 58.0 68.0 02:30:02 INFO - 2015-11-24 02:30:02,447 DEBUG : BROWSER_OUTPUT: 02:30:02 INFO - 2015-11-24 02:30:02,447 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:84.50 stddev:1.43 (1.7%) stddev-sans-first:1.41 02:30:02 INFO - 2015-11-24 02:30:02,448 DEBUG : BROWSER_OUTPUT: Values: 83.0 86.0 86.0 85.0 83.0 84.0 84.0 84.0 87.0 83.0 02:30:02 INFO - 2015-11-24 02:30:02,448 DEBUG : BROWSER_OUTPUT: 02:30:02 INFO - 2015-11-24 02:30:02,448 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:131.40 Median:131.50 stddev:6.69 (5.1%) stddev-sans-first:6.98 02:30:02 INFO - 2015-11-24 02:30:02,448 DEBUG : BROWSER_OUTPUT: Values: 128.0 128.0 128.0 132.0 131.0 132.0 144.0 124.0 142.0 125.0 02:30:02 INFO - 2015-11-24 02:30:02,448 DEBUG : BROWSER_OUTPUT: 02:30:02 INFO - 2015-11-24 02:30:02,448 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.90 Median:139.50 stddev:2.96 (2.1%) stddev-sans-first:3.06 02:30:02 INFO - 2015-11-24 02:30:02,448 DEBUG : BROWSER_OUTPUT: Values: 137.0 134.0 140.0 145.0 137.0 137.0 141.0 139.0 140.0 139.0 02:30:02 INFO - 2015-11-24 02:30:02,448 DEBUG : BROWSER_OUTPUT: 02:30:02 INFO - 2015-11-24 02:30:02,448 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:86.10 Median:84.00 stddev:13.81 (16.4%) stddev-sans-first:13.00 02:30:02 INFO - 2015-11-24 02:30:02,448 DEBUG : BROWSER_OUTPUT: Values: 68.0 85.0 83.0 101.0 76.0 62.0 96.0 101.0 92.0 97.0 02:30:02 INFO - 2015-11-24 02:30:02,449 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:30:02 INFO - 2015-11-24 02:30:02,449 DEBUG : BROWSER_OUTPUT: 02:30:03 INFO - 2015-11-24 02:30:03,055 INFO : Browser exited with error code: 0 02:30:03 INFO - 2015-11-24 02:30:03,102 INFO : Completed test kraken (00:00:57) 02:30:03 INFO - 2015-11-24 02:30:03,102 INFO : Starting test v8_7 02:30:03 INFO - 2015-11-24 02:30:03,103 DEBUG : operating with platform_type : mac_ 02:30:03 INFO - 2015-11-24 02:30:03,103 INFO : Initialising browser for v8_7 test... 02:30:03 INFO - 2015-11-24 02:30:03,115 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmp1uEP05/profile http://localhost:59493/getInfo.html 02:30:05 INFO - 2015-11-24 02:30:05,671 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:30:05 INFO - 2015-11-24 02:30:05,672 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:30:05 INFO - 2015-11-24 02:30:05,672 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 02:30:05 INFO - 2015-11-24 02:30:05,672 DEBUG : BROWSER_OUTPUT: __metrics 02:30:06 INFO - 2015-11-24 02:30:06,244 INFO : Browser initialized. 02:30:06 INFO - 2015-11-24 02:30:06,244 INFO : Running cycle 1/1 for v8_7 test... 02:30:06 INFO - 2015-11-24 02:30:06,244 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmp1uEP05/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:30:18 INFO - 2015-11-24 02:30:18,259 DEBUG : BROWSER_OUTPUT: RSS: Main: 236417024 02:30:18 INFO - 2015-11-24 02:30:18,259 DEBUG : BROWSER_OUTPUT: 02:30:39 INFO - 2015-11-24 02:30:39,662 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59493/tests/v8_7/run.html (next: http://localhost:59493/tests/v8_7/run.html) 02:30:39 INFO - 2015-11-24 02:30:39,918 DEBUG : BROWSER_OUTPUT: RSS: Main: 248078336 02:30:39 INFO - 2015-11-24 02:30:39,919 DEBUG : BROWSER_OUTPUT: 02:30:39 INFO - 2015-11-24 02:30:39,919 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:30:39 INFO - 2015-11-24 02:30:39,919 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:30:39 INFO - 2015-11-24 02:30:39,919 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:30:39 INFO - 2015-11-24 02:30:39,919 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:30:39 INFO - 2015-11-24 02:30:39,919 DEBUG : BROWSER_OUTPUT: |0;Richards;176.7096660187312 02:30:39 INFO - 2015-11-24 02:30:39,919 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;157.10919088766693 02:30:39 INFO - 2015-11-24 02:30:39,919 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.473962684489 02:30:39 INFO - 2015-11-24 02:30:39,919 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4726.415094339623 02:30:39 INFO - 2015-11-24 02:30:39,919 DEBUG : BROWSER_OUTPUT: |4;RayTrace;938.9671361502348 02:30:39 INFO - 2015-11-24 02:30:39,919 DEBUG : BROWSER_OUTPUT: |5;Earley;733.1378299120234 02:30:39 INFO - 2015-11-24 02:30:39,919 DEBUG : BROWSER_OUTPUT: |6;Boyer;12587.5 02:30:39 INFO - 2015-11-24 02:30:39,919 DEBUG : BROWSER_OUTPUT: |7;RegExp;27162.162162162163 02:30:39 INFO - 2015-11-24 02:30:39,919 DEBUG : BROWSER_OUTPUT: |8;Splay;684.931506849315 02:30:39 INFO - 2015-11-24 02:30:39,920 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4513.513513513513 02:30:39 INFO - 2015-11-24 02:30:39,920 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:30:39 INFO - 2015-11-24 02:30:39,920 DEBUG : BROWSER_OUTPUT: __startTimestamp1448361039912__endTimestamp 02:30:39 INFO - 2015-11-24 02:30:39,920 DEBUG : BROWSER_OUTPUT: 02:30:39 INFO - 2015-11-24 02:30:39,920 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:30:39 INFO - 2015-11-24 02:30:39,920 DEBUG : BROWSER_OUTPUT: Number of tests: 10 02:30:39 INFO - 2015-11-24 02:30:39,920 DEBUG : BROWSER_OUTPUT: 02:30:39 INFO - 2015-11-24 02:30:39,920 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:176.71 Median:176.71 stddev:0.00 (0.0%) 02:30:39 INFO - 2015-11-24 02:30:39,920 DEBUG : BROWSER_OUTPUT: Values: 176.7 02:30:39 INFO - 2015-11-24 02:30:39,920 DEBUG : BROWSER_OUTPUT: 02:30:39 INFO - 2015-11-24 02:30:39,920 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:157.11 Median:157.11 stddev:0.00 (0.0%) 02:30:39 INFO - 2015-11-24 02:30:39,920 DEBUG : BROWSER_OUTPUT: Values: 157.1 02:30:39 INFO - 2015-11-24 02:30:39,920 DEBUG : BROWSER_OUTPUT: 02:30:39 INFO - 2015-11-24 02:30:39,920 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.47 Median:278.47 stddev:0.00 (0.0%) 02:30:39 INFO - 2015-11-24 02:30:39,920 DEBUG : BROWSER_OUTPUT: Values: 278.5 02:30:39 INFO - 2015-11-24 02:30:39,921 DEBUG : BROWSER_OUTPUT: 02:30:39 INFO - 2015-11-24 02:30:39,921 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4726.42 Median:4726.42 stddev:0.00 (0.0%) 02:30:39 INFO - 2015-11-24 02:30:39,921 DEBUG : BROWSER_OUTPUT: Values: 4726.4 02:30:39 INFO - 2015-11-24 02:30:39,921 DEBUG : BROWSER_OUTPUT: 02:30:39 INFO - 2015-11-24 02:30:39,921 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:938.97 Median:938.97 stddev:0.00 (0.0%) 02:30:39 INFO - 2015-11-24 02:30:39,921 DEBUG : BROWSER_OUTPUT: Values: 939.0 02:30:39 INFO - 2015-11-24 02:30:39,921 DEBUG : BROWSER_OUTPUT: 02:30:39 INFO - 2015-11-24 02:30:39,921 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:733.14 Median:733.14 stddev:0.00 (0.0%) 02:30:39 INFO - 2015-11-24 02:30:39,921 DEBUG : BROWSER_OUTPUT: Values: 733.1 02:30:39 INFO - 2015-11-24 02:30:39,921 DEBUG : BROWSER_OUTPUT: 02:30:39 INFO - 2015-11-24 02:30:39,921 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12587.50 Median:12587.50 stddev:0.00 (0.0%) 02:30:39 INFO - 2015-11-24 02:30:39,921 DEBUG : BROWSER_OUTPUT: Values: 12587.5 02:30:39 INFO - 2015-11-24 02:30:39,921 DEBUG : BROWSER_OUTPUT: 02:30:39 INFO - 2015-11-24 02:30:39,921 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27162.16 Median:27162.16 stddev:0.00 (0.0%) 02:30:39 INFO - 2015-11-24 02:30:39,922 DEBUG : BROWSER_OUTPUT: Values: 27162.2 02:30:39 INFO - 2015-11-24 02:30:39,922 DEBUG : BROWSER_OUTPUT: 02:30:39 INFO - 2015-11-24 02:30:39,922 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:684.93 Median:684.93 stddev:0.00 (0.0%) 02:30:39 INFO - 2015-11-24 02:30:39,922 DEBUG : BROWSER_OUTPUT: Values: 684.9 02:30:39 INFO - 2015-11-24 02:30:39,922 DEBUG : BROWSER_OUTPUT: 02:30:39 INFO - 2015-11-24 02:30:39,922 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4513.51 Median:4513.51 stddev:0.00 (0.0%) 02:30:39 INFO - 2015-11-24 02:30:39,922 DEBUG : BROWSER_OUTPUT: Values: 4513.5 02:30:39 INFO - 2015-11-24 02:30:39,922 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:30:39 INFO - 2015-11-24 02:30:39,922 DEBUG : BROWSER_OUTPUT: 02:30:40 INFO - 2015-11-24 02:30:40,532 INFO : Browser exited with error code: 0 02:30:40 INFO - 2015-11-24 02:30:40,550 INFO : Completed test v8_7 (00:00:37) 02:30:40 INFO - 2015-11-24 02:30:40,967 INFO : Completed test suite (00:20:05) 02:30:40 INFO - 2015-11-24 02:30:40,967 DEBUG : Working with test: dromaeo_css 02:30:40 INFO - 2015-11-24 02:30:40,967 DEBUG : Generating results file: dromaeo_css 02:30:40 INFO - 2015-11-24 02:30:40,968 DEBUG : Working with test: kraken 02:30:40 INFO - 2015-11-24 02:30:40,968 DEBUG : Generating results file: kraken 02:30:40 INFO - 2015-11-24 02:30:40,968 INFO : javascript benchmark 02:30:40 INFO - 2015-11-24 02:30:40,968 DEBUG : Working with test: v8_7 02:30:40 INFO - 2015-11-24 02:30:40,969 DEBUG : Generating results file: v8_7 02:30:40 INFO - 2015-11-24 02:30:40,969 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:30:41 INFO - 2015-11-24 02:30:41,433 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 02:30:41 INFO - 2015-11-24 02:30:41,433 DEBUG : process_Request line: dromaeo_css 7677.22 graph.html#tests=[[72,64,61]] 02:30:41 INFO - 2015-11-24 02:30:41,433 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:30:41 INFO - 2015-11-24 02:30:41,535 DEBUG : process_Request line: kraken 1524.00 graph.html#tests=[[232,64,61]] 02:30:41 INFO - 2015-11-24 02:30:41,536 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:30:41 INFO - 2015-11-24 02:30:41,564 DEBUG : process_Request line: v8_7 21731.27 graph.html#tests=[[230,64,61]] 02:30:41 INFO - 2015-11-24 02:30:41,565 INFO : javascript benchmark 02:30:41 INFO - 2015-11-24 02:30:41,566 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3467.4625433057877, 3513.9121521961965, 3533.1520435095586, 3568.4468907319374, 3577.2487777566703, 5963.910541341883, 6023.307319658241, 6028.4574388305045, 6043.4560889519935, 6074.908876366852, 5473.233747275384, 5501.762103526705, 5771.643663739029, 5948.524118070544, 6002.219711437518, 5280.735963201824, 5322.281491998579, 5356.892862142755, 5428.37573679028, 5444.8366549003595, 4404.537523560028, 4597.770111494428, 5479.698616576086, 5485.780568777264, 5493.121100623901, 5185.274061631375, 5224.63427560071, 5318.282031925679, 5387.299651045359, 5430.5384042356445, 5364.1149210380245, 5368.32895888014, 5386.245925570423, 5391.0, 5400.513953744143, 5329.413764485904, 5336.573074154058, 5388.838334849922, 5405.593328929655, 5414.7834086636485, 5279.63042587019, 5283.731904342969, 5624.5781566382275, 5904.232449781501, 6037.124616930564, 6248.9062664060075, 6297.0554416837385, 6298.905516417258, 6303.338149494329, 6308.2430108386825, 6299.968500157515, 6304.495640348807, 6321.810345689637, 6328.303886572473, 6333.778317758903, 5944.97027514864, 6015.248093988252, 6031.638101713911, 6083.087536869417, 6107.0228763397645, 6435.131257280301, 6443.7744678936015, 6455.61266324022, 6462.903056454157, 6469.741210351627, 6137.8060289513105, 6241.625502469867, 6316.842078948063, 6328.019157030668, 6328.6519241442165, 6275.121482992385, 6275.905861412082, 6388.840278993062, 6419.646919419477, 6451.161349024596, 6251.593646412968, 6277.591956522811, 6288.685565721696, 6292.2134733158355, 6297.779577714758, 5343.545798607084, 6144.15675297409, 6263.0, 6267.467265282411, 6304.05439184126, 5016.623753218523, 5048.192289233779, 5049.545540901263, 5055.747212639353, 5090.796368145233, 4523.5024147343765, 4596.6092882105395, 4606.861794146181, 4623.53764623535, 4647.326137710081, 4930.013997200503, 5599.860003499945, 5895.64626122434, 6054.122152287893, 6070.514358851281, 6342.429181373698, 6343.714532846033, 6344.68276586178, 6348.333424990402, 6351.523635727339, 6003.21958145447, 6014.458698717049, 6019.578629495893, 6025.186599809057, 6027.638341699512, 5433.0, 5512.4211957744665, 5530.032244357221, 5597.692126932976, 5621.128725047624, 6458.903116453163, 6493.415592596594, 6550.344965503412, 6550.6069635822005, 6705.564138330993, 6389.52078594098, 6394.1687580614225, 6407.038944158414, 6411.326810684811, 6427.421532062137, 6280.0, 6325.96837015812, 6450.193725784277, 6534.542582019213, 6549.083128362128, 5217.34783152106, 5232.738363081907, 6159.414855588712, 6173.290071641639, 6297.4017468340435, 5222.55608273301, 6302.117703521419, 6306.905396418965, 6309.148264984168, 6320.5891617044745, 6024.397560244116, 6138.32709113608, 6203.06953956892, 6219.47134493555, 6223.937760622336, 6133.172021777003, 6201.131841542097, 6213.0, 6213.502919766317, 6249.0, 5939.287285525765, 6016.608920420159, 6130.938690613037, 6165.969170154121, 6221.4089661482085, 6202.81391558254, 6262.279837818709, 6275.215598050244, 6275.37246275387, 6303.338149494237, 6134.9079763804475, 6179.598326108789, 6187.504999599932, 6195.783147589813, 6202.41077097675], "unit": "ms", "name": "dojo.html", "value": 5809.046291454477}, {"lowerIsBetter": false, "replicates": [540.5378401466749, 572.3732512898376, 576.2796504369538, 583.1602492410925, 606.7936901453505, 41398.17203655925, 41601.37597936026, 41766.79116604417, 41804.0, 41841.58158418415, 43477.78261108698, 43552.34671479923, 43737.343939840925, 44062.55937440625, 44113.558864411345, 8994.325425593073, 9640.662576809813, 9763.0, 9797.020297970217, 9804.068613481708, 9567.473788941605, 9668.274879384038, 9701.320907536476, 9715.368501047446, 9727.805443891119, 9709.174720148796, 9763.853542196874, 9768.267379946497, 9775.706728798148, 9796.951015244913, 9692.418454892693, 9738.172255358302, 9763.902360976406, 9767.120959113678, 9785.021497850157, 9599.616015359377, 9770.853437198448, 9772.0, 9782.0, 9811.166050885684, 40814.79592602047, 40938.59061409377, 41033.35866565334, 41040.58959410398, 41462.37806432906, 3294.7528935329947, 3324.1357247115925, 3339.532465454838, 3571.3035957988204, 3807.333716599584, 28926.421471570662, 29170.854145729347, 29204.0, 29256.0, 29337.533123343746, 2342.8242881783763, 2689.9865500672568, 2809.859507024661, 2825.5055365311196, 2840.8863645454157, 512434.0, 516758.0, 516775.41612292075, 516975.0, 517988.0, 58185.70907145522, 59424.702876486204, 74014.0, 74989.62505187439, 75161.24838751652, 71465.2853471469, 72176.63911680409, 72293.63853180701, 72681.0, 72860.63569682118, 16003.759943600855, 16194.67610647804, 16306.184690765414, 16379.344826206818, 16383.0, 12331.938340308421, 12438.440270187682, 12449.190802597803, 12470.314132722788, 12486.313252771002, 21729.67405488919, 21880.45298867541, 22211.111555537598, 22213.666794998087, 22229.333120006424, 7832.960835195788, 9109.0, 9367.531623418938, 9379.202767764817, 9396.90603093974, 953.1785913695539, 955.9856602150974, 1012.6860673191187, 1021.3871676993745, 1122.5846436818267, 30001.39997200044, 30096.0, 30251.0, 30294.84852575723, 30838.0, 1090.907272881798, 1152.6772503698978, 1153.6654370232707, 1214.2350319298962, 1245.0910835090253, 15261.542153735405, 15348.769768453481, 15393.538193854203, 15558.9222053889, 15573.221338933008, 530663.0, 540617.0, 549120.0, 551771.0, 551911.0, 59216.70391648014, 59640.70179649074, 59737.701311494035, 59868.0, 59987.800243994876, 1225.7487215121057, 1299.4996926183487, 1404.4241860837008, 1431.6349330920548, 1434.1036851967729, 29838.85080574583, 29987.237776182745, 30073.0, 30090.84954575213, 30095.097147085624, 50960.235596466824, 51243.2313515305, 51549.0, 51828.222576662134, 51936.18223362164, 478538.0, 483800.0, 487384.0, 490028.0, 490759.0, 34083.65916340805, 43629.63703629738, 45143.54856451525, 45290.773546132055, 45396.092078158916, 37693.0, 46476.767616161706, 46694.53305467038, 47564.810879728284, 47642.0, 26593.0, 30506.389872202875, 31456.84271578719, 33992.13043282643, 35000.0, 31155.06534803869, 37263.6273637271, 37890.43164352592, 38126.0, 38850.80574597109, 40000.599994000855, 40117.79941100276, 41238.58761412348, 41399.7930010348, 41410.1717965645, 32623.0, 33153.0, 33906.8304658485, 33920.491192632624, 34805.1298717524, 25868.22881322082, 26010.349741255865, 26149.328359689403, 26240.868795656665, 26518.0], "unit": "ms", "name": "ext.html", "value": 20456.153700276256}, {"lowerIsBetter": false, "replicates": [361.1278761790277, 365.8024666679993, 368.41422138799305, 369.1804194687794, 369.9815009249537, 15926.0, 19653.901730491347, 20873.37379878604, 21277.468063298424, 21483.785162148375, 12006.519739210422, 17178.312867485285, 18577.071146442693, 20878.686819697716, 20883.895580522116, 5195.19474481455, 5244.79020839166, 5324.41431442541, 5349.7592608332525, 5367.275417818583, 5282.3925248596515, 5327.387350454689, 5524.751386187611, 5709.172170035343, 5733.598648094635, 4492.7528985905765, 5227.137522308814, 5252.8161514347, 5607.43925607438, 5686.772529098831, 5542.334919809628, 5556.0, 5589.832305030835, 5602.467765562265, 5621.831345059655, 5004.949950500485, 5349.598780091509, 5425.511703946664, 5573.303337082864, 5613.410591887834, 12672.0, 12903.935480322538, 20146.899265503725, 23904.0, 24070.0, 1971.7732460767052, 1972.8618996670239, 1997.7502812148482, 2105.536781907978, 2194.8902554872193, 9836.704898852975, 10019.148372388356, 10028.548715307756, 12844.807327890088, 14428.0, 1676.7317229243386, 1777.25355350753, 1784.4022252545412, 1804.3955274982766, 1805.2959345855127, 73648.63175684141, 84694.57652711697, 96659.0, 97394.51302743441, 98783.0, 9222.0, 10958.726031849108, 10987.450627468595, 11029.227954043301, 11165.325201219719, 13159.53941612058, 13199.538016169388, 13262.403191856389, 13262.469501219843, 13299.867001329863, 7962.32320252785, 8181.181881811771, 8350.373721970876, 8357.540335281617, 8387.370947178986, 6721.345068697935, 8391.909051823346, 8422.368322375847, 8510.106438823834, 8553.401261911731, 3986.4418981342637, 4408.338749187584, 4408.501109622744, 4452.465704115527, 4502.752348620857, 1500.1524138861507, 1856.3873921605837, 1870.4949663590755, 1903.6287923854716, 1904.2478221102588, 396.64896566538243, 399.15578551364234, 404.8218783735147, 422.2589355680761, 430.66838534328394, 20632.793672063388, 20930.058147383403, 21009.78990210109, 21335.359939201848, 22500.874956252123, 900.945893304835, 963.7686955130719, 964.5081008685621, 968.8692026576463, 988.253868329421, 8809.823803523894, 10546.41994690284, 10755.0, 10800.837987430195, 10882.673519794418, 751645.0, 751851.0, 764276.0, 765244.0, 780820.0, 130395.0, 130925.0, 132728.0, 134685.0, 140053.0, 1154.5958914380067, 1177.2995067934564, 1186.0867132308247, 1189.8631657359342, 1192.0, 18049.368272110412, 18271.543211419288, 18276.268949241883, 18319.35882244115, 18474.907625461787, 43441.131177376905, 53916.460835391146, 54377.0, 54514.999999998414, 54752.631184220714, 76176.23823761691, 76978.0, 77256.0, 77311.0, 79510.0, 7949.523028618301, 9585.376950498196, 9699.369540979813, 9767.413955162712, 9777.608895644378, 17874.46376608704, 19341.323053693053, 19570.804291956898, 19809.801901981373, 19963.900180499004, 13331.800022999856, 15080.095194288378, 15594.0, 15887.443939462064, 15937.203139843194, 15240.618984525476, 15284.235788210768, 15306.387744490541, 15477.922610386877, 15618.45335413255, 15936.840631593535, 16108.0, 16211.51365459038, 16216.432424865074, 16298.67402651964, 9619.134277915022, 9640.132388085107, 9747.853782193131, 9871.210303175585, 9885.011498850345, 10773.838392423962, 15652.37390504367, 16124.435644752377, 16276.43032493857, 16308.510744677678], "unit": "ms", "name": "jquery.html", "value": 9615.162576117547}, {"lowerIsBetter": false, "replicates": [1559.2437667731142, 1564.0381165583162, 1896.9905150474242, 1917.3481016454402, 1939.7769256535498, 7732.536047837134, 7878.566678832662, 8181.91818081819, 8563.486190828555, 8611.311095112384, 8196.590170491481, 8364.665413383458, 8455.450395724274, 8475.32197424206, 8490.10853860345, 2349.0721165139844, 2349.224755830576, 2381.9761802381927, 2388.868612226327, 2393.56915755164, 2341.9648705269433, 2356.6582845487396, 2375.3467796355967, 2389.916352927648, 2402.1832576923844, 2342.5783358995373, 2361.515889242701, 2378.607529757588, 2396.772306630867, 2404.831661783676, 2069.7619773725914, 2363.3264519612, 2374.905003799846, 2401.8438801477846, 2401.8678972656407, 2051.0, 2403.3390817525146, 2421.1889017179265, 2423.6849209602638, 2439.4511234972165, 8475.788105297417, 8541.701040463617, 8545.145485451467, 8558.743237702878, 8589.613467393981, 5185.688858668492, 5277.12927366984, 5285.709285989269, 5308.9469105308835, 5328.387235467932, 3457.0493114393494, 3536.929261414757, 3563.2160924596546, 3563.2160924596546, 3570.696490798285, 1056.334509259162, 1069.1767339148812, 1073.0128281980597, 1083.756154865157, 1084.604119496386, 11302.547898084067, 11335.659930202108, 11360.091192704482, 11370.147238957112, 11387.772244555146, 4649.651276154302, 4671.15919134559, 4714.010057887814, 4719.2685133803625, 4720.12677654635, 8088.150744171778, 9627.470489123165, 9632.75918102039, 9648.083432073941, 9715.46564938921, 4468.821247150077, 5196.168613021899, 5209.843704688866, 5214.713190774544, 5258.92111618326, 4298.656107511391, 4372.934405983913, 4597.816087356468, 4703.223968045303, 4737.715737055788, 3831.7126215533945, 3846.2307538492414, 3884.902877428087, 3898.2788184186015, 3905.5313362396696, 1303.6349822049842, 1311.5278499740086, 1314.6910476038124, 1322.107577385261, 1322.6707159304838, 1374.17549470319, 1395.0443945897093, 1398.5734351023036, 1417.5818133650598, 1427.3862239237228, 7886.684532618631, 7904.130545639975, 7906.288434040964, 7948.403869709679, 7952.1650226726515, 504.1026971989864, 515.0394514231007, 516.4860963341424, 516.7648719832467, 519.4597618476741, 5991.221141251609, 6152.323244443108, 6165.229346331708, 6172.783952561639, 6193.659348735772, 9978.351407158512, 10255.487225638837, 10267.640632577974, 10289.176865850714, 10295.691129266133, 9203.493807840632, 10056.74858128538, 10096.798064038678, 10104.74738131538, 10135.493225338703, 6792.626405547643, 7875.960620196977, 7916.208379162153, 7933.0, 7950.840983180304, 7390.260973902567, 7437.0331856858265, 7455.4035677146785, 7491.138519070377, 7524.699012039676, 8924.196822286025, 9009.009009008872, 9048.230900373543, 9076.27389808827, 9110.0, 9190.770230744285, 9222.584983675617, 9316.767080823034, 9328.02055784133, 9364.672236471692, 6626.27111017778, 6888.552244104118, 7087.964560177166, 7261.0, 7279.8544029120185, 7816.843663126592, 7904.644291007034, 7919.0, 7924.564148971862, 7958.920410795818, 7365.705371785069, 7454.888176677463, 7460.104787425326, 7541.208173141741, 7602.505837120791, 7310.59791711461, 7318.377937875341, 7337.816554585965, 7428.480006399716, 7441.776746697607, 7425.331720144996, 7499.812504687427, 7522.247775222434, 7529.87051942213, 7545.396368290633, 5767.990601644779, 6750.25747167821, 6832.385085342343, 6858.725650973905, 6875.449964002768, 6951.687174077279, 6980.05769221169, 7034.47241456903, 7048.013278140962, 7050.15398152225], "unit": "ms", "name": "mootools.html", "value": 4705.083817393871}, {"lowerIsBetter": false, "replicates": [329.1146815067468, 337.5999440662813, 339.568747690433, 339.87084907735056, 348.0463529927998, 6852.2462529121885, 6982.79051628452, 7028.402585780208, 7066.576005439677, 7078.186008609018, 5052.964142350818, 6005.549583781212, 6987.0916780818425, 7013.929860701392, 7042.683079261433, 4718.221493453576, 4722.268048452478, 5068.645194836363, 5098.515641014116, 5110.488951104879, 4076.7350122242105, 5003.120085864759, 5080.949190508085, 5101.948980510185, 5111.361079865017, 4053.351463765798, 4982.850514484553, 5003.074431230216, 5020.221865610818, 5050.545450909417, 5039.622028347871, 5041.470645582216, 5057.494250574931, 5058.0, 5070.264811602297, 4365.5416181300825, 4365.738055716667, 4371.14762621289, 4372.234858899712, 4394.60448559628, 5884.087966365178, 6142.662153581551, 6439.549231553793, 6670.199576050905, 6674.199096108449, 5879.7648094076185, 5882.529397648178, 5893.823185304448, 5895.616784908967, 5898.8230353089475, 7443.2556744325675, 7462.962685186593, 7472.0286362772495, 7480.0, 7516.736914207976, 4698.812047518095, 4700.952990470086, 4701.177293973541, 4702.27114797207, 4732.0, 7639.0, 7928.0, 7931.762047138595, 7945.960270198612, 7958.283754462068, 4671.32265821454, 4718.127146477913, 4721.5750582447745, 4722.433308003062, 4735.1240020595615, 4024.5170579530645, 4170.791460426966, 4757.048590281957, 4804.783784729626, 4828.082664293773, 5743.310802703702, 5788.218590490314, 5813.7383817728305, 5867.178594996704, 5893.0, 7508.249175082448, 7509.249075092447, 7525.2098529654695, 7531.397488200931, 7552.169261381244, 1597.400974634512, 1651.6944365292459, 1661.775660285846, 1708.880378373502, 1714.4256674014346, 1068.551208492435, 1077.3751224289892, 1080.8324709670014, 1082.604849230041, 1092.1481244629201, 6801.047853300542, 6807.115075040312, 6818.4886133540185, 6842.04211410403, 6867.901135818345, 7608.2011388804485, 7640.121386040565, 7645.961770191225, 7652.502587331805, 7679.0, 6767.729290828312, 6788.49086318528, 6802.897956530656, 6815.148106486689, 7064.646767661597, 4093.508778946486, 4135.0, 4141.751494910315, 4146.91706165875, 4157.230912281238, 8120.593970301461, 8123.4313598047565, 8140.267375936194, 8150.0, 8158.469699469634, 7926.960365198137, 8152.6331315090965, 8168.959155204305, 8177.509349439053, 8184.549849758201, 8106.63520141595, 8116.472429292196, 8128.63421146038, 8131.918680813116, 8143.6742530298125, 7592.088949326117, 7835.333996610352, 7851.254130857559, 7851.9214807851195, 7875.1731068239305, 7681.807954800951, 7685.346745526693, 7700.075990881131, 7708.691652333844, 7753.340966017726, 7134.608751293656, 7564.621768911643, 8075.596220189084, 8105.148959359418, 8129.227723366271, 4545.431821022372, 4673.0, 4733.290006498915, 4750.548697873696, 4776.426828780569, 6398.87202255943, 7381.151167615578, 7546.132194797449, 7751.263629955145, 7759.961200193963, 7322.963385183253, 7489.325960663567, 7506.662200201114, 7507.399408047452, 7538.849223015619, 7485.850282994201, 7495.550266983998, 7508.324250817453, 7508.474406791691, 7524.548527088174, 7095.574265544084, 7271.600061996641, 7308.199736137285, 7335.083114610674, 7338.743143990148, 7487.363574096263, 7493.925060749323, 7495.175530691728, 7497.175310715926, 7509.586972716553, 7183.7615509876305, 7249.601271930094, 7335.413166946525, 7351.228121047213, 7395.482316237812], "unit": "ms", "name": "prototype.html", "value": 5375.21285941007}, {"lowerIsBetter": false, "replicates": [598.8862116197919, 704.982375440614, 731.480648739395, 797.1032588338118, 856.3192262151592, 12152.513899444022, 15195.696086078271, 15346.769798453031, 15367.23163841809, 15389.769153462694, 14016.439342426316, 14135.78796318056, 14166.220857852813, 14558.199299038548, 14573.0, 709.7622296530643, 781.308541940384, 954.9570269337879, 975.8585005174245, 979.4906648542753, 966.9854952175723, 968.1528662420383, 974.9171320437771, 975.765816204113, 991.5637119667359, 1019.9796004079914, 1040.9895901040968, 1041.4896700616719, 1042.8696412948382, 1043.1498328861992, 975.7902051058985, 1000.7698229407241, 1017.4912543728136, 1022.2128960700294, 1030.6598822388594, 729.6971756720955, 735.6799792090458, 743.9330460258549, 754.2871985973258, 762.4777027735963, 14986.325615347336, 15149.091054536762, 15206.16366099875, 15281.847181528154, 15369.231538423033, 12572.937135314356, 12665.556705515262, 12743.936280318632, 12921.0, 12972.935135324356, 10048.748781280454, 10225.642102526375, 10334.534945927451, 10567.418791966438, 10912.672619821418, 3475.391806433889, 3499.7025252853537, 3567.1438854674952, 3608.566971963355, 3739.7943113128767, 72290.27709722889, 72819.63590182015, 73555.52888942245, 82870.0, 83720.16279837185, 9365.344425890258, 9520.523973801282, 9562.665306714232, 9795.853062204073, 10181.287309888237, 21513.784862151177, 21855.125794968342, 21873.562528749335, 21908.0, 21977.0, 7446.441516886255, 7477.401807855358, 7580.0, 7596.164421913585, 7647.464677472523, 4048.919021619551, 4054.0675644601906, 4061.1674606705556, 4117.197146556453, 4132.297509423405, 3399.7620166588595, 3407.744419168572, 3410.7612467127065, 3411.4882767584563, 3424.828758562062, 612.3478495402383, 618.4650277510011, 623.76297007137, 633.6483251795206, 636.7134789344814, 479.30740080583917, 485.75954902323576, 520.7240162713767, 541.0, 574.6121368076615, 8024.879626805603, 8155.836883262302, 8513.787155321166, 8620.267277281377, 8693.261072808755, 605.4671888737882, 618.6411881108946, 623.1649589550025, 628.9371062893765, 636.0808631527399, 3784.7350685452307, 4019.3970904363996, 4050.2911990401562, 4120.320147175682, 4147.709660323749, 100620.0, 102360.46459303117, 102553.0, 103809.48095259626, 104595.4770226144, 81966.0, 85004.57497712472, 85597.57201213954, 85734.57132714421, 87100.56449717711, 75359.62320188365, 76175.0, 76361.2363876354, 77377.22622773812, 78061.0, 8298.87551686713, 8306.83704281389, 8378.916210838057, 8453.450525715809, 8530.556327681314, 53847.73076134594, 54819.0, 55199.0, 55959.72020139873, 56055.71972140113, 55771.72114139403, 67155.64955226543, 69310.65344673244, 70369.64815176096, 74961.62519187588, 9989.204102441026, 10821.513031913426, 11399.715007124889, 11448.656540303804, 11516.349173954974, 9979.700608981742, 11913.22564033335, 12510.49874015124, 12583.748325033264, 13044.086913915935, 11959.162858599815, 11993.0, 12023.939880300892, 12058.095642826647, 12067.215630983957, 10711.517981690688, 11630.069594432594, 12042.0, 12045.698857528632, 12125.090618203494, 11398.259113157617, 11556.768864622492, 11923.880761192624, 11930.522779088738, 12241.510339586317, 9779.119879210904, 9822.607095716377, 9864.704058878246, 10132.645357412455, 10457.47712614351, 9305.488198149167, 9696.466694331879, 10242.846357304796, 10260.281780275309, 10317.432541210006], "unit": "ms", "name": "yui.html", "value": 7084.988373275039}], "name": "dromaeo_css", "value": 7677.219520054808}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 107.0, 114.0, 112.0, 114.0, 123.0, 111.0, 113.0, 119.0, 127.0], "unit": "ms", "name": "ai-astar", "value": 115.5}, {"lowerIsBetter": true, "replicates": [160.0, 118.0, 178.0, 185.0, 156.0, 144.0, 170.0, 107.0, 151.0, 135.0], "unit": "ms", "name": "audio-beat-detection", "value": 150.4}, {"lowerIsBetter": true, "replicates": [192.0, 189.0, 192.0, 192.0, 202.0, 217.0, 199.0, 198.0, 202.0, 196.0], "unit": "ms", "name": "audio-dft", "value": 197.9}, {"lowerIsBetter": true, "replicates": [56.0, 67.0, 59.0, 64.0, 122.0, 55.0, 57.0, 58.0, 60.0, 95.0], "unit": "ms", "name": "audio-fft", "value": 69.3}, {"lowerIsBetter": true, "replicates": [77.0, 76.0, 109.0, 74.0, 77.0, 76.0, 112.0, 86.0, 93.0, 105.0], "unit": "ms", "name": "audio-oscillator", "value": 88.5}, {"lowerIsBetter": true, "replicates": [118.0, 134.0, 85.0, 133.0, 134.0, 87.0, 105.0, 112.0, 87.0, 95.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.0}, {"lowerIsBetter": true, "replicates": [116.0, 124.0, 96.0, 104.0, 95.0, 96.0, 105.0, 140.0, 94.0, 95.0], "unit": "ms", "name": "imaging-darkroom", "value": 106.5}, {"lowerIsBetter": true, "replicates": [89.0, 119.0, 145.0, 82.0, 141.0, 76.0, 150.0, 140.0, 103.0, 92.0], "unit": "ms", "name": "imaging-desaturate", "value": 113.7}, {"lowerIsBetter": true, "replicates": [58.0, 60.0, 56.0, 55.0, 56.0, 58.0, 62.0, 56.0, 53.0, 77.0], "unit": "ms", "name": "json-parse-financial", "value": 59.1}, {"lowerIsBetter": true, "replicates": [77.0, 99.0, 96.0, 66.0, 65.0, 68.0, 67.0, 68.0, 58.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 73.2}, {"lowerIsBetter": true, "replicates": [83.0, 86.0, 86.0, 85.0, 83.0, 84.0, 84.0, 84.0, 87.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.5}, {"lowerIsBetter": true, "replicates": [128.0, 128.0, 128.0, 132.0, 131.0, 132.0, 144.0, 124.0, 142.0, 125.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 131.4}, {"lowerIsBetter": true, "replicates": [137.0, 134.0, 140.0, 145.0, 137.0, 137.0, 141.0, 139.0, 140.0, 139.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 138.9}, {"lowerIsBetter": true, "replicates": [68.0, 85.0, 83.0, 101.0, 76.0, 62.0, 96.0, 101.0, 92.0, 97.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 86.1}], "name": "kraken", "value": 1524.0}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [176.7096660187312], "unit": "score", "name": "Richards", "value": 199.77401799999998}, {"lowerIsBetter": false, "replicates": [157.10919088766693], "unit": "score", "name": "DeltaBlue", "value": 420.84106999999995}, {"lowerIsBetter": false, "replicates": [278.473962684489], "unit": "score", "name": "Encrypt", "value": 955.8559709999997}, {"lowerIsBetter": false, "replicates": [4726.415094339623], "unit": "score", "name": "Decrypt", "value": 56.317736526946064}, {"lowerIsBetter": false, "replicates": [938.9671361502348], "unit": "score", "name": "RayTrace", "value": 788.0882850000002}, {"lowerIsBetter": false, "replicates": [733.1378299120234], "unit": "score", "name": "Earley", "value": 909.0555320000003}, {"lowerIsBetter": false, "replicates": [12587.5], "unit": "score", "name": "Boyer", "value": 52.946415094339656}, {"lowerIsBetter": false, "replicates": [27162.162162162163], "unit": "score", "name": "RegExp", "value": 33.538751243781114}, {"lowerIsBetter": false, "replicates": [684.931506849315], "unit": "score", "name": "Splay", "value": 118.97686000000003}, {"lowerIsBetter": false, "replicates": [4513.513513513513], "unit": "score", "name": "NavierStokes", "value": 328.7904191616765}], "name": "v8_7", "value": 21731.27101649781}]} 02:30:41 INFO - RETURN: dromaeo_css: 7677.22 02:30:41 INFO - RETURN: kraken: 1524.00 02:30:41 INFO - RETURN: v8_7: 21731.27 02:30:41 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,61]]", "result": "21731.27"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1524.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7677.22"}}} 02:30:41 INFO - Return code: 0 02:30:41 INFO - # TBPL SUCCESS # 02:30:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:30:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:30:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:30:41 INFO - 2015-11-24 02:30:41.661 screenresolution[2571:30423] starting screenresolution argv=screenresolution get 02:30:41 INFO - 2015-11-24 02:30:41.664 screenresolution[2571:30423] Display 0: 1600x1200x32@60 02:30:41 INFO - 2015-11-24 02:30:41.670 screenresolution[2572:30426] starting screenresolution argv=screenresolution list 02:30:41 INFO - Available Modes on Display 0 02:30:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:30:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:30:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:30:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:30:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:30:41 INFO - Intel Iris: 02:30:41 INFO - Chipset Model: Intel Iris 02:30:41 INFO - Type: GPU 02:30:41 INFO - Bus: Built-In 02:30:41 INFO - VRAM (Dynamic, Max): 1536 MB 02:30:41 INFO - Vendor: Intel (0x8086) 02:30:41 INFO - Device ID: 0x0a2e 02:30:41 INFO - Revision ID: 0x0009 02:30:41 INFO - Displays: 02:30:41 INFO - Display: 02:30:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:30:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:30:41 INFO - Display Serial Number: 1600x1200 60 02:30:41 INFO - Main Display: Yes 02:30:41 INFO - Mirror: Off 02:30:41 INFO - Online: Yes 02:30:41 INFO - Rotation: Supported 02:30:41 INFO - Return code: 0 02:30:41 INFO - Running post-action listener: _resource_record_post_action 02:30:41 INFO - Running post-run listener: _resource_record_post_run 02:30:42 INFO - Total resource usage - Wall time: 1237s; CPU: 54.0%; Read bytes: 0; Write bytes: 690738176; Read time: 0; Write time: 2023 02:30:42 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 336937472; Write bytes: 336369152; Read time: 26143; Write time: 600 02:30:42 INFO - run-tests - Wall time: 1207s; CPU: 54.0%; Read bytes: 0; Write bytes: 343932416; Read time: 0; Write time: 1388 02:30:42 INFO - Running post-run listener: _upload_blobber_files 02:30:42 INFO - Blob upload gear active. 02:30:42 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 02:30:42 INFO - Copying logs to upload dir... 02:30:42 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1278.142975 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2015-11-24 02:30:43.027167) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 02:30:43.030729) ========= 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.CTFymuWQmD/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.HrisXIEcBp/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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.009764 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:30:43.054269) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 02:30:43.054615) ========= 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.CTFymuWQmD/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.HrisXIEcBp/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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.005324 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 02:30:43.103544) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 02:30:43.103859) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 02:30:43.104262) ========= ========= Total master_lag: 3.41 =========