builder: fx-team_yosemite_test-dromaeojs slave: t-yosemite-r5-0008 starttime: 1446484487.01 results: success (0) buildid: 20151102071406 builduid: 4beb9d6cd16a4a50919b61ac8f7565f4 revision: 74156ecb4a205ae76ff8b8ab82e0c1a6060dd9c8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-02 09:14:47.013338) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-02 09:14:47.013899) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-02 09:14:47.014202) ========= 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.VlItKxa9pK/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.w3lwqQKaCy/Listeners TMPDIR=/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005703 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-02 09:14:47.076121) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-02 09:14:47.076472) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-02 09:14:47.212054) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 09:14:47.212395) ========= 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.VlItKxa9pK/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.w3lwqQKaCy/Listeners TMPDIR=/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.024580 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 09:14:47.262553) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-02 09:14:47.263128) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-02 09:14:47.263776) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 09:14:47.264243) ========= 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.VlItKxa9pK/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.w3lwqQKaCy/Listeners TMPDIR=/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False --2015-11-02 09:14:47-- 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% 1.26G=0s 2015-11-02 09:14:47 (1.26 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.241276 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 09:14:47.524461) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 09:14:47.524815) ========= 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.VlItKxa9pK/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.w3lwqQKaCy/Listeners TMPDIR=/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.088452 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 09:14:47.628357) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 09:14:47.628751) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 74156ecb4a205ae76ff8b8ab82e0c1a6060dd9c8 --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 74156ecb4a205ae76ff8b8ab82e0c1a6060dd9c8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VlItKxa9pK/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.w3lwqQKaCy/Listeners TMPDIR=/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 2015-11-02 09:14:47,701 truncating revision to first 12 chars 2015-11-02 09:14:47,702 Setting DEBUG logging. 2015-11-02 09:14:47,702 attempt 1/10 2015-11-02 09:14:47,702 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/74156ecb4a20?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-02 09:14:47,957 unpacking tar archive at: fx-team-74156ecb4a20/testing/mozharness/ program finished with exit code 0 elapsedTime=0.507251 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 09:14:48.152736) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-02 09:14:48.153127) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-02 09:14:48.166238) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-02 09:14:48.166620) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-02 09:14:48.167123) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 50 secs) (at 2015-11-02 09:14:48.167609) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VlItKxa9pK/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.w3lwqQKaCy/Listeners TMPDIR=/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 09:14:48 INFO - MultiFileLogger online at 20151102 09:14:48 in /builds/slave/test 09:14:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 09:14:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:14:48 INFO - {'append_to_log': False, 09:14:48 INFO - 'base_work_dir': '/builds/slave/test', 09:14:48 INFO - 'blob_upload_branch': 'Fx-Team', 09:14:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:14:48 INFO - 'branch': 'Fx-Team', 09:14:48 INFO - 'buildbot_json_path': 'buildprops.json', 09:14:48 INFO - 'config_files': ('talos/mac_config.py',), 09:14:48 INFO - 'default_actions': ('clobber', 09:14:48 INFO - 'read-buildbot-config', 09:14:48 INFO - 'download-and-extract', 09:14:48 INFO - 'populate-webroot', 09:14:48 INFO - 'create-virtualenv', 09:14:48 INFO - 'install', 09:14:48 INFO - 'run-tests'), 09:14:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:14:48 INFO - 'download_minidump_stackwalk': True, 09:14:48 INFO - 'download_symbols': 'ondemand', 09:14:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:14:48 INFO - 'tooltool.py': '/tools/tooltool.py', 09:14:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:14:48 INFO - '/tools/misc-python/virtualenv.py')}, 09:14:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:14:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:14:48 INFO - 'installer_path': 'installer.exe', 09:14:48 INFO - 'log_level': 'info', 09:14:48 INFO - 'log_name': 'talos', 09:14:48 INFO - 'log_to_console': True, 09:14:48 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:14:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:14:48 INFO - 'opt_config_files': (), 09:14:48 INFO - 'pip_index': False, 09:14:48 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:14:48 INFO - 'cmd': ('bash', 09:14:48 INFO - '-c', 09:14:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:14:48 INFO - 'enabled': True, 09:14:48 INFO - 'halt_on_failure': False, 09:14:48 INFO - 'name': 'check_screen_resolution'},), 09:14:48 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:14:48 INFO - 'cmd': ('bash', 09:14:48 INFO - '-c', 09:14:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:14:48 INFO - 'enabled': True, 09:14:48 INFO - 'halt_on_failure': False, 09:14:48 INFO - 'name': 'check_screen_resolution'},), 09:14:48 INFO - 'run_cmd_checks_enabled': True, 09:14:48 INFO - 'sps_profile': False, 09:14:48 INFO - 'sps_profile_interval': 0, 09:14:48 INFO - 'suite': 'dromaeojs', 09:14:48 INFO - 'system_bits': '64', 09:14:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:14:48 INFO - 'title': 't-yosemite-r5-0008', 09:14:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:14:48 INFO - 'use_talos_json': True, 09:14:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:14:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:14:48 INFO - 'work_dir': 'build'} 09:14:48 INFO - ##### 09:14:48 INFO - ##### Running clobber step. 09:14:48 INFO - ##### 09:14:48 INFO - Running pre-action listener: _resource_record_pre_action 09:14:48 INFO - Running main action method: clobber 09:14:48 INFO - rmtree: /builds/slave/test/build 09:14:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:14:51 INFO - Running post-action listener: _resource_record_post_action 09:14:51 INFO - ##### 09:14:51 INFO - ##### Running read-buildbot-config step. 09:14:51 INFO - ##### 09:14:51 INFO - Running pre-action listener: _resource_record_pre_action 09:14:51 INFO - Running main action method: read_buildbot_config 09:14:51 INFO - Using buildbot properties: 09:14:51 INFO - { 09:14:51 INFO - "properties": { 09:14:51 INFO - "buildnumber": 1184, 09:14:51 INFO - "product": "firefox", 09:14:51 INFO - "script_repo_revision": "production", 09:14:51 INFO - "builddir": "fx-team_yosemite_test-dromaeojs", 09:14:51 INFO - "repository": "", 09:14:51 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 fx-team talos dromaeojs", 09:14:51 INFO - "buildid": "20151102071406", 09:14:51 INFO - "slavename": "t-yosemite-r5-0008", 09:14:51 INFO - "pgo_build": "False", 09:14:51 INFO - "basedir": "/builds/slave/test", 09:14:51 INFO - "project": "", 09:14:51 INFO - "platform": "yosemite", 09:14:51 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 09:14:51 INFO - "slavebuilddir": "test", 09:14:51 INFO - "scheduler": "tests-fx-team-macosx64-talos", 09:14:51 INFO - "branch": "fx-team", 09:14:51 INFO - "repo_path": "integration/fx-team", 09:14:51 INFO - "stage_platform": "macosx64", 09:14:51 INFO - "builduid": "4beb9d6cd16a4a50919b61ac8f7565f4", 09:14:51 INFO - "revision": "74156ecb4a205ae76ff8b8ab82e0c1a6060dd9c8" 09:14:51 INFO - }, 09:14:51 INFO - "sourcestamp": { 09:14:51 INFO - "repository": "", 09:14:51 INFO - "hasPatch": false, 09:14:51 INFO - "project": "", 09:14:51 INFO - "branch": "fx-team-macosx64-talos", 09:14:51 INFO - "changes": [ 09:14:51 INFO - { 09:14:51 INFO - "category": null, 09:14:51 INFO - "files": [ 09:14:51 INFO - { 09:14:51 INFO - "url": null, 09:14:51 INFO - "name": "https://queue.taskcluster.net/v1/task/QCbBN9c2TzSw7hibfAvTug/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 09:14:51 INFO - } 09:14:51 INFO - ], 09:14:51 INFO - "repository": "", 09:14:51 INFO - "rev": "74156ecb4a205ae76ff8b8ab82e0c1a6060dd9c8", 09:14:51 INFO - "who": "vporof@mozilla.com", 09:14:51 INFO - "when": 1446484108, 09:14:51 INFO - "number": 6609996, 09:14:51 INFO - "comments": "Bug 1213100 - Part 2: Refactor styles, add comments, fix bad merge and newly added css, r=pbrosset", 09:14:51 INFO - "project": "", 09:14:51 INFO - "at": "Mon 02 Nov 2015 09:08:28", 09:14:51 INFO - "branch": "fx-team-macosx64-talos", 09:14:51 INFO - "revlink": "", 09:14:51 INFO - "properties": [ 09:14:51 INFO - [ 09:14:51 INFO - "buildid", 09:14:51 INFO - "20151102071406", 09:14:51 INFO - "Change" 09:14:51 INFO - ], 09:14:51 INFO - [ 09:14:51 INFO - "builduid", 09:14:51 INFO - "4beb9d6cd16a4a50919b61ac8f7565f4", 09:14:51 INFO - "Change" 09:14:51 INFO - ], 09:14:51 INFO - [ 09:14:51 INFO - "pgo_build", 09:14:51 INFO - "False", 09:14:51 INFO - "Change" 09:14:51 INFO - ] 09:14:51 INFO - ], 09:14:51 INFO - "revision": "74156ecb4a205ae76ff8b8ab82e0c1a6060dd9c8" 09:14:51 INFO - } 09:14:51 INFO - ], 09:14:51 INFO - "revision": "74156ecb4a205ae76ff8b8ab82e0c1a6060dd9c8" 09:14:51 INFO - } 09:14:51 INFO - } 09:14:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/QCbBN9c2TzSw7hibfAvTug/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 09:14:51 INFO - Running post-action listener: _resource_record_post_action 09:14:51 INFO - ##### 09:14:51 INFO - ##### Running download-and-extract step. 09:14:51 INFO - ##### 09:14:51 INFO - Running pre-action listener: _resource_record_pre_action 09:14:51 INFO - Running main action method: download_and_extract 09:14:51 INFO - mkdir: /builds/slave/test/build/tests 09:14:51 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')]} 09:14:51 INFO - https://queue.taskcluster.net/v1/task/QCbBN9c2TzSw7hibfAvTug/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:14:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QCbBN9c2TzSw7hibfAvTug/artifacts/public/build/test_packages.json 09:14:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QCbBN9c2TzSw7hibfAvTug/artifacts/public/build/test_packages.json 09:14:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QCbBN9c2TzSw7hibfAvTug/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 09:14:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QCbBN9c2TzSw7hibfAvTug/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 09:14:52 INFO - Downloaded 1149 bytes. 09:14:52 INFO - Reading from file /builds/slave/test/build/test_packages.json 09:14:52 INFO - Using the following test package requirements: 09:14:52 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 09:14:52 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 09:14:52 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 09:14:52 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 09:14:52 INFO - u'jsshell-mac.zip'], 09:14:52 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 09:14:52 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 09:14:52 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 09:14:52 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 09:14:52 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 09:14:52 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 09:14:52 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 09:14:52 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 09:14:52 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 09:14:52 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 09:14:52 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 09:14:52 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 09:14:52 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:14:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:14:52 INFO - https://queue.taskcluster.net/v1/task/QCbBN9c2TzSw7hibfAvTug/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:14:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QCbBN9c2TzSw7hibfAvTug/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 09:14:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QCbBN9c2TzSw7hibfAvTug/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 09:14:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QCbBN9c2TzSw7hibfAvTug/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 09:14:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QCbBN9c2TzSw7hibfAvTug/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 09:14:53 INFO - Downloaded 17452513 bytes. 09:14:53 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 09:14:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 09:14:53 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 09:14:59 INFO - Return code: 0 09:14:59 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 09:14: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')]} 09:14:59 INFO - https://queue.taskcluster.net/v1/task/QCbBN9c2TzSw7hibfAvTug/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:14:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QCbBN9c2TzSw7hibfAvTug/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 09:14:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QCbBN9c2TzSw7hibfAvTug/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 09:14:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QCbBN9c2TzSw7hibfAvTug/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 09:14:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QCbBN9c2TzSw7hibfAvTug/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 09:15:01 INFO - Downloaded 17452513 bytes. 09:15:01 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 09:15:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 09:15:01 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 09:15:06 INFO - Return code: 0 09:15:06 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')]} 09:15:06 INFO - https://queue.taskcluster.net/v1/task/QCbBN9c2TzSw7hibfAvTug/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:15:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QCbBN9c2TzSw7hibfAvTug/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 09:15:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QCbBN9c2TzSw7hibfAvTug/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 09:15:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QCbBN9c2TzSw7hibfAvTug/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 09:15:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QCbBN9c2TzSw7hibfAvTug/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 09:15:07 INFO - Downloaded 11131307 bytes. 09:15:07 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 09:15:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 09:15:07 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 09:15:08 INFO - Return code: 0 09:15:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:15:08 INFO - https://queue.taskcluster.net/v1/task/QCbBN9c2TzSw7hibfAvTug/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 09:15:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QCbBN9c2TzSw7hibfAvTug/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 09:15:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QCbBN9c2TzSw7hibfAvTug/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 09:15:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QCbBN9c2TzSw7hibfAvTug/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 09:15:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QCbBN9c2TzSw7hibfAvTug/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 09:15:11 INFO - Downloaded 108574702 bytes. 09:15:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QCbBN9c2TzSw7hibfAvTug/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 09:15:11 INFO - mkdir: /builds/slave/test/properties 09:15:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:15:11 INFO - Writing to file /builds/slave/test/properties/build_url 09:15:11 INFO - Contents: 09:15:11 INFO - build_url:https://queue.taskcluster.net/v1/task/QCbBN9c2TzSw7hibfAvTug/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 09:15:11 INFO - Running post-action listener: _resource_record_post_action 09:15:11 INFO - Running post-action listener: set_extra_try_arguments 09:15:11 INFO - ##### 09:15:11 INFO - ##### Running populate-webroot step. 09:15:11 INFO - ##### 09:15:11 INFO - Running pre-action listener: _resource_record_pre_action 09:15:11 INFO - Running main action method: populate_webroot 09:15:11 INFO - Guessing talos json url... 09:15:11 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')]} 09:15:11 INFO - https://queue.taskcluster.net/v1/task/QCbBN9c2TzSw7hibfAvTug/artifacts/public/build/firefox-45.0a1.en-US.mac.txt matches https://queue.taskcluster.net 09:15:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QCbBN9c2TzSw7hibfAvTug/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 09:15:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QCbBN9c2TzSw7hibfAvTug/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 09:15:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QCbBN9c2TzSw7hibfAvTug/artifacts/public/build/firefox-45.0a1.en-US.mac.txt to /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 09:15:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QCbBN9c2TzSw7hibfAvTug/artifacts/public/build/firefox-45.0a1.en-US.mac.txt', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.txt'}, attempt #1 09:15:12 INFO - Downloaded 103 bytes. 09:15:12 INFO - Reading from file /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 09:15:12 INFO - Contents: 09:15:12 INFO - 20151102071406 09:15:12 INFO - https://hg.mozilla.org/integration/fx-team/rev/74156ecb4a205ae76ff8b8ab82e0c1a6060dd9c8 09:15:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:15:12 INFO - trying https://hg.mozilla.org/integration/fx-team/raw-file/74156ecb4a/testing/talos/talos.json 09:15:12 INFO - Downloading https://hg.mozilla.org/integration/fx-team/raw-file/74156ecb4a/testing/talos/talos.json to /builds/slave/test/build/talos.json 09:15:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/integration/fx-team/raw-file/74156ecb4a/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 09:15:12 INFO - Downloaded 4264 bytes. 09:15:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:15:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:15:12 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 09:15:12 INFO - '../fennec_ids.txt'], 09:15:12 INFO - 'tests': ['tcheck2']}, 09:15:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:15:12 INFO - '--tppagecycles', 09:15:12 INFO - '7'], 09:15:12 INFO - 'tests': ['tsvgm']}}, 09:15:12 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:15:12 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:15:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:15:12 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:15:12 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:15:12 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:15:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:15:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:12 INFO - 'talos_options': ['--e10s'], 09:15:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:15:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:12 INFO - 'tests': ['damp', 'tps']}, 09:15:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:12 INFO - 'talos_options': ['--e10s'], 09:15:12 INFO - 'tests': ['damp', 'tps']}, 09:15:12 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:15:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:15:12 INFO - 'other': {'tests': ['a11yr', 09:15:12 INFO - 'ts_paint', 09:15:12 INFO - 'tpaint', 09:15:12 INFO - 'sessionrestore', 09:15:12 INFO - 'sessionrestore_no_auto_restore']}, 09:15:12 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:15:12 INFO - 'tests': ['a11yr', 09:15:12 INFO - 'ts_paint', 09:15:12 INFO - 'tpaint', 09:15:12 INFO - 'sessionrestore', 09:15:12 INFO - 'sessionrestore_no_auto_restore']}, 09:15:12 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:15:12 INFO - 'tests': ['a11yr', 09:15:12 INFO - 'ts_paint', 09:15:12 INFO - 'tpaint', 09:15:12 INFO - 'sessionrestore', 09:15:12 INFO - 'sessionrestore_no_auto_restore']}, 09:15:12 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:15:12 INFO - 'tests': ['a11yr', 09:15:12 INFO - 'ts_paint', 09:15:12 INFO - 'tpaint', 09:15:12 INFO - 'sessionrestore', 09:15:12 INFO - 'sessionrestore_no_auto_restore']}, 09:15:12 INFO - 'other_l64': {'tests': ['a11yr', 09:15:12 INFO - 'ts_paint', 09:15:12 INFO - 'tpaint', 09:15:12 INFO - 'sessionrestore', 09:15:12 INFO - 'sessionrestore_no_auto_restore']}, 09:15:12 INFO - 'other_nol64': {'tests': ['a11yr', 09:15:12 INFO - 'ts_paint', 09:15:12 INFO - 'tpaint', 09:15:12 INFO - 'sessionrestore', 09:15:12 INFO - 'sessionrestore_no_auto_restore']}, 09:15:12 INFO - 'svgr': {'tests': ['tsvgx', 09:15:12 INFO - 'tsvgr_opacity', 09:15:12 INFO - 'tart', 09:15:12 INFO - 'tscrollx', 09:15:12 INFO - 'cart']}, 09:15:12 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:15:12 INFO - 'tests': ['tsvgx', 09:15:12 INFO - 'tsvgr_opacity', 09:15:12 INFO - 'tart', 09:15:12 INFO - 'tscrollx', 09:15:12 INFO - 'cart']}, 09:15:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:12 INFO - 'tests': ['tp5o']}, 09:15:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:12 INFO - 'talos_options': ['--e10s'], 09:15:12 INFO - 'tests': ['tp5o']}, 09:15:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:12 INFO - 'talos_options': ['--xperf_path', 09:15:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:15:12 INFO - 'tests': ['tp5n']}, 09:15:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:12 INFO - 'talos_options': ['--e10s', 09:15:12 INFO - '--xperf_path', 09:15:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 09:15:12 INFO - 'C:/slave/talos-data/talos/xperf.config'], 09:15:12 INFO - 'tests': ['tp5n']}}, 09:15:12 INFO - 'talos.zip': {'path': '', 09:15:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:15:12 INFO - Running post-action listener: _resource_record_post_action 09:15:12 INFO - ##### 09:15:12 INFO - ##### Running create-virtualenv step. 09:15:12 INFO - ##### 09:15:12 INFO - Running pre-action listener: _resource_record_pre_action 09:15:12 INFO - Running main action method: create_virtualenv 09:15:12 INFO - Creating virtualenv /builds/slave/test/build/venv 09:15:12 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 09:15:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:15:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:15:12 INFO - Using real prefix '/tools/python27' 09:15:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:15:13 INFO - Installing distribute.............................................................................................................................................................................................done. 09:15:17 INFO - Installing pip.................done. 09:15:17 INFO - Return code: 0 09:15:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:15:17 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')]} 09:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:17 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')]} 09:15:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:17 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 0x100bdea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c4b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4c9d03ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b939f0>, '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 0x1008f2cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b5d990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VlItKxa9pK/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.w3lwqQKaCy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:15:17 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 09:15:17 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 09:15:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VlItKxa9pK/Render', 09:15:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:15:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:15:17 INFO - 'HOME': '/Users/cltbld', 09:15:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:15:17 INFO - 'LOGNAME': 'cltbld', 09:15:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:17 INFO - 'MOZ_NO_REMOTE': '1', 09:15:17 INFO - 'NO_EM_RESTART': '1', 09:15:17 INFO - 'PAGER': '/bin/cat', 09:15:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:15:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:17 INFO - 'PWD': '/builds/slave/test', 09:15:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:15:17 INFO - 'SHELL': '/bin/bash', 09:15:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w3lwqQKaCy/Listeners', 09:15:17 INFO - 'TMPDIR': '/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/', 09:15:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:15:17 INFO - 'USER': 'cltbld', 09:15:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:15:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:15:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:17 INFO - 'XPC_FLAGS': '0x0', 09:15:17 INFO - 'XPC_SERVICE_NAME': '0', 09:15:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:15:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:18 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 09:15:18 INFO - Cleaning up... 09:15:18 INFO - Return code: 0 09:15:18 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:15:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:15:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:15:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100bdea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c4b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4c9d03ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b939f0>, '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 0x1008f2cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b5d990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VlItKxa9pK/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.w3lwqQKaCy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:15:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 09:15:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:15:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VlItKxa9pK/Render', 09:15:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:15:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:15:18 INFO - 'HOME': '/Users/cltbld', 09:15:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:15:18 INFO - 'LOGNAME': 'cltbld', 09:15:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:18 INFO - 'MOZ_NO_REMOTE': '1', 09:15:18 INFO - 'NO_EM_RESTART': '1', 09:15:18 INFO - 'PAGER': '/bin/cat', 09:15:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:15:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:18 INFO - 'PWD': '/builds/slave/test', 09:15:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:15:18 INFO - 'SHELL': '/bin/bash', 09:15:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w3lwqQKaCy/Listeners', 09:15:18 INFO - 'TMPDIR': '/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/', 09:15:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:15:18 INFO - 'USER': 'cltbld', 09:15:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:15:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:15:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:18 INFO - 'XPC_FLAGS': '0x0', 09:15:18 INFO - 'XPC_SERVICE_NAME': '0', 09:15:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:15:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:18 INFO - Downloading/unpacking psutil>=0.7.1 09:15:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:21 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 09:15:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:15:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:15:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:15:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:15:21 INFO - Installing collected packages: psutil 09:15:21 INFO - Running setup.py install for psutil 09:15:21 INFO - building 'psutil._psutil_osx' extension 09:15:21 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 09:15:23 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 09:15:23 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 09:15:24 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 09:15:24 INFO - building 'psutil._psutil_posix' extension 09:15:24 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 09:15:24 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:15:24 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:15:24 INFO - ^ 09:15:24 INFO - 1 warning generated. 09:15:24 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 09:15:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:15:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:15:24 INFO - Successfully installed psutil 09:15:24 INFO - Cleaning up... 09:15:24 INFO - Return code: 0 09:15:24 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:15:24 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')]} 09:15:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:24 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')]} 09:15:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:24 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 0x100bdea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c4b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4c9d03ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b939f0>, '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 0x1008f2cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b5d990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VlItKxa9pK/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.w3lwqQKaCy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:15:24 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 09:15:24 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 09:15:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VlItKxa9pK/Render', 09:15:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:15:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:15:24 INFO - 'HOME': '/Users/cltbld', 09:15:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:15:24 INFO - 'LOGNAME': 'cltbld', 09:15:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:24 INFO - 'MOZ_NO_REMOTE': '1', 09:15:24 INFO - 'NO_EM_RESTART': '1', 09:15:24 INFO - 'PAGER': '/bin/cat', 09:15:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:15:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:24 INFO - 'PWD': '/builds/slave/test', 09:15:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:15:24 INFO - 'SHELL': '/bin/bash', 09:15:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w3lwqQKaCy/Listeners', 09:15:24 INFO - 'TMPDIR': '/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/', 09:15:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:15:24 INFO - 'USER': 'cltbld', 09:15:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:15:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:15:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:24 INFO - 'XPC_FLAGS': '0x0', 09:15:24 INFO - 'XPC_SERVICE_NAME': '0', 09:15:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:15:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:25 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:15:25 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 09:15:25 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 09:15:25 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 09:15:25 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 09:15:25 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 09:15:25 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 09:15:27 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:15:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:15:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:15:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:15:27 INFO - Installing collected packages: mozsystemmonitor 09:15:27 INFO - Running setup.py install for mozsystemmonitor 09:15:27 INFO - Successfully installed mozsystemmonitor 09:15:27 INFO - Cleaning up... 09:15:27 INFO - Return code: 0 09:15:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:15: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')]} 09:15:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15: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')]} 09:15:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:27 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 0x100bdea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c4b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4c9d03ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b939f0>, '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 0x1008f2cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b5d990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VlItKxa9pK/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.w3lwqQKaCy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:15:27 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 09:15:27 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 09:15:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VlItKxa9pK/Render', 09:15:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:15:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:15:27 INFO - 'HOME': '/Users/cltbld', 09:15:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:15:27 INFO - 'LOGNAME': 'cltbld', 09:15:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:27 INFO - 'MOZ_NO_REMOTE': '1', 09:15:27 INFO - 'NO_EM_RESTART': '1', 09:15:27 INFO - 'PAGER': '/bin/cat', 09:15:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:15:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:27 INFO - 'PWD': '/builds/slave/test', 09:15:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:15:27 INFO - 'SHELL': '/bin/bash', 09:15:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w3lwqQKaCy/Listeners', 09:15:27 INFO - 'TMPDIR': '/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/', 09:15:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:15:27 INFO - 'USER': 'cltbld', 09:15:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:15:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:15:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:27 INFO - 'XPC_FLAGS': '0x0', 09:15:27 INFO - 'XPC_SERVICE_NAME': '0', 09:15:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:15:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:28 INFO - Downloading/unpacking blobuploader==1.2.4 09:15:28 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 09:15:28 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 09:15:28 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 09:15:28 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 09:15:28 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 09:15:28 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 09:15:30 INFO - Downloading blobuploader-1.2.4.tar.gz 09:15:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:15:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:15:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:15:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:15:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:15:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:15:31 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 09:15:31 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 09:15:31 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 09:15:31 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 09:15:31 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 09:15:31 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 09:15:31 INFO - Downloading docopt-0.6.1.tar.gz 09:15:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:15:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:15:32 INFO - Installing collected packages: blobuploader, requests, docopt 09:15:32 INFO - Running setup.py install for blobuploader 09:15:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:15:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:15:32 INFO - Running setup.py install for requests 09:15:32 INFO - Running setup.py install for docopt 09:15:32 INFO - Successfully installed blobuploader requests docopt 09:15:32 INFO - Cleaning up... 09:15:33 INFO - Return code: 0 09:15:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:15:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:15:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:15:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:33 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 0x100bdea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c4b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4c9d03ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b939f0>, '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 0x1008f2cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b5d990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VlItKxa9pK/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.w3lwqQKaCy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:15:33 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 09:15:33 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 09:15:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VlItKxa9pK/Render', 09:15:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:15:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:15:33 INFO - 'HOME': '/Users/cltbld', 09:15:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:15:33 INFO - 'LOGNAME': 'cltbld', 09:15:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:33 INFO - 'MOZ_NO_REMOTE': '1', 09:15:33 INFO - 'NO_EM_RESTART': '1', 09:15:33 INFO - 'PAGER': '/bin/cat', 09:15:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:15:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:33 INFO - 'PWD': '/builds/slave/test', 09:15:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:15:33 INFO - 'SHELL': '/bin/bash', 09:15:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w3lwqQKaCy/Listeners', 09:15:33 INFO - 'TMPDIR': '/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/', 09:15:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:15:33 INFO - 'USER': 'cltbld', 09:15:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:15:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:15:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:33 INFO - 'XPC_FLAGS': '0x0', 09:15:33 INFO - 'XPC_SERVICE_NAME': '0', 09:15:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:15:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:15:33 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-qWsjhr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:15:33 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-8qAuFX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:15:33 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-5dBRvZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:15:33 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-6UGycU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:15:33 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-KIdSch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:15:34 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-7CTEvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:15:34 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-wvW_7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:15:34 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-xZST_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:15:34 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-0hJgeY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:15:34 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-NID9E8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:15:34 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-xNeFwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:15:34 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-8Di15j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:15:34 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-FNOplJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:15:35 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-bmsUd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:15:35 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-3L3zl2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:15:35 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-WPSkkR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:15:35 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-wCjdNn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:15:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:15:35 INFO - Running setup.py install for manifestparser 09:15:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:15:35 INFO - Running setup.py install for mozcrash 09:15:35 INFO - Running setup.py install for mozdebug 09:15:36 INFO - Running setup.py install for mozdevice 09:15:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:15:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:15:36 INFO - Running setup.py install for mozfile 09:15:36 INFO - Running setup.py install for mozhttpd 09:15:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:15:36 INFO - Running setup.py install for mozinfo 09:15:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:15:36 INFO - Running setup.py install for mozInstall 09:15:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:15:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:15:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:15:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:15:36 INFO - Running setup.py install for mozleak 09:15:37 INFO - Running setup.py install for mozlog 09:15:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:15:37 INFO - Running setup.py install for moznetwork 09:15:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:15:37 INFO - Running setup.py install for mozprocess 09:15:37 INFO - Running setup.py install for mozprofile 09:15:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:15:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:15:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:15:37 INFO - Running setup.py install for mozrunner 09:15:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:15:38 INFO - Running setup.py install for mozscreenshot 09:15:38 INFO - Running setup.py install for moztest 09:15:38 INFO - Running setup.py install for mozversion 09:15:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:15:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:15:38 INFO - Cleaning up... 09:15:38 INFO - Return code: 0 09:15:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:15:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:15:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:15:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:38 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 0x100bdea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c4b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4c9d03ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b939f0>, '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 0x1008f2cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b5d990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VlItKxa9pK/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.w3lwqQKaCy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:15:38 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 09:15:38 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 09:15:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VlItKxa9pK/Render', 09:15:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:15:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:15:38 INFO - 'HOME': '/Users/cltbld', 09:15:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:15:38 INFO - 'LOGNAME': 'cltbld', 09:15:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:38 INFO - 'MOZ_NO_REMOTE': '1', 09:15:38 INFO - 'NO_EM_RESTART': '1', 09:15:38 INFO - 'PAGER': '/bin/cat', 09:15:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:15:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:38 INFO - 'PWD': '/builds/slave/test', 09:15:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:15:38 INFO - 'SHELL': '/bin/bash', 09:15:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w3lwqQKaCy/Listeners', 09:15:38 INFO - 'TMPDIR': '/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/', 09:15:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:15:38 INFO - 'USER': 'cltbld', 09:15:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:15:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:15:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:38 INFO - 'XPC_FLAGS': '0x0', 09:15:38 INFO - 'XPC_SERVICE_NAME': '0', 09:15:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:15:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:15:38 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-ix8pYm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:15:39 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)) 09:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:15:39 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-U2jCKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:15:39 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)) 09:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:15:39 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-w4sZEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:15:39 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)) 09:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:15:39 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-d2GuiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:15:39 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)) 09:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:15:39 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-MGqWIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:15:39 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)) 09:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:15:39 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-YRnNmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:15:39 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)) 09:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:15:39 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-gpbQRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:15:39 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)) 09:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:15:39 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-9bswmx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:15:39 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)) 09:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:15:39 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-9ZEwOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:15:40 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)) 09:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:15:40 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-L5QTaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:15:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:15:40 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-S3Q0QS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:15:40 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)) 09:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:15:40 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-aIzZes-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:15:40 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)) 09:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:15:40 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-OcpkrN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:15:40 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)) 09:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:15:40 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-RANozB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:15:40 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)) 09:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:15:40 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-Ss4tMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:15:40 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)) 09:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:15:40 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-PotTDR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:15:41 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)) 09:15:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:15:41 INFO - Running setup.py (path:/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/pip-QOYT55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:15:41 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)) 09:15:41 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)) 09:15:41 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)) 09:15:41 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)) 09:15:41 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)) 09:15:41 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)) 09:15:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:43 INFO - Downloading blessings-1.5.1.tar.gz 09:15:43 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 09:15:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:15:43 INFO - Installing collected packages: blessings 09:15:43 INFO - Running setup.py install for blessings 09:15:43 INFO - Successfully installed blessings 09:15:43 INFO - Cleaning up... 09:15:44 INFO - Return code: 0 09:15:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:15:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:15:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:15:44 INFO - Reading from file tmpfile_stdout 09:15:44 INFO - Current package versions: 09:15:44 INFO - blessings == 1.5.1 09:15:44 INFO - blobuploader == 1.2.4 09:15:44 INFO - docopt == 0.6.1 09:15:44 INFO - manifestparser == 1.1 09:15:44 INFO - mozInstall == 1.12 09:15:44 INFO - mozcrash == 0.16 09:15:44 INFO - mozdebug == 0.1 09:15:44 INFO - mozdevice == 0.47 09:15:44 INFO - mozfile == 1.2 09:15:44 INFO - mozhttpd == 0.7 09:15:44 INFO - mozinfo == 0.9 09:15:44 INFO - mozleak == 0.1 09:15:44 INFO - mozlog == 3.0 09:15:44 INFO - moznetwork == 0.27 09:15:44 INFO - mozprocess == 0.22 09:15:44 INFO - mozprofile == 0.27 09:15:44 INFO - mozrunner == 6.11 09:15:44 INFO - mozscreenshot == 0.1 09:15:44 INFO - mozsystemmonitor == 0.0 09:15:44 INFO - moztest == 0.7 09:15:44 INFO - mozversion == 1.4 09:15:44 INFO - psutil == 3.1.1 09:15:44 INFO - requests == 1.2.3 09:15:44 INFO - wsgiref == 0.1.2 09:15:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:15:44 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')]} 09:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:44 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')]} 09:15:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:44 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 0x100bdea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c4b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4c9d03ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b939f0>, '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 0x1008f2cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b5d990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VlItKxa9pK/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.w3lwqQKaCy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:15:44 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 09:15:44 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 09:15:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VlItKxa9pK/Render', 09:15:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:15:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:15:44 INFO - 'HOME': '/Users/cltbld', 09:15:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:15:44 INFO - 'LOGNAME': 'cltbld', 09:15:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:44 INFO - 'MOZ_NO_REMOTE': '1', 09:15:44 INFO - 'NO_EM_RESTART': '1', 09:15:44 INFO - 'PAGER': '/bin/cat', 09:15:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:15:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:44 INFO - 'PWD': '/builds/slave/test', 09:15:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:15:44 INFO - 'SHELL': '/bin/bash', 09:15:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w3lwqQKaCy/Listeners', 09:15:44 INFO - 'TMPDIR': '/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/', 09:15:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:15:44 INFO - 'USER': 'cltbld', 09:15:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:15:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:15:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:44 INFO - 'XPC_FLAGS': '0x0', 09:15:44 INFO - 'XPC_SERVICE_NAME': '0', 09:15:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:15:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:44 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)) 09:15:44 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)) 09:15:44 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)) 09:15:44 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)) 09:15:44 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)) 09:15:44 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)) 09:15:44 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)) 09:15:44 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)) 09:15:44 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)) 09:15:44 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)) 09:15:44 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)) 09:15:44 INFO - Cleaning up... 09:15:44 INFO - Return code: 0 09:15:44 INFO - Running post-action listener: _resource_record_post_action 09:15:44 INFO - Running post-action listener: _start_resource_monitoring 09:15:44 INFO - Starting resource monitoring. 09:15:44 INFO - ##### 09:15:44 INFO - ##### Running install step. 09:15:44 INFO - ##### 09:15:44 INFO - Running pre-action listener: _resource_record_pre_action 09:15:44 INFO - Running main action method: install 09:15:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:15:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:15:45 INFO - Reading from file tmpfile_stdout 09:15:45 INFO - Detecting whether we're running mozinstall >=1.0... 09:15:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:15:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:15:45 INFO - Reading from file tmpfile_stdout 09:15:45 INFO - Output received: 09:15:45 INFO - Usage: mozinstall [options] installer 09:15:45 INFO - Options: 09:15:45 INFO - -h, --help show this help message and exit 09:15:45 INFO - -d DEST, --destination=DEST 09:15:45 INFO - Directory to install application into. [default: 09:15:45 INFO - "/builds/slave/test"] 09:15:45 INFO - --app=APP Application being installed. [default: firefox] 09:15:45 INFO - mkdir: /builds/slave/test/build/application 09:15:45 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'] 09:15:45 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 09:16:23 INFO - Reading from file tmpfile_stdout 09:16:23 INFO - Output received: 09:16:23 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:16:23 INFO - Running post-action listener: _resource_record_post_action 09:16:23 INFO - ##### 09:16:23 INFO - ##### Running run-tests step. 09:16:23 INFO - ##### 09:16:23 INFO - Running pre-action listener: _resource_record_pre_action 09:16:23 INFO - Running main action method: run_tests 09:16:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:16:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:16:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:16:23 INFO - 2015-11-02 09:16:23.842 screenresolution[1626:7503] starting screenresolution argv=screenresolution get 09:16:23 INFO - 2015-11-02 09:16:23.845 screenresolution[1626:7503] Display 0: 1600x1200x32@60 09:16:23 INFO - 2015-11-02 09:16:23.852 screenresolution[1627:7505] starting screenresolution argv=screenresolution list 09:16:23 INFO - Available Modes on Display 0 09:16:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:16:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:16:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:16:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:16:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:16:24 INFO - Intel HD Graphics 3000: 09:16:24 INFO - Chipset Model: Intel HD Graphics 3000 09:16:24 INFO - Type: GPU 09:16:24 INFO - Bus: Built-In 09:16:24 INFO - VRAM (Total): 512 MB 09:16:24 INFO - VRAM (Dynamic, Max): 10 09:16:24 INFO - Vendor: Intel (0x8086) 09:16:24 INFO - Device ID: 0x0116 09:16:24 INFO - Revision ID: 0x0009 09:16:24 INFO - Displays: 09:16:24 INFO - Display: 09:16:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:16:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:16:24 INFO - Display Serial Number: 1600x1200 60 09:16:24 INFO - Main Display: Yes 09:16:24 INFO - Mirror: Off 09:16:24 INFO - Online: Yes 09:16:24 INFO - Rotation: Supported 09:16:24 INFO - Return code: 0 09:16:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:16:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:16:24 INFO - Python 2.7.3 09:16:24 INFO - Return code: 0 09:16:24 INFO - grabbing minidump binary from tooltool 09:16:24 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')]} 09:16:24 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 0x100b939f0>, '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 0x1008f2cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b5d990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:16:24 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 09:16:24 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 09:16:24 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:16:24 INFO - Return code: 0 09:16:24 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:16:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:16:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:16:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:16:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:16:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QCbBN9c2TzSw7hibfAvTug/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0008', '--webServer', 'localhost'] in /builds/slave/test/build 09:16:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QCbBN9c2TzSw7hibfAvTug/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0008 --webServer localhost 09:16:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VlItKxa9pK/Render', 09:16:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:16:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:16:24 INFO - 'HOME': '/Users/cltbld', 09:16:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:16:24 INFO - 'LOGNAME': 'cltbld', 09:16:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:16:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:16:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:24 INFO - 'MOZ_NO_REMOTE': '1', 09:16:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:16:24 INFO - 'NO_EM_RESTART': '1', 09:16:24 INFO - 'PAGER': '/bin/cat', 09:16:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:16:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:24 INFO - 'PWD': '/builds/slave/test', 09:16:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:16:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:16:24 INFO - 'SHELL': '/bin/bash', 09:16:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w3lwqQKaCy/Listeners', 09:16:24 INFO - 'TMPDIR': '/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/', 09:16:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:16:24 INFO - 'USER': 'cltbld', 09:16:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:16:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:16:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:24 INFO - 'XPC_FLAGS': '0x0', 09:16:24 INFO - 'XPC_SERVICE_NAME': '0', 09:16:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:16:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QCbBN9c2TzSw7hibfAvTug/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0008', '--webServer', 'localhost'] with output_timeout 3600 09:16:24 INFO - mozversion INFO | application_buildid: 20151102071406 09:16:24 INFO - mozversion INFO | application_changeset: 74156ecb4a205ae76ff8b8ab82e0c1a6060dd9c8 09:16:24 INFO - mozversion INFO | application_display_name: Nightly 09:16:24 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:16:24 INFO - mozversion INFO | application_name: Firefox 09:16:24 INFO - mozversion INFO | application_remotingname: firefox 09:16:24 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 09:16:24 INFO - mozversion INFO | application_vendor: Mozilla 09:16:24 INFO - mozversion INFO | application_version: 45.0a1 09:16:24 INFO - mozversion INFO | platform_buildid: 20151102071406 09:16:24 INFO - mozversion INFO | platform_changeset: 74156ecb4a205ae76ff8b8ab82e0c1a6060dd9c8 09:16:24 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 09:16:24 INFO - mozversion INFO | platform_version: 45.0a1 09:16:24 INFO - 2015-11-02 09:16:24,574 DEBUG : using testdate: 1446484584 09:16:24 INFO - 2015-11-02 09:16:24,574 DEBUG : actual date: 1446484584 09:16:24 INFO - 2015-11-02 09:16:24,584 INFO : starting webserver on 'localhost:49269' 09:16:24 INFO - 2015-11-02 09:16:24,585 INFO : Starting test suite t-yosemite-r5-0008 09:16:24 INFO - 2015-11-02 09:16:24,585 INFO : Starting test dromaeo_css 09:16:24 INFO - 2015-11-02 09:16:24,585 DEBUG : operating with platform_type : mac_ 09:16:24 INFO - 2015-11-02 09:16:24,586 INFO : Initialising browser for dromaeo_css test... 09:16:24 INFO - 2015-11-02 09:16:24,608 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/tmpwejXLf/profile http://localhost:49269/getInfo.html 09:16:27 INFO - 2015-11-02 09:16:27,493 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:16:27 INFO - 2015-11-02 09:16:27,494 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:16:27 INFO - 2015-11-02 09:16:27,494 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 09:16:27 INFO - 2015-11-02 09:16:27,494 DEBUG : BROWSER_OUTPUT: __metrics 09:16:27 INFO - 2015-11-02 09:16:27,510 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:16:28 INFO - 2015-11-02 09:16:28,256 INFO : Browser initialized. 09:16:28 INFO - 2015-11-02 09:16:28,256 INFO : Running cycle 1/1 for dromaeo_css test... 09:16:28 INFO - 2015-11-02 09:16:28,257 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/tmpwejXLf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:16:40 INFO - 2015-11-02 09:16:40,234 DEBUG : BROWSER_OUTPUT: RSS: Main: 221458432 09:16:40 INFO - 2015-11-02 09:16:40,234 DEBUG : BROWSER_OUTPUT: 09:17:32 INFO - 2015-11-02 09:17:32,145 DEBUG : BROWSER_OUTPUT: 1446484652141 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] 09:19:42 INFO - 2015-11-02 09:19:42,096 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49269/tests/dromaeo/cssquery-ext.html) 09:19:43 INFO - 2015-11-02 09:19:43,411 DEBUG : BROWSER_OUTPUT: RSS: Main: 311869440 09:19:43 INFO - 2015-11-02 09:19:43,411 DEBUG : BROWSER_OUTPUT: 09:22:46 INFO - 2015-11-02 09:22:46,095 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-ext.html (next: http://localhost:49269/tests/dromaeo/cssquery-jquery.html) 09:22:46 INFO - 2015-11-02 09:22:46,668 DEBUG : BROWSER_OUTPUT: RSS: Main: 351256576 09:22:46 INFO - 2015-11-02 09:22:46,669 DEBUG : BROWSER_OUTPUT: 09:25:48 INFO - 2015-11-02 09:25:48,894 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49269/tests/dromaeo/cssquery-mootools.html) 09:25:49 INFO - 2015-11-02 09:25:49,483 DEBUG : BROWSER_OUTPUT: RSS: Main: 324145152 09:25:49 INFO - 2015-11-02 09:25:49,483 DEBUG : BROWSER_OUTPUT: 09:28:51 INFO - 2015-11-02 09:28:51,593 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49269/tests/dromaeo/cssquery-prototype.html) 09:28:52 INFO - 2015-11-02 09:28:52,181 DEBUG : BROWSER_OUTPUT: RSS: Main: 312893440 09:28:52 INFO - 2015-11-02 09:28:52,181 DEBUG : BROWSER_OUTPUT: 09:31:55 INFO - 2015-11-02 09:31:55,246 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49269/tests/dromaeo/cssquery-yui.html) 09:31:55 INFO - 2015-11-02 09:31:55,861 DEBUG : BROWSER_OUTPUT: RSS: Main: 314945536 09:31:55 INFO - 2015-11-02 09:31:55,861 DEBUG : BROWSER_OUTPUT: 09:34:58 INFO - 2015-11-02 09:34:58,596 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-yui.html (next: http://localhost:49269/tests/dromaeo/cssquery-dojo.html) 09:34:58 INFO - 2015-11-02 09:34:58,859 DEBUG : BROWSER_OUTPUT: RSS: Main: 389042176 09:34:58 INFO - 2015-11-02 09:34:58,859 DEBUG : BROWSER_OUTPUT: 09:34:58 INFO - 2015-11-02 09:34:58,859 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:34:58 INFO - 2015-11-02 09:34:58,859 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:34:58 INFO - 2015-11-02 09:34:58,860 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:34:58 INFO - 2015-11-02 09:34:58,860 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:34:58 INFO - 2015-11-02 09:34:58,863 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2954.497735384983;2972.2272209225594;2980.8211507309547;3002.384511175208;3099.922501937452;4787.090452813972;4894.902101957963;4916.360873086503;4931.901361972763;4949.739278704127;4827.468978412372;4877.3903262092235;4914.459409464965;4932.482089380617;4985.40175178979;4525.0949810037955;4535.206338890697;4536.070105628338;4577.427821522309;4578.038611891507;4586.954130458686;4603.516630753773;4627.490975992638;4629.7222166669935;4632.420947381577;4433.202023635744;4515.729056256635;4520.977395113036;4527.185106680796;4556.9088618227615;4378.5183629800695;4484.7084939479155;4491.079328737601;4510.233260345716;4518.909621807578;4533.659975501851;4533.84131555394;4561.087782443525;4607.124646317223;4657.836975705834;4766.833160839354;4932.087563800673;4933.309336692866;4944.9258261126115;4946.777395017233;5150.304708864331;5210.296609957645;5220.373555173365;5264.763085661154;5380.757865896044;5281.683099014072;5284.894302113936;5308.9469105308835;5327.067763141435;5329.360476742777;4751.192297309466;4987.077390682699;5003.974980125076;5019.47295533971;5026.12042892496;5270.762815673227;5338.466153384708;5353.544948679328;5499.285092937893;5518.19986102021;5158.716270605078;5160.7419629018395;5193.324867767242;5200.427952925175;5215.19164529491;5177.482251774868;5301.496357845998;5339;5341.145416733304;5390.595705322116;5080.491950804964;5136.845894623168;5172.922406163911;5198.6880787152895;5242.633015688942;5234.18870075139;5256.421793602701;5262.210668399771;5271.578273738091;5334.199870019451;4004.3993400990084;4111.280525908014;4115.176964607091;4120.25835349634;4138.751674899516;3665.395209790408;3739.682127019234;3775.301569209705;3777.8111094445167;3792.60177681345;4917.336159618406;4982.277569752366;4988.900221995613;5001.174806156943;5024.949750502448;5173.896522069613;5333.439988801198;5345.251664766935;5352.223927530564;5420.457954204548;4814.975925120352;4818.084563932912;4832.95167048325;4897.4857639948;4966.428860680996;4658.394408726844;4667.486576476585;4679.883002924886;4683.15703173432;4730.526947305242;5220.608454366014;5354.571634269249;5380.3274590676165;5390.326209223847;5427.538659214011;5263.526282634582;5287.418383977836;5295.470452954673;5297.073012222922;5313.229581710553;5239.109351410346;5305.045091883498;5316;5354.250404943389;5372.006178856924;5247.449017853223;5264.684118952875;5277.8416647500635;5278.5249327560705;5315.202719592092;5222.608304377263;5322.201669749568;5324.733763311897;5328.147496400712;5350.598705097055;5004.874878128076;5101.438841727481;5136.563392111712;5150.304708864255;5178.0679477694375;5202.583793296603;5214.061468935476;5235.633505654568;5239.921401179062;5247.475252474722;4977.303177555217;5083.618728595444;5148.6910785353;5149.433562308218;5162.174052151638;4973.179425394769;5009.874753131201;5093.312402825719;5114.207297868837;5148.871278218075;5076.543111120017;5086.821961231339;5101.183810590288;5117.795288188431;5123.38519377677 09:34:58 INFO - 2015-11-02 09:34:58,865 DEBUG : BROWSER_OUTPUT: |1;ext.html;518.3857129301778;518.5229588778326;522.3001178420915;528.5533724003218;543.5868739757783;27468.17595472134;29178;29315;35631;36359;38712.419313710314;39103.60896391035;39105.80447097767;39156.80421597888;39494.80252598733;8438.535880526584;8625.396222264444;8637.611307491177;8652.091530389313;8664.176903194186;7638.847223055535;7840.255175758322;10161.796764064715;10383.325083869524;10394.896051039506;10120.544575494083;10249.84625230622;10261.076503114718;10268.178545716324;10339.172866170687;7625.6568454419685;7813.296803287732;10001.399916005026;10109.241806864478;10125.240606954434;10086.596536138546;10315.587376504931;10365.170786337076;10365.429901355423;10444.63443779464;36240.81879590585;36473.08817279563;36542.45186322207;36572.63427365719;36725.26549468996;2811.339335256213;2949.7050294970545;2991.760659147263;3192.9042128736173;3285.802851828874;25284.786701839763;25507.872460637576;25697.614535781977;26233.081842135434;26798.33004174892;2129.7337832770904;2195.2536137713096;2223.1663126327626;2273.886305684726;2360.634101714237;261944;263695;264324;265149;266392;45045.774771125936;46844.297335539995;53369;57680.423195768344;58963.705181473815;54387.72806135944;54642;54692.72653636707;54696;54829.45170548323;15292.158931258888;15443.227838608025;15445.459408920633;15455.690886182214;15542.766858497132;11803.819618038127;11846.466908989116;11861.169718119821;11939.343336116597;12006.759864802654;17366.305347785947;17536.912315438596;17563;17593.208305626278;17600.64798704019;7304.085201080926;7552.471327007167;7569.5079819811535;7574.242575742382;7599.924000760032;873.1617647058895;912.808310254854;916.935814492979;998.4109375468363;1015.8476228565775;26134.58373812862;26279;26593.867030664722;26653;26833.731662683513;947.3699989507038;954.8519979403064;962.8459446488528;971.4608392342177;1029.2383636109225;12167.026637869127;12178.330191839534;12209.93895030537;12277.263364197997;12325.876741232652;310843;314301;317970;319983;320284;47697;48018.5198148014;48117.75941120272;48128.75935620369;48579.757101214265;1253.5048655780915;1262.9179103358251;1268.6828292926768;1269.8666640002853;1274.0444666500125;23877.28368148958;24506;24668.87665561661;24706.50586988214;24717.629235561122;38760.418593720555;39585.406218907316;42511;43227.78386108049;45512;191236;192243;192579;194087;194772;27324;27351.86324068367;27367.863160684068;27417.31456713598;27647.723522764514;30513.694863051085;30786;32681.836590817846;36352;37611.43582846205;29004;29623.407531849673;29637.85181074081;29751.25621859471;29922.25194370158;28953.85523072371;28978;29085.272868178465;29220.123396298146;29228.43480778223;29719.702802971693;29906.551401729426;29920.700792992662;30203;32122.678773212905;29321.41357172802;29580.704192957794;31037.8448107758;31042.53436198504;31143.22141946379;21790.891045545304;21811.781882180974;22392.529157980538;22430.551388972457;22452 09:34:58 INFO - 2015-11-02 09:34:58,866 DEBUG : BROWSER_OUTPUT: |2;jquery.html;310.1177151005389;313.33260155868;314.2708915316466;315.1538120147404;319.1351437604093;13081.476740930351;13602.387892544835;15844.524664260076;16090.678186436278;16550.91724541377;13346.26595537245;15773.526794196163;16933.06868122253;17358.913205433986;17377;4334.696571240014;4456.064226512436;4461.7992190351515;4496.527864574222;4824.252240902666;3108.347247078116;3203.0230779612207;3203.2312245061134;4440.067585806984;4455.443069616298;4302.290122129845;4393.824247030115;4413.3821265022925;4425.336199570058;4442.689011769177;4268.658507319438;4409.779511024436;4450.310201918708;4450.421445212101;4452.487963884146;3738.6822120119823;3739.813009349549;3745.382011968022;3755.023693839594;3765.7363984521094;11714.297142171412;11743;11956.282623042558;12538.435770390355;12570.937145314307;1652.6859896619724;1676.9329226830912;1776.786785585725;1781.2429717370067;1882.8964406957612;8473.279771219391;8485;8741.868871966926;8795;8806.251468625174;1316.861729518406;1369.9863001369959;1370.294298436306;1399.1465206224195;1405.6696676281065;55468.72265638646;55503.44496555023;56107.158392624144;56318.718406408116;56627.999999999585;5993.250843644544;6049.637021778707;6065.211522502134;6084.056971169476;6117.877642447126;6954.617496037767;6963.79108626742;6967.930320696728;6969.54697944632;6980.476464265201;5116.437191908887;5122.513361230677;5143.897122057538;5147.099257629975;5161.81933632321;5502.8349149525575;5514.310711161105;5549.38956714761;5569.665820050729;5571.442855714477;2683.490136873988;2693.7171596982425;2708.2687674328217;2727.7681397081074;2736.138116493298;947.5167664491021;947.5830634520789;962.9037096290315;967.4437198610827;1015.57345914716;381.17475665185117;396.4212250114807;404.5812583975571;418.11777150213027;429.57257528759084;10514.239170383364;10883.714419971895;10974.561017559208;11036;11056.226064175431;371.85869369639363;402.8589993502251;412.91948070126637;417.74726290593753;421.7996451685425;5589.608727389043;5738.426157384311;5810.360860305363;6008.519318454513;6020.277566692025;508183;509576;516007;528254;528380;61872.690636546526;66111.33888661148;66478.99999999904;66831;67002;441.2939297124639;454.34120525238535;455.23520485583873;455.28065656263027;456.7510706664809;9952.850707239542;10054.949725251327;10119.544620491948;10206.744831378977;10230.23273254494;31280.061598152093;31646.525302120946;31742.36515269728;31960.52059219067;32000.5199922006;42333.78833105938;42867.57132428636;42870.785646072814;42940.78529607332;43257.3511397323;5663;5730.971345143247;5754.971225143848;5771.94228057714;5803.506701930383;10585.4707264638;10726.731831703957;10942.617008404668;11014.00873921351;11019.338839669645;9128.634854605742;9261.259099272176;9303.209227215762;9385;9485.525723713648;9111.134442227978;9126.17864392208;9134.588943497425;9157.31320150978;9186.494742789211;9012.459252444874;9188.127127923104;9262.72211833619;9517.191038761783;9525;5073.949260507347;5162.225666149958;5164.070467315919;5483.917741233805;5509.752061157177;8946.418482798597;9120.407173533698;9173.633054677739;9294.209992150743;9333.953330233306 09:34:58 INFO - 2015-11-02 09:34:58,870 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1088.5972190289594;1567.6472793621438;1645.7942757155356;1667.5247554446985;1670.3402156148325;6596.538242323039;6903.6203008834555;7172.497925145235;7274.418046556276;7290.416766658668;7100.112485939258;7166.247544007882;7188.245234250394;7207.747728829492;7210.8557828843395;2066.2458202755997;2074.7614024387162;2077.480629842539;2092.4036649554805;2095.130520833852;2053.9383818485394;2082.9895850520725;2083.593699228651;2090.602785470756;2092.424583239606;2044.815966563009;2076.709260703503;2088.1960445228547;2092.0376626751713;2092.780258072903;2007.0065317667702;2023.4435530229157;2023.4536675097715;2024.3623258673472;2027.817496425314;2012.4566367080806;2033.1054336092072;2037.6230397376532;2037.7554693436734;2048.3752455501067;6342.302346741901;7074.469414793911;7103.502754807166;7107.928920710779;7147.3210045045635;4060.695447841394;4342.50061242958;4439.4228750262255;4449.26587113126;4500.48244451889;2621.082621082625;2646.9867650661818;2660.840349579031;2708.9051883184193;2716.348076461635;796.3072127249272;805.0339592488978;1444.3139508733373;1481.4148411377553;1526.084349390368;9215.447073175565;9277.721668349961;9287.071292870727;9300;9306.86039709405;3851.1527463957887;3889.533256009297;3912.68698504119;3951.269015232191;3952.2490726761825;7873.881891771628;7874.21257874208;7882.014748156481;7889.802754931173;7925.603719813987;4437.733735975852;4448.132614140211;4459.1304695584695;4467.352233926063;4468.955310446919;4072.898177545585;4127.752334859858;4135.421041054255;4140.3168477200925;4140.420341152241;3099.9225019374694;3123.5783169272313;3124.7968882022597;3173.2701478660038;3184.681531846843;962.7544976031068;977.6529332087007;979.5445118020012;979.9559019844124;996.7508122969258;1181.1023622047305;1198.964031079069;1200.2918278215895;1215.380156120385;1221.6335099470123;6749;6852.45180385568;6885.758998435031;6893.276205998298;6894.551854129466;437.24793355428613;450.19639942702776;451.3230154767848;454.0895504513429;454.46373279530474;5023.346964894614;5426.484483974095;5454.945450545444;5463.951018368112;5483.369412517532;7733.574653394117;8221.054578723404;8386.496810191285;8424.368172387096;8443.155684431631;8263.462874913112;8323.708670196515;8387.748367548984;8399;8400.327973762085;6733.293004234582;6806.217285012287;6828.829279267959;6835.726570937206;6836.794896153124;6687.799366019027;6762.526623136333;6788.93211067883;6796.694148763218;6812.21659509143;7591.924080759121;7660.80847978805;7718.266764657348;7738.535687858522;7738.613069346397;7854.803629909298;7912.4856884302335;7917.366610671248;7927.722529711433;7937.523748575104;5902.1146827976145;5949.6430214187285;6343.11196432509;6346.809595712136;6369.87260254783;6818.249992500721;6855.314468553105;6864.656767161722;6869.519133660596;6882.208546017272;6312.3687631238345;6383.904241436289;6455.386738259858;6500.154979852589;6506.089147519446;6256.343083976299;6313.1477250572425;6318.715657795502;6378.840528986627;6409.9038514423255;6473.158489396348;6487.967560162169;6490.993895946136;6491.935080649133;6500.959846424549;5690.231818704588;5847.678377689268;5886.735096920564;5891.823245302648;5898.616589921641;5992.280926288873;6016.947034269073;6034.24571928509;6037.667928263988;6044.516438684983 09:34:58 INFO - 2015-11-02 09:34:58,870 DEBUG : BROWSER_OUTPUT: |4;prototype.html;294.5463985462388;301.1762828663606;304.4611038461922;305.13494243818775;309.30560890800155;5527.474889885464;5616.719164041791;5637.182608521767;5669.433056694328;5747.080467125261;5460.235567020621;5549.6115271930985;5560.555155587554;5642.57680673949;5687.7156142192935;4254.893627659302;4269.2955662315835;4275.187714334282;4292.205941900743;4307.806148723299;4206.369044643313;4215.241256573816;4287.635550978171;4289.335153051282;4324.135172965403;4246.2993606055115;4286.849960251392;4291.9570804292025;4293.914121717564;4333.285007973681;4248.745075295461;4279.309672679306;4302;4323.243432399333;4341.674374421931;3711.0536813112753;3721.162738383869;3739.326921154191;3742.4760533525327;3757.1358587525024;5290.867728306785;5463.043967305745;5473.945260547383;5478.698671573062;5510.6969116698565;4934.383202099738;4938.80244790208;4948.90102197954;4953.306537084811;4960.404751429815;5954.8809023819285;5961.046232602806;5975.940240597625;5977.820665380002;5990.430909063632;3930.8820735377985;3983.207556599542;3989.142334398089;3999.200159968018;4122.381642753581;6066.120412540157;6112.327643959161;6123.5407344448895;6133.6626485543275;6173.629582225081;4115.691323150776;4130.173965206971;4135.958640413617;4138.089620283533;4143.56492568282;4173.937390939138;4183.393407955829;4189.748615083105;4196.265653510623;4206.26390381682;4737.194676904935;4887.3890763654545;4891.779869905863;4895.559399653977;4912.582430493448;5939.554533410012;5969.2240008799445;5975.133605627159;5977.551683623746;6010.0083486224285;1521.4903007492615;1541.768734689783;1544.2664734251366;1549.651328451112;1564.092826160824;993.2004736187439;1007.0282177698556;1008.2387797213204;1025.610268098118;1033.6227277043824;5615.831525054255;5637.295338082739;5653.604247702704;5674.687892165971;5705.400932902068;6173;6181.258249010148;6185.443310102112;6196;6258;5625.128105143709;5633.57748168889;5642.943570564324;5650.29371328584;5680.403557626472;3309.7352211823477;3415.9146021349666;3434.244466217428;3435.124043368925;3441.3117376524297;6226.875462490815;6235.96882015587;6250.499960003189;6287.245530536365;6291.276503202191;6355.173827402408;6367.140436041168;6370.458511026614;6370.936290637127;6429.7749578764515;6040.909386359208;6197.225346831646;6214.067889816473;6261.655608941461;6266.467350275278;6176.104464852661;6186.5360097993735;6214.8135555933395;6221.191245138103;6243.282022567463;5876.706164691663;6000.429959153874;6016.759329626766;6069.666168360783;6126.479249263863;6172.753089876354;6214.067889816563;6280.528960328085;6299.401556852092;6299.590526615755;4197.790110494524;4200.15996800635;4205.642520385802;4207.053412982054;4257.680673949404;5980.312264089685;6119.694015299128;6134.601250918676;6148.569600128127;6200.689965501797;5994.6403215807195;6081.543884208791;6088.782243551396;6091.9086213707715;6101.420365065312;6048.183495228088;6054.152418661303;6056.424639659225;6091.817245482643;6124.142620033288;5726.226959360433;5915;5921.5558833086825;5941.1385349125;5946.226990491208;6053.424924632153;6066.939330606638;6074.483668888194;6085.939140608714;6088;5925.792597259076;5930.347661757117;5936.821895343147;5955.434233747787;5974.551908606785 09:34:58 INFO - 2015-11-02 09:34:58,873 DEBUG : BROWSER_OUTPUT: |5;yui.html;645.8869697802884;678.0947435174039;694.607546736094;707.4764674141134;710.7405796884136;12492.250464972109;12752.808707869377;12758.744825103504;12762.55331063413;12768.489260429571;11892.7621447571;11938.582149624764;11967.64097077089;12047.51809927604;12052.337121458317;640.1805688718424;657.8815813153631;658.4732214228621;804.3324041045947;810.8459392715365;819.8278361544053;822.9753107406757;836.4730219961447;838.0822998816286;838.1283465196219;857.5412154497345;866.1771317248607;873.3406278259905;875.1598465473154;876.8947726272856;665.0257372948629;684.8219462939621;844.1010324004915;851.3742399336483;862.3704695572204;637.9681015949184;640.3276559612389;642.9935700642981;644.230144976753;644.9613023218575;12132.332721700302;12290.111823721418;12311.076669249842;12321.630351089481;12323.383830808423;8028.759137225892;8402.747917562421;9199.080091990814;10400.947995259976;11319.094472442184;7968.681252749883;8146.185381461865;8167.877481837777;8197.590120494011;8237.093919668832;2655.3892604701027;2665.586834040727;2687.9803502099667;2779.4580056888913;2833.8016338856287;39831;39936;40029.39955900635;40096.39855402171;40216.19567608632;5649.604527683023;5804.129380592861;5887.8233652990475;5919;6017.518598512109;9892.950535247277;9910.752231194278;9914.157296629868;9936.602535898628;10012.998700130074;5498.945010549924;5683.6643388803595;5729.627574207747;5737.3115226172295;5890.9410905891245;3372.51248711644;3458.6368431314854;3507.263474670297;3562.1806984393734;3573.446115852047;2450.816188785848;2473.6042233242597;2481.044797752878;2481.243220817668;2488.390344365642;376.93780526213413;378.7935575111571;382.4053596657169;384.5231912428624;384.88261080370756;497.34847349971653;536.257283662123;547.8630342414397;550.0758725341465;577.4168090228899;7125.144982602121;7205.747798827016;7236.855262894713;7270.600116993616;7350.264973502607;463.6962789372966;524.1482590789966;524.1718085425019;526.4104203292337;536.7851324383554;3204.1669166017004;3794.3739283017994;3810.1427178885083;3854.9614503855164;3879.650831425185;51996.22005669918;52884.47115528795;55006;56081;56895.146572801445;47128.5287147131;47400;47457.28814067792;47566;47772.28341574879;43504.347434788506;43830.34254486185;43970.78014610035;44315.77842110769;44563.554364455944;7351.8162045949275;7567.772966811004;7613.428992825671;7648.61756912141;7653.846923061396;30047.69952300449;30930;31601.20996975094;32035.35929281448;33544.32911341808;40231.59768402279;40461.393079104426;40537.59462405338;40981.590184097775;42522.57477425186;6606.108175396452;6638.970959501285;6793.762218322335;6804.591724496546;7058.329458701415;9969.50152492387;10067.647632332833;10075.19398448137;10278.229132814919;10368.170546356123;9244.399114057565;9327.86008209891;9379.34344595899;9689.273304502332;10267.84598231042;9278.381282081977;9281.62873485053;9440.716778496657;9641.325107242426;10004.349717268355;9229.907700923173;9344.626214951597;9497.715068547956;9597.376170548892;10155.492225388849;7307;7575.242475752601;7576.7348142814735;7804.843903121792;8249.752507424786;7088.291170882871;7485.850282994418;7531.133919599316;7793.688252469838;8163.061247956561 09:34:58 INFO - 2015-11-02 09:34:58,874 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:34:58 INFO - 2015-11-02 09:34:58,874 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:34:58 INFO - 2015-11-02 09:34:58,874 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1037 09:34:58 INFO - 2015-11-02 09:34:58,874 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:34:58 INFO - 2015-11-02 09:34:58,874 DEBUG : BROWSER_OUTPUT: __startTimestamp1446485698858__endTimestamp 09:34:58 INFO - 2015-11-02 09:34:58,874 DEBUG : BROWSER_OUTPUT: 09:34:58 INFO - 2015-11-02 09:34:58,875 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:34:58 INFO - 2015-11-02 09:34:58,875 DEBUG : BROWSER_OUTPUT: Number of tests: 6 09:34:58 INFO - 2015-11-02 09:34:58,875 DEBUG : BROWSER_OUTPUT: 09:34:58 INFO - 2015-11-02 09:34:58,875 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4913.72 Median:5086.82 stddev:512.97 (10.1%) stddev-sans-first:490.98 09:34:58 INFO - 2015-11-02 09:34:58,875 DEBUG : BROWSER_OUTPUT: Values: 2954.5 2972.2 2980.8 3002.4 3099.9 4787.1 4894.9 4916.4 4931.9 4949.7 4827.5 4877.4 4914.5 4932.5 4985.4 4525.1 4535.2 4536.1 4577.4 4578.0 4587.0 4603.5 4627.5 4629.7 4632.4 4433.2 4515.7 4521.0 4527.2 4556.9 4378.5 4484.7 4491.1 4510.2 4518.9 4533.7 4533.8 4561.1 4607.1 4657.8 4766.8 4932.1 4933.3 4944.9 4946.8 5150.3 5210.3 5220.4 5264.8 5380.8 5281.7 5284.9 5308.9 5327.1 5329.4 4751.2 4987.1 5004.0 5019.5 5026.1 5270.8 5338.5 5353.5 5499.3 5518.2 5158.7 5160.7 5193.3 5200.4 5215.2 5177.5 5301.5 5339.0 5341.1 5390.6 5080.5 5136.8 5172.9 5198.7 5242.6 5234.2 5256.4 5262.2 5271.6 5334.2 4004.4 4111.3 4115.2 4120.3 4138.8 3665.4 3739.7 3775.3 3777.8 3792.6 4917.3 4982.3 4988.9 5001.2 5024.9 5173.9 5333.4 5345.3 5352.2 5420.5 4815.0 4818.1 4833.0 4897.5 4966.4 4658.4 4667.5 4679.9 4683.2 4730.5 5220.6 5354.6 5380.3 5390.3 5427.5 5263.5 5287.4 5295.5 5297.1 5313.2 5239.1 5305.0 5316.0 5354.3 5372.0 5247.4 5264.7 5277.8 5278.5 5315.2 5222.6 5322.2 5324.7 5328.1 5350.6 5004.9 5101.4 5136.6 5150.3 5178.1 5202.6 5214.1 5235.6 5239.9 5247.5 4977.3 5083.6 5148.7 5149.4 5162.2 4973.2 5009.9 5093.3 5114.2 5148.9 5076.5 5086.8 5101.2 5117.8 5123.4 09:34:58 INFO - 2015-11-02 09:34:58,875 DEBUG : BROWSER_OUTPUT: 09:34:58 INFO - 2015-11-02 09:34:58,876 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41082.99 Median:29224.28 stddev:68838.34 (235.6%) stddev-sans-first:68964.07 09:34:58 INFO - 2015-11-02 09:34:58,877 DEBUG : BROWSER_OUTPUT: Values: 518.4 518.5 522.3 528.6 543.6 27468.2 29178.0 29315.0 35631.0 36359.0 38712.4 39103.6 39105.8 39156.8 39494.8 8438.5 8625.4 8637.6 8652.1 8664.2 7638.8 7840.3 10161.8 10383.3 10394.9 10120.5 10249.8 10261.1 10268.2 10339.2 7625.7 7813.3 10001.4 10109.2 10125.2 10086.6 10315.6 10365.2 10365.4 10444.6 36240.8 36473.1 36542.5 36572.6 36725.3 2811.3 2949.7 2991.8 3192.9 3285.8 25284.8 25507.9 25697.6 26233.1 26798.3 2129.7 2195.3 2223.2 2273.9 2360.6 261944.0 263695.0 264324.0 265149.0 266392.0 45045.8 46844.3 53369.0 57680.4 58963.7 54387.7 54642.0 54692.7 54696.0 54829.5 15292.2 15443.2 15445.5 15455.7 15542.8 11803.8 11846.5 11861.2 11939.3 12006.8 17366.3 17536.9 17563.0 17593.2 17600.6 7304.1 7552.5 7569.5 7574.2 7599.9 873.2 912.8 916.9 998.4 1015.8 26134.6 26279.0 26593.9 26653.0 26833.7 947.4 954.9 962.8 971.5 1029.2 12167.0 12178.3 12209.9 12277.3 12325.9 310843.0 314301.0 317970.0 319983.0 320284.0 47697.0 48018.5 48117.8 48128.8 48579.8 1253.5 1262.9 1268.7 1269.9 1274.0 23877.3 24506.0 24668.9 24706.5 24717.6 38760.4 39585.4 42511.0 43227.8 45512.0 191236.0 192243.0 192579.0 194087.0 194772.0 27324.0 27351.9 27367.9 27417.3 27647.7 30513.7 30786.0 32681.8 36352.0 37611.4 29004.0 29623.4 29637.9 29751.3 29922.3 28953.9 28978.0 29085.3 29220.1 29228.4 29719.7 29906.6 29920.7 30203.0 32122.7 29321.4 29580.7 31037.8 31042.5 31143.2 21790.9 21811.8 22392.5 22430.6 22452.0 09:34:58 INFO - 2015-11-02 09:34:58,877 DEBUG : BROWSER_OUTPUT: 09:34:58 INFO - 2015-11-02 09:34:58,877 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25132.55 Median:4453.97 stddev:84854.58 (1905.1%) stddev-sans-first:85072.14 09:34:58 INFO - 2015-11-02 09:34:58,878 DEBUG : BROWSER_OUTPUT: Values: 310.1 313.3 314.3 315.2 319.1 13081.5 13602.4 15844.5 16090.7 16550.9 13346.3 15773.5 16933.1 17358.9 17377.0 4334.7 4456.1 4461.8 4496.5 4824.3 3108.3 3203.0 3203.2 4440.1 4455.4 4302.3 4393.8 4413.4 4425.3 4442.7 4268.7 4409.8 4450.3 4450.4 4452.5 3738.7 3739.8 3745.4 3755.0 3765.7 11714.3 11743.0 11956.3 12538.4 12570.9 1652.7 1676.9 1776.8 1781.2 1882.9 8473.3 8485.0 8741.9 8795.0 8806.3 1316.9 1370.0 1370.3 1399.1 1405.7 55468.7 55503.4 56107.2 56318.7 56628.0 5993.3 6049.6 6065.2 6084.1 6117.9 6954.6 6963.8 6967.9 6969.5 6980.5 5116.4 5122.5 5143.9 5147.1 5161.8 5502.8 5514.3 5549.4 5569.7 5571.4 2683.5 2693.7 2708.3 2727.8 2736.1 947.5 947.6 962.9 967.4 1015.6 381.2 396.4 404.6 418.1 429.6 10514.2 10883.7 10974.6 11036.0 11056.2 371.9 402.9 412.9 417.7 421.8 5589.6 5738.4 5810.4 6008.5 6020.3 508183.0 509576.0 516007.0 528254.0 528380.0 61872.7 66111.3 66479.0 66831.0 67002.0 441.3 454.3 455.2 455.3 456.8 9952.9 10054.9 10119.5 10206.7 10230.2 31280.1 31646.5 31742.4 31960.5 32000.5 42333.8 42867.6 42870.8 42940.8 43257.4 5663.0 5731.0 5755.0 5771.9 5803.5 10585.5 10726.7 10942.6 11014.0 11019.3 9128.6 9261.3 9303.2 9385.0 9485.5 9111.1 9126.2 9134.6 9157.3 9186.5 9012.5 9188.1 9262.7 9517.2 9525.0 5073.9 5162.2 5164.1 5483.9 5509.8 8946.4 9120.4 9173.6 9294.2 9334.0 09:34:58 INFO - 2015-11-02 09:34:58,879 DEBUG : BROWSER_OUTPUT: 09:34:58 INFO - 2015-11-02 09:34:58,879 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4967.67 Median:6284.36 stddev:2548.29 (40.5%) stddev-sans-first:2538.75 09:34:58 INFO - 2015-11-02 09:34:58,880 DEBUG : BROWSER_OUTPUT: Values: 1088.6 1567.6 1645.8 1667.5 1670.3 6596.5 6903.6 7172.5 7274.4 7290.4 7100.1 7166.2 7188.2 7207.7 7210.9 2066.2 2074.8 2077.5 2092.4 2095.1 2053.9 2083.0 2083.6 2090.6 2092.4 2044.8 2076.7 2088.2 2092.0 2092.8 2007.0 2023.4 2023.5 2024.4 2027.8 2012.5 2033.1 2037.6 2037.8 2048.4 6342.3 7074.5 7103.5 7107.9 7147.3 4060.7 4342.5 4439.4 4449.3 4500.5 2621.1 2647.0 2660.8 2708.9 2716.3 796.3 805.0 1444.3 1481.4 1526.1 9215.4 9277.7 9287.1 9300.0 9306.9 3851.2 3889.5 3912.7 3951.3 3952.2 7873.9 7874.2 7882.0 7889.8 7925.6 4437.7 4448.1 4459.1 4467.4 4469.0 4072.9 4127.8 4135.4 4140.3 4140.4 3099.9 3123.6 3124.8 3173.3 3184.7 962.8 977.7 979.5 980.0 996.8 1181.1 1199.0 1200.3 1215.4 1221.6 6749.0 6852.5 6885.8 6893.3 6894.6 437.2 450.2 451.3 454.1 454.5 5023.3 5426.5 5454.9 5464.0 5483.4 7733.6 8221.1 8386.5 8424.4 8443.2 8263.5 8323.7 8387.7 8399.0 8400.3 6733.3 6806.2 6828.8 6835.7 6836.8 6687.8 6762.5 6788.9 6796.7 6812.2 7591.9 7660.8 7718.3 7738.5 7738.6 7854.8 7912.5 7917.4 7927.7 7937.5 5902.1 5949.6 6343.1 6346.8 6369.9 6818.2 6855.3 6864.7 6869.5 6882.2 6312.4 6383.9 6455.4 6500.2 6506.1 6256.3 6313.1 6318.7 6378.8 6409.9 6473.2 6488.0 6491.0 6491.9 6501.0 5690.2 5847.7 5886.7 5891.8 5898.6 5992.3 6016.9 6034.2 6037.7 6044.5 09:34:58 INFO - 2015-11-02 09:34:58,880 DEBUG : BROWSER_OUTPUT: 09:34:58 INFO - 2015-11-02 09:34:58,880 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4978.00 Median:5646.62 stddev:1503.57 (26.6%) stddev-sans-first:1466.12 09:34:58 INFO - 2015-11-02 09:34:58,882 DEBUG : BROWSER_OUTPUT: Values: 294.5 301.2 304.5 305.1 309.3 5527.5 5616.7 5637.2 5669.4 5747.1 5460.2 5549.6 5560.6 5642.6 5687.7 4254.9 4269.3 4275.2 4292.2 4307.8 4206.4 4215.2 4287.6 4289.3 4324.1 4246.3 4286.8 4292.0 4293.9 4333.3 4248.7 4279.3 4302.0 4323.2 4341.7 3711.1 3721.2 3739.3 3742.5 3757.1 5290.9 5463.0 5473.9 5478.7 5510.7 4934.4 4938.8 4948.9 4953.3 4960.4 5954.9 5961.0 5975.9 5977.8 5990.4 3930.9 3983.2 3989.1 3999.2 4122.4 6066.1 6112.3 6123.5 6133.7 6173.6 4115.7 4130.2 4136.0 4138.1 4143.6 4173.9 4183.4 4189.7 4196.3 4206.3 4737.2 4887.4 4891.8 4895.6 4912.6 5939.6 5969.2 5975.1 5977.6 6010.0 1521.5 1541.8 1544.3 1549.7 1564.1 993.2 1007.0 1008.2 1025.6 1033.6 5615.8 5637.3 5653.6 5674.7 5705.4 6173.0 6181.3 6185.4 6196.0 6258.0 5625.1 5633.6 5642.9 5650.3 5680.4 3309.7 3415.9 3434.2 3435.1 3441.3 6226.9 6236.0 6250.5 6287.2 6291.3 6355.2 6367.1 6370.5 6370.9 6429.8 6040.9 6197.2 6214.1 6261.7 6266.5 6176.1 6186.5 6214.8 6221.2 6243.3 5876.7 6000.4 6016.8 6069.7 6126.5 6172.8 6214.1 6280.5 6299.4 6299.6 4197.8 4200.2 4205.6 4207.1 4257.7 5980.3 6119.7 6134.6 6148.6 6200.7 5994.6 6081.5 6088.8 6091.9 6101.4 6048.2 6054.2 6056.4 6091.8 6124.1 5726.2 5915.0 5921.6 5941.1 5946.2 6053.4 6066.9 6074.5 6085.9 6088.0 5925.8 5930.3 5936.8 5955.4 5974.6 09:34:58 INFO - 2015-11-02 09:34:58,882 DEBUG : BROWSER_OUTPUT: 09:34:58 INFO - 2015-11-02 09:34:58,882 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11912.32 Median:31289.41 stddev:14779.30 (47.2%) stddev-sans-first:14796.54 09:34:58 INFO - 2015-11-02 09:34:58,882 DEBUG : BROWSER_OUTPUT: Values: 645.9 678.1 694.6 707.5 710.7 12492.3 12752.8 12758.7 12762.6 12768.5 11892.8 11938.6 11967.6 12047.5 12052.3 640.2 657.9 658.5 804.3 810.8 819.8 823.0 836.5 838.1 838.1 857.5 866.2 873.3 875.2 876.9 665.0 684.8 844.1 851.4 862.4 638.0 640.3 643.0 644.2 645.0 12132.3 12290.1 12311.1 12321.6 12323.4 8028.8 8402.7 9199.1 10400.9 11319.1 7968.7 8146.2 8167.9 8197.6 8237.1 2655.4 2665.6 2688.0 2779.5 2833.8 39831.0 39936.0 40029.4 40096.4 40216.2 5649.6 5804.1 5887.8 5919.0 6017.5 9893.0 9910.8 9914.2 9936.6 10013.0 5498.9 5683.7 5729.6 5737.3 5890.9 3372.5 3458.6 3507.3 3562.2 3573.4 2450.8 2473.6 2481.0 2481.2 2488.4 376.9 378.8 382.4 384.5 384.9 497.3 536.3 547.9 550.1 577.4 7125.1 7205.7 7236.9 7270.6 7350.3 463.7 524.1 524.2 526.4 536.8 3204.2 3794.4 3810.1 3855.0 3879.7 51996.2 52884.5 55006.0 56081.0 56895.1 47128.5 47400.0 47457.3 47566.0 47772.3 43504.3 43830.3 43970.8 44315.8 44563.6 7351.8 7567.8 7613.4 7648.6 7653.8 30047.7 30930.0 31601.2 32035.4 33544.3 40231.6 40461.4 40537.6 40981.6 42522.6 6606.1 6639.0 6793.8 6804.6 7058.3 9969.5 10067.6 10075.2 10278.2 10368.2 9244.4 9327.9 9379.3 9689.3 10267.8 9278.4 9281.6 9440.7 9641.3 10004.3 9229.9 9344.6 9497.7 9597.4 10155.5 7307.0 7575.2 7576.7 7804.8 8249.8 7088.3 7485.9 7531.1 7793.7 8163.1 09:34:58 INFO - 2015-11-02 09:34:58,883 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:34:58 INFO - 2015-11-02 09:34:58,883 DEBUG : BROWSER_OUTPUT: 09:34:59 INFO - 2015-11-02 09:34:59,547 INFO : Browser exited with error code: 0 09:34:59 INFO - 2015-11-02 09:34:59,577 INFO : Completed test dromaeo_css (00:18:34) 09:34:59 INFO - 2015-11-02 09:34:59,577 INFO : Starting test kraken 09:34:59 INFO - 2015-11-02 09:34:59,577 DEBUG : operating with platform_type : mac_ 09:34:59 INFO - 2015-11-02 09:34:59,578 INFO : Initialising browser for kraken test... 09:34:59 INFO - 2015-11-02 09:34:59,592 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/tmpf2FFjJ/profile http://localhost:49269/getInfo.html 09:35:01 INFO - 2015-11-02 09:35:01,887 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:35:01 INFO - 2015-11-02 09:35:01,887 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:35:01 INFO - 2015-11-02 09:35:01,888 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 09:35:01 INFO - 2015-11-02 09:35:01,888 DEBUG : BROWSER_OUTPUT: __metrics 09:35:01 INFO - 2015-11-02 09:35:01,904 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:35:02 INFO - 2015-11-02 09:35:02,618 INFO : Browser initialized. 09:35:02 INFO - 2015-11-02 09:35:02,618 INFO : Running cycle 1/1 for kraken test... 09:35:02 INFO - 2015-11-02 09:35:02,618 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/tmpf2FFjJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:35:14 INFO - 2015-11-02 09:35:14,590 DEBUG : BROWSER_OUTPUT: RSS: Main: 222064640 09:35:14 INFO - 2015-11-02 09:35:14,590 DEBUG : BROWSER_OUTPUT: 09:35:17 INFO - 2015-11-02 09:35:17,188 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection) 09:35:17 INFO - 2015-11-02 09:35:17,776 DEBUG : BROWSER_OUTPUT: RSS: Main: 277839872 09:35:17 INFO - 2015-11-02 09:35:17,777 DEBUG : BROWSER_OUTPUT: 09:35:20 INFO - 2015-11-02 09:35:20,655 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-dft) 09:35:21 INFO - 2015-11-02 09:35:21,242 DEBUG : BROWSER_OUTPUT: RSS: Main: 292700160 09:35:21 INFO - 2015-11-02 09:35:21,243 DEBUG : BROWSER_OUTPUT: 09:35:24 INFO - 2015-11-02 09:35:24,428 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-fft) 09:35:24 INFO - 2015-11-02 09:35:24,995 DEBUG : BROWSER_OUTPUT: RSS: Main: 273399808 09:35:24 INFO - 2015-11-02 09:35:24,995 DEBUG : BROWSER_OUTPUT: 09:35:27 INFO - 2015-11-02 09:35:27,112 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator) 09:35:27 INFO - 2015-11-02 09:35:27,697 DEBUG : BROWSER_OUTPUT: RSS: Main: 275968000 09:35:27 INFO - 2015-11-02 09:35:27,697 DEBUG : BROWSER_OUTPUT: 09:35:30 INFO - 2015-11-02 09:35:30,006 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:35:30 INFO - 2015-11-02 09:35:30,581 DEBUG : BROWSER_OUTPUT: RSS: Main: 275849216 09:35:30 INFO - 2015-11-02 09:35:30,582 DEBUG : BROWSER_OUTPUT: 09:35:33 INFO - 2015-11-02 09:35:33,860 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom) 09:35:34 INFO - 2015-11-02 09:35:34,439 DEBUG : BROWSER_OUTPUT: RSS: Main: 276066304 09:35:34 INFO - 2015-11-02 09:35:34,439 DEBUG : BROWSER_OUTPUT: 09:35:37 INFO - 2015-11-02 09:35:37,802 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate) 09:35:38 INFO - 2015-11-02 09:35:38,383 DEBUG : BROWSER_OUTPUT: RSS: Main: 276717568 09:35:38 INFO - 2015-11-02 09:35:38,384 DEBUG : BROWSER_OUTPUT: 09:35:41 INFO - 2015-11-02 09:35:41,482 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial) 09:35:42 INFO - 2015-11-02 09:35:42,053 DEBUG : BROWSER_OUTPUT: RSS: Main: 276381696 09:35:42 INFO - 2015-11-02 09:35:42,053 DEBUG : BROWSER_OUTPUT: 09:35:43 INFO - 2015-11-02 09:35:43,689 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:35:44 INFO - 2015-11-02 09:35:44,253 DEBUG : BROWSER_OUTPUT: RSS: Main: 313012224 09:35:44 INFO - 2015-11-02 09:35:44,253 DEBUG : BROWSER_OUTPUT: 09:35:46 INFO - 2015-11-02 09:35:46,160 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:35:46 INFO - 2015-11-02 09:35:46,773 DEBUG : BROWSER_OUTPUT: RSS: Main: 312225792 09:35:46 INFO - 2015-11-02 09:35:46,773 DEBUG : BROWSER_OUTPUT: 09:35:48 INFO - 2015-11-02 09:35:48,984 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:35:49 INFO - 2015-11-02 09:35:49,571 DEBUG : BROWSER_OUTPUT: RSS: Main: 320692224 09:35:49 INFO - 2015-11-02 09:35:49,571 DEBUG : BROWSER_OUTPUT: 09:35:52 INFO - 2015-11-02 09:35:52,314 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:35:52 INFO - 2015-11-02 09:35:52,914 DEBUG : BROWSER_OUTPUT: RSS: Main: 321609728 09:35:52 INFO - 2015-11-02 09:35:52,914 DEBUG : BROWSER_OUTPUT: 09:35:55 INFO - 2015-11-02 09:35:55,637 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:35:56 INFO - 2015-11-02 09:35:56,222 DEBUG : BROWSER_OUTPUT: RSS: Main: 321007616 09:35:56 INFO - 2015-11-02 09:35:56,222 DEBUG : BROWSER_OUTPUT: 09:35:58 INFO - 2015-11-02 09:35:58,051 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49269/tests/kraken/driver.html?testName=ai-astar) 09:35:58 INFO - 2015-11-02 09:35:58,304 DEBUG : BROWSER_OUTPUT: RSS: Main: 380358656 09:35:58 INFO - 2015-11-02 09:35:58,304 DEBUG : BROWSER_OUTPUT: 09:35:58 INFO - 2015-11-02 09:35:58,305 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:35:58 INFO - 2015-11-02 09:35:58,305 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:35:58 INFO - 2015-11-02 09:35:58,305 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:35:58 INFO - 2015-11-02 09:35:58,305 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:35:58 INFO - 2015-11-02 09:35:58,305 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;108;107;111;111;108;118;110;108;113 09:35:58 INFO - 2015-11-02 09:35:58,305 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;166;145;169;195;163;166;163;140;172;144 09:35:58 INFO - 2015-11-02 09:35:58,306 DEBUG : BROWSER_OUTPUT: |2;audio-dft;173;178;179;174;175;182;182;172;182;180 09:35:58 INFO - 2015-11-02 09:35:58,306 DEBUG : BROWSER_OUTPUT: |3;audio-fft;77;85;100;95;75;80;77;88;91;72 09:35:58 INFO - 2015-11-02 09:35:58,306 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;105;105;149;99;102;99;143;95;96;147 09:35:58 INFO - 2015-11-02 09:35:58,306 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;135;136;134;131;129;129;132;130;136;136 09:35:58 INFO - 2015-11-02 09:35:58,306 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;141;141;137;135;141;141;137;135;141;141 09:35:58 INFO - 2015-11-02 09:35:58,306 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;111;114;112;113;114;113;108;114;113;114 09:35:58 INFO - 2015-11-02 09:35:58,307 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;59;65;61;65;64;64;73;64;66 09:35:58 INFO - 2015-11-02 09:35:58,307 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;70;71;74;75;76;76;74;72;71 09:35:58 INFO - 2015-11-02 09:35:58,307 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;92;95;97;95;96;95;95;97;97;94 09:35:58 INFO - 2015-11-02 09:35:58,307 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;137;148;136;136;146;143;139;155;135;137 09:35:58 INFO - 2015-11-02 09:35:58,307 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;147;167;165;165;163;147;166;164;153;158 09:35:58 INFO - 2015-11-02 09:35:58,307 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;72;75;78;79;80;78;79;78;80;75 09:35:58 INFO - 2015-11-02 09:35:58,308 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:35:58 INFO - 2015-11-02 09:35:58,308 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:35:58 INFO - 2015-11-02 09:35:58,308 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,916 09:35:58 INFO - 2015-11-02 09:35:58,308 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:35:58 INFO - 2015-11-02 09:35:58,308 DEBUG : BROWSER_OUTPUT: __startTimestamp1446485758302__endTimestamp 09:35:58 INFO - 2015-11-02 09:35:58,308 DEBUG : BROWSER_OUTPUT: 09:35:58 INFO - 2015-11-02 09:35:58,309 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:35:58 INFO - 2015-11-02 09:35:58,309 DEBUG : BROWSER_OUTPUT: Number of tests: 14 09:35:58 INFO - 2015-11-02 09:35:58,309 DEBUG : BROWSER_OUTPUT: 09:35:58 INFO - 2015-11-02 09:35:58,309 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.20 Median:110.50 stddev:3.33 (3.0%) stddev-sans-first:3.43 09:35:58 INFO - 2015-11-02 09:35:58,309 DEBUG : BROWSER_OUTPUT: Values: 108.0 108.0 107.0 111.0 111.0 108.0 118.0 110.0 108.0 113.0 09:35:58 INFO - 2015-11-02 09:35:58,309 DEBUG : BROWSER_OUTPUT: 09:35:58 INFO - 2015-11-02 09:35:58,309 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:162.30 Median:166.00 stddev:16.22 (9.8%) stddev-sans-first:17.15 09:35:58 INFO - 2015-11-02 09:35:58,310 DEBUG : BROWSER_OUTPUT: Values: 166.0 145.0 169.0 195.0 163.0 166.0 163.0 140.0 172.0 144.0 09:35:58 INFO - 2015-11-02 09:35:58,311 DEBUG : BROWSER_OUTPUT: 09:35:58 INFO - 2015-11-02 09:35:58,312 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:177.70 Median:179.50 stddev:3.92 (2.2%) stddev-sans-first:3.77 09:35:58 INFO - 2015-11-02 09:35:58,312 DEBUG : BROWSER_OUTPUT: Values: 173.0 178.0 179.0 174.0 175.0 182.0 182.0 172.0 182.0 180.0 09:35:58 INFO - 2015-11-02 09:35:58,312 DEBUG : BROWSER_OUTPUT: 09:35:58 INFO - 2015-11-02 09:35:58,312 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:84.00 Median:82.50 stddev:9.32 (11.3%) stddev-sans-first:9.54 09:35:58 INFO - 2015-11-02 09:35:58,312 DEBUG : BROWSER_OUTPUT: Values: 77.0 85.0 100.0 95.0 75.0 80.0 77.0 88.0 91.0 72.0 09:35:58 INFO - 2015-11-02 09:35:58,312 DEBUG : BROWSER_OUTPUT: 09:35:58 INFO - 2015-11-02 09:35:58,313 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:114.00 Median:122.00 stddev:22.60 (18.5%) stddev-sans-first:23.73 09:35:58 INFO - 2015-11-02 09:35:58,313 DEBUG : BROWSER_OUTPUT: Values: 105.0 105.0 149.0 99.0 102.0 99.0 143.0 95.0 96.0 147.0 09:35:58 INFO - 2015-11-02 09:35:58,313 DEBUG : BROWSER_OUTPUT: 09:35:58 INFO - 2015-11-02 09:35:58,313 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:132.80 Median:134.50 stddev:2.94 (2.2%) stddev-sans-first:3.00 09:35:58 INFO - 2015-11-02 09:35:58,313 DEBUG : BROWSER_OUTPUT: Values: 135.0 136.0 134.0 131.0 129.0 129.0 132.0 130.0 136.0 136.0 09:35:58 INFO - 2015-11-02 09:35:58,313 DEBUG : BROWSER_OUTPUT: 09:35:58 INFO - 2015-11-02 09:35:58,314 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:139.00 Median:141.00 stddev:2.67 (1.9%) stddev-sans-first:2.73 09:35:58 INFO - 2015-11-02 09:35:58,314 DEBUG : BROWSER_OUTPUT: Values: 141.0 141.0 137.0 135.0 141.0 141.0 137.0 135.0 141.0 141.0 09:35:58 INFO - 2015-11-02 09:35:58,314 DEBUG : BROWSER_OUTPUT: 09:35:58 INFO - 2015-11-02 09:35:58,314 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:112.60 Median:113.50 stddev:1.90 (1.7%) stddev-sans-first:1.92 09:35:58 INFO - 2015-11-02 09:35:58,314 DEBUG : BROWSER_OUTPUT: Values: 111.0 114.0 112.0 113.0 114.0 113.0 108.0 114.0 113.0 114.0 09:35:58 INFO - 2015-11-02 09:35:58,314 DEBUG : BROWSER_OUTPUT: 09:35:58 INFO - 2015-11-02 09:35:58,315 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:63.80 Median:64.50 stddev:4.34 (6.7%) stddev-sans-first:3.84 09:35:58 INFO - 2015-11-02 09:35:58,315 DEBUG : BROWSER_OUTPUT: Values: 57.0 59.0 65.0 61.0 65.0 64.0 64.0 73.0 64.0 66.0 09:35:58 INFO - 2015-11-02 09:35:58,315 DEBUG : BROWSER_OUTPUT: 09:35:58 INFO - 2015-11-02 09:35:58,315 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:72.80 Median:74.00 stddev:2.53 (3.4%) stddev-sans-first:2.28 09:35:58 INFO - 2015-11-02 09:35:58,315 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 71.0 74.0 75.0 76.0 76.0 74.0 72.0 71.0 09:35:58 INFO - 2015-11-02 09:35:58,315 DEBUG : BROWSER_OUTPUT: 09:35:58 INFO - 2015-11-02 09:35:58,316 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:95.30 Median:95.50 stddev:1.57 (1.6%) stddev-sans-first:1.12 09:35:58 INFO - 2015-11-02 09:35:58,316 DEBUG : BROWSER_OUTPUT: Values: 92.0 95.0 97.0 95.0 96.0 95.0 95.0 97.0 97.0 94.0 09:35:58 INFO - 2015-11-02 09:35:58,316 DEBUG : BROWSER_OUTPUT: 09:35:58 INFO - 2015-11-02 09:35:58,316 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:141.20 Median:141.00 stddev:6.63 (4.7%) stddev-sans-first:6.86 09:35:58 INFO - 2015-11-02 09:35:58,316 DEBUG : BROWSER_OUTPUT: Values: 137.0 148.0 136.0 136.0 146.0 143.0 139.0 155.0 135.0 137.0 09:35:58 INFO - 2015-11-02 09:35:58,317 DEBUG : BROWSER_OUTPUT: 09:35:58 INFO - 2015-11-02 09:35:58,317 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.50 Median:164.50 stddev:7.81 (4.7%) stddev-sans-first:6.85 09:35:58 INFO - 2015-11-02 09:35:58,317 DEBUG : BROWSER_OUTPUT: Values: 147.0 167.0 165.0 165.0 163.0 147.0 166.0 164.0 153.0 158.0 09:35:58 INFO - 2015-11-02 09:35:58,317 DEBUG : BROWSER_OUTPUT: 09:35:58 INFO - 2015-11-02 09:35:58,317 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.40 Median:78.50 stddev:2.59 (3.3%) stddev-sans-first:1.87 09:35:58 INFO - 2015-11-02 09:35:58,318 DEBUG : BROWSER_OUTPUT: Values: 72.0 75.0 78.0 79.0 80.0 78.0 79.0 78.0 80.0 75.0 09:35:58 INFO - 2015-11-02 09:35:58,319 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:35:58 INFO - 2015-11-02 09:35:58,319 DEBUG : BROWSER_OUTPUT: 09:35:58 INFO - 2015-11-02 09:35:58,987 INFO : Browser exited with error code: 0 09:35:59 INFO - 2015-11-02 09:35:59,040 INFO : Completed test kraken (00:00:59) 09:35:59 INFO - 2015-11-02 09:35:59,040 INFO : Starting test v8_7 09:35:59 INFO - 2015-11-02 09:35:59,040 DEBUG : operating with platform_type : mac_ 09:35:59 INFO - 2015-11-02 09:35:59,040 INFO : Initialising browser for v8_7 test... 09:35:59 INFO - 2015-11-02 09:35:59,054 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/tmpcIBxOq/profile http://localhost:49269/getInfo.html 09:36:01 INFO - 2015-11-02 09:36:01,356 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:36:01 INFO - 2015-11-02 09:36:01,357 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:36:01 INFO - 2015-11-02 09:36:01,357 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 09:36:01 INFO - 2015-11-02 09:36:01,357 DEBUG : BROWSER_OUTPUT: __metrics 09:36:01 INFO - 2015-11-02 09:36:01,373 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:36:02 INFO - 2015-11-02 09:36:02,090 INFO : Browser initialized. 09:36:02 INFO - 2015-11-02 09:36:02,090 INFO : Running cycle 1/1 for v8_7 test... 09:36:02 INFO - 2015-11-02 09:36:02,090 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/tmpcIBxOq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:36:14 INFO - 2015-11-02 09:36:14,061 DEBUG : BROWSER_OUTPUT: RSS: Main: 220774400 09:36:14 INFO - 2015-11-02 09:36:14,061 DEBUG : BROWSER_OUTPUT: 09:36:35 INFO - 2015-11-02 09:36:35,673 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/v8_7/run.html (next: http://localhost:49269/tests/v8_7/run.html) 09:36:35 INFO - 2015-11-02 09:36:35,930 DEBUG : BROWSER_OUTPUT: RSS: Main: 678731776 09:36:35 INFO - 2015-11-02 09:36:35,930 DEBUG : BROWSER_OUTPUT: 09:36:35 INFO - 2015-11-02 09:36:35,930 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:36:35 INFO - 2015-11-02 09:36:35,930 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:36:35 INFO - 2015-11-02 09:36:35,930 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:36:35 INFO - 2015-11-02 09:36:35,930 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:36:35 INFO - 2015-11-02 09:36:35,931 DEBUG : BROWSER_OUTPUT: |0;Richards;171.43836790673754 09:36:35 INFO - 2015-11-02 09:36:35,931 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;210.43771043771045 09:36:35 INFO - 2015-11-02 09:36:35,931 DEBUG : BROWSER_OUTPUT: |2;Encrypt;351.12359550561797 09:36:35 INFO - 2015-11-02 09:36:35,931 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6223.60248447205 09:36:35 INFO - 2015-11-02 09:36:35,931 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2237.136465324385 09:36:35 INFO - 2015-11-02 09:36:35,931 DEBUG : BROWSER_OUTPUT: |5;Earley;1043.8413361169103 09:36:35 INFO - 2015-11-02 09:36:35,931 DEBUG : BROWSER_OUTPUT: |6;Boyer;13743.243243243243 09:36:35 INFO - 2015-11-02 09:36:35,931 DEBUG : BROWSER_OUTPUT: |7;RegExp;31937.5 09:36:35 INFO - 2015-11-02 09:36:35,931 DEBUG : BROWSER_OUTPUT: |8;Splay;681.6632583503749 09:36:35 INFO - 2015-11-02 09:36:35,931 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6281.25 09:36:35 INFO - 2015-11-02 09:36:35,931 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:36:35 INFO - 2015-11-02 09:36:35,931 DEBUG : BROWSER_OUTPUT: __startTimestamp1446485795924__endTimestamp 09:36:35 INFO - 2015-11-02 09:36:35,931 DEBUG : BROWSER_OUTPUT: 09:36:35 INFO - 2015-11-02 09:36:35,931 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:36:35 INFO - 2015-11-02 09:36:35,932 DEBUG : BROWSER_OUTPUT: Number of tests: 10 09:36:35 INFO - 2015-11-02 09:36:35,932 DEBUG : BROWSER_OUTPUT: 09:36:35 INFO - 2015-11-02 09:36:35,932 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:171.44 Median:171.44 stddev:0.00 (0.0%) 09:36:35 INFO - 2015-11-02 09:36:35,932 DEBUG : BROWSER_OUTPUT: Values: 171.4 09:36:35 INFO - 2015-11-02 09:36:35,932 DEBUG : BROWSER_OUTPUT: 09:36:35 INFO - 2015-11-02 09:36:35,932 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:210.44 Median:210.44 stddev:0.00 (0.0%) 09:36:35 INFO - 2015-11-02 09:36:35,932 DEBUG : BROWSER_OUTPUT: Values: 210.4 09:36:35 INFO - 2015-11-02 09:36:35,932 DEBUG : BROWSER_OUTPUT: 09:36:35 INFO - 2015-11-02 09:36:35,932 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:351.12 Median:351.12 stddev:0.00 (0.0%) 09:36:35 INFO - 2015-11-02 09:36:35,932 DEBUG : BROWSER_OUTPUT: Values: 351.1 09:36:35 INFO - 2015-11-02 09:36:35,932 DEBUG : BROWSER_OUTPUT: 09:36:35 INFO - 2015-11-02 09:36:35,932 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6223.60 Median:6223.60 stddev:0.00 (0.0%) 09:36:35 INFO - 2015-11-02 09:36:35,932 DEBUG : BROWSER_OUTPUT: Values: 6223.6 09:36:35 INFO - 2015-11-02 09:36:35,932 DEBUG : BROWSER_OUTPUT: 09:36:35 INFO - 2015-11-02 09:36:35,933 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2237.14 Median:2237.14 stddev:0.00 (0.0%) 09:36:35 INFO - 2015-11-02 09:36:35,933 DEBUG : BROWSER_OUTPUT: Values: 2237.1 09:36:35 INFO - 2015-11-02 09:36:35,933 DEBUG : BROWSER_OUTPUT: 09:36:35 INFO - 2015-11-02 09:36:35,933 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:1043.84 Median:1043.84 stddev:0.00 (0.0%) 09:36:35 INFO - 2015-11-02 09:36:35,933 DEBUG : BROWSER_OUTPUT: Values: 1043.8 09:36:35 INFO - 2015-11-02 09:36:35,933 DEBUG : BROWSER_OUTPUT: 09:36:35 INFO - 2015-11-02 09:36:35,933 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:13743.24 Median:13743.24 stddev:0.00 (0.0%) 09:36:35 INFO - 2015-11-02 09:36:35,933 DEBUG : BROWSER_OUTPUT: Values: 13743.2 09:36:35 INFO - 2015-11-02 09:36:35,933 DEBUG : BROWSER_OUTPUT: 09:36:35 INFO - 2015-11-02 09:36:35,933 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:31937.50 Median:31937.50 stddev:0.00 (0.0%) 09:36:35 INFO - 2015-11-02 09:36:35,933 DEBUG : BROWSER_OUTPUT: Values: 31937.5 09:36:35 INFO - 2015-11-02 09:36:35,933 DEBUG : BROWSER_OUTPUT: 09:36:35 INFO - 2015-11-02 09:36:35,933 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:681.66 Median:681.66 stddev:0.00 (0.0%) 09:36:35 INFO - 2015-11-02 09:36:35,933 DEBUG : BROWSER_OUTPUT: Values: 681.7 09:36:35 INFO - 2015-11-02 09:36:35,933 DEBUG : BROWSER_OUTPUT: 09:36:35 INFO - 2015-11-02 09:36:35,934 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6281.25 Median:6281.25 stddev:0.00 (0.0%) 09:36:35 INFO - 2015-11-02 09:36:35,934 DEBUG : BROWSER_OUTPUT: Values: 6281.3 09:36:35 INFO - 2015-11-02 09:36:35,934 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:36:35 INFO - 2015-11-02 09:36:35,934 DEBUG : BROWSER_OUTPUT: 09:36:36 INFO - 2015-11-02 09:36:36,636 INFO : Browser exited with error code: 0 09:36:36 INFO - 2015-11-02 09:36:36,657 INFO : Completed test v8_7 (00:00:37) 09:36:36 INFO - 2015-11-02 09:36:36,920 INFO : Completed test suite (00:20:12) 09:36:36 INFO - 2015-11-02 09:36:36,921 DEBUG : Working with test: dromaeo_css 09:36:36 INFO - 2015-11-02 09:36:36,921 DEBUG : Generating results file: dromaeo_css 09:36:36 INFO - 2015-11-02 09:36:36,922 DEBUG : Working with test: kraken 09:36:36 INFO - 2015-11-02 09:36:36,922 DEBUG : Generating results file: kraken 09:36:36 INFO - 2015-11-02 09:36:36,922 INFO : javascript benchmark 09:36:36 INFO - 2015-11-02 09:36:36,922 DEBUG : Working with test: v8_7 09:36:36 INFO - 2015-11-02 09:36:36,922 DEBUG : Generating results file: v8_7 09:36:36 INFO - 2015-11-02 09:36:36,922 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:36:37 INFO - 2015-11-02 09:36:37,058 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,55]] 09:36:37 INFO - 2015-11-02 09:36:37,058 DEBUG : process_Request line: dromaeo_css 6023.39 graph.html#tests=[[72,64,55]] 09:36:37 INFO - 2015-11-02 09:36:37,058 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:36:37 INFO - 2015-11-02 09:36:37,170 DEBUG : process_Request line: kraken 1642.60 graph.html#tests=[[232,64,55]] 09:36:37 INFO - 2015-11-02 09:36:37,170 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:36:37 INFO - 2015-11-02 09:36:37,272 DEBUG : process_Request line: v8_7 16818.45 graph.html#tests=[[230,64,55]] 09:36:37 INFO - 2015-11-02 09:36:37,273 INFO : javascript benchmark 09:36:37 INFO - 2015-11-02 09:36:37,275 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [310.1177151005389, 313.33260155868, 314.2708915316466, 315.1538120147404, 319.1351437604093, 13081.476740930351, 13602.387892544835, 15844.524664260076, 16090.678186436278, 16550.91724541377, 13346.26595537245, 15773.526794196163, 16933.06868122253, 17358.913205433986, 17377.0, 4334.696571240014, 4456.064226512436, 4461.7992190351515, 4496.527864574222, 4824.252240902666, 3108.347247078116, 3203.0230779612207, 3203.2312245061134, 4440.067585806984, 4455.443069616298, 4302.290122129845, 4393.824247030115, 4413.3821265022925, 4425.336199570058, 4442.689011769177, 4268.658507319438, 4409.779511024436, 4450.310201918708, 4450.421445212101, 4452.487963884146, 3738.6822120119823, 3739.813009349549, 3745.382011968022, 3755.023693839594, 3765.7363984521094, 11714.297142171412, 11743.0, 11956.282623042558, 12538.435770390355, 12570.937145314307, 1652.6859896619724, 1676.9329226830912, 1776.786785585725, 1781.2429717370067, 1882.8964406957612, 8473.279771219391, 8485.0, 8741.868871966926, 8795.0, 8806.251468625174, 1316.861729518406, 1369.9863001369959, 1370.294298436306, 1399.1465206224195, 1405.6696676281065, 55468.72265638646, 55503.44496555023, 56107.158392624144, 56318.718406408116, 56627.999999999585, 5993.250843644544, 6049.637021778707, 6065.211522502134, 6084.056971169476, 6117.877642447126, 6954.617496037767, 6963.79108626742, 6967.930320696728, 6969.54697944632, 6980.476464265201, 5116.437191908887, 5122.513361230677, 5143.897122057538, 5147.099257629975, 5161.81933632321, 5502.8349149525575, 5514.310711161105, 5549.38956714761, 5569.665820050729, 5571.442855714477, 2683.490136873988, 2693.7171596982425, 2708.2687674328217, 2727.7681397081074, 2736.138116493298, 947.5167664491021, 947.5830634520789, 962.9037096290315, 967.4437198610827, 1015.57345914716, 381.17475665185117, 396.4212250114807, 404.5812583975571, 418.11777150213027, 429.57257528759084, 10514.239170383364, 10883.714419971895, 10974.561017559208, 11036.0, 11056.226064175431, 371.85869369639363, 402.8589993502251, 412.91948070126637, 417.74726290593753, 421.7996451685425, 5589.608727389043, 5738.426157384311, 5810.360860305363, 6008.519318454513, 6020.277566692025, 508183.0, 509576.0, 516007.0, 528254.0, 528380.0, 61872.690636546526, 66111.33888661148, 66478.99999999904, 66831.0, 67002.0, 441.2939297124639, 454.34120525238535, 455.23520485583873, 455.28065656263027, 456.7510706664809, 9952.850707239542, 10054.949725251327, 10119.544620491948, 10206.744831378977, 10230.23273254494, 31280.061598152093, 31646.525302120946, 31742.36515269728, 31960.52059219067, 32000.5199922006, 42333.78833105938, 42867.57132428636, 42870.785646072814, 42940.78529607332, 43257.3511397323, 5663.0, 5730.971345143247, 5754.971225143848, 5771.94228057714, 5803.506701930383, 10585.4707264638, 10726.731831703957, 10942.617008404668, 11014.00873921351, 11019.338839669645, 9128.634854605742, 9261.259099272176, 9303.209227215762, 9385.0, 9485.525723713648, 9111.134442227978, 9126.17864392208, 9134.588943497425, 9157.31320150978, 9186.494742789211, 9012.459252444874, 9188.127127923104, 9262.72211833619, 9517.191038761783, 9525.0, 5073.949260507347, 5162.225666149958, 5164.070467315919, 5483.917741233805, 5509.752061157177, 8946.418482798597, 9120.407173533698, 9173.633054677739, 9294.209992150743, 9333.953330233306], "dojo.html": [2954.497735384983, 2972.2272209225594, 2980.8211507309547, 3002.384511175208, 3099.922501937452, 4787.090452813972, 4894.902101957963, 4916.360873086503, 4931.901361972763, 4949.739278704127, 4827.468978412372, 4877.3903262092235, 4914.459409464965, 4932.482089380617, 4985.40175178979, 4525.0949810037955, 4535.206338890697, 4536.070105628338, 4577.427821522309, 4578.038611891507, 4586.954130458686, 4603.516630753773, 4627.490975992638, 4629.7222166669935, 4632.420947381577, 4433.202023635744, 4515.729056256635, 4520.977395113036, 4527.185106680796, 4556.9088618227615, 4378.5183629800695, 4484.7084939479155, 4491.079328737601, 4510.233260345716, 4518.909621807578, 4533.659975501851, 4533.84131555394, 4561.087782443525, 4607.124646317223, 4657.836975705834, 4766.833160839354, 4932.087563800673, 4933.309336692866, 4944.9258261126115, 4946.777395017233, 5150.304708864331, 5210.296609957645, 5220.373555173365, 5264.763085661154, 5380.757865896044, 5281.683099014072, 5284.894302113936, 5308.9469105308835, 5327.067763141435, 5329.360476742777, 4751.192297309466, 4987.077390682699, 5003.974980125076, 5019.47295533971, 5026.12042892496, 5270.762815673227, 5338.466153384708, 5353.544948679328, 5499.285092937893, 5518.19986102021, 5158.716270605078, 5160.7419629018395, 5193.324867767242, 5200.427952925175, 5215.19164529491, 5177.482251774868, 5301.496357845998, 5339.0, 5341.145416733304, 5390.595705322116, 5080.491950804964, 5136.845894623168, 5172.922406163911, 5198.6880787152895, 5242.633015688942, 5234.18870075139, 5256.421793602701, 5262.210668399771, 5271.578273738091, 5334.199870019451, 4004.3993400990084, 4111.280525908014, 4115.176964607091, 4120.25835349634, 4138.751674899516, 3665.395209790408, 3739.682127019234, 3775.301569209705, 3777.8111094445167, 3792.60177681345, 4917.336159618406, 4982.277569752366, 4988.900221995613, 5001.174806156943, 5024.949750502448, 5173.896522069613, 5333.439988801198, 5345.251664766935, 5352.223927530564, 5420.457954204548, 4814.975925120352, 4818.084563932912, 4832.95167048325, 4897.4857639948, 4966.428860680996, 4658.394408726844, 4667.486576476585, 4679.883002924886, 4683.15703173432, 4730.526947305242, 5220.608454366014, 5354.571634269249, 5380.3274590676165, 5390.326209223847, 5427.538659214011, 5263.526282634582, 5287.418383977836, 5295.470452954673, 5297.073012222922, 5313.229581710553, 5239.109351410346, 5305.045091883498, 5316.0, 5354.250404943389, 5372.006178856924, 5247.449017853223, 5264.684118952875, 5277.8416647500635, 5278.5249327560705, 5315.202719592092, 5222.608304377263, 5322.201669749568, 5324.733763311897, 5328.147496400712, 5350.598705097055, 5004.874878128076, 5101.438841727481, 5136.563392111712, 5150.304708864255, 5178.0679477694375, 5202.583793296603, 5214.061468935476, 5235.633505654568, 5239.921401179062, 5247.475252474722, 4977.303177555217, 5083.618728595444, 5148.6910785353, 5149.433562308218, 5162.174052151638, 4973.179425394769, 5009.874753131201, 5093.312402825719, 5114.207297868837, 5148.871278218075, 5076.543111120017, 5086.821961231339, 5101.183810590288, 5117.795288188431, 5123.38519377677], "mootools.html": [1088.5972190289594, 1567.6472793621438, 1645.7942757155356, 1667.5247554446985, 1670.3402156148325, 6596.538242323039, 6903.6203008834555, 7172.497925145235, 7274.418046556276, 7290.416766658668, 7100.112485939258, 7166.247544007882, 7188.245234250394, 7207.747728829492, 7210.8557828843395, 2066.2458202755997, 2074.7614024387162, 2077.480629842539, 2092.4036649554805, 2095.130520833852, 2053.9383818485394, 2082.9895850520725, 2083.593699228651, 2090.602785470756, 2092.424583239606, 2044.815966563009, 2076.709260703503, 2088.1960445228547, 2092.0376626751713, 2092.780258072903, 2007.0065317667702, 2023.4435530229157, 2023.4536675097715, 2024.3623258673472, 2027.817496425314, 2012.4566367080806, 2033.1054336092072, 2037.6230397376532, 2037.7554693436734, 2048.3752455501067, 6342.302346741901, 7074.469414793911, 7103.502754807166, 7107.928920710779, 7147.3210045045635, 4060.695447841394, 4342.50061242958, 4439.4228750262255, 4449.26587113126, 4500.48244451889, 2621.082621082625, 2646.9867650661818, 2660.840349579031, 2708.9051883184193, 2716.348076461635, 796.3072127249272, 805.0339592488978, 1444.3139508733373, 1481.4148411377553, 1526.084349390368, 9215.447073175565, 9277.721668349961, 9287.071292870727, 9300.0, 9306.86039709405, 3851.1527463957887, 3889.533256009297, 3912.68698504119, 3951.269015232191, 3952.2490726761825, 7873.881891771628, 7874.21257874208, 7882.014748156481, 7889.802754931173, 7925.603719813987, 4437.733735975852, 4448.132614140211, 4459.1304695584695, 4467.352233926063, 4468.955310446919, 4072.898177545585, 4127.752334859858, 4135.421041054255, 4140.3168477200925, 4140.420341152241, 3099.9225019374694, 3123.5783169272313, 3124.7968882022597, 3173.2701478660038, 3184.681531846843, 962.7544976031068, 977.6529332087007, 979.5445118020012, 979.9559019844124, 996.7508122969258, 1181.1023622047305, 1198.964031079069, 1200.2918278215895, 1215.380156120385, 1221.6335099470123, 6749.0, 6852.45180385568, 6885.758998435031, 6893.276205998298, 6894.551854129466, 437.24793355428613, 450.19639942702776, 451.3230154767848, 454.0895504513429, 454.46373279530474, 5023.346964894614, 5426.484483974095, 5454.945450545444, 5463.951018368112, 5483.369412517532, 7733.574653394117, 8221.054578723404, 8386.496810191285, 8424.368172387096, 8443.155684431631, 8263.462874913112, 8323.708670196515, 8387.748367548984, 8399.0, 8400.327973762085, 6733.293004234582, 6806.217285012287, 6828.829279267959, 6835.726570937206, 6836.794896153124, 6687.799366019027, 6762.526623136333, 6788.93211067883, 6796.694148763218, 6812.21659509143, 7591.924080759121, 7660.80847978805, 7718.266764657348, 7738.535687858522, 7738.613069346397, 7854.803629909298, 7912.4856884302335, 7917.366610671248, 7927.722529711433, 7937.523748575104, 5902.1146827976145, 5949.6430214187285, 6343.11196432509, 6346.809595712136, 6369.87260254783, 6818.249992500721, 6855.314468553105, 6864.656767161722, 6869.519133660596, 6882.208546017272, 6312.3687631238345, 6383.904241436289, 6455.386738259858, 6500.154979852589, 6506.089147519446, 6256.343083976299, 6313.1477250572425, 6318.715657795502, 6378.840528986627, 6409.9038514423255, 6473.158489396348, 6487.967560162169, 6490.993895946136, 6491.935080649133, 6500.959846424549, 5690.231818704588, 5847.678377689268, 5886.735096920564, 5891.823245302648, 5898.616589921641, 5992.280926288873, 6016.947034269073, 6034.24571928509, 6037.667928263988, 6044.516438684983], "ext.html": [518.3857129301778, 518.5229588778326, 522.3001178420915, 528.5533724003218, 543.5868739757783, 27468.17595472134, 29178.0, 29315.0, 35631.0, 36359.0, 38712.419313710314, 39103.60896391035, 39105.80447097767, 39156.80421597888, 39494.80252598733, 8438.535880526584, 8625.396222264444, 8637.611307491177, 8652.091530389313, 8664.176903194186, 7638.847223055535, 7840.255175758322, 10161.796764064715, 10383.325083869524, 10394.896051039506, 10120.544575494083, 10249.84625230622, 10261.076503114718, 10268.178545716324, 10339.172866170687, 7625.6568454419685, 7813.296803287732, 10001.399916005026, 10109.241806864478, 10125.240606954434, 10086.596536138546, 10315.587376504931, 10365.170786337076, 10365.429901355423, 10444.63443779464, 36240.81879590585, 36473.08817279563, 36542.45186322207, 36572.63427365719, 36725.26549468996, 2811.339335256213, 2949.7050294970545, 2991.760659147263, 3192.9042128736173, 3285.802851828874, 25284.786701839763, 25507.872460637576, 25697.614535781977, 26233.081842135434, 26798.33004174892, 2129.7337832770904, 2195.2536137713096, 2223.1663126327626, 2273.886305684726, 2360.634101714237, 261944.0, 263695.0, 264324.0, 265149.0, 266392.0, 45045.774771125936, 46844.297335539995, 53369.0, 57680.423195768344, 58963.705181473815, 54387.72806135944, 54642.0, 54692.72653636707, 54696.0, 54829.45170548323, 15292.158931258888, 15443.227838608025, 15445.459408920633, 15455.690886182214, 15542.766858497132, 11803.819618038127, 11846.466908989116, 11861.169718119821, 11939.343336116597, 12006.759864802654, 17366.305347785947, 17536.912315438596, 17563.0, 17593.208305626278, 17600.64798704019, 7304.085201080926, 7552.471327007167, 7569.5079819811535, 7574.242575742382, 7599.924000760032, 873.1617647058895, 912.808310254854, 916.935814492979, 998.4109375468363, 1015.8476228565775, 26134.58373812862, 26279.0, 26593.867030664722, 26653.0, 26833.731662683513, 947.3699989507038, 954.8519979403064, 962.8459446488528, 971.4608392342177, 1029.2383636109225, 12167.026637869127, 12178.330191839534, 12209.93895030537, 12277.263364197997, 12325.876741232652, 310843.0, 314301.0, 317970.0, 319983.0, 320284.0, 47697.0, 48018.5198148014, 48117.75941120272, 48128.75935620369, 48579.757101214265, 1253.5048655780915, 1262.9179103358251, 1268.6828292926768, 1269.8666640002853, 1274.0444666500125, 23877.28368148958, 24506.0, 24668.87665561661, 24706.50586988214, 24717.629235561122, 38760.418593720555, 39585.406218907316, 42511.0, 43227.78386108049, 45512.0, 191236.0, 192243.0, 192579.0, 194087.0, 194772.0, 27324.0, 27351.86324068367, 27367.863160684068, 27417.31456713598, 27647.723522764514, 30513.694863051085, 30786.0, 32681.836590817846, 36352.0, 37611.43582846205, 29004.0, 29623.407531849673, 29637.85181074081, 29751.25621859471, 29922.25194370158, 28953.85523072371, 28978.0, 29085.272868178465, 29220.123396298146, 29228.43480778223, 29719.702802971693, 29906.551401729426, 29920.700792992662, 30203.0, 32122.678773212905, 29321.41357172802, 29580.704192957794, 31037.8448107758, 31042.53436198504, 31143.22141946379, 21790.891045545304, 21811.781882180974, 22392.529157980538, 22430.551388972457, 22452.0], "prototype.html": [294.5463985462388, 301.1762828663606, 304.4611038461922, 305.13494243818775, 309.30560890800155, 5527.474889885464, 5616.719164041791, 5637.182608521767, 5669.433056694328, 5747.080467125261, 5460.235567020621, 5549.6115271930985, 5560.555155587554, 5642.57680673949, 5687.7156142192935, 4254.893627659302, 4269.2955662315835, 4275.187714334282, 4292.205941900743, 4307.806148723299, 4206.369044643313, 4215.241256573816, 4287.635550978171, 4289.335153051282, 4324.135172965403, 4246.2993606055115, 4286.849960251392, 4291.9570804292025, 4293.914121717564, 4333.285007973681, 4248.745075295461, 4279.309672679306, 4302.0, 4323.243432399333, 4341.674374421931, 3711.0536813112753, 3721.162738383869, 3739.326921154191, 3742.4760533525327, 3757.1358587525024, 5290.867728306785, 5463.043967305745, 5473.945260547383, 5478.698671573062, 5510.6969116698565, 4934.383202099738, 4938.80244790208, 4948.90102197954, 4953.306537084811, 4960.404751429815, 5954.8809023819285, 5961.046232602806, 5975.940240597625, 5977.820665380002, 5990.430909063632, 3930.8820735377985, 3983.207556599542, 3989.142334398089, 3999.200159968018, 4122.381642753581, 6066.120412540157, 6112.327643959161, 6123.5407344448895, 6133.6626485543275, 6173.629582225081, 4115.691323150776, 4130.173965206971, 4135.958640413617, 4138.089620283533, 4143.56492568282, 4173.937390939138, 4183.393407955829, 4189.748615083105, 4196.265653510623, 4206.26390381682, 4737.194676904935, 4887.3890763654545, 4891.779869905863, 4895.559399653977, 4912.582430493448, 5939.554533410012, 5969.2240008799445, 5975.133605627159, 5977.551683623746, 6010.0083486224285, 1521.4903007492615, 1541.768734689783, 1544.2664734251366, 1549.651328451112, 1564.092826160824, 993.2004736187439, 1007.0282177698556, 1008.2387797213204, 1025.610268098118, 1033.6227277043824, 5615.831525054255, 5637.295338082739, 5653.604247702704, 5674.687892165971, 5705.400932902068, 6173.0, 6181.258249010148, 6185.443310102112, 6196.0, 6258.0, 5625.128105143709, 5633.57748168889, 5642.943570564324, 5650.29371328584, 5680.403557626472, 3309.7352211823477, 3415.9146021349666, 3434.244466217428, 3435.124043368925, 3441.3117376524297, 6226.875462490815, 6235.96882015587, 6250.499960003189, 6287.245530536365, 6291.276503202191, 6355.173827402408, 6367.140436041168, 6370.458511026614, 6370.936290637127, 6429.7749578764515, 6040.909386359208, 6197.225346831646, 6214.067889816473, 6261.655608941461, 6266.467350275278, 6176.104464852661, 6186.5360097993735, 6214.8135555933395, 6221.191245138103, 6243.282022567463, 5876.706164691663, 6000.429959153874, 6016.759329626766, 6069.666168360783, 6126.479249263863, 6172.753089876354, 6214.067889816563, 6280.528960328085, 6299.401556852092, 6299.590526615755, 4197.790110494524, 4200.15996800635, 4205.642520385802, 4207.053412982054, 4257.680673949404, 5980.312264089685, 6119.694015299128, 6134.601250918676, 6148.569600128127, 6200.689965501797, 5994.6403215807195, 6081.543884208791, 6088.782243551396, 6091.9086213707715, 6101.420365065312, 6048.183495228088, 6054.152418661303, 6056.424639659225, 6091.817245482643, 6124.142620033288, 5726.226959360433, 5915.0, 5921.5558833086825, 5941.1385349125, 5946.226990491208, 6053.424924632153, 6066.939330606638, 6074.483668888194, 6085.939140608714, 6088.0, 5925.792597259076, 5930.347661757117, 5936.821895343147, 5955.434233747787, 5974.551908606785], "yui.html": [645.8869697802884, 678.0947435174039, 694.607546736094, 707.4764674141134, 710.7405796884136, 12492.250464972109, 12752.808707869377, 12758.744825103504, 12762.55331063413, 12768.489260429571, 11892.7621447571, 11938.582149624764, 11967.64097077089, 12047.51809927604, 12052.337121458317, 640.1805688718424, 657.8815813153631, 658.4732214228621, 804.3324041045947, 810.8459392715365, 819.8278361544053, 822.9753107406757, 836.4730219961447, 838.0822998816286, 838.1283465196219, 857.5412154497345, 866.1771317248607, 873.3406278259905, 875.1598465473154, 876.8947726272856, 665.0257372948629, 684.8219462939621, 844.1010324004915, 851.3742399336483, 862.3704695572204, 637.9681015949184, 640.3276559612389, 642.9935700642981, 644.230144976753, 644.9613023218575, 12132.332721700302, 12290.111823721418, 12311.076669249842, 12321.630351089481, 12323.383830808423, 8028.759137225892, 8402.747917562421, 9199.080091990814, 10400.947995259976, 11319.094472442184, 7968.681252749883, 8146.185381461865, 8167.877481837777, 8197.590120494011, 8237.093919668832, 2655.3892604701027, 2665.586834040727, 2687.9803502099667, 2779.4580056888913, 2833.8016338856287, 39831.0, 39936.0, 40029.39955900635, 40096.39855402171, 40216.19567608632, 5649.604527683023, 5804.129380592861, 5887.8233652990475, 5919.0, 6017.518598512109, 9892.950535247277, 9910.752231194278, 9914.157296629868, 9936.602535898628, 10012.998700130074, 5498.945010549924, 5683.6643388803595, 5729.627574207747, 5737.3115226172295, 5890.9410905891245, 3372.51248711644, 3458.6368431314854, 3507.263474670297, 3562.1806984393734, 3573.446115852047, 2450.816188785848, 2473.6042233242597, 2481.044797752878, 2481.243220817668, 2488.390344365642, 376.93780526213413, 378.7935575111571, 382.4053596657169, 384.5231912428624, 384.88261080370756, 497.34847349971653, 536.257283662123, 547.8630342414397, 550.0758725341465, 577.4168090228899, 7125.144982602121, 7205.747798827016, 7236.855262894713, 7270.600116993616, 7350.264973502607, 463.6962789372966, 524.1482590789966, 524.1718085425019, 526.4104203292337, 536.7851324383554, 3204.1669166017004, 3794.3739283017994, 3810.1427178885083, 3854.9614503855164, 3879.650831425185, 51996.22005669918, 52884.47115528795, 55006.0, 56081.0, 56895.146572801445, 47128.5287147131, 47400.0, 47457.28814067792, 47566.0, 47772.28341574879, 43504.347434788506, 43830.34254486185, 43970.78014610035, 44315.77842110769, 44563.554364455944, 7351.8162045949275, 7567.772966811004, 7613.428992825671, 7648.61756912141, 7653.846923061396, 30047.69952300449, 30930.0, 31601.20996975094, 32035.35929281448, 33544.32911341808, 40231.59768402279, 40461.393079104426, 40537.59462405338, 40981.590184097775, 42522.57477425186, 6606.108175396452, 6638.970959501285, 6793.762218322335, 6804.591724496546, 7058.329458701415, 9969.50152492387, 10067.647632332833, 10075.19398448137, 10278.229132814919, 10368.170546356123, 9244.399114057565, 9327.86008209891, 9379.34344595899, 9689.273304502332, 10267.84598231042, 9278.381282081977, 9281.62873485053, 9440.716778496657, 9641.325107242426, 10004.349717268355, 9229.907700923173, 9344.626214951597, 9497.715068547956, 9597.376170548892, 10155.492225388849, 7307.0, 7575.242475752601, 7576.7348142814735, 7804.843903121792, 8249.752507424786, 7088.291170882871, 7485.850282994418, 7531.133919599316, 7793.688252469838, 8163.061247956561]}, "summary": {"suite": 6023.384288125136, "subtests": {"jquery.html": {"filtered": 6127.636703532483, "value": 6127.636703532483}, "dojo.html": {"filtered": 4882.4750825887895, "value": 4882.4750825887895}, "mootools.html": {"filtered": 4042.4370721596497, "value": 4042.4370721596497}, "ext.html": {"filtered": 16724.709834975227, "value": 16724.709834975227}, "prototype.html": {"filtered": 4486.564716774392, "value": 4486.564716774392}, "yui.html": {"filtered": 5262.046143923628, "value": 5262.046143923628}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0008"}, "testrun": {"date": 1446484584, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151102071406", "branch": "Fx-Team", "revision": "74156ecb4a205ae76ff8b8ab82e0c1a6060dd9c8"}}, {"talos_counters": {}, "results": {"audio-dft": [173.0, 178.0, 179.0, 174.0, 175.0, 182.0, 182.0, 172.0, 182.0, 180.0], "ai-astar": [108.0, 108.0, 107.0, 111.0, 111.0, 108.0, 118.0, 110.0, 108.0, 113.0], "imaging-gaussian-blur": [135.0, 136.0, 134.0, 131.0, 129.0, 129.0, 132.0, 130.0, 136.0, 136.0], "audio-beat-detection": [166.0, 145.0, 169.0, 195.0, 163.0, 166.0, 163.0, 140.0, 172.0, 144.0], "json-stringify-tinderbox": [69.0, 70.0, 71.0, 74.0, 75.0, 76.0, 76.0, 74.0, 72.0, 71.0], "stanford-crypto-pbkdf2": [147.0, 167.0, 165.0, 165.0, 163.0, 147.0, 166.0, 164.0, 153.0, 158.0], "json-parse-financial": [57.0, 59.0, 65.0, 61.0, 65.0, 64.0, 64.0, 73.0, 64.0, 66.0], "stanford-crypto-sha256-iterative": [72.0, 75.0, 78.0, 79.0, 80.0, 78.0, 79.0, 78.0, 80.0, 75.0], "audio-fft": [77.0, 85.0, 100.0, 95.0, 75.0, 80.0, 77.0, 88.0, 91.0, 72.0], "imaging-darkroom": [141.0, 141.0, 137.0, 135.0, 141.0, 141.0, 137.0, 135.0, 141.0, 141.0], "stanford-crypto-ccm": [137.0, 148.0, 136.0, 136.0, 146.0, 143.0, 139.0, 155.0, 135.0, 137.0], "audio-oscillator": [105.0, 105.0, 149.0, 99.0, 102.0, 99.0, 143.0, 95.0, 96.0, 147.0], "stanford-crypto-aes": [92.0, 95.0, 97.0, 95.0, 96.0, 95.0, 95.0, 97.0, 97.0, 94.0], "imaging-desaturate": [111.0, 114.0, 112.0, 113.0, 114.0, 113.0, 108.0, 114.0, 113.0, 114.0]}, "summary": {"suite": 1642.6, "subtests": {"audio-fft": {"filtered": 84.0, "value": 84.0}, "stanford-crypto-pbkdf2": {"filtered": 159.5, "value": 159.5}, "audio-beat-detection": {"filtered": 162.3, "value": 162.3}, "stanford-crypto-ccm": {"filtered": 141.2, "value": 141.2}, "imaging-darkroom": {"filtered": 139.0, "value": 139.0}, "json-parse-financial": {"filtered": 63.8, "value": 63.8}, "audio-oscillator": {"filtered": 114.0, "value": 114.0}, "ai-astar": {"filtered": 110.2, "value": 110.2}, "audio-dft": {"filtered": 177.7, "value": 177.7}, "stanford-crypto-sha256-iterative": {"filtered": 77.4, "value": 77.4}, "json-stringify-tinderbox": {"filtered": 72.8, "value": 72.8}, "imaging-gaussian-blur": {"filtered": 132.8, "value": 132.8}, "stanford-crypto-aes": {"filtered": 95.3, "value": 95.3}, "imaging-desaturate": {"filtered": 112.6, "value": 112.6}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0008"}, "testrun": {"date": 1446484584, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151102071406", "branch": "Fx-Team", "revision": "74156ecb4a205ae76ff8b8ab82e0c1a6060dd9c8"}}, {"talos_counters": {}, "results": {"DeltaBlue": [210.43771043771045], "Encrypt": [351.12359550561797], "NavierStokes": [6281.25], "Decrypt": [6223.60248447205], "Splay": [681.6632583503749], "Richards": [171.43836790673754], "RegExp": [31937.5], "Earley": [1043.8413361169103], "Boyer": [13743.243243243243], "RayTrace": [2237.136465324385]}, "summary": {"suite": 16818.446003304532, "subtests": {"DeltaBlue": {"filtered": 314.1927359999999, "value": 314.1927359999999}, "Encrypt": {"filtered": 758.083488, "value": 758.083488}, "NavierStokes": {"filtered": 236.25870646766182, "value": 236.25870646766182}, "Decrypt": {"filtered": 42.76960179640721, "value": 42.76960179640721}, "Splay": {"filtered": 119.547297, "value": 119.547297}, "RegExp": {"filtered": 28.523992172211365, "value": 28.523992172211365}, "Richards": {"filtered": 205.91656600000005, "value": 205.91656600000005}, "Earley": {"filtered": 638.471554, "value": 638.471554}, "Boyer": {"filtered": 48.493866273352964, "value": 48.493866273352964}, "RayTrace": {"filtered": 330.775083, "value": 330.775083}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0008"}, "testrun": {"date": 1446484584, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151102071406", "branch": "Fx-Team", "revision": "74156ecb4a205ae76ff8b8ab82e0c1a6060dd9c8"}}] 09:36:37 INFO - RETURN: dromaeo_css: 6023.39 09:36:37 INFO - RETURN: kraken: 1642.60 09:36:37 INFO - RETURN: v8_7: 16818.45 09:36:37 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,55]]", "result": "16818.45"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,55]]", "result": "1642.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,55]]", "result": "6023.39"}}} 09:36:37 INFO - Return code: 0 09:36:37 INFO - # TBPL SUCCESS # 09:36:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:36:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:36:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:36:37 INFO - 2015-11-02 09:36:37.376 screenresolution[1655:9867] starting screenresolution argv=screenresolution get 09:36:37 INFO - 2015-11-02 09:36:37.379 screenresolution[1655:9867] Display 0: 1600x1200x32@60 09:36:37 INFO - 2015-11-02 09:36:37.385 screenresolution[1656:9870] starting screenresolution argv=screenresolution list 09:36:37 INFO - Available Modes on Display 0 09:36:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:36:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:36:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:36:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:36:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:36:37 INFO - Intel HD Graphics 3000: 09:36:37 INFO - Chipset Model: Intel HD Graphics 3000 09:36:37 INFO - Type: GPU 09:36:37 INFO - Bus: Built-In 09:36:37 INFO - VRAM (Total): 512 MB 09:36:37 INFO - VRAM (Dynamic, Max): 10 09:36:37 INFO - Vendor: Intel (0x8086) 09:36:37 INFO - Device ID: 0x0116 09:36:37 INFO - Revision ID: 0x0009 09:36:37 INFO - Displays: 09:36:37 INFO - Display: 09:36:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:36:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:36:37 INFO - Display Serial Number: 1600x1200 60 09:36:37 INFO - Main Display: Yes 09:36:37 INFO - Mirror: Off 09:36:37 INFO - Online: Yes 09:36:37 INFO - Rotation: Supported 09:36:37 INFO - Return code: 0 09:36:37 INFO - Running post-action listener: _resource_record_post_action 09:36:37 INFO - Running post-run listener: _resource_record_post_run 09:36:38 INFO - Total resource usage - Wall time: 1253s; CPU: 30.0%; Read bytes: 39314432; Write bytes: 684967936; Read time: 5582; Write time: 47423 09:36:38 INFO - install - Wall time: 39s; CPU: 30.0%; Read bytes: 342645248; Write bytes: 343816192; Read time: 34620; Write time: 5011 09:36:38 INFO - run-tests - Wall time: 1214s; CPU: 30.0%; Read bytes: 37008384; Write bytes: 339865600; Read time: 5055; Write time: 42396 09:36:38 INFO - Running post-run listener: _upload_blobber_files 09:36:38 INFO - Blob upload gear active. 09:36:38 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 09:36:38 INFO - Copying logs to upload dir... 09:36:38 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1310.598032 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 50 secs) (at 2015-11-02 09:36:38.828788) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-02 09:36:38.832638) ========= 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.VlItKxa9pK/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.w3lwqQKaCy/Listeners TMPDIR=/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/QCbBN9c2TzSw7hibfAvTug/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010104 build_url: 'https://queue.taskcluster.net/v1/task/QCbBN9c2TzSw7hibfAvTug/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-02 09:36:38.858532) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 09:36:38.860919) ========= 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.VlItKxa9pK/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.w3lwqQKaCy/Listeners TMPDIR=/var/folders/34/flcqp4795z1_0jwq28z22ctc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005460 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 09:36:38.913738) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-02 09:36:38.914183) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-02 09:36:38.914728) ========= ========= Total master_lag: 0.26 =========