builder: fx-team_yosemite_test-dromaeojs-e10s slave: t-yosemite-r5-0052 starttime: 1447091064.88 results: success (0) buildid: 20151109064656 builduid: 761b8c65f74741358c58aee9e196c46d revision: a02cf2019a51f59e1eb712ab3d306f70c86808c0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-09 09:44:24.879428) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-09 09:44:24.879920) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-09 09:44:24.880263) ========= 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.PKT1zRx2xT/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.ax09RrBbVM/Listeners TMPDIR=/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/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.006015 basedir: '/builds/slave/test' ========= master_lag: 0.33 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-09 09:44:25.215353) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-09 09:44:25.215708) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-09 09:44:25.249312) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 09:44:25.249792) ========= 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.PKT1zRx2xT/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.ax09RrBbVM/Listeners TMPDIR=/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/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.017672 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 09:44:25.299378) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-09 09:44:25.299782) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-09 09:44:25.300239) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 09:44:25.300595) ========= 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.PKT1zRx2xT/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.ax09RrBbVM/Listeners TMPDIR=/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/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-09 09:44:25-- 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.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% 33.2M=0s 2015-11-09 09:44:25 (33.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.223538 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 09:44:25.540702) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 09:44:25.541060) ========= 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.PKT1zRx2xT/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.ax09RrBbVM/Listeners TMPDIR=/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/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.135896 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 09:44:25.709854) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 09:44:25.710329) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a02cf2019a51f59e1eb712ab3d306f70c86808c0 --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 a02cf2019a51f59e1eb712ab3d306f70c86808c0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.PKT1zRx2xT/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.ax09RrBbVM/Listeners TMPDIR=/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/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-09 09:44:25,797 truncating revision to first 12 chars 2015-11-09 09:44:25,797 Setting DEBUG logging. 2015-11-09 09:44:25,797 attempt 1/10 2015-11-09 09:44:25,797 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a02cf2019a51?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-09 09:44:26,065 unpacking tar archive at: fx-team-a02cf2019a51/testing/mozharness/ program finished with exit code 0 elapsedTime=0.527848 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 09:44:26.258001) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-09 09:44:26.258381) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-09 09:44:26.272598) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-09 09:44:26.273038) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-09 09:44:26.273624) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 47 secs) (at 2015-11-09 09:44:26.273986) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.PKT1zRx2xT/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.ax09RrBbVM/Listeners TMPDIR=/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/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:44:26 INFO - MultiFileLogger online at 20151109 09:44:26 in /builds/slave/test 09:44:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 09:44:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:44:26 INFO - {'append_to_log': False, 09:44:26 INFO - 'base_work_dir': '/builds/slave/test', 09:44:26 INFO - 'blob_upload_branch': 'Fx-Team', 09:44:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:44:26 INFO - 'branch': 'Fx-Team', 09:44:26 INFO - 'buildbot_json_path': 'buildprops.json', 09:44:26 INFO - 'config_files': ('talos/mac_config.py',), 09:44:26 INFO - 'default_actions': ('clobber', 09:44:26 INFO - 'read-buildbot-config', 09:44:26 INFO - 'download-and-extract', 09:44:26 INFO - 'populate-webroot', 09:44:26 INFO - 'create-virtualenv', 09:44:26 INFO - 'install', 09:44:26 INFO - 'run-tests'), 09:44:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:44:26 INFO - 'download_minidump_stackwalk': True, 09:44:26 INFO - 'download_symbols': 'ondemand', 09:44:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:44:26 INFO - 'tooltool.py': '/tools/tooltool.py', 09:44:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:44:26 INFO - '/tools/misc-python/virtualenv.py')}, 09:44:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:44:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:44:26 INFO - 'installer_path': 'installer.exe', 09:44:26 INFO - 'log_level': 'info', 09:44:26 INFO - 'log_name': 'talos', 09:44:26 INFO - 'log_to_console': True, 09:44:26 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:44:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:44:26 INFO - 'opt_config_files': (), 09:44:26 INFO - 'pip_index': False, 09:44:26 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:44:26 INFO - 'cmd': ('bash', 09:44:26 INFO - '-c', 09:44:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:44:26 INFO - 'enabled': True, 09:44:26 INFO - 'halt_on_failure': False, 09:44:26 INFO - 'name': 'check_screen_resolution'},), 09:44:26 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:44:26 INFO - 'cmd': ('bash', 09:44:26 INFO - '-c', 09:44:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:44:26 INFO - 'enabled': True, 09:44:26 INFO - 'halt_on_failure': False, 09:44:26 INFO - 'name': 'check_screen_resolution'},), 09:44:26 INFO - 'run_cmd_checks_enabled': True, 09:44:26 INFO - 'sps_profile': False, 09:44:26 INFO - 'sps_profile_interval': 0, 09:44:26 INFO - 'suite': 'dromaeojs-e10s', 09:44:26 INFO - 'system_bits': '64', 09:44:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:44:26 INFO - 'title': 't-yosemite-r5-0052', 09:44:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:44:26 INFO - 'use_talos_json': True, 09:44:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:44:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:44:26 INFO - 'work_dir': 'build'} 09:44:26 INFO - ##### 09:44:26 INFO - ##### Running clobber step. 09:44:26 INFO - ##### 09:44:26 INFO - Running pre-action listener: _resource_record_pre_action 09:44:26 INFO - Running main action method: clobber 09:44:26 INFO - rmtree: /builds/slave/test/build 09:44:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:44:30 INFO - Running post-action listener: _resource_record_post_action 09:44:30 INFO - ##### 09:44:30 INFO - ##### Running read-buildbot-config step. 09:44:30 INFO - ##### 09:44:30 INFO - Running pre-action listener: _resource_record_pre_action 09:44:30 INFO - Running main action method: read_buildbot_config 09:44:30 INFO - Using buildbot properties: 09:44:30 INFO - { 09:44:30 INFO - "properties": { 09:44:30 INFO - "buildnumber": 20, 09:44:30 INFO - "product": "firefox", 09:44:30 INFO - "script_repo_revision": "production", 09:44:30 INFO - "builddir": "fx-team_yosemite_test-dromaeojs-e10s", 09:44:30 INFO - "repository": "", 09:44:30 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 fx-team talos dromaeojs-e10s", 09:44:30 INFO - "buildid": "20151109064656", 09:44:30 INFO - "slavename": "t-yosemite-r5-0052", 09:44:30 INFO - "pgo_build": "False", 09:44:30 INFO - "basedir": "/builds/slave/test", 09:44:30 INFO - "project": "", 09:44:30 INFO - "platform": "yosemite", 09:44:30 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 09:44:30 INFO - "slavebuilddir": "test", 09:44:30 INFO - "scheduler": "tests-fx-team-macosx64-talos", 09:44:30 INFO - "branch": "fx-team", 09:44:30 INFO - "repo_path": "integration/fx-team", 09:44:30 INFO - "stage_platform": "macosx64", 09:44:30 INFO - "builduid": "761b8c65f74741358c58aee9e196c46d", 09:44:30 INFO - "revision": "a02cf2019a51f59e1eb712ab3d306f70c86808c0" 09:44:30 INFO - }, 09:44:30 INFO - "sourcestamp": { 09:44:30 INFO - "repository": "", 09:44:30 INFO - "hasPatch": false, 09:44:30 INFO - "project": "", 09:44:30 INFO - "branch": "fx-team-macosx64-talos", 09:44:30 INFO - "changes": [ 09:44:30 INFO - { 09:44:30 INFO - "category": null, 09:44:30 INFO - "files": [ 09:44:30 INFO - { 09:44:30 INFO - "url": null, 09:44:30 INFO - "name": "https://queue.taskcluster.net/v1/task/vm0kCyZpQ-Kv_wn5ZIxzjg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 09:44:30 INFO - } 09:44:30 INFO - ], 09:44:30 INFO - "repository": "", 09:44:30 INFO - "rev": "a02cf2019a51f59e1eb712ab3d306f70c86808c0", 09:44:30 INFO - "who": "cbook@mozilla.com", 09:44:30 INFO - "when": 1447091013, 09:44:30 INFO - "number": 6638007, 09:44:30 INFO - "comments": "Bug 1160379 - Annotate relevant tests for --tag devtools-memory. r=jsantell", 09:44:30 INFO - "project": "", 09:44:30 INFO - "at": "Mon 09 Nov 2015 09:43:33", 09:44:30 INFO - "branch": "fx-team-macosx64-talos", 09:44:30 INFO - "revlink": "", 09:44:30 INFO - "properties": [ 09:44:30 INFO - [ 09:44:30 INFO - "buildid", 09:44:30 INFO - "20151109064656", 09:44:30 INFO - "Change" 09:44:30 INFO - ], 09:44:30 INFO - [ 09:44:30 INFO - "builduid", 09:44:30 INFO - "761b8c65f74741358c58aee9e196c46d", 09:44:30 INFO - "Change" 09:44:30 INFO - ], 09:44:30 INFO - [ 09:44:30 INFO - "pgo_build", 09:44:30 INFO - "False", 09:44:30 INFO - "Change" 09:44:30 INFO - ] 09:44:30 INFO - ], 09:44:30 INFO - "revision": "a02cf2019a51f59e1eb712ab3d306f70c86808c0" 09:44:30 INFO - } 09:44:30 INFO - ], 09:44:30 INFO - "revision": "a02cf2019a51f59e1eb712ab3d306f70c86808c0" 09:44:30 INFO - } 09:44:30 INFO - } 09:44:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/vm0kCyZpQ-Kv_wn5ZIxzjg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 09:44:30 INFO - Running post-action listener: _resource_record_post_action 09:44:30 INFO - ##### 09:44:30 INFO - ##### Running download-and-extract step. 09:44:30 INFO - ##### 09:44:30 INFO - Running pre-action listener: _resource_record_pre_action 09:44:30 INFO - Running main action method: download_and_extract 09:44:30 INFO - mkdir: /builds/slave/test/build/tests 09:44:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:30 INFO - https://queue.taskcluster.net/v1/task/vm0kCyZpQ-Kv_wn5ZIxzjg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:44:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vm0kCyZpQ-Kv_wn5ZIxzjg/artifacts/public/build/test_packages.json 09:44:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vm0kCyZpQ-Kv_wn5ZIxzjg/artifacts/public/build/test_packages.json 09:44:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vm0kCyZpQ-Kv_wn5ZIxzjg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 09:44:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vm0kCyZpQ-Kv_wn5ZIxzjg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 09:44:37 INFO - Downloaded 1149 bytes. 09:44:37 INFO - Reading from file /builds/slave/test/build/test_packages.json 09:44:37 INFO - Using the following test package requirements: 09:44:37 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 09:44:37 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 09:44:37 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 09:44:37 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 09:44:37 INFO - u'jsshell-mac.zip'], 09:44:37 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 09:44:37 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 09:44:37 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 09:44:37 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 09:44:37 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 09:44:37 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 09:44:37 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 09:44:37 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 09:44:37 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 09:44:37 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 09:44:37 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 09:44:37 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 09:44:37 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:44:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:37 INFO - https://queue.taskcluster.net/v1/task/vm0kCyZpQ-Kv_wn5ZIxzjg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:44:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vm0kCyZpQ-Kv_wn5ZIxzjg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 09:44:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vm0kCyZpQ-Kv_wn5ZIxzjg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 09:44:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vm0kCyZpQ-Kv_wn5ZIxzjg/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:44:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vm0kCyZpQ-Kv_wn5ZIxzjg/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:44:48 INFO - Downloaded 17436565 bytes. 09:44:48 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:44:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 09:44:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 09:44:53 INFO - Return code: 0 09:44:53 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:44:53 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:44:53 INFO - https://queue.taskcluster.net/v1/task/vm0kCyZpQ-Kv_wn5ZIxzjg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:44:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vm0kCyZpQ-Kv_wn5ZIxzjg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 09:44:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vm0kCyZpQ-Kv_wn5ZIxzjg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 09:44:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vm0kCyZpQ-Kv_wn5ZIxzjg/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:44:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vm0kCyZpQ-Kv_wn5ZIxzjg/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:44:55 INFO - Downloaded 17436565 bytes. 09:44:55 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:44:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 09:44:55 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 09:45:01 INFO - Return code: 0 09:45:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:01 INFO - https://queue.taskcluster.net/v1/task/vm0kCyZpQ-Kv_wn5ZIxzjg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:45:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vm0kCyZpQ-Kv_wn5ZIxzjg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 09:45:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vm0kCyZpQ-Kv_wn5ZIxzjg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 09:45:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vm0kCyZpQ-Kv_wn5ZIxzjg/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:45:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vm0kCyZpQ-Kv_wn5ZIxzjg/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:45:03 INFO - Downloaded 11131618 bytes. 09:45:03 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:45:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 09:45:03 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 09:45:03 INFO - Return code: 0 09:45:03 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:45:03 INFO - https://queue.taskcluster.net/v1/task/vm0kCyZpQ-Kv_wn5ZIxzjg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 09:45:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vm0kCyZpQ-Kv_wn5ZIxzjg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 09:45:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vm0kCyZpQ-Kv_wn5ZIxzjg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 09:45:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vm0kCyZpQ-Kv_wn5ZIxzjg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 09:45:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vm0kCyZpQ-Kv_wn5ZIxzjg/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:45:07 INFO - Downloaded 108652023 bytes. 09:45:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/vm0kCyZpQ-Kv_wn5ZIxzjg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 09:45:07 INFO - mkdir: /builds/slave/test/properties 09:45:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:45:07 INFO - Writing to file /builds/slave/test/properties/build_url 09:45:07 INFO - Contents: 09:45:07 INFO - build_url:https://queue.taskcluster.net/v1/task/vm0kCyZpQ-Kv_wn5ZIxzjg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 09:45:07 INFO - Running post-action listener: _resource_record_post_action 09:45:07 INFO - Running post-action listener: set_extra_try_arguments 09:45:07 INFO - ##### 09:45:07 INFO - ##### Running populate-webroot step. 09:45:07 INFO - ##### 09:45:07 INFO - Running pre-action listener: _resource_record_pre_action 09:45:07 INFO - Running main action method: populate_webroot 09:45:07 INFO - Guessing talos json url... 09:45:07 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:45:07 INFO - https://queue.taskcluster.net/v1/task/vm0kCyZpQ-Kv_wn5ZIxzjg/artifacts/public/build/firefox-45.0a1.en-US.mac.txt matches https://queue.taskcluster.net 09:45:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vm0kCyZpQ-Kv_wn5ZIxzjg/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 09:45:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vm0kCyZpQ-Kv_wn5ZIxzjg/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 09:45:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vm0kCyZpQ-Kv_wn5ZIxzjg/artifacts/public/build/firefox-45.0a1.en-US.mac.txt to /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 09:45:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vm0kCyZpQ-Kv_wn5ZIxzjg/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:45:08 INFO - Downloaded 103 bytes. 09:45:08 INFO - Reading from file /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 09:45:08 INFO - Contents: 09:45:08 INFO - 20151109064656 09:45:08 INFO - https://hg.mozilla.org/integration/fx-team/rev/a02cf2019a51f59e1eb712ab3d306f70c86808c0 09:45: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:45:08 INFO - trying https://hg.mozilla.org/integration/fx-team/raw-file/a02cf2019a/testing/talos/talos.json 09:45:08 INFO - Downloading https://hg.mozilla.org/integration/fx-team/raw-file/a02cf2019a/testing/talos/talos.json to /builds/slave/test/build/talos.json 09:45:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/integration/fx-team/raw-file/a02cf2019a/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 09:45:08 INFO - Downloaded 4206 bytes. 09:45:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:45:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:45:08 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 09:45:08 INFO - '../fennec_ids.txt'], 09:45:08 INFO - 'tests': ['tcheck2']}, 09:45:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:45:08 INFO - '--tppagecycles', 09:45:08 INFO - '7'], 09:45:08 INFO - 'tests': ['tsvgm']}}, 09:45:08 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:45:08 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:45:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:45:08 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:45:08 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:45:08 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:45:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:45:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:08 INFO - 'talos_options': ['--e10s'], 09:45:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:45:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:08 INFO - 'tests': ['damp', 'tps']}, 09:45:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:08 INFO - 'talos_options': ['--e10s'], 09:45:08 INFO - 'tests': ['damp', 'tps']}, 09:45:08 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:45:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:45:08 INFO - 'other': {'tests': ['a11yr', 09:45:08 INFO - 'ts_paint', 09:45:08 INFO - 'tpaint', 09:45:08 INFO - 'sessionrestore', 09:45:08 INFO - 'sessionrestore_no_auto_restore']}, 09:45:08 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:45:08 INFO - 'tests': ['a11yr', 09:45:08 INFO - 'ts_paint', 09:45:08 INFO - 'tpaint', 09:45:08 INFO - 'sessionrestore', 09:45:08 INFO - 'sessionrestore_no_auto_restore']}, 09:45:08 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:45:08 INFO - 'tests': ['a11yr', 09:45:08 INFO - 'ts_paint', 09:45:08 INFO - 'tpaint', 09:45:08 INFO - 'sessionrestore', 09:45:08 INFO - 'sessionrestore_no_auto_restore']}, 09:45:08 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:45:08 INFO - 'tests': ['a11yr', 09:45:08 INFO - 'ts_paint', 09:45:08 INFO - 'tpaint', 09:45:08 INFO - 'sessionrestore', 09:45:08 INFO - 'sessionrestore_no_auto_restore']}, 09:45:08 INFO - 'other_l64': {'tests': ['a11yr', 09:45:08 INFO - 'ts_paint', 09:45:08 INFO - 'tpaint', 09:45:08 INFO - 'sessionrestore', 09:45:08 INFO - 'sessionrestore_no_auto_restore']}, 09:45:08 INFO - 'other_nol64': {'tests': ['a11yr', 09:45:08 INFO - 'ts_paint', 09:45:08 INFO - 'tpaint', 09:45:08 INFO - 'sessionrestore', 09:45:08 INFO - 'sessionrestore_no_auto_restore']}, 09:45:08 INFO - 'svgr': {'tests': ['tsvgx', 09:45:08 INFO - 'tsvgr_opacity', 09:45:08 INFO - 'tart', 09:45:08 INFO - 'tscrollx', 09:45:08 INFO - 'cart']}, 09:45:08 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:45:08 INFO - 'tests': ['tsvgx', 09:45:08 INFO - 'tsvgr_opacity', 09:45:08 INFO - 'tart', 09:45:08 INFO - 'tscrollx', 09:45:08 INFO - 'cart']}, 09:45:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:08 INFO - 'tests': ['tp5o']}, 09:45:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:08 INFO - 'talos_options': ['--e10s'], 09:45:08 INFO - 'tests': ['tp5o']}, 09:45:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:08 INFO - 'talos_options': ['--xperf_path', 09:45:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:45:08 INFO - 'tests': ['tp5n']}, 09:45:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:08 INFO - 'talos_options': ['--e10s', 09:45:08 INFO - '--xperf_path', 09:45:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:45:08 INFO - 'tests': ['tp5n']}}, 09:45:08 INFO - 'talos.zip': {'path': '', 09:45:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:45:08 INFO - Running post-action listener: _resource_record_post_action 09:45:08 INFO - ##### 09:45:08 INFO - ##### Running create-virtualenv step. 09:45:08 INFO - ##### 09:45:08 INFO - Running pre-action listener: _resource_record_pre_action 09:45:08 INFO - Running main action method: create_virtualenv 09:45:08 INFO - Creating virtualenv /builds/slave/test/build/venv 09:45:08 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:45:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:45:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:45:09 INFO - Using real prefix '/tools/python27' 09:45:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:45:10 INFO - Installing distribute.............................................................................................................................................................................................done. 09:45:13 INFO - Installing pip.................done. 09:45:13 INFO - Return code: 0 09:45:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:45:13 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:45:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:13 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:45:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:13 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 0x10fa54a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fac1228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4f156cf80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa099f0>, '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 0x10f768cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9d3990>, '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.PKT1zRx2xT/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.ax09RrBbVM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/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:45:13 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:45:13 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:45:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PKT1zRx2xT/Render', 09:45:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:13 INFO - 'HOME': '/Users/cltbld', 09:45:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:13 INFO - 'LOGNAME': 'cltbld', 09:45:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:13 INFO - 'MOZ_NO_REMOTE': '1', 09:45:13 INFO - 'NO_EM_RESTART': '1', 09:45:13 INFO - 'PAGER': '/bin/cat', 09:45:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:13 INFO - 'PWD': '/builds/slave/test', 09:45:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:13 INFO - 'SHELL': '/bin/bash', 09:45:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ax09RrBbVM/Listeners', 09:45:13 INFO - 'TMPDIR': '/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/', 09:45:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:13 INFO - 'USER': 'cltbld', 09:45:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:13 INFO - 'XPC_FLAGS': '0x0', 09:45:13 INFO - 'XPC_SERVICE_NAME': '0', 09:45:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:45:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:14 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:45:14 INFO - Cleaning up... 09:45:14 INFO - Return code: 0 09:45:14 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:45:14 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:45:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:14 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:45:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:14 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 0x10fa54a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fac1228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4f156cf80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa099f0>, '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 0x10f768cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9d3990>, '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.PKT1zRx2xT/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.ax09RrBbVM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/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:45:14 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:45:14 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:45:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PKT1zRx2xT/Render', 09:45:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:14 INFO - 'HOME': '/Users/cltbld', 09:45:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:14 INFO - 'LOGNAME': 'cltbld', 09:45:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:14 INFO - 'MOZ_NO_REMOTE': '1', 09:45:14 INFO - 'NO_EM_RESTART': '1', 09:45:14 INFO - 'PAGER': '/bin/cat', 09:45:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:14 INFO - 'PWD': '/builds/slave/test', 09:45:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:14 INFO - 'SHELL': '/bin/bash', 09:45:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ax09RrBbVM/Listeners', 09:45:14 INFO - 'TMPDIR': '/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/', 09:45:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:14 INFO - 'USER': 'cltbld', 09:45:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:14 INFO - 'XPC_FLAGS': '0x0', 09:45:14 INFO - 'XPC_SERVICE_NAME': '0', 09:45:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:45:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:14 INFO - Downloading/unpacking psutil>=0.7.1 09:45:14 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:45:14 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:45:14 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:45:14 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:45:14 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:45:14 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:45:17 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 09:45:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:45:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:45:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:45:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:45:17 INFO - Installing collected packages: psutil 09:45:17 INFO - Running setup.py install for psutil 09:45:17 INFO - building 'psutil._psutil_osx' extension 09:45:17 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:45:19 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:45:19 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:45:19 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:45:19 INFO - building 'psutil._psutil_posix' extension 09:45:19 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:45:19 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:45:19 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:45:19 INFO - ^ 09:45:20 INFO - 1 warning generated. 09:45:20 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:45:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:45:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:45:20 INFO - Successfully installed psutil 09:45:20 INFO - Cleaning up... 09:45:20 INFO - Return code: 0 09:45:20 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:45:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:20 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 0x10fa54a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fac1228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4f156cf80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa099f0>, '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 0x10f768cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9d3990>, '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.PKT1zRx2xT/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.ax09RrBbVM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/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:45:20 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:45:20 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:45:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PKT1zRx2xT/Render', 09:45:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:20 INFO - 'HOME': '/Users/cltbld', 09:45:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:20 INFO - 'LOGNAME': 'cltbld', 09:45:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:20 INFO - 'MOZ_NO_REMOTE': '1', 09:45:20 INFO - 'NO_EM_RESTART': '1', 09:45:20 INFO - 'PAGER': '/bin/cat', 09:45:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:20 INFO - 'PWD': '/builds/slave/test', 09:45:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:20 INFO - 'SHELL': '/bin/bash', 09:45:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ax09RrBbVM/Listeners', 09:45:20 INFO - 'TMPDIR': '/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/', 09:45:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:20 INFO - 'USER': 'cltbld', 09:45:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:20 INFO - 'XPC_FLAGS': '0x0', 09:45:20 INFO - 'XPC_SERVICE_NAME': '0', 09:45:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:45:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:20 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:45:20 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:45:20 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:45:20 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:45:20 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:45:20 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:45:20 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:45:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:45:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:45:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:45:23 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:45:23 INFO - Installing collected packages: mozsystemmonitor 09:45:23 INFO - Running setup.py install for mozsystemmonitor 09:45:23 INFO - Successfully installed mozsystemmonitor 09:45:23 INFO - Cleaning up... 09:45:23 INFO - Return code: 0 09:45:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:45:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:23 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 0x10fa54a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fac1228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4f156cf80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa099f0>, '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 0x10f768cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9d3990>, '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.PKT1zRx2xT/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.ax09RrBbVM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/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:45:23 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:45:23 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:45:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PKT1zRx2xT/Render', 09:45:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:23 INFO - 'HOME': '/Users/cltbld', 09:45:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:23 INFO - 'LOGNAME': 'cltbld', 09:45:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:23 INFO - 'MOZ_NO_REMOTE': '1', 09:45:23 INFO - 'NO_EM_RESTART': '1', 09:45:23 INFO - 'PAGER': '/bin/cat', 09:45:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:23 INFO - 'PWD': '/builds/slave/test', 09:45:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:23 INFO - 'SHELL': '/bin/bash', 09:45:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ax09RrBbVM/Listeners', 09:45:23 INFO - 'TMPDIR': '/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/', 09:45:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:23 INFO - 'USER': 'cltbld', 09:45:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:23 INFO - 'XPC_FLAGS': '0x0', 09:45:23 INFO - 'XPC_SERVICE_NAME': '0', 09:45:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:45:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:23 INFO - Downloading/unpacking blobuploader==1.2.4 09:45:23 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:45:23 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:45:23 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:45:23 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:45:23 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:45:23 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:45:26 INFO - Downloading blobuploader-1.2.4.tar.gz 09:45:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:45:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:45:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:45:26 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:45:26 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:45:26 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:45:26 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:45:26 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:45:26 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:45:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:45:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:45:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:45:27 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:45:27 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:45:27 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:45:27 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:45:27 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:45:27 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:45:27 INFO - Downloading docopt-0.6.1.tar.gz 09:45:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:45:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:45:27 INFO - Installing collected packages: blobuploader, requests, docopt 09:45:27 INFO - Running setup.py install for blobuploader 09:45:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:45:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:45:27 INFO - Running setup.py install for requests 09:45:28 INFO - Running setup.py install for docopt 09:45:28 INFO - Successfully installed blobuploader requests docopt 09:45:28 INFO - Cleaning up... 09:45:28 INFO - Return code: 0 09:45:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:45:28 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:45:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:28 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:45:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:28 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 0x10fa54a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fac1228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4f156cf80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa099f0>, '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 0x10f768cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9d3990>, '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.PKT1zRx2xT/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.ax09RrBbVM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/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:45:28 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:45:28 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:45:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PKT1zRx2xT/Render', 09:45:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:28 INFO - 'HOME': '/Users/cltbld', 09:45:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:28 INFO - 'LOGNAME': 'cltbld', 09:45:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:28 INFO - 'MOZ_NO_REMOTE': '1', 09:45:28 INFO - 'NO_EM_RESTART': '1', 09:45:28 INFO - 'PAGER': '/bin/cat', 09:45:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:28 INFO - 'PWD': '/builds/slave/test', 09:45:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:28 INFO - 'SHELL': '/bin/bash', 09:45:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ax09RrBbVM/Listeners', 09:45:28 INFO - 'TMPDIR': '/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/', 09:45:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:28 INFO - 'USER': 'cltbld', 09:45:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:28 INFO - 'XPC_FLAGS': '0x0', 09:45:28 INFO - 'XPC_SERVICE_NAME': '0', 09:45:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:45:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:45:29 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-GFazSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:45:29 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-Vpqei7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:45:29 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-_qTNgU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:45:29 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-J3eHJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:45:29 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-2NRRog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:45:29 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-Swpjjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:45:29 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-igGSlT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:45:29 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-FqDrEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:45:29 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-NA4KbX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:45:30 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-nwq7I6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:45:30 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-hkfTsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:45:30 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-nybP96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:45:30 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-0KVJQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:45:30 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-GwMbGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:45:30 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-uuPSfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:45:30 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-oRV_3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:45:31 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-gylbCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:45:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:45:31 INFO - Running setup.py install for manifestparser 09:45:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:45:31 INFO - Running setup.py install for mozcrash 09:45:31 INFO - Running setup.py install for mozdebug 09:45:31 INFO - Running setup.py install for mozdevice 09:45:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:45:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:45:31 INFO - Running setup.py install for mozfile 09:45:32 INFO - Running setup.py install for mozhttpd 09:45:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:45:32 INFO - Running setup.py install for mozinfo 09:45:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:45:32 INFO - Running setup.py install for mozInstall 09:45:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:45:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:45:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:45:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:45:32 INFO - Running setup.py install for mozleak 09:45:32 INFO - Running setup.py install for mozlog 09:45:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:45:32 INFO - Running setup.py install for moznetwork 09:45:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:45:33 INFO - Running setup.py install for mozprocess 09:45:33 INFO - Running setup.py install for mozprofile 09:45:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:45:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:45:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:45:33 INFO - Running setup.py install for mozrunner 09:45:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:45:33 INFO - Running setup.py install for mozscreenshot 09:45:33 INFO - Running setup.py install for moztest 09:45:34 INFO - Running setup.py install for mozversion 09:45:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:45:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:45:34 INFO - Cleaning up... 09:45:34 INFO - Return code: 0 09:45:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:45:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:34 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 0x10fa54a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fac1228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4f156cf80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa099f0>, '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 0x10f768cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9d3990>, '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.PKT1zRx2xT/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.ax09RrBbVM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/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:45:34 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:45:34 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:45:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PKT1zRx2xT/Render', 09:45:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:34 INFO - 'HOME': '/Users/cltbld', 09:45:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:34 INFO - 'LOGNAME': 'cltbld', 09:45:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:34 INFO - 'MOZ_NO_REMOTE': '1', 09:45:34 INFO - 'NO_EM_RESTART': '1', 09:45:34 INFO - 'PAGER': '/bin/cat', 09:45:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:34 INFO - 'PWD': '/builds/slave/test', 09:45:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:34 INFO - 'SHELL': '/bin/bash', 09:45:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ax09RrBbVM/Listeners', 09:45:34 INFO - 'TMPDIR': '/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/', 09:45:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:34 INFO - 'USER': 'cltbld', 09:45:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:34 INFO - 'XPC_FLAGS': '0x0', 09:45:34 INFO - 'XPC_SERVICE_NAME': '0', 09:45:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:45:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:45:34 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-NOKU9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:45:34 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:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:45:34 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-Efr6Vm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:45:34 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:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:45:34 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-bZYE3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:45:35 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:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:45:35 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-G37rQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:45:35 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:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:45:35 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-8kxjlW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:45:35 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:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:45:35 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-OP0E5m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:45:35 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:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:45:35 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-MQ_3pr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:45:35 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:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:45:35 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-bSoBvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:45:35 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:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:45:35 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-Pzblg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:45:35 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:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:45:35 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-PAKi7Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:45:35 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:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:45:35 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-XqyrRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:45:36 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:45:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:45:36 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-tJPLnG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:45:36 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:45:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:45:36 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-X4fWg2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:45:36 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:45:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:45:36 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-qrqPNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:45:36 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:45:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:45:36 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-y90ViC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:45:36 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:45:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:45:36 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-v0umkj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:45:36 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:45:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:45:36 INFO - Running setup.py (path:/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/pip-qo3b50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:45:36 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:45:36 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:45:36 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:45:36 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:45:36 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:45:36 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:45:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:45:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:39 INFO - Downloading blessings-1.5.1.tar.gz 09:45:39 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:45:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:45:39 INFO - Installing collected packages: blessings 09:45:39 INFO - Running setup.py install for blessings 09:45:39 INFO - Successfully installed blessings 09:45:39 INFO - Cleaning up... 09:45:39 INFO - Return code: 0 09:45:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:45:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:45:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:45:40 INFO - Reading from file tmpfile_stdout 09:45:40 INFO - Current package versions: 09:45:40 INFO - blessings == 1.5.1 09:45:40 INFO - blobuploader == 1.2.4 09:45:40 INFO - docopt == 0.6.1 09:45:40 INFO - manifestparser == 1.1 09:45:40 INFO - mozInstall == 1.12 09:45:40 INFO - mozcrash == 0.16 09:45:40 INFO - mozdebug == 0.1 09:45:40 INFO - mozdevice == 0.47 09:45:40 INFO - mozfile == 1.2 09:45:40 INFO - mozhttpd == 0.7 09:45:40 INFO - mozinfo == 0.9 09:45:40 INFO - mozleak == 0.1 09:45:40 INFO - mozlog == 3.0 09:45:40 INFO - moznetwork == 0.27 09:45:40 INFO - mozprocess == 0.22 09:45:40 INFO - mozprofile == 0.27 09:45:40 INFO - mozrunner == 6.11 09:45:40 INFO - mozscreenshot == 0.1 09:45:40 INFO - mozsystemmonitor == 0.0 09:45:40 INFO - moztest == 0.7 09:45:40 INFO - mozversion == 1.4 09:45:40 INFO - psutil == 3.1.1 09:45:40 INFO - requests == 1.2.3 09:45:40 INFO - wsgiref == 0.1.2 09:45:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:45:40 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:45:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:40 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:45:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:40 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 0x10fa54a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fac1228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4f156cf80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa099f0>, '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 0x10f768cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9d3990>, '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.PKT1zRx2xT/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.ax09RrBbVM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/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:45:40 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:45:40 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:45:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PKT1zRx2xT/Render', 09:45:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:40 INFO - 'HOME': '/Users/cltbld', 09:45:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:40 INFO - 'LOGNAME': 'cltbld', 09:45:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:40 INFO - 'MOZ_NO_REMOTE': '1', 09:45:40 INFO - 'NO_EM_RESTART': '1', 09:45:40 INFO - 'PAGER': '/bin/cat', 09:45:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:40 INFO - 'PWD': '/builds/slave/test', 09:45:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:40 INFO - 'SHELL': '/bin/bash', 09:45:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ax09RrBbVM/Listeners', 09:45:40 INFO - 'TMPDIR': '/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/', 09:45:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:40 INFO - 'USER': 'cltbld', 09:45:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:40 INFO - 'XPC_FLAGS': '0x0', 09:45:40 INFO - 'XPC_SERVICE_NAME': '0', 09:45:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:45:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:40 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:45:40 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:45:40 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:45:40 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:45:40 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:45:40 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:45:40 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:45:40 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:45:40 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:45:40 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:45:40 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:45:40 INFO - Cleaning up... 09:45:40 INFO - Return code: 0 09:45:40 INFO - Running post-action listener: _resource_record_post_action 09:45:40 INFO - Running post-action listener: _start_resource_monitoring 09:45:40 INFO - Starting resource monitoring. 09:45:40 INFO - ##### 09:45:40 INFO - ##### Running install step. 09:45:40 INFO - ##### 09:45:40 INFO - Running pre-action listener: _resource_record_pre_action 09:45:40 INFO - Running main action method: install 09:45:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:45:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:45:40 INFO - Reading from file tmpfile_stdout 09:45:40 INFO - Detecting whether we're running mozinstall >=1.0... 09:45:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:45:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:45:41 INFO - Reading from file tmpfile_stdout 09:45:41 INFO - Output received: 09:45:41 INFO - Usage: mozinstall [options] installer 09:45:41 INFO - Options: 09:45:41 INFO - -h, --help show this help message and exit 09:45:41 INFO - -d DEST, --destination=DEST 09:45:41 INFO - Directory to install application into. [default: 09:45:41 INFO - "/builds/slave/test"] 09:45:41 INFO - --app=APP Application being installed. [default: firefox] 09:45:41 INFO - mkdir: /builds/slave/test/build/application 09:45:41 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:45:41 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:46:21 INFO - Reading from file tmpfile_stdout 09:46:21 INFO - Output received: 09:46:21 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:46:21 INFO - Running post-action listener: _resource_record_post_action 09:46:21 INFO - ##### 09:46:21 INFO - ##### Running run-tests step. 09:46:21 INFO - ##### 09:46:21 INFO - Running pre-action listener: _resource_record_pre_action 09:46:21 INFO - Running main action method: run_tests 09:46:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:46:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:46:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:46:21 INFO - 2015-11-09 09:46:21.272 screenresolution[1630:7737] starting screenresolution argv=screenresolution get 09:46:21 INFO - 2015-11-09 09:46:21.275 screenresolution[1630:7737] Display 0: 1600x1200x32@60 09:46:21 INFO - 2015-11-09 09:46:21.283 screenresolution[1631:7739] starting screenresolution argv=screenresolution list 09:46:21 INFO - Available Modes on Display 0 09:46:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:46:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:46:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:46:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:46:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:46:21 INFO - Intel HD Graphics 3000: 09:46:21 INFO - Chipset Model: Intel HD Graphics 3000 09:46:21 INFO - Type: GPU 09:46:21 INFO - Bus: Built-In 09:46:21 INFO - VRAM (Total): 512 MB 09:46:21 INFO - VRAM (Dynamic, Max): 10 09:46:21 INFO - Vendor: Intel (0x8086) 09:46:21 INFO - Device ID: 0x0116 09:46:21 INFO - Revision ID: 0x0009 09:46:21 INFO - Displays: 09:46:21 INFO - Display: 09:46:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:46:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:46:21 INFO - Display Serial Number: 1600x1200 60 09:46:21 INFO - Main Display: Yes 09:46:21 INFO - Mirror: Off 09:46:21 INFO - Online: Yes 09:46:21 INFO - Rotation: Supported 09:46:21 INFO - Return code: 0 09:46:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:46:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:46:21 INFO - Python 2.7.3 09:46:21 INFO - Return code: 0 09:46:21 INFO - grabbing minidump binary from tooltool 09:46:21 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:46:21 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 0x10fa099f0>, '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 0x10f768cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9d3990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:46:21 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:46:21 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:46:21 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:46:21 INFO - Return code: 0 09:46:21 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:46:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:46:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:46:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:46:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:46:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/vm0kCyZpQ-Kv_wn5ZIxzjg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0052', '--webServer', 'localhost'] in /builds/slave/test/build 09:46:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/vm0kCyZpQ-Kv_wn5ZIxzjg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0052 --webServer localhost 09:46:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PKT1zRx2xT/Render', 09:46:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:46:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:46:21 INFO - 'HOME': '/Users/cltbld', 09:46:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:46:21 INFO - 'LOGNAME': 'cltbld', 09:46:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:46:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:46:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:21 INFO - 'MOZ_NO_REMOTE': '1', 09:46:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:46:21 INFO - 'NO_EM_RESTART': '1', 09:46:21 INFO - 'PAGER': '/bin/cat', 09:46:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:46:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:21 INFO - 'PWD': '/builds/slave/test', 09:46:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:46:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:46:21 INFO - 'SHELL': '/bin/bash', 09:46:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ax09RrBbVM/Listeners', 09:46:21 INFO - 'TMPDIR': '/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/', 09:46:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:46:21 INFO - 'USER': 'cltbld', 09:46:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:46:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:46:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:21 INFO - 'XPC_FLAGS': '0x0', 09:46:21 INFO - 'XPC_SERVICE_NAME': '0', 09:46:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:46:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/vm0kCyZpQ-Kv_wn5ZIxzjg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0052', '--webServer', 'localhost'] with output_timeout 3600 09:46:22 INFO - mozversion INFO | application_buildid: 20151109064656 09:46:22 INFO - mozversion INFO | application_changeset: a02cf2019a51f59e1eb712ab3d306f70c86808c0 09:46:22 INFO - mozversion INFO | application_display_name: Nightly 09:46:22 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:46:22 INFO - mozversion INFO | application_name: Firefox 09:46:22 INFO - mozversion INFO | application_remotingname: firefox 09:46:22 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 09:46:22 INFO - mozversion INFO | application_vendor: Mozilla 09:46:22 INFO - mozversion INFO | application_version: 45.0a1 09:46:22 INFO - mozversion INFO | platform_buildid: 20151109064656 09:46:22 INFO - mozversion INFO | platform_changeset: a02cf2019a51f59e1eb712ab3d306f70c86808c0 09:46:22 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 09:46:22 INFO - mozversion INFO | platform_version: 45.0a1 09:46:22 INFO - 2015-11-09 09:46:22,036 DEBUG : using testdate: 1447091182 09:46:22 INFO - 2015-11-09 09:46:22,036 DEBUG : actual date: 1447091182 09:46:22 INFO - 2015-11-09 09:46:22,048 INFO : starting webserver on 'localhost:49278' 09:46:22 INFO - 2015-11-09 09:46:22,049 INFO : Starting test suite t-yosemite-r5-0052.e 09:46:22 INFO - 2015-11-09 09:46:22,050 INFO : Starting test dromaeo_css 09:46:22 INFO - 2015-11-09 09:46:22,050 DEBUG : operating with platform_type : mac_ 09:46:22 INFO - 2015-11-09 09:46:22,051 INFO : Initialising browser for dromaeo_css test... 09:46:22 INFO - 2015-11-09 09:46:22,080 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/tmpKhHDzW/profile http://localhost:49278/getInfo.html 09:46:26 INFO - 2015-11-09 09:46:26,576 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:46:26 INFO - 2015-11-09 09:46:26,576 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:46:26 INFO - 2015-11-09 09:46:26,577 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 09:46:26 INFO - 2015-11-09 09:46:26,577 DEBUG : BROWSER_OUTPUT: __metrics 09:46:27 INFO - 2015-11-09 09:46:27,272 INFO : Browser initialized. 09:46:27 INFO - 2015-11-09 09:46:27,273 INFO : Running cycle 1/1 for dromaeo_css test... 09:46:27 INFO - 2015-11-09 09:46:27,273 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/tmpKhHDzW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:46:39 INFO - 2015-11-09 09:46:39,602 DEBUG : BROWSER_OUTPUT: RSS: Main: 241463296 09:46:39 INFO - 2015-11-09 09:46:39,602 DEBUG : BROWSER_OUTPUT: 09:47:29 INFO - 2015-11-09 09:47:29,476 DEBUG : BROWSER_OUTPUT: 1447091249470 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:49:39 INFO - 2015-11-09 09:49:39,151 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 09:49:40 INFO - 2015-11-09 09:49:40,234 DEBUG : BROWSER_OUTPUT: RSS: Main: 264978432 09:49:40 INFO - 2015-11-09 09:49:40,235 DEBUG : BROWSER_OUTPUT: 09:52:42 INFO - 2015-11-09 09:52:42,484 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 09:52:43 INFO - 2015-11-09 09:52:43,058 DEBUG : BROWSER_OUTPUT: RSS: Main: 272121856 09:52:43 INFO - 2015-11-09 09:52:43,058 DEBUG : BROWSER_OUTPUT: 09:55:44 INFO - 2015-11-09 09:55:44,817 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 09:55:45 INFO - 2015-11-09 09:55:45,408 DEBUG : BROWSER_OUTPUT: RSS: Main: 274788352 09:55:45 INFO - 2015-11-09 09:55:45,408 DEBUG : BROWSER_OUTPUT: 09:58:47 INFO - 2015-11-09 09:58:47,130 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 09:58:47 INFO - 2015-11-09 09:58:47,711 DEBUG : BROWSER_OUTPUT: RSS: Main: 278679552 09:58:47 INFO - 2015-11-09 09:58:47,711 DEBUG : BROWSER_OUTPUT: 10:01:50 INFO - 2015-11-09 10:01:50,336 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 10:01:50 INFO - 2015-11-09 10:01:50,949 DEBUG : BROWSER_OUTPUT: RSS: Main: 283557888 10:01:50 INFO - 2015-11-09 10:01:50,950 DEBUG : BROWSER_OUTPUT: 10:04:53 INFO - 2015-11-09 10:04:53,522 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 10:04:53 INFO - 2015-11-09 10:04:53,780 DEBUG : BROWSER_OUTPUT: RSS: Main: 288894976 10:04:53 INFO - 2015-11-09 10:04:53,780 DEBUG : BROWSER_OUTPUT: 10:04:53 INFO - 2015-11-09 10:04:53,780 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:04:53 INFO - 2015-11-09 10:04:53,780 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:04:53 INFO - 2015-11-09 10:04:53,780 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:04:53 INFO - 2015-11-09 10:04:53,780 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:04:53 INFO - 2015-11-09 10:04:53,781 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2706.9323266918327;2763.419681866808;2797.8041537092404;2826.3640680846825;2835.2203144135374;4640.930386044208;4741.431028276603;4765.237561990082;4766.137650689654;4833.589144922686;4561.817527298904;4615.376924115243;4633.6061434778085;4640.419947506562;4773.925866679995;4384.934225986613;4439.866803995886;4529.411176547044;4540.091981603676;4603.677742558022;123.53711960612044;4197.754163840529;4477.6417886569;4541.545845415449;4600.17196904557;4285.978570107145;4352.499462561815;4385.627221686161;4400.889977750549;4413.801378937956;4427.46870375557;4450.310201918708;4464.1071785643;4468.4414448193975;4503.729776213438;4274.2092712848225;4419.4033805436175;4430.446194225722;4442.62237709795;4454.28731402974;4406.140802543506;4513.435820522434;4531.139083574143;4600.884977875547;4663.743494107823;5032.295478632995;5036.244563315496;5038;5058.747062646889;5098.439171691111;4825.662203645711;4837.8306759263605;4996.525330093636;5099.796008159669;5141.100307446182;4794.95205047952;4801.399825021837;4823.469418363977;4831.806727730922;4915.213565829486;5147.742612869341;5164.638475306692;5177.792888284502;5207.114790485626;5210.739463026834;4812.278158276216;4876.390451193601;4914.459409464956;5013.749312534359;5148.382194136728;5146.974265128725;5166.8966620668125;5184.066867963803;5184.792608295701;5188.766505507261;5081.2632168335385;5087.567556757643;5087.592992560586;5122.564582010571;5144.382674079135;4824.49342818999;4880.975595122072;4902.3872015998;4982.626303027215;5028.7737051832755;3924.4113382992778;3947.072437977073;3986.880393588197;3996.0409501719378;4010.7192496525545;3516.6834984851484;3598.226381328027;3623.601403845575;3659.3596120678776;3680.0799800049986;4633.166030114544;4643.767811609474;4688.015516741522;4691.671582989158;4694.859154225379;5068.417132029864;5111.105556527667;5117.2068329409;5136.717480538607;5164.845054648292;4572.748498832596;4716.64625153108;4742.146413645577;4805.567498925114;4825.372701548777;4348.195583817004;4410.867673969786;4418.845340413134;4430.424044874146;4445.688801783909;5192.740362981911;5194.091034069098;5198.818041368534;5204.973975130176;5212.348456442945;4864.197407427876;4980.775865086152;4983.07813054586;5096.872578185575;5169.327987361619;5269.683818970874;5284;5290.1800220965815;5296.576273898156;5296.973515132399;5102.540771330598;5117.360329958755;5137.974310128575;5163.715995620277;5364.544013758718;4968.751562421937;5024.221245706921;5030.899382012412;5128.410232823273;5155.149400348901;4946.208606622923;4959.82640607577;5003.699778013331;5005.7997680092385;5031.270465782368;4972.801087956441;4980.377452818398;4987.700737955589;4989.900201996013;5040.344755181803;4409.492908315585;4743.66794324394;4753.714777113384;4768.57082862544;4856;4911.877203069952;4981.028699403581;4990.94324935263;5045.31888195089;5046.394432668103;4704.317873908332;4885.1450996076255;4903.362562866804;4911.9754401227765;4938.481459446706 10:04:53 INFO - 2015-11-09 10:04:53,781 DEBUG : BROWSER_OUTPUT: |1;ext.html;471.1613328275668;494.77487743076904;494.77487743076904;506.81247938262834;524.3105316508788;35742.28515429693;36619;36899.4465083024;37080.44379334312;37184.814075929615;38784.61215387852;38786.612133878654;38823.22353552927;39158.21683566327;39399;8104.1085480597085;8299.751007469786;8339.45793523422;8354.874676879852;8492.575371231414;8106.148854370294;8179.018517777845;8239.95880020599;8268.297194738454;8316.875246871301;8092.595370231465;8214.219649133323;8214.63034163464;8252.876206856901;8319.376046796484;8055;8153.266206041485;8172.18278172184;8195.836083278331;8210.425270231086;8019;8112.148224436467;8120.837583248302;8148.062972758149;8218.424710270283;35313;35778.64221357779;35908;36013.81993090018;36027.4595881062;2214.7563767985507;2366.7869891709656;2384.408350841634;2643.1409791817737;2723.5097682417354;24554.50890982188;25356;26291.868540657364;26298.079567215056;26340.60489092665;2145.8605190662556;2154.439845640129;2160.3950893749775;2167.729033870766;2169.143188440573;239433;241741.79129104418;244750.09124406858;244952;245650;36154.45768313477;36880.26239475195;53705.1944220837;54108.188377174374;54167.45832541703;35751.82124089363;36082.8195859019;36115;36128.09679757975;36319.63680363215;13058.804117938238;13130.737385252241;13237.139585927076;13268.270245136417;13313.40089695966;10531.104856087166;10559;10579.682609521727;10597.89402105969;10599.576016959236;11943.820842687366;12326.81509777354;12337.383130843422;12362.320072396105;12368.134230603771;5239.663885709196;5338.572914166857;5354.7858085676135;5355.518003379714;5371.435999220103;794.6849252629531;832.2052439919862;920.6363486422825;946.597695979206;949.4350861237552;28648.713512865022;29530.852345738134;29582.260443489085;29689.554656680168;30001.849990750343;880.6389380354024;904.7104926423613;923.1691477670016;1004.1314263162458;1042.2704107125044;13430.19418834873;13514.93242533781;13584.1849489029;13642.454301828015;13723.725525489634;354119;360553;365121;365293;365547;51173;52277.954440910966;52318.47681523136;52663;52835.20747188795;1225.9632211033684;1233.8272641830151;1241.7764802335485;1242.5402601037674;1255.0524354112586;24957.875210624556;25844.35389115287;26097.217083487525;26144.084957026414;26188.73811261863;42860.57139428566;43398.34902476402;43496.34755478607;43506.56493435025;43879;244860;245115;245152;245613;246096;28213.57679634766;33749.15627109243;34137.658623413445;40040;40803.38794918138;39189.608103918596;39679.40480892731;40041.799791000856;40163;40830.79584602177;32276.83861580771;32615.836920815244;32952;33274.33451330911;33420;32175.195620109684;32421;32736.50895236621;32804.50793238151;32998.34003319968;32946.67053329436;33104.50343244805;33145.83427082849;34730.479042814884;35847.283054338244;27176.864115679295;27965.300867478476;28075.157745267676;28747.5687864678;30858.228544286572;21908.946844833757;22367.328980130624;22534.549309014055;22651.660225096966;22750.886245568665 10:04:53 INFO - 2015-11-09 10:04:53,781 DEBUG : BROWSER_OUTPUT: |2;jquery.html;287.85894911493347;291.84240510124533;293.55966050923615;294.3759230431484;299.30411792582254;8780.69267575635;8947.06055864133;14602.78095828562;14993.025453345539;15188.54434366968;10031.899681003188;10116.342437741541;10353.585856565729;10357.844632330522;10367;3314.237725323177;3939.5666476687543;3944.2505923874373;3970.702197335197;3986.4219688145345;3879;4052.53395859477;4111.198316328318;4156.584341565849;4172.874813755577;4080.8571699990507;4114.917701645965;4119.382092686106;4120.690948178883;4145.689073319498;4020.557738648746;4194.056337324108;4202.075543380452;4202.789860506962;4244.511881133678;3542.256126213498;3543.0433782878476;3557.1462848916076;3562.69717074049;3602.009447401985;11021.944890275578;11038.779224415466;11567.942160289145;11573.537058517733;11624.941875290653;1564.8435156484375;1588.317023679817;1622;1661.335465813672;1852.2868695552174;12369.196002259914;12441.875581244161;12677.302748348837;12751.171173873761;12775.29735864527;1463.6414078550717;1545.6676814484827;1576.8107827060712;1611.58904479357;1645.1198608744264;47935.76032119852;52004;54894.242009451635;55150.72424637851;55216;14919.701605967819;14927.626809329853;14931.17878516692;14944.534151865038;15190.088594684354;21017.05423255957;21135.14675518816;21327.78672213289;21341.67987480158;21369;8011.719589814328;8106.108328083906;8248.670053197804;8301.626426810808;8404.579771011426;7301.561906285639;7409.370203532652;7485.70057197706;7506.774796756106;7536.0956685198125;7023.122109736283;7138.607376594337;7144.3570078693165;7146.178189508169;7250.456215783837;909.2680392284275;920.6593560382702;922.1009515722117;970.8932017478072;2993.625796775403;350.4847873625766;352.4976907906275;362.20857426523133;370.48317596952637;400.2475346348846;9722.611095556098;9811.116999470081;10164.440955747505;10263.435511046964;10299.17606591471;397.9263836190314;404.12305297504486;411.6377587722845;411.9279126152911;432.7057600831402;5430.51125398716;5586.050371436865;5610.4670056344585;5623.5220006299105;5646.407127251661;525624;532334;542740;563752;574221;59172;59876;60072.098918516254;60542.697286514165;61440.69279653663;431.9805608747614;434.8086841789602;435.3317657395882;435.6297147424727;435.92589259825905;9395.765105872408;9427.481488518197;9487.952560237154;9704.175145112744;9710.951445242728;29542.852285738434;30580.235494111934;31069.378612428078;31239.375212496077;31250.21874453157;40786.388204176365;41421.378679320434;41548.1690366197;41686.37470438007;41887.581124189586;5301.284326615858;5415.377231618257;5433.347998240237;5437.34751829783;5495.395506494362;8057.315128214167;8586.527740974307;10140.188784897338;10168.288219824837;10303.330283531546;8280.751577452686;8526.360522960678;8656.307495400228;8713.782155446164;8728.563571821256;8298;8412.873806893023;8414.705485307984;8444.40889137779;8585.914140858762;8404.32765378756;8811.383203175716;8858.645654174019;8888.955555222183;8944.5080520572;5277.15565509532;5288.338957630296;5334.1732031535175;5334.973325133349;5347.171188465794;8564.914350856412;8748.256398206224;8835.425697329652;8846.33652476054;8868.201861832466 10:04:53 INFO - 2015-11-09 10:04:53,785 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1463.4365769178862;1517.8254500732417;1537.5003123984707;1564.1944398634705;1590.5625952862958;6501.609903405787;6618.569792963466;6890.621015844126;7282.9271707282915;7300.8683654033575;6787.626680532569;7011.579305241689;7109.289071092888;7131.7503887363955;7137.678804453799;1925.8940758258325;1926.5087402712288;1931.3626503253893;1935.4000259919399;1936.3029309448586;1938.6510428122933;1981.28673677476;1990.93031743889;1993.1429485321305;1993.3820515640125;1925.2010415677478;1945.085809669453;1951.1610007696684;1954.4722924810364;1959.882407055574;1844.58496838211;1886.151231945623;1888.1880791259753;1898.0509745127436;1900.819422154907;1915.8946257955806;1925.2587753714781;1929.21866644008;1947.5423275530238;1950.1809240119185;7044.577325360444;7102.39629631482;7127.572345659225;7168.283171682842;7175.031370764932;4110.23960567296;4188.225178342016;4201.264778663722;4221.831126754926;4236.5128010278595;2320.709911261092;2392.545416370884;2453.7300896901324;2505.912293069734;2539.9619005714744;755.3126654744157;781.9218078192192;785.6189747972229;785.6464590934046;846.0312941681801;8660.480371177686;8678.956605216996;8709;8712.56437178145;8757.080506546848;3834.6357096075826;3884.3590807516443;3913.3542965410957;3919.9020024499614;3960.524737031517;8089.271965523131;8097.797555061171;8098.473599216032;8103.716369927024;8108.391870609727;4293.2057569349145;4303.053328267776;4310.676699247569;4314.482262128565;4351.6301114405;3920.2355540669864;3923.4507168996365;3931.744436611611;3937.4684417603257;3946.309395855714;3245.6105267368066;3315.983420082884;3324.5678061851804;3337.249118948217;3343.164208947763;1054.393723608928;1065.547142464465;1069.9037086662238;1070.6520380876245;1074.403705943209;842.7345386203449;904.1500989070253;1160.4719852467276;1172.536847945057;1172.7947609168361;6709.496787740939;6798.354156355138;6815.011823285695;6823.28355522663;6831.180258369028;958.0946006024241;993.1111655068673;997.945113018791;1011.5245834457793;1015.137133436573;5292.761825717852;5339.519443250126;5368.731563421813;5375.247465354853;5417.431169727122;7841.568713720686;8160.224778646138;8362.45644033148;8415.789605259917;8471.152884711479;8365.079841217583;8383.16168383169;8396.07643159252;8398.580070996426;8409.411341206056;6559.180102487189;6594.670266486753;6690.59856408617;6791.083203767428;6817.863642727217;6612.107365505595;6644.800655980328;6659.234188068434;6686.69909854048;6749.021391898245;7435.814104647211;7572.886406703794;7676.846463070819;7741.380689544935;7750.8837367440665;7645.426593005435;7907.169747176464;7907.644156013108;7912.090109637235;7934.523928564305;5979.282486101695;6016.909746353896;6068.393160684073;6074.453299203093;6093.36019717941;6819.693113809792;6936.687849046906;6977.1976222733;6981.266966968598;7001.474889383215;6370.203724534434;6388.425041746265;6488.2538508072175;6513.837154071186;6527.477801775942;6188.690565471618;6291.96854015727;6317.778877739257;6412.198475190601;6471.417572418505;6379.170707808141;6458.257300410513;6460.257070436772;6462.935370646233;6474.2878283387845;5782.7686892523825;5831.883362332815;5845.853853653693;5853.9121913172185;5855.2095467113095;5324.627276090637;5356.5982551308025;5357.517823395757;5387.003404370204;5432.918506222489 10:04:53 INFO - 2015-11-09 10:04:53,785 DEBUG : BROWSER_OUTPUT: |4;prototype.html;272.7994923731058;275.1923105684815;278.4736847358494;279.8600699650175;281.04724982309966;5260.842174734755;5269.76286067127;5274.92087618686;5364.785408583657;5418.891622167559;5292.3913749918775;5302.549283310923;5315.123004704219;5321.787128514865;5331.067063263923;4122.97938510307;4134.297169481196;4135.4623898893105;4140.006398464377;4141.855035073773;4102.5897410258885;4120.114175452277;4120.649744771698;4145.316022856225;4153.605407486284;3967.7222594418404;4044.9595504045024;4078.062045729484;4101.405296232045;4127.669786417095;4094.9385759213637;4101.794910254475;4109.671226301919;4112.074783173792;4139.7309174903685;3503.684668379858;3504.56192975878;3515.8945231643092;3533.0990597397754;3534.8232588370734;5029.547340739351;5081.822136225252;5082.3138876251605;5166.07010738067;5252.4222335543445;4481.103779244164;4508.684392092555;4542.500324964251;4545.772711364419;4586.197415452316;5531.612787104904;5538.086215774392;5541.889162216733;5542.307211598551;5547;3806.9809650951843;3807.295650304675;3808.21931504041;3808.6953043756434;3853.98073009636;5689.203511508392;5845.444682755132;5849.502792262663;5851.502622277111;5922.851928701773;3908.8241029153755;3925.9607403926166;3928.46965659638;3956.1296514766705;4006.6193711597934;4005.0588111793704;4015.377616469452;4020.2562525932794;4025.577314382006;4027.597240275949;4591.609713174351;4592.770361481913;4597.310403439444;4597.563231493003;4660.906781864412;5382.4886635769535;5412.107002344569;5425.294711687534;5561.4716601922755;5605.831825045255;1410.5697762182633;1426.8715815576647;1431.141315210886;1434.1108512722178;1436.289036926728;883.6377085394957;884.2042162054203;911.7264820553808;938.1884669760608;938.9436633801994;5067.670601410897;5207.3490813648295;5228.346456692913;5243.9213411798855;5320.148776195868;5764.279465066867;5799.130130480377;5810.4189581041555;5830.067189249699;5835.824925252249;5264.815731449381;5274.12976858814;5294.258803767476;5303.708296043677;5319.095753721799;3079.3071558899514;3163.28826014145;3193.744500439959;3209.5185722141864;3239.530268111158;5893.410658934158;5907.49786268172;5916.852078697981;5957.76168953237;5972;5920;5923.585349025527;5965.403459654;5965.850853728692;5979.282486101609;5795.536357091507;5912.526997840162;5933.58464907461;5956.106584012433;5979.760809567656;5764.250647415809;5784.913226301524;5804.593678442468;5827.94172058274;5868.559858010581;5661.603687741818;5681.9147712783515;5686.2607860977805;5697.715114244188;5704.429557044263;5884.764609415575;5916.3492015877355;5939.910901336397;5954;6030.90953635687;3607.314610224049;3826.6556009959236;3920.6079392060565;3923.9019024524614;3925.038365600446;5569.136783798518;5660.88678226425;5709.429057094258;5711.143328500758;5716.5998380113;5428.07722687152;5533.142362933751;5534.640248383842;5549;5584.720763961867;5521.558275338044;5544.805931792368;5555.0278701227935;5571.3592936811165;5574.777008919597;5331.040412725747;5447.264619276505;5450.672959622435;5485.01269771445;5494.5054945055135;5558.861028474321;5565.081761509306;5565.916511252253;5624.128260119688;5631.014572449887;5527.585431092603;5532.5297349724115;5533.059379905506;5540.80607178763;5553.833384998295 10:04:53 INFO - 2015-11-09 10:04:53,788 DEBUG : BROWSER_OUTPUT: |5;yui.html;517.9119549676552;565.8868226354728;566.8271177290927;589.5372132875693;652.6084349390367;11876.346800925945;12130.818037729441;12160.817587736192;12248.387580620967;12300;11167.83248251277;11441.199116061858;11537.884621153786;11602.129840261972;11619.07047436203;620.1318154583596;628.0391001767304;761.299604363985;779.9688012479494;783.7687882074773;780.6643143448315;782.2373186143493;792.0851416613821;796.4783067091035;798.3573223555036;815.4373482297226;834.8121672623641;837.8785076163953;838.4675730910885;840.2437805974611;817.2726273616486;826.5371392020458;833.795720048586;834.4617721569614;834.6244190114443;607.325868286202;610.3194937644539;611.5474548833876;612.8958077126899;616.8612062285995;11857.28856268618;12052.638420847388;12080.456379462945;12112.878871211264;12117.757644847143;8064.112947575762;8430.48616067893;8686.565671716453;9291.860622090675;10628.574857005711;8129.105798362176;8166.305864001567;8290.8341833163;8324.375671824577;8646.351523635753;2563.858987755673;2600.3369140869145;2635.71007189209;2695.043259642818;2752.40823223008;41032.179356413006;41264.968375790544;41317.79341103305;41369.37945930813;41847.58152418467;6004.42957918997;6087.421694939062;6181.011038233951;6185.628862268279;6375.458086062644;10636.787264254826;10637.255392122477;10645.467726613639;10681.732956676145;10706.304090234109;5380.784768609212;5418.864528386822;5594.300712410949;5648.4633959773755;5678.176664383641;3231.6929891660257;3284.359549887749;3313.6023677158896;3391.0844072100394;3485.7734247273847;2342.508073304625;2375.2874137758604;2375.5011447595853;2388.10446082719;2405.4948460823075;339.30103985789356;346.24691296430166;351.5851295471317;352.56634339762235;357.0805176670085;491.5698763581866;505.5147058823571;507.57363814396086;523.2177894048422;535.5810609841052;6383.2978372379;7504.287092726182;7556.886646700304;7678.769636910902;7765.922340776633;502.4171960525846;506.35186960690373;545.5008667069587;553.2033871225423;562.7917670461956;3324.351751408452;3329.916752081169;3363.9158971189986;3395.286989732184;3442.1050526863196;52345.47654523406;52762.20856687153;52924.206136907975;53073.734631326595;53429.46570534245;43676;44461;44595.33107003398;44996.3250551242;45087.32369014467;42689.786551067045;42743;42989.57010429918;43758.781206094405;43922.34116488192;7041;7193.3140980996495;7325.41396688253;7352.705891764484;7389.778306650809;30447.695523044487;30807.69192308048;31055;31112.066638000895;32074;37167.814160929025;37539.81230093832;40767;41998.79000604978;42071;6288.748450061947;6349.682515874096;6394.113889892955;6410.294867564471;6717.328267173243;9658.9034109658;10063.39619622825;10177.338472999232;10244.334118282288;10624.84062739075;9191.35660503785;9442.763930901509;9514.286428518028;9832.360896541702;9898.505074746377;9001.36990410665;9120.589573469077;9596.376235544667;9598.808023839623;10040.297179197387;8908.777280568038;9344.719658410258;9409.106134917172;9463.337566370563;9855.852162217428;7555.471117021975;8082.151374105634;8163.510189388656;8327.875081873655;8429.5785210738;7054.1209377062105;7694.4229182810395;7791.142974272939;7825.569593672175;8096.5546894921345 10:04:53 INFO - 2015-11-09 10:04:53,789 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:04:53 INFO - 2015-11-09 10:04:53,789 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:04:53 INFO - 2015-11-09 10:04:53,789 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,297 10:04:53 INFO - 2015-11-09 10:04:53,789 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:04:53 INFO - 2015-11-09 10:04:53,789 DEBUG : BROWSER_OUTPUT: __startTimestamp1447092293774__endTimestamp 10:04:53 INFO - 2015-11-09 10:04:53,790 DEBUG : BROWSER_OUTPUT: 10:04:53 INFO - 2015-11-09 10:04:53,790 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:04:53 INFO - 2015-11-09 10:04:53,790 DEBUG : BROWSER_OUTPUT: Number of tests: 6 10:04:53 INFO - 2015-11-09 10:04:53,790 DEBUG : BROWSER_OUTPUT: 10:04:53 INFO - 2015-11-09 10:04:53,790 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4699.12 Median:4837.83 stddev:621.12 (12.8%) stddev-sans-first:603.05 10:04:53 INFO - 2015-11-09 10:04:53,791 DEBUG : BROWSER_OUTPUT: Values: 2706.9 2763.4 2797.8 2826.4 2835.2 4640.9 4741.4 4765.2 4766.1 4833.6 4561.8 4615.4 4633.6 4640.4 4773.9 4384.9 4439.9 4529.4 4540.1 4603.7 123.5 4197.8 4477.6 4541.5 4600.2 4286.0 4352.5 4385.6 4400.9 4413.8 4427.5 4450.3 4464.1 4468.4 4503.7 4274.2 4419.4 4430.4 4442.6 4454.3 4406.1 4513.4 4531.1 4600.9 4663.7 5032.3 5036.2 5038.0 5058.7 5098.4 4825.7 4837.8 4996.5 5099.8 5141.1 4795.0 4801.4 4823.5 4831.8 4915.2 5147.7 5164.6 5177.8 5207.1 5210.7 4812.3 4876.4 4914.5 5013.7 5148.4 5147.0 5166.9 5184.1 5184.8 5188.8 5081.3 5087.6 5087.6 5122.6 5144.4 4824.5 4881.0 4902.4 4982.6 5028.8 3924.4 3947.1 3986.9 3996.0 4010.7 3516.7 3598.2 3623.6 3659.4 3680.1 4633.2 4643.8 4688.0 4691.7 4694.9 5068.4 5111.1 5117.2 5136.7 5164.8 4572.7 4716.6 4742.1 4805.6 4825.4 4348.2 4410.9 4418.8 4430.4 4445.7 5192.7 5194.1 5198.8 5205.0 5212.3 4864.2 4980.8 4983.1 5096.9 5169.3 5269.7 5284.0 5290.2 5296.6 5297.0 5102.5 5117.4 5138.0 5163.7 5364.5 4968.8 5024.2 5030.9 5128.4 5155.1 4946.2 4959.8 5003.7 5005.8 5031.3 4972.8 4980.4 4987.7 4989.9 5040.3 4409.5 4743.7 4753.7 4768.6 4856.0 4911.9 4981.0 4990.9 5045.3 5046.4 4704.3 4885.1 4903.4 4912.0 4938.5 10:04:53 INFO - 2015-11-09 10:04:53,791 DEBUG : BROWSER_OUTPUT: 10:04:53 INFO - 2015-11-09 10:04:53,791 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:43117.70 Median:194930.64 stddev:75982.39 (39.0%) stddev-sans-first:76128.07 10:04:53 INFO - 2015-11-09 10:04:53,793 DEBUG : BROWSER_OUTPUT: Values: 471.2 494.8 494.8 506.8 524.3 35742.3 36619.0 36899.4 37080.4 37184.8 38784.6 38786.6 38823.2 39158.2 39399.0 8104.1 8299.8 8339.5 8354.9 8492.6 8106.1 8179.0 8240.0 8268.3 8316.9 8092.6 8214.2 8214.6 8252.9 8319.4 8055.0 8153.3 8172.2 8195.8 8210.4 8019.0 8112.1 8120.8 8148.1 8218.4 35313.0 35778.6 35908.0 36013.8 36027.5 2214.8 2366.8 2384.4 2643.1 2723.5 24554.5 25356.0 26291.9 26298.1 26340.6 2145.9 2154.4 2160.4 2167.7 2169.1 239433.0 241741.8 244750.1 244952.0 245650.0 36154.5 36880.3 53705.2 54108.2 54167.5 35751.8 36082.8 36115.0 36128.1 36319.6 13058.8 13130.7 13237.1 13268.3 13313.4 10531.1 10559.0 10579.7 10597.9 10599.6 11943.8 12326.8 12337.4 12362.3 12368.1 5239.7 5338.6 5354.8 5355.5 5371.4 794.7 832.2 920.6 946.6 949.4 28648.7 29530.9 29582.3 29689.6 30001.8 880.6 904.7 923.2 1004.1 1042.3 13430.2 13514.9 13584.2 13642.5 13723.7 354119.0 360553.0 365121.0 365293.0 365547.0 51173.0 52278.0 52318.5 52663.0 52835.2 1226.0 1233.8 1241.8 1242.5 1255.1 24957.9 25844.4 26097.2 26144.1 26188.7 42860.6 43398.3 43496.3 43506.6 43879.0 244860.0 245115.0 245152.0 245613.0 246096.0 28213.6 33749.2 34137.7 40040.0 40803.4 39189.6 39679.4 40041.8 40163.0 40830.8 32276.8 32615.8 32952.0 33274.3 33420.0 32175.2 32421.0 32736.5 32804.5 32998.3 32946.7 33104.5 33145.8 34730.5 35847.3 27176.9 27965.3 28075.2 28747.6 30858.2 21908.9 22367.3 22534.5 22651.7 22750.9 10:04:53 INFO - 2015-11-09 10:04:53,793 DEBUG : BROWSER_OUTPUT: 10:04:53 INFO - 2015-11-09 10:04:53,793 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26241.59 Median:4198.07 stddev:89511.68 (2132.2%) stddev-sans-first:89741.56 10:04:53 INFO - 2015-11-09 10:04:53,794 DEBUG : BROWSER_OUTPUT: Values: 287.9 291.8 293.6 294.4 299.3 8780.7 8947.1 14602.8 14993.0 15188.5 10031.9 10116.3 10353.6 10357.8 10367.0 3314.2 3939.6 3944.3 3970.7 3986.4 3879.0 4052.5 4111.2 4156.6 4172.9 4080.9 4114.9 4119.4 4120.7 4145.7 4020.6 4194.1 4202.1 4202.8 4244.5 3542.3 3543.0 3557.1 3562.7 3602.0 11021.9 11038.8 11567.9 11573.5 11624.9 1564.8 1588.3 1622.0 1661.3 1852.3 12369.2 12441.9 12677.3 12751.2 12775.3 1463.6 1545.7 1576.8 1611.6 1645.1 47935.8 52004.0 54894.2 55150.7 55216.0 14919.7 14927.6 14931.2 14944.5 15190.1 21017.1 21135.1 21327.8 21341.7 21369.0 8011.7 8106.1 8248.7 8301.6 8404.6 7301.6 7409.4 7485.7 7506.8 7536.1 7023.1 7138.6 7144.4 7146.2 7250.5 909.3 920.7 922.1 970.9 2993.6 350.5 352.5 362.2 370.5 400.2 9722.6 9811.1 10164.4 10263.4 10299.2 397.9 404.1 411.6 411.9 432.7 5430.5 5586.1 5610.5 5623.5 5646.4 525624.0 532334.0 542740.0 563752.0 574221.0 59172.0 59876.0 60072.1 60542.7 61440.7 432.0 434.8 435.3 435.6 435.9 9395.8 9427.5 9488.0 9704.2 9711.0 29542.9 30580.2 31069.4 31239.4 31250.2 40786.4 41421.4 41548.2 41686.4 41887.6 5301.3 5415.4 5433.3 5437.3 5495.4 8057.3 8586.5 10140.2 10168.3 10303.3 8280.8 8526.4 8656.3 8713.8 8728.6 8298.0 8412.9 8414.7 8444.4 8585.9 8404.3 8811.4 8858.6 8889.0 8944.5 5277.2 5288.3 5334.2 5335.0 5347.2 8564.9 8748.3 8835.4 8846.3 8868.2 10:04:53 INFO - 2015-11-09 10:04:53,794 DEBUG : BROWSER_OUTPUT: 10:04:53 INFO - 2015-11-09 10:04:53,795 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4893.90 Median:6240.33 stddev:2535.24 (40.6%) stddev-sans-first:2529.25 10:04:53 INFO - 2015-11-09 10:04:53,796 DEBUG : BROWSER_OUTPUT: Values: 1463.4 1517.8 1537.5 1564.2 1590.6 6501.6 6618.6 6890.6 7282.9 7300.9 6787.6 7011.6 7109.3 7131.8 7137.7 1925.9 1926.5 1931.4 1935.4 1936.3 1938.7 1981.3 1990.9 1993.1 1993.4 1925.2 1945.1 1951.2 1954.5 1959.9 1844.6 1886.2 1888.2 1898.1 1900.8 1915.9 1925.3 1929.2 1947.5 1950.2 7044.6 7102.4 7127.6 7168.3 7175.0 4110.2 4188.2 4201.3 4221.8 4236.5 2320.7 2392.5 2453.7 2505.9 2540.0 755.3 781.9 785.6 785.6 846.0 8660.5 8679.0 8709.0 8712.6 8757.1 3834.6 3884.4 3913.4 3919.9 3960.5 8089.3 8097.8 8098.5 8103.7 8108.4 4293.2 4303.1 4310.7 4314.5 4351.6 3920.2 3923.5 3931.7 3937.5 3946.3 3245.6 3316.0 3324.6 3337.2 3343.2 1054.4 1065.5 1069.9 1070.7 1074.4 842.7 904.2 1160.5 1172.5 1172.8 6709.5 6798.4 6815.0 6823.3 6831.2 958.1 993.1 997.9 1011.5 1015.1 5292.8 5339.5 5368.7 5375.2 5417.4 7841.6 8160.2 8362.5 8415.8 8471.2 8365.1 8383.2 8396.1 8398.6 8409.4 6559.2 6594.7 6690.6 6791.1 6817.9 6612.1 6644.8 6659.2 6686.7 6749.0 7435.8 7572.9 7676.8 7741.4 7750.9 7645.4 7907.2 7907.6 7912.1 7934.5 5979.3 6016.9 6068.4 6074.5 6093.4 6819.7 6936.7 6977.2 6981.3 7001.5 6370.2 6388.4 6488.3 6513.8 6527.5 6188.7 6292.0 6317.8 6412.2 6471.4 6379.2 6458.3 6460.3 6462.9 6474.3 5782.8 5831.9 5845.9 5853.9 5855.2 5324.6 5356.6 5357.5 5387.0 5432.9 10:04:53 INFO - 2015-11-09 10:04:53,796 DEBUG : BROWSER_OUTPUT: 10:04:53 INFO - 2015-11-09 10:04:53,796 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4666.31 Median:5320.97 stddev:1402.66 (26.4%) stddev-sans-first:1367.28 10:04:53 INFO - 2015-11-09 10:04:53,796 DEBUG : BROWSER_OUTPUT: Values: 272.8 275.2 278.5 279.9 281.0 5260.8 5269.8 5274.9 5364.8 5418.9 5292.4 5302.5 5315.1 5321.8 5331.1 4123.0 4134.3 4135.5 4140.0 4141.9 4102.6 4120.1 4120.6 4145.3 4153.6 3967.7 4045.0 4078.1 4101.4 4127.7 4094.9 4101.8 4109.7 4112.1 4139.7 3503.7 3504.6 3515.9 3533.1 3534.8 5029.5 5081.8 5082.3 5166.1 5252.4 4481.1 4508.7 4542.5 4545.8 4586.2 5531.6 5538.1 5541.9 5542.3 5547.0 3807.0 3807.3 3808.2 3808.7 3854.0 5689.2 5845.4 5849.5 5851.5 5922.9 3908.8 3926.0 3928.5 3956.1 4006.6 4005.1 4015.4 4020.3 4025.6 4027.6 4591.6 4592.8 4597.3 4597.6 4660.9 5382.5 5412.1 5425.3 5561.5 5605.8 1410.6 1426.9 1431.1 1434.1 1436.3 883.6 884.2 911.7 938.2 938.9 5067.7 5207.3 5228.3 5243.9 5320.1 5764.3 5799.1 5810.4 5830.1 5835.8 5264.8 5274.1 5294.3 5303.7 5319.1 3079.3 3163.3 3193.7 3209.5 3239.5 5893.4 5907.5 5916.9 5957.8 5972.0 5920.0 5923.6 5965.4 5965.9 5979.3 5795.5 5912.5 5933.6 5956.1 5979.8 5764.3 5784.9 5804.6 5827.9 5868.6 5661.6 5681.9 5686.3 5697.7 5704.4 5884.8 5916.3 5939.9 5954.0 6030.9 3607.3 3826.7 3920.6 3923.9 3925.0 5569.1 5660.9 5709.4 5711.1 5716.6 5428.1 5533.1 5534.6 5549.0 5584.7 5521.6 5544.8 5555.0 5571.4 5574.8 5331.0 5447.3 5450.7 5485.0 5494.5 5558.9 5565.1 5565.9 5624.1 5631.0 5527.6 5532.5 5533.1 5540.8 5553.8 10:04:53 INFO - 2015-11-09 10:04:53,797 DEBUG : BROWSER_OUTPUT: 10:04:53 INFO - 2015-11-09 10:04:53,797 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11705.43 Median:2982.18 stddev:14417.34 (483.4%) stddev-sans-first:14433.31 10:04:53 INFO - 2015-11-09 10:04:53,799 DEBUG : BROWSER_OUTPUT: Values: 517.9 565.9 566.8 589.5 652.6 11876.3 12130.8 12160.8 12248.4 12300.0 11167.8 11441.2 11537.9 11602.1 11619.1 620.1 628.0 761.3 780.0 783.8 780.7 782.2 792.1 796.5 798.4 815.4 834.8 837.9 838.5 840.2 817.3 826.5 833.8 834.5 834.6 607.3 610.3 611.5 612.9 616.9 11857.3 12052.6 12080.5 12112.9 12117.8 8064.1 8430.5 8686.6 9291.9 10628.6 8129.1 8166.3 8290.8 8324.4 8646.4 2563.9 2600.3 2635.7 2695.0 2752.4 41032.2 41265.0 41317.8 41369.4 41847.6 6004.4 6087.4 6181.0 6185.6 6375.5 10636.8 10637.3 10645.5 10681.7 10706.3 5380.8 5418.9 5594.3 5648.5 5678.2 3231.7 3284.4 3313.6 3391.1 3485.8 2342.5 2375.3 2375.5 2388.1 2405.5 339.3 346.2 351.6 352.6 357.1 491.6 505.5 507.6 523.2 535.6 6383.3 7504.3 7556.9 7678.8 7765.9 502.4 506.4 545.5 553.2 562.8 3324.4 3329.9 3363.9 3395.3 3442.1 52345.5 52762.2 52924.2 53073.7 53429.5 43676.0 44461.0 44595.3 44996.3 45087.3 42689.8 42743.0 42989.6 43758.8 43922.3 7041.0 7193.3 7325.4 7352.7 7389.8 30447.7 30807.7 31055.0 31112.1 32074.0 37167.8 37539.8 40767.0 41998.8 42071.0 6288.7 6349.7 6394.1 6410.3 6717.3 9658.9 10063.4 10177.3 10244.3 10624.8 9191.4 9442.8 9514.3 9832.4 9898.5 9001.4 9120.6 9596.4 9598.8 10040.3 8908.8 9344.7 9409.1 9463.3 9855.9 7555.5 8082.2 8163.5 8327.9 8429.6 7054.1 7694.4 7791.1 7825.6 8096.6 10:04:53 INFO - 2015-11-09 10:04:53,799 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:04:53 INFO - 2015-11-09 10:04:53,799 DEBUG : BROWSER_OUTPUT: 10:04:54 INFO - 2015-11-09 10:04:54,414 INFO : Browser exited with error code: 0 10:04:54 INFO - 2015-11-09 10:04:54,445 INFO : Completed test dromaeo_css (00:18:32) 10:04:54 INFO - 2015-11-09 10:04:54,445 INFO : Starting test kraken 10:04:54 INFO - 2015-11-09 10:04:54,445 DEBUG : operating with platform_type : mac_ 10:04:54 INFO - 2015-11-09 10:04:54,445 INFO : Initialising browser for kraken test... 10:04:54 INFO - 2015-11-09 10:04:54,459 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/tmpOBHfEe/profile http://localhost:49278/getInfo.html 10:04:57 INFO - 2015-11-09 10:04:57,809 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:04:57 INFO - 2015-11-09 10:04:57,810 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:04:57 INFO - 2015-11-09 10:04:57,810 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 10:04:57 INFO - 2015-11-09 10:04:57,810 DEBUG : BROWSER_OUTPUT: __metrics 10:04:58 INFO - 2015-11-09 10:04:58,483 INFO : Browser initialized. 10:04:58 INFO - 2015-11-09 10:04:58,483 INFO : Running cycle 1/1 for kraken test... 10:04:58 INFO - 2015-11-09 10:04:58,484 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/tmpOBHfEe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:05:10 INFO - 2015-11-09 10:05:10,768 DEBUG : BROWSER_OUTPUT: RSS: Main: 240947200 10:05:10 INFO - 2015-11-09 10:05:10,768 DEBUG : BROWSER_OUTPUT: 10:05:13 INFO - 2015-11-09 10:05:13,563 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 10:05:14 INFO - 2015-11-09 10:05:14,174 DEBUG : BROWSER_OUTPUT: RSS: Main: 259371008 10:05:14 INFO - 2015-11-09 10:05:14,174 DEBUG : BROWSER_OUTPUT: 10:05:17 INFO - 2015-11-09 10:05:17,103 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 10:05:17 INFO - 2015-11-09 10:05:17,700 DEBUG : BROWSER_OUTPUT: RSS: Main: 267100160 10:05:17 INFO - 2015-11-09 10:05:17,700 DEBUG : BROWSER_OUTPUT: 10:05:20 INFO - 2015-11-09 10:05:20,896 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 10:05:21 INFO - 2015-11-09 10:05:21,482 DEBUG : BROWSER_OUTPUT: RSS: Main: 267063296 10:05:21 INFO - 2015-11-09 10:05:21,483 DEBUG : BROWSER_OUTPUT: 10:05:23 INFO - 2015-11-09 10:05:23,671 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 10:05:24 INFO - 2015-11-09 10:05:24,262 DEBUG : BROWSER_OUTPUT: RSS: Main: 267354112 10:05:24 INFO - 2015-11-09 10:05:24,263 DEBUG : BROWSER_OUTPUT: 10:05:26 INFO - 2015-11-09 10:05:26,596 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:05:27 INFO - 2015-11-09 10:05:27,184 DEBUG : BROWSER_OUTPUT: RSS: Main: 267833344 10:05:27 INFO - 2015-11-09 10:05:27,184 DEBUG : BROWSER_OUTPUT: 10:05:30 INFO - 2015-11-09 10:05:30,562 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 10:05:31 INFO - 2015-11-09 10:05:31,151 DEBUG : BROWSER_OUTPUT: RSS: Main: 266506240 10:05:31 INFO - 2015-11-09 10:05:31,151 DEBUG : BROWSER_OUTPUT: 10:05:34 INFO - 2015-11-09 10:05:34,664 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 10:05:35 INFO - 2015-11-09 10:05:35,251 DEBUG : BROWSER_OUTPUT: RSS: Main: 266469376 10:05:35 INFO - 2015-11-09 10:05:35,251 DEBUG : BROWSER_OUTPUT: 10:05:38 INFO - 2015-11-09 10:05:38,488 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 10:05:39 INFO - 2015-11-09 10:05:39,074 DEBUG : BROWSER_OUTPUT: RSS: Main: 265736192 10:05:39 INFO - 2015-11-09 10:05:39,075 DEBUG : BROWSER_OUTPUT: 10:05:40 INFO - 2015-11-09 10:05:40,757 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:05:41 INFO - 2015-11-09 10:05:41,350 DEBUG : BROWSER_OUTPUT: RSS: Main: 267485184 10:05:41 INFO - 2015-11-09 10:05:41,350 DEBUG : BROWSER_OUTPUT: 10:05:43 INFO - 2015-11-09 10:05:43,304 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:05:43 INFO - 2015-11-09 10:05:43,930 DEBUG : BROWSER_OUTPUT: RSS: Main: 267358208 10:05:43 INFO - 2015-11-09 10:05:43,930 DEBUG : BROWSER_OUTPUT: 10:05:46 INFO - 2015-11-09 10:05:46,288 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:05:46 INFO - 2015-11-09 10:05:46,877 DEBUG : BROWSER_OUTPUT: RSS: Main: 268345344 10:05:46 INFO - 2015-11-09 10:05:46,877 DEBUG : BROWSER_OUTPUT: 10:05:49 INFO - 2015-11-09 10:05:49,729 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:05:50 INFO - 2015-11-09 10:05:50,337 DEBUG : BROWSER_OUTPUT: RSS: Main: 267812864 10:05:50 INFO - 2015-11-09 10:05:50,337 DEBUG : BROWSER_OUTPUT: 10:05:53 INFO - 2015-11-09 10:05:53,284 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:05:53 INFO - 2015-11-09 10:05:53,877 DEBUG : BROWSER_OUTPUT: RSS: Main: 266240000 10:05:53 INFO - 2015-11-09 10:05:53,878 DEBUG : BROWSER_OUTPUT: 10:05:55 INFO - 2015-11-09 10:05:55,764 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 10:05:56 INFO - 2015-11-09 10:05:56,026 DEBUG : BROWSER_OUTPUT: RSS: Main: 268075008 10:05:56 INFO - 2015-11-09 10:05:56,026 DEBUG : BROWSER_OUTPUT: 10:05:56 INFO - 2015-11-09 10:05:56,026 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:05:56 INFO - 2015-11-09 10:05:56,026 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:05:56 INFO - 2015-11-09 10:05:56,027 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:05:56 INFO - 2015-11-09 10:05:56,027 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:05:56 INFO - 2015-11-09 10:05:56,027 DEBUG : BROWSER_OUTPUT: |0;ai-astar;117;113;128;129;129;140;129;129;128;129 10:05:56 INFO - 2015-11-09 10:05:56,027 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;166;154;177;194;151;173;171;155;197;154 10:05:56 INFO - 2015-11-09 10:05:56,027 DEBUG : BROWSER_OUTPUT: |2;audio-dft;188;194;203;200;193;193;193;184;195;195 10:05:56 INFO - 2015-11-09 10:05:56,027 DEBUG : BROWSER_OUTPUT: |3;audio-fft;81;85;93;129;80;82;85;84;138;78 10:05:56 INFO - 2015-11-09 10:05:56,027 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;96;100;148;102;105;104;148;108;109;148 10:05:56 INFO - 2015-11-09 10:05:56,027 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;143;136;143;142;138;137;136;144;137;136 10:05:56 INFO - 2015-11-09 10:05:56,027 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;150;148;156;151;148;149;150;149;149;157 10:05:56 INFO - 2015-11-09 10:05:56,027 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;122;127;128;124;123;127;126;121;124;127 10:05:56 INFO - 2015-11-09 10:05:56,027 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;68;68;70;71;75;73;73;74;73;73 10:05:56 INFO - 2015-11-09 10:05:56,027 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;75;74;76;80;79;80;79;80;80;79 10:05:56 INFO - 2015-11-09 10:05:56,028 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;98;102;108;107;109;106;102;102;114;105 10:05:56 INFO - 2015-11-09 10:05:56,028 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;146;150;150;158;149;156;145;151;158;164 10:05:56 INFO - 2015-11-09 10:05:56,028 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;188;192;188;185;188;173;188;186;185;172 10:05:56 INFO - 2015-11-09 10:05:56,028 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;79;82;88;86;89;92;90;88;86;87 10:05:56 INFO - 2015-11-09 10:05:56,028 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:05:56 INFO - 2015-11-09 10:05:56,028 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:05:56 INFO - 2015-11-09 10:05:56,028 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,735 10:05:56 INFO - 2015-11-09 10:05:56,028 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:05:56 INFO - 2015-11-09 10:05:56,029 DEBUG : BROWSER_OUTPUT: __startTimestamp1447092356024__endTimestamp 10:05:56 INFO - 2015-11-09 10:05:56,029 DEBUG : BROWSER_OUTPUT: 10:05:56 INFO - 2015-11-09 10:05:56,030 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:05:56 INFO - 2015-11-09 10:05:56,030 DEBUG : BROWSER_OUTPUT: Number of tests: 14 10:05:56 INFO - 2015-11-09 10:05:56,030 DEBUG : BROWSER_OUTPUT: 10:05:56 INFO - 2015-11-09 10:05:56,031 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:127.10 Median:129.00 stddev:7.36 (5.7%) stddev-sans-first:6.83 10:05:56 INFO - 2015-11-09 10:05:56,031 DEBUG : BROWSER_OUTPUT: Values: 117.0 113.0 128.0 129.0 129.0 140.0 129.0 129.0 128.0 129.0 10:05:56 INFO - 2015-11-09 10:05:56,031 DEBUG : BROWSER_OUTPUT: 10:05:56 INFO - 2015-11-09 10:05:56,031 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:169.20 Median:172.00 stddev:16.57 (9.6%) stddev-sans-first:17.54 10:05:56 INFO - 2015-11-09 10:05:56,031 DEBUG : BROWSER_OUTPUT: Values: 166.0 154.0 177.0 194.0 151.0 173.0 171.0 155.0 197.0 154.0 10:05:56 INFO - 2015-11-09 10:05:56,032 DEBUG : BROWSER_OUTPUT: 10:05:56 INFO - 2015-11-09 10:05:56,032 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:193.80 Median:194.50 stddev:5.35 (2.8%) stddev-sans-first:5.25 10:05:56 INFO - 2015-11-09 10:05:56,032 DEBUG : BROWSER_OUTPUT: Values: 188.0 194.0 203.0 200.0 193.0 193.0 193.0 184.0 195.0 195.0 10:05:56 INFO - 2015-11-09 10:05:56,032 DEBUG : BROWSER_OUTPUT: 10:05:56 INFO - 2015-11-09 10:05:56,032 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:93.50 Median:83.00 stddev:21.57 (26.0%) stddev-sans-first:22.40 10:05:56 INFO - 2015-11-09 10:05:56,034 DEBUG : BROWSER_OUTPUT: Values: 81.0 85.0 93.0 129.0 80.0 82.0 85.0 84.0 138.0 78.0 10:05:56 INFO - 2015-11-09 10:05:56,034 DEBUG : BROWSER_OUTPUT: 10:05:56 INFO - 2015-11-09 10:05:56,034 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:116.80 Median:128.50 stddev:21.85 (17.0%) stddev-sans-first:21.84 10:05:56 INFO - 2015-11-09 10:05:56,034 DEBUG : BROWSER_OUTPUT: Values: 96.0 100.0 148.0 102.0 105.0 104.0 148.0 108.0 109.0 148.0 10:05:56 INFO - 2015-11-09 10:05:56,034 DEBUG : BROWSER_OUTPUT: 10:05:56 INFO - 2015-11-09 10:05:56,035 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:139.20 Median:140.00 stddev:3.36 (2.4%) stddev-sans-first:3.27 10:05:56 INFO - 2015-11-09 10:05:56,035 DEBUG : BROWSER_OUTPUT: Values: 143.0 136.0 143.0 142.0 138.0 137.0 136.0 144.0 137.0 136.0 10:05:56 INFO - 2015-11-09 10:05:56,035 DEBUG : BROWSER_OUTPUT: 10:05:56 INFO - 2015-11-09 10:05:56,035 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:150.70 Median:150.00 stddev:3.20 (2.1%) stddev-sans-first:3.38 10:05:56 INFO - 2015-11-09 10:05:56,036 DEBUG : BROWSER_OUTPUT: Values: 150.0 148.0 156.0 151.0 148.0 149.0 150.0 149.0 149.0 157.0 10:05:56 INFO - 2015-11-09 10:05:56,036 DEBUG : BROWSER_OUTPUT: 10:05:56 INFO - 2015-11-09 10:05:56,036 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:124.90 Median:126.50 stddev:2.42 (1.9%) stddev-sans-first:2.33 10:05:56 INFO - 2015-11-09 10:05:56,036 DEBUG : BROWSER_OUTPUT: Values: 122.0 127.0 128.0 124.0 123.0 127.0 126.0 121.0 124.0 127.0 10:05:56 INFO - 2015-11-09 10:05:56,036 DEBUG : BROWSER_OUTPUT: 10:05:56 INFO - 2015-11-09 10:05:56,036 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.80 Median:73.00 stddev:2.44 (3.3%) stddev-sans-first:2.17 10:05:56 INFO - 2015-11-09 10:05:56,037 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 70.0 71.0 75.0 73.0 73.0 74.0 73.0 73.0 10:05:56 INFO - 2015-11-09 10:05:56,037 DEBUG : BROWSER_OUTPUT: 10:05:56 INFO - 2015-11-09 10:05:56,037 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:78.20 Median:79.50 stddev:2.30 (2.9%) stddev-sans-first:2.13 10:05:56 INFO - 2015-11-09 10:05:56,037 DEBUG : BROWSER_OUTPUT: Values: 75.0 74.0 76.0 80.0 79.0 80.0 79.0 80.0 80.0 79.0 10:05:56 INFO - 2015-11-09 10:05:56,037 DEBUG : BROWSER_OUTPUT: 10:05:56 INFO - 2015-11-09 10:05:56,037 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:105.30 Median:107.50 stddev:4.55 (4.2%) stddev-sans-first:3.98 10:05:56 INFO - 2015-11-09 10:05:56,038 DEBUG : BROWSER_OUTPUT: Values: 98.0 102.0 108.0 107.0 109.0 106.0 102.0 102.0 114.0 105.0 10:05:56 INFO - 2015-11-09 10:05:56,038 DEBUG : BROWSER_OUTPUT: 10:05:56 INFO - 2015-11-09 10:05:56,038 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:152.70 Median:153.50 stddev:6.06 (3.9%) stddev-sans-first:5.92 10:05:56 INFO - 2015-11-09 10:05:56,038 DEBUG : BROWSER_OUTPUT: Values: 146.0 150.0 150.0 158.0 149.0 156.0 145.0 151.0 158.0 164.0 10:05:56 INFO - 2015-11-09 10:05:56,038 DEBUG : BROWSER_OUTPUT: 10:05:56 INFO - 2015-11-09 10:05:56,038 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.50 Median:188.00 stddev:6.64 (3.5%) stddev-sans-first:6.92 10:05:56 INFO - 2015-11-09 10:05:56,038 DEBUG : BROWSER_OUTPUT: Values: 188.0 192.0 188.0 185.0 188.0 173.0 188.0 186.0 185.0 172.0 10:05:56 INFO - 2015-11-09 10:05:56,039 DEBUG : BROWSER_OUTPUT: 10:05:56 INFO - 2015-11-09 10:05:56,039 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:86.70 Median:88.00 stddev:3.80 (4.3%) stddev-sans-first:2.83 10:05:56 INFO - 2015-11-09 10:05:56,039 DEBUG : BROWSER_OUTPUT: Values: 79.0 82.0 88.0 86.0 89.0 92.0 90.0 88.0 86.0 87.0 10:05:56 INFO - 2015-11-09 10:05:56,039 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:05:56 INFO - 2015-11-09 10:05:56,039 DEBUG : BROWSER_OUTPUT: 10:05:56 INFO - 2015-11-09 10:05:56,722 INFO : Browser exited with error code: 0 10:05:56 INFO - 2015-11-09 10:05:56,775 INFO : Completed test kraken (00:01:02) 10:05:56 INFO - 2015-11-09 10:05:56,775 INFO : Starting test v8_7 10:05:56 INFO - 2015-11-09 10:05:56,776 DEBUG : operating with platform_type : mac_ 10:05:56 INFO - 2015-11-09 10:05:56,776 INFO : Initialising browser for v8_7 test... 10:05:56 INFO - 2015-11-09 10:05:56,790 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/tmptG2f4Z/profile http://localhost:49278/getInfo.html 10:06:00 INFO - 2015-11-09 10:06:00,067 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:06:00 INFO - 2015-11-09 10:06:00,067 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:06:00 INFO - 2015-11-09 10:06:00,067 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 10:06:00 INFO - 2015-11-09 10:06:00,067 DEBUG : BROWSER_OUTPUT: __metrics 10:06:00 INFO - 2015-11-09 10:06:00,739 INFO : Browser initialized. 10:06:00 INFO - 2015-11-09 10:06:00,740 INFO : Running cycle 1/1 for v8_7 test... 10:06:00 INFO - 2015-11-09 10:06:00,740 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/T/tmptG2f4Z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:06:13 INFO - 2015-11-09 10:06:13,056 DEBUG : BROWSER_OUTPUT: RSS: Main: 239898624 10:06:13 INFO - 2015-11-09 10:06:13,056 DEBUG : BROWSER_OUTPUT: 10:06:35 INFO - 2015-11-09 10:06:35,595 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/v8_7/run.html (next: http://localhost:49278/tests/v8_7/run.html) 10:06:35 INFO - 2015-11-09 10:06:35,859 DEBUG : BROWSER_OUTPUT: RSS: Main: 260866048 10:06:35 INFO - 2015-11-09 10:06:35,859 DEBUG : BROWSER_OUTPUT: 10:06:35 INFO - 2015-11-09 10:06:35,860 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:06:35 INFO - 2015-11-09 10:06:35,860 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:06:35 INFO - 2015-11-09 10:06:35,860 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:06:35 INFO - 2015-11-09 10:06:35,860 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:06:35 INFO - 2015-11-09 10:06:35,860 DEBUG : BROWSER_OUTPUT: |0;Richards;183.55359765051395 10:06:35 INFO - 2015-11-09 10:06:35,860 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;227.1694684234439 10:06:35 INFO - 2015-11-09 10:06:35,860 DEBUG : BROWSER_OUTPUT: |2;Encrypt;389.7116134060795 10:06:35 INFO - 2015-11-09 10:06:35,861 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6797.2972972972975 10:06:35 INFO - 2015-11-09 10:06:35,861 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1298.7012987012988 10:06:35 INFO - 2015-11-09 10:06:35,861 DEBUG : BROWSER_OUTPUT: |5;Earley;895.2551477170994 10:06:35 INFO - 2015-11-09 10:06:35,861 DEBUG : BROWSER_OUTPUT: |6;Boyer;14197.18309859155 10:06:35 INFO - 2015-11-09 10:06:35,861 DEBUG : BROWSER_OUTPUT: |7;RegExp;33816.666666666664 10:06:35 INFO - 2015-11-09 10:06:35,861 DEBUG : BROWSER_OUTPUT: |8;Splay;713.6752136752136 10:06:35 INFO - 2015-11-09 10:06:35,861 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6555.555555555556 10:06:35 INFO - 2015-11-09 10:06:35,861 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:06:35 INFO - 2015-11-09 10:06:35,862 DEBUG : BROWSER_OUTPUT: __startTimestamp1447092395856__endTimestamp 10:06:35 INFO - 2015-11-09 10:06:35,862 DEBUG : BROWSER_OUTPUT: 10:06:35 INFO - 2015-11-09 10:06:35,862 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:06:35 INFO - 2015-11-09 10:06:35,862 DEBUG : BROWSER_OUTPUT: Number of tests: 10 10:06:35 INFO - 2015-11-09 10:06:35,862 DEBUG : BROWSER_OUTPUT: 10:06:35 INFO - 2015-11-09 10:06:35,862 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:183.55 Median:183.55 stddev:0.00 (0.0%) 10:06:35 INFO - 2015-11-09 10:06:35,862 DEBUG : BROWSER_OUTPUT: Values: 183.6 10:06:35 INFO - 2015-11-09 10:06:35,862 DEBUG : BROWSER_OUTPUT: 10:06:35 INFO - 2015-11-09 10:06:35,863 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:227.17 Median:227.17 stddev:0.00 (0.0%) 10:06:35 INFO - 2015-11-09 10:06:35,863 DEBUG : BROWSER_OUTPUT: Values: 227.2 10:06:35 INFO - 2015-11-09 10:06:35,863 DEBUG : BROWSER_OUTPUT: 10:06:35 INFO - 2015-11-09 10:06:35,863 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:389.71 Median:389.71 stddev:0.00 (0.0%) 10:06:35 INFO - 2015-11-09 10:06:35,863 DEBUG : BROWSER_OUTPUT: Values: 389.7 10:06:35 INFO - 2015-11-09 10:06:35,863 DEBUG : BROWSER_OUTPUT: 10:06:35 INFO - 2015-11-09 10:06:35,863 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6797.30 Median:6797.30 stddev:0.00 (0.0%) 10:06:35 INFO - 2015-11-09 10:06:35,864 DEBUG : BROWSER_OUTPUT: Values: 6797.3 10:06:35 INFO - 2015-11-09 10:06:35,864 DEBUG : BROWSER_OUTPUT: 10:06:35 INFO - 2015-11-09 10:06:35,864 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1298.70 Median:1298.70 stddev:0.00 (0.0%) 10:06:35 INFO - 2015-11-09 10:06:35,864 DEBUG : BROWSER_OUTPUT: Values: 1298.7 10:06:35 INFO - 2015-11-09 10:06:35,864 DEBUG : BROWSER_OUTPUT: 10:06:35 INFO - 2015-11-09 10:06:35,864 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:895.26 Median:895.26 stddev:0.00 (0.0%) 10:06:35 INFO - 2015-11-09 10:06:35,864 DEBUG : BROWSER_OUTPUT: Values: 895.3 10:06:35 INFO - 2015-11-09 10:06:35,864 DEBUG : BROWSER_OUTPUT: 10:06:35 INFO - 2015-11-09 10:06:35,865 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:14197.18 Median:14197.18 stddev:0.00 (0.0%) 10:06:35 INFO - 2015-11-09 10:06:35,865 DEBUG : BROWSER_OUTPUT: Values: 14197.2 10:06:35 INFO - 2015-11-09 10:06:35,865 DEBUG : BROWSER_OUTPUT: 10:06:35 INFO - 2015-11-09 10:06:35,865 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:33816.67 Median:33816.67 stddev:0.00 (0.0%) 10:06:35 INFO - 2015-11-09 10:06:35,865 DEBUG : BROWSER_OUTPUT: Values: 33816.7 10:06:35 INFO - 2015-11-09 10:06:35,865 DEBUG : BROWSER_OUTPUT: 10:06:35 INFO - 2015-11-09 10:06:35,865 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:713.68 Median:713.68 stddev:0.00 (0.0%) 10:06:35 INFO - 2015-11-09 10:06:35,865 DEBUG : BROWSER_OUTPUT: Values: 713.7 10:06:35 INFO - 2015-11-09 10:06:35,865 DEBUG : BROWSER_OUTPUT: 10:06:35 INFO - 2015-11-09 10:06:35,865 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6555.56 Median:6555.56 stddev:0.00 (0.0%) 10:06:35 INFO - 2015-11-09 10:06:35,866 DEBUG : BROWSER_OUTPUT: Values: 6555.6 10:06:35 INFO - 2015-11-09 10:06:35,866 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:06:35 INFO - 2015-11-09 10:06:35,866 DEBUG : BROWSER_OUTPUT: 10:06:36 INFO - 2015-11-09 10:06:36,581 INFO : Browser exited with error code: 0 10:06:36 INFO - 2015-11-09 10:06:36,602 INFO : Completed test v8_7 (00:00:39) 10:06:36 INFO - 2015-11-09 10:06:36,869 INFO : Completed test suite (00:20:14) 10:06:36 INFO - 2015-11-09 10:06:36,870 DEBUG : Working with test: dromaeo_css 10:06:36 INFO - 2015-11-09 10:06:36,870 DEBUG : Generating results file: dromaeo_css 10:06:36 INFO - 2015-11-09 10:06:36,870 DEBUG : Working with test: kraken 10:06:36 INFO - 2015-11-09 10:06:36,870 DEBUG : Generating results file: kraken 10:06:36 INFO - 2015-11-09 10:06:36,871 INFO : javascript benchmark 10:06:36 INFO - 2015-11-09 10:06:36,871 DEBUG : Working with test: v8_7 10:06:36 INFO - 2015-11-09 10:06:36,871 DEBUG : Generating results file: v8_7 10:06:36 INFO - 2015-11-09 10:06:36,871 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:06:36 INFO - 2015-11-09 10:06:36,999 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,57]] 10:06:36 INFO - 2015-11-09 10:06:36,999 DEBUG : process_Request line: dromaeo_css 5921.65 graph.html#tests=[[72,64,57]] 10:06:37 INFO - 2015-11-09 10:06:36,999 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:06:37 INFO - 2015-11-09 10:06:37,028 DEBUG : process_Request line: kraken 1794.40 graph.html#tests=[[232,64,57]] 10:06:37 INFO - 2015-11-09 10:06:37,028 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:06:37 INFO - 2015-11-09 10:06:37,058 DEBUG : process_Request line: v8_7 17136.82 graph.html#tests=[[230,64,57]] 10:06:37 INFO - 2015-11-09 10:06:37,059 INFO : javascript benchmark 10:06:37 INFO - 2015-11-09 10:06:37,061 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [287.85894911493347, 291.84240510124533, 293.55966050923615, 294.3759230431484, 299.30411792582254, 8780.69267575635, 8947.06055864133, 14602.78095828562, 14993.025453345539, 15188.54434366968, 10031.899681003188, 10116.342437741541, 10353.585856565729, 10357.844632330522, 10367.0, 3314.237725323177, 3939.5666476687543, 3944.2505923874373, 3970.702197335197, 3986.4219688145345, 3879.0, 4052.53395859477, 4111.198316328318, 4156.584341565849, 4172.874813755577, 4080.8571699990507, 4114.917701645965, 4119.382092686106, 4120.690948178883, 4145.689073319498, 4020.557738648746, 4194.056337324108, 4202.075543380452, 4202.789860506962, 4244.511881133678, 3542.256126213498, 3543.0433782878476, 3557.1462848916076, 3562.69717074049, 3602.009447401985, 11021.944890275578, 11038.779224415466, 11567.942160289145, 11573.537058517733, 11624.941875290653, 1564.8435156484375, 1588.317023679817, 1622.0, 1661.335465813672, 1852.2868695552174, 12369.196002259914, 12441.875581244161, 12677.302748348837, 12751.171173873761, 12775.29735864527, 1463.6414078550717, 1545.6676814484827, 1576.8107827060712, 1611.58904479357, 1645.1198608744264, 47935.76032119852, 52004.0, 54894.242009451635, 55150.72424637851, 55216.0, 14919.701605967819, 14927.626809329853, 14931.17878516692, 14944.534151865038, 15190.088594684354, 21017.05423255957, 21135.14675518816, 21327.78672213289, 21341.67987480158, 21369.0, 8011.719589814328, 8106.108328083906, 8248.670053197804, 8301.626426810808, 8404.579771011426, 7301.561906285639, 7409.370203532652, 7485.70057197706, 7506.774796756106, 7536.0956685198125, 7023.122109736283, 7138.607376594337, 7144.3570078693165, 7146.178189508169, 7250.456215783837, 909.2680392284275, 920.6593560382702, 922.1009515722117, 970.8932017478072, 2993.625796775403, 350.4847873625766, 352.4976907906275, 362.20857426523133, 370.48317596952637, 400.2475346348846, 9722.611095556098, 9811.116999470081, 10164.440955747505, 10263.435511046964, 10299.17606591471, 397.9263836190314, 404.12305297504486, 411.6377587722845, 411.9279126152911, 432.7057600831402, 5430.51125398716, 5586.050371436865, 5610.4670056344585, 5623.5220006299105, 5646.407127251661, 525624.0, 532334.0, 542740.0, 563752.0, 574221.0, 59172.0, 59876.0, 60072.098918516254, 60542.697286514165, 61440.69279653663, 431.9805608747614, 434.8086841789602, 435.3317657395882, 435.6297147424727, 435.92589259825905, 9395.765105872408, 9427.481488518197, 9487.952560237154, 9704.175145112744, 9710.951445242728, 29542.852285738434, 30580.235494111934, 31069.378612428078, 31239.375212496077, 31250.21874453157, 40786.388204176365, 41421.378679320434, 41548.1690366197, 41686.37470438007, 41887.581124189586, 5301.284326615858, 5415.377231618257, 5433.347998240237, 5437.34751829783, 5495.395506494362, 8057.315128214167, 8586.527740974307, 10140.188784897338, 10168.288219824837, 10303.330283531546, 8280.751577452686, 8526.360522960678, 8656.307495400228, 8713.782155446164, 8728.563571821256, 8298.0, 8412.873806893023, 8414.705485307984, 8444.40889137779, 8585.914140858762, 8404.32765378756, 8811.383203175716, 8858.645654174019, 8888.955555222183, 8944.5080520572, 5277.15565509532, 5288.338957630296, 5334.1732031535175, 5334.973325133349, 5347.171188465794, 8564.914350856412, 8748.256398206224, 8835.425697329652, 8846.33652476054, 8868.201861832466], "dojo.html": [2706.9323266918327, 2763.419681866808, 2797.8041537092404, 2826.3640680846825, 2835.2203144135374, 4640.930386044208, 4741.431028276603, 4765.237561990082, 4766.137650689654, 4833.589144922686, 4561.817527298904, 4615.376924115243, 4633.6061434778085, 4640.419947506562, 4773.925866679995, 4384.934225986613, 4439.866803995886, 4529.411176547044, 4540.091981603676, 4603.677742558022, 123.53711960612044, 4197.754163840529, 4477.6417886569, 4541.545845415449, 4600.17196904557, 4285.978570107145, 4352.499462561815, 4385.627221686161, 4400.889977750549, 4413.801378937956, 4427.46870375557, 4450.310201918708, 4464.1071785643, 4468.4414448193975, 4503.729776213438, 4274.2092712848225, 4419.4033805436175, 4430.446194225722, 4442.62237709795, 4454.28731402974, 4406.140802543506, 4513.435820522434, 4531.139083574143, 4600.884977875547, 4663.743494107823, 5032.295478632995, 5036.244563315496, 5038.0, 5058.747062646889, 5098.439171691111, 4825.662203645711, 4837.8306759263605, 4996.525330093636, 5099.796008159669, 5141.100307446182, 4794.95205047952, 4801.399825021837, 4823.469418363977, 4831.806727730922, 4915.213565829486, 5147.742612869341, 5164.638475306692, 5177.792888284502, 5207.114790485626, 5210.739463026834, 4812.278158276216, 4876.390451193601, 4914.459409464956, 5013.749312534359, 5148.382194136728, 5146.974265128725, 5166.8966620668125, 5184.066867963803, 5184.792608295701, 5188.766505507261, 5081.2632168335385, 5087.567556757643, 5087.592992560586, 5122.564582010571, 5144.382674079135, 4824.49342818999, 4880.975595122072, 4902.3872015998, 4982.626303027215, 5028.7737051832755, 3924.4113382992778, 3947.072437977073, 3986.880393588197, 3996.0409501719378, 4010.7192496525545, 3516.6834984851484, 3598.226381328027, 3623.601403845575, 3659.3596120678776, 3680.0799800049986, 4633.166030114544, 4643.767811609474, 4688.015516741522, 4691.671582989158, 4694.859154225379, 5068.417132029864, 5111.105556527667, 5117.2068329409, 5136.717480538607, 5164.845054648292, 4572.748498832596, 4716.64625153108, 4742.146413645577, 4805.567498925114, 4825.372701548777, 4348.195583817004, 4410.867673969786, 4418.845340413134, 4430.424044874146, 4445.688801783909, 5192.740362981911, 5194.091034069098, 5198.818041368534, 5204.973975130176, 5212.348456442945, 4864.197407427876, 4980.775865086152, 4983.07813054586, 5096.872578185575, 5169.327987361619, 5269.683818970874, 5284.0, 5290.1800220965815, 5296.576273898156, 5296.973515132399, 5102.540771330598, 5117.360329958755, 5137.974310128575, 5163.715995620277, 5364.544013758718, 4968.751562421937, 5024.221245706921, 5030.899382012412, 5128.410232823273, 5155.149400348901, 4946.208606622923, 4959.82640607577, 5003.699778013331, 5005.7997680092385, 5031.270465782368, 4972.801087956441, 4980.377452818398, 4987.700737955589, 4989.900201996013, 5040.344755181803, 4409.492908315585, 4743.66794324394, 4753.714777113384, 4768.57082862544, 4856.0, 4911.877203069952, 4981.028699403581, 4990.94324935263, 5045.31888195089, 5046.394432668103, 4704.317873908332, 4885.1450996076255, 4903.362562866804, 4911.9754401227765, 4938.481459446706], "mootools.html": [1463.4365769178862, 1517.8254500732417, 1537.5003123984707, 1564.1944398634705, 1590.5625952862958, 6501.609903405787, 6618.569792963466, 6890.621015844126, 7282.9271707282915, 7300.8683654033575, 6787.626680532569, 7011.579305241689, 7109.289071092888, 7131.7503887363955, 7137.678804453799, 1925.8940758258325, 1926.5087402712288, 1931.3626503253893, 1935.4000259919399, 1936.3029309448586, 1938.6510428122933, 1981.28673677476, 1990.93031743889, 1993.1429485321305, 1993.3820515640125, 1925.2010415677478, 1945.085809669453, 1951.1610007696684, 1954.4722924810364, 1959.882407055574, 1844.58496838211, 1886.151231945623, 1888.1880791259753, 1898.0509745127436, 1900.819422154907, 1915.8946257955806, 1925.2587753714781, 1929.21866644008, 1947.5423275530238, 1950.1809240119185, 7044.577325360444, 7102.39629631482, 7127.572345659225, 7168.283171682842, 7175.031370764932, 4110.23960567296, 4188.225178342016, 4201.264778663722, 4221.831126754926, 4236.5128010278595, 2320.709911261092, 2392.545416370884, 2453.7300896901324, 2505.912293069734, 2539.9619005714744, 755.3126654744157, 781.9218078192192, 785.6189747972229, 785.6464590934046, 846.0312941681801, 8660.480371177686, 8678.956605216996, 8709.0, 8712.56437178145, 8757.080506546848, 3834.6357096075826, 3884.3590807516443, 3913.3542965410957, 3919.9020024499614, 3960.524737031517, 8089.271965523131, 8097.797555061171, 8098.473599216032, 8103.716369927024, 8108.391870609727, 4293.2057569349145, 4303.053328267776, 4310.676699247569, 4314.482262128565, 4351.6301114405, 3920.2355540669864, 3923.4507168996365, 3931.744436611611, 3937.4684417603257, 3946.309395855714, 3245.6105267368066, 3315.983420082884, 3324.5678061851804, 3337.249118948217, 3343.164208947763, 1054.393723608928, 1065.547142464465, 1069.9037086662238, 1070.6520380876245, 1074.403705943209, 842.7345386203449, 904.1500989070253, 1160.4719852467276, 1172.536847945057, 1172.7947609168361, 6709.496787740939, 6798.354156355138, 6815.011823285695, 6823.28355522663, 6831.180258369028, 958.0946006024241, 993.1111655068673, 997.945113018791, 1011.5245834457793, 1015.137133436573, 5292.761825717852, 5339.519443250126, 5368.731563421813, 5375.247465354853, 5417.431169727122, 7841.568713720686, 8160.224778646138, 8362.45644033148, 8415.789605259917, 8471.152884711479, 8365.079841217583, 8383.16168383169, 8396.07643159252, 8398.580070996426, 8409.411341206056, 6559.180102487189, 6594.670266486753, 6690.59856408617, 6791.083203767428, 6817.863642727217, 6612.107365505595, 6644.800655980328, 6659.234188068434, 6686.69909854048, 6749.021391898245, 7435.814104647211, 7572.886406703794, 7676.846463070819, 7741.380689544935, 7750.8837367440665, 7645.426593005435, 7907.169747176464, 7907.644156013108, 7912.090109637235, 7934.523928564305, 5979.282486101695, 6016.909746353896, 6068.393160684073, 6074.453299203093, 6093.36019717941, 6819.693113809792, 6936.687849046906, 6977.1976222733, 6981.266966968598, 7001.474889383215, 6370.203724534434, 6388.425041746265, 6488.2538508072175, 6513.837154071186, 6527.477801775942, 6188.690565471618, 6291.96854015727, 6317.778877739257, 6412.198475190601, 6471.417572418505, 6379.170707808141, 6458.257300410513, 6460.257070436772, 6462.935370646233, 6474.2878283387845, 5782.7686892523825, 5831.883362332815, 5845.853853653693, 5853.9121913172185, 5855.2095467113095, 5324.627276090637, 5356.5982551308025, 5357.517823395757, 5387.003404370204, 5432.918506222489], "ext.html": [471.1613328275668, 494.77487743076904, 494.77487743076904, 506.81247938262834, 524.3105316508788, 35742.28515429693, 36619.0, 36899.4465083024, 37080.44379334312, 37184.814075929615, 38784.61215387852, 38786.612133878654, 38823.22353552927, 39158.21683566327, 39399.0, 8104.1085480597085, 8299.751007469786, 8339.45793523422, 8354.874676879852, 8492.575371231414, 8106.148854370294, 8179.018517777845, 8239.95880020599, 8268.297194738454, 8316.875246871301, 8092.595370231465, 8214.219649133323, 8214.63034163464, 8252.876206856901, 8319.376046796484, 8055.0, 8153.266206041485, 8172.18278172184, 8195.836083278331, 8210.425270231086, 8019.0, 8112.148224436467, 8120.837583248302, 8148.062972758149, 8218.424710270283, 35313.0, 35778.64221357779, 35908.0, 36013.81993090018, 36027.4595881062, 2214.7563767985507, 2366.7869891709656, 2384.408350841634, 2643.1409791817737, 2723.5097682417354, 24554.50890982188, 25356.0, 26291.868540657364, 26298.079567215056, 26340.60489092665, 2145.8605190662556, 2154.439845640129, 2160.3950893749775, 2167.729033870766, 2169.143188440573, 239433.0, 241741.79129104418, 244750.09124406858, 244952.0, 245650.0, 36154.45768313477, 36880.26239475195, 53705.1944220837, 54108.188377174374, 54167.45832541703, 35751.82124089363, 36082.8195859019, 36115.0, 36128.09679757975, 36319.63680363215, 13058.804117938238, 13130.737385252241, 13237.139585927076, 13268.270245136417, 13313.40089695966, 10531.104856087166, 10559.0, 10579.682609521727, 10597.89402105969, 10599.576016959236, 11943.820842687366, 12326.81509777354, 12337.383130843422, 12362.320072396105, 12368.134230603771, 5239.663885709196, 5338.572914166857, 5354.7858085676135, 5355.518003379714, 5371.435999220103, 794.6849252629531, 832.2052439919862, 920.6363486422825, 946.597695979206, 949.4350861237552, 28648.713512865022, 29530.852345738134, 29582.260443489085, 29689.554656680168, 30001.849990750343, 880.6389380354024, 904.7104926423613, 923.1691477670016, 1004.1314263162458, 1042.2704107125044, 13430.19418834873, 13514.93242533781, 13584.1849489029, 13642.454301828015, 13723.725525489634, 354119.0, 360553.0, 365121.0, 365293.0, 365547.0, 51173.0, 52277.954440910966, 52318.47681523136, 52663.0, 52835.20747188795, 1225.9632211033684, 1233.8272641830151, 1241.7764802335485, 1242.5402601037674, 1255.0524354112586, 24957.875210624556, 25844.35389115287, 26097.217083487525, 26144.084957026414, 26188.73811261863, 42860.57139428566, 43398.34902476402, 43496.34755478607, 43506.56493435025, 43879.0, 244860.0, 245115.0, 245152.0, 245613.0, 246096.0, 28213.57679634766, 33749.15627109243, 34137.658623413445, 40040.0, 40803.38794918138, 39189.608103918596, 39679.40480892731, 40041.799791000856, 40163.0, 40830.79584602177, 32276.83861580771, 32615.836920815244, 32952.0, 33274.33451330911, 33420.0, 32175.195620109684, 32421.0, 32736.50895236621, 32804.50793238151, 32998.34003319968, 32946.67053329436, 33104.50343244805, 33145.83427082849, 34730.479042814884, 35847.283054338244, 27176.864115679295, 27965.300867478476, 28075.157745267676, 28747.5687864678, 30858.228544286572, 21908.946844833757, 22367.328980130624, 22534.549309014055, 22651.660225096966, 22750.886245568665], "prototype.html": [272.7994923731058, 275.1923105684815, 278.4736847358494, 279.8600699650175, 281.04724982309966, 5260.842174734755, 5269.76286067127, 5274.92087618686, 5364.785408583657, 5418.891622167559, 5292.3913749918775, 5302.549283310923, 5315.123004704219, 5321.787128514865, 5331.067063263923, 4122.97938510307, 4134.297169481196, 4135.4623898893105, 4140.006398464377, 4141.855035073773, 4102.5897410258885, 4120.114175452277, 4120.649744771698, 4145.316022856225, 4153.605407486284, 3967.7222594418404, 4044.9595504045024, 4078.062045729484, 4101.405296232045, 4127.669786417095, 4094.9385759213637, 4101.794910254475, 4109.671226301919, 4112.074783173792, 4139.7309174903685, 3503.684668379858, 3504.56192975878, 3515.8945231643092, 3533.0990597397754, 3534.8232588370734, 5029.547340739351, 5081.822136225252, 5082.3138876251605, 5166.07010738067, 5252.4222335543445, 4481.103779244164, 4508.684392092555, 4542.500324964251, 4545.772711364419, 4586.197415452316, 5531.612787104904, 5538.086215774392, 5541.889162216733, 5542.307211598551, 5547.0, 3806.9809650951843, 3807.295650304675, 3808.21931504041, 3808.6953043756434, 3853.98073009636, 5689.203511508392, 5845.444682755132, 5849.502792262663, 5851.502622277111, 5922.851928701773, 3908.8241029153755, 3925.9607403926166, 3928.46965659638, 3956.1296514766705, 4006.6193711597934, 4005.0588111793704, 4015.377616469452, 4020.2562525932794, 4025.577314382006, 4027.597240275949, 4591.609713174351, 4592.770361481913, 4597.310403439444, 4597.563231493003, 4660.906781864412, 5382.4886635769535, 5412.107002344569, 5425.294711687534, 5561.4716601922755, 5605.831825045255, 1410.5697762182633, 1426.8715815576647, 1431.141315210886, 1434.1108512722178, 1436.289036926728, 883.6377085394957, 884.2042162054203, 911.7264820553808, 938.1884669760608, 938.9436633801994, 5067.670601410897, 5207.3490813648295, 5228.346456692913, 5243.9213411798855, 5320.148776195868, 5764.279465066867, 5799.130130480377, 5810.4189581041555, 5830.067189249699, 5835.824925252249, 5264.815731449381, 5274.12976858814, 5294.258803767476, 5303.708296043677, 5319.095753721799, 3079.3071558899514, 3163.28826014145, 3193.744500439959, 3209.5185722141864, 3239.530268111158, 5893.410658934158, 5907.49786268172, 5916.852078697981, 5957.76168953237, 5972.0, 5920.0, 5923.585349025527, 5965.403459654, 5965.850853728692, 5979.282486101609, 5795.536357091507, 5912.526997840162, 5933.58464907461, 5956.106584012433, 5979.760809567656, 5764.250647415809, 5784.913226301524, 5804.593678442468, 5827.94172058274, 5868.559858010581, 5661.603687741818, 5681.9147712783515, 5686.2607860977805, 5697.715114244188, 5704.429557044263, 5884.764609415575, 5916.3492015877355, 5939.910901336397, 5954.0, 6030.90953635687, 3607.314610224049, 3826.6556009959236, 3920.6079392060565, 3923.9019024524614, 3925.038365600446, 5569.136783798518, 5660.88678226425, 5709.429057094258, 5711.143328500758, 5716.5998380113, 5428.07722687152, 5533.142362933751, 5534.640248383842, 5549.0, 5584.720763961867, 5521.558275338044, 5544.805931792368, 5555.0278701227935, 5571.3592936811165, 5574.777008919597, 5331.040412725747, 5447.264619276505, 5450.672959622435, 5485.01269771445, 5494.5054945055135, 5558.861028474321, 5565.081761509306, 5565.916511252253, 5624.128260119688, 5631.014572449887, 5527.585431092603, 5532.5297349724115, 5533.059379905506, 5540.80607178763, 5553.833384998295], "yui.html": [517.9119549676552, 565.8868226354728, 566.8271177290927, 589.5372132875693, 652.6084349390367, 11876.346800925945, 12130.818037729441, 12160.817587736192, 12248.387580620967, 12300.0, 11167.83248251277, 11441.199116061858, 11537.884621153786, 11602.129840261972, 11619.07047436203, 620.1318154583596, 628.0391001767304, 761.299604363985, 779.9688012479494, 783.7687882074773, 780.6643143448315, 782.2373186143493, 792.0851416613821, 796.4783067091035, 798.3573223555036, 815.4373482297226, 834.8121672623641, 837.8785076163953, 838.4675730910885, 840.2437805974611, 817.2726273616486, 826.5371392020458, 833.795720048586, 834.4617721569614, 834.6244190114443, 607.325868286202, 610.3194937644539, 611.5474548833876, 612.8958077126899, 616.8612062285995, 11857.28856268618, 12052.638420847388, 12080.456379462945, 12112.878871211264, 12117.757644847143, 8064.112947575762, 8430.48616067893, 8686.565671716453, 9291.860622090675, 10628.574857005711, 8129.105798362176, 8166.305864001567, 8290.8341833163, 8324.375671824577, 8646.351523635753, 2563.858987755673, 2600.3369140869145, 2635.71007189209, 2695.043259642818, 2752.40823223008, 41032.179356413006, 41264.968375790544, 41317.79341103305, 41369.37945930813, 41847.58152418467, 6004.42957918997, 6087.421694939062, 6181.011038233951, 6185.628862268279, 6375.458086062644, 10636.787264254826, 10637.255392122477, 10645.467726613639, 10681.732956676145, 10706.304090234109, 5380.784768609212, 5418.864528386822, 5594.300712410949, 5648.4633959773755, 5678.176664383641, 3231.6929891660257, 3284.359549887749, 3313.6023677158896, 3391.0844072100394, 3485.7734247273847, 2342.508073304625, 2375.2874137758604, 2375.5011447595853, 2388.10446082719, 2405.4948460823075, 339.30103985789356, 346.24691296430166, 351.5851295471317, 352.56634339762235, 357.0805176670085, 491.5698763581866, 505.5147058823571, 507.57363814396086, 523.2177894048422, 535.5810609841052, 6383.2978372379, 7504.287092726182, 7556.886646700304, 7678.769636910902, 7765.922340776633, 502.4171960525846, 506.35186960690373, 545.5008667069587, 553.2033871225423, 562.7917670461956, 3324.351751408452, 3329.916752081169, 3363.9158971189986, 3395.286989732184, 3442.1050526863196, 52345.47654523406, 52762.20856687153, 52924.206136907975, 53073.734631326595, 53429.46570534245, 43676.0, 44461.0, 44595.33107003398, 44996.3250551242, 45087.32369014467, 42689.786551067045, 42743.0, 42989.57010429918, 43758.781206094405, 43922.34116488192, 7041.0, 7193.3140980996495, 7325.41396688253, 7352.705891764484, 7389.778306650809, 30447.695523044487, 30807.69192308048, 31055.0, 31112.066638000895, 32074.0, 37167.814160929025, 37539.81230093832, 40767.0, 41998.79000604978, 42071.0, 6288.748450061947, 6349.682515874096, 6394.113889892955, 6410.294867564471, 6717.328267173243, 9658.9034109658, 10063.39619622825, 10177.338472999232, 10244.334118282288, 10624.84062739075, 9191.35660503785, 9442.763930901509, 9514.286428518028, 9832.360896541702, 9898.505074746377, 9001.36990410665, 9120.589573469077, 9596.376235544667, 9598.808023839623, 10040.297179197387, 8908.777280568038, 9344.719658410258, 9409.106134917172, 9463.337566370563, 9855.852162217428, 7555.471117021975, 8082.151374105634, 8163.510189388656, 8327.875081873655, 8429.5785210738, 7054.1209377062105, 7694.4229182810395, 7791.142974272939, 7825.569593672175, 8096.5546894921345]}, "summary": {"lowerIsBetter": false, "suite": 5921.648006397226, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6588.984030075203, "unit": "ms", "value": 6588.984030075203}, "dojo.html": {"lowerIsBetter": false, "filtered": 4662.7420386579215, "unit": "ms", "value": 4662.7420386579215}, "mootools.html": {"lowerIsBetter": false, "filtered": 4000.345635763779, "unit": "ms", "value": 4000.345635763779}, "ext.html": {"lowerIsBetter": false, "filtered": 16211.258562269246, "unit": "ms", "value": 16211.258562269246}, "prototype.html": {"lowerIsBetter": false, "filtered": 4201.354922645355, "unit": "ms", "value": 4201.354922645355}, "yui.html": {"lowerIsBetter": false, "filtered": 5150.507472674942, "unit": "ms", "value": 5150.507472674942}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0052.e"}, "testrun": {"date": 1447091182, "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": "20151109064656", "branch": "Fx-Team", "revision": "a02cf2019a51f59e1eb712ab3d306f70c86808c0"}}, {"talos_counters": {}, "results": {"audio-dft": [188.0, 194.0, 203.0, 200.0, 193.0, 193.0, 193.0, 184.0, 195.0, 195.0], "ai-astar": [117.0, 113.0, 128.0, 129.0, 129.0, 140.0, 129.0, 129.0, 128.0, 129.0], "imaging-gaussian-blur": [143.0, 136.0, 143.0, 142.0, 138.0, 137.0, 136.0, 144.0, 137.0, 136.0], "audio-beat-detection": [166.0, 154.0, 177.0, 194.0, 151.0, 173.0, 171.0, 155.0, 197.0, 154.0], "json-stringify-tinderbox": [75.0, 74.0, 76.0, 80.0, 79.0, 80.0, 79.0, 80.0, 80.0, 79.0], "stanford-crypto-pbkdf2": [188.0, 192.0, 188.0, 185.0, 188.0, 173.0, 188.0, 186.0, 185.0, 172.0], "json-parse-financial": [68.0, 68.0, 70.0, 71.0, 75.0, 73.0, 73.0, 74.0, 73.0, 73.0], "stanford-crypto-sha256-iterative": [79.0, 82.0, 88.0, 86.0, 89.0, 92.0, 90.0, 88.0, 86.0, 87.0], "audio-fft": [81.0, 85.0, 93.0, 129.0, 80.0, 82.0, 85.0, 84.0, 138.0, 78.0], "imaging-darkroom": [150.0, 148.0, 156.0, 151.0, 148.0, 149.0, 150.0, 149.0, 149.0, 157.0], "stanford-crypto-ccm": [146.0, 150.0, 150.0, 158.0, 149.0, 156.0, 145.0, 151.0, 158.0, 164.0], "audio-oscillator": [96.0, 100.0, 148.0, 102.0, 105.0, 104.0, 148.0, 108.0, 109.0, 148.0], "stanford-crypto-aes": [98.0, 102.0, 108.0, 107.0, 109.0, 106.0, 102.0, 102.0, 114.0, 105.0], "imaging-desaturate": [122.0, 127.0, 128.0, 124.0, 123.0, 127.0, 126.0, 121.0, 124.0, 127.0]}, "summary": {"lowerIsBetter": true, "suite": 1794.4, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 93.5, "unit": "ms", "value": 93.5}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 184.5, "unit": "ms", "value": 184.5}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 169.2, "unit": "ms", "value": 169.2}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 152.7, "unit": "ms", "value": 152.7}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 150.7, "unit": "ms", "value": 150.7}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 71.8, "unit": "ms", "value": 71.8}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 116.8, "unit": "ms", "value": 116.8}, "ai-astar": {"lowerIsBetter": true, "filtered": 127.1, "unit": "ms", "value": 127.1}, "audio-dft": {"lowerIsBetter": true, "filtered": 193.8, "unit": "ms", "value": 193.8}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 86.7, "unit": "ms", "value": 86.7}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 78.2, "unit": "ms", "value": 78.2}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 139.2, "unit": "ms", "value": 139.2}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 105.3, "unit": "ms", "value": 105.3}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 124.9, "unit": "ms", "value": 124.9}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0052.e"}, "testrun": {"date": 1447091182, "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": "20151109064656", "branch": "Fx-Team", "revision": "a02cf2019a51f59e1eb712ab3d306f70c86808c0"}}, {"talos_counters": {}, "results": {"DeltaBlue": [227.1694684234439], "Encrypt": [389.7116134060795], "NavierStokes": [6555.555555555556], "Decrypt": [6797.2972972972975], "Splay": [713.6752136752136], "Richards": [183.55359765051395], "RegExp": [33816.666666666664], "Earley": [895.2551477170994], "Boyer": [14197.18309859155], "RayTrace": [1298.7012987012988]}, "summary": {"lowerIsBetter": false, "suite": 17136.819288053437, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 291.0514360000001, "unit": "score", "value": 291.0514360000001}, "Encrypt": {"lowerIsBetter": false, "filtered": 683.020446, "unit": "score", "value": 683.020446}, "NavierStokes": {"lowerIsBetter": false, "filtered": 226.372881355932, "unit": "score", "value": 226.372881355932}, "Decrypt": {"lowerIsBetter": false, "filtered": 39.159829025844964, "unit": "score", "value": 39.159829025844964}, "Splay": {"lowerIsBetter": false, "filtered": 114.18499401197602, "unit": "score", "value": 114.18499401197602}, "RegExp": {"lowerIsBetter": false, "filtered": 26.93893543617548, "unit": "score", "value": 26.93893543617548}, "Richards": {"lowerIsBetter": false, "filtered": 192.32529600000007, "unit": "score", "value": 192.32529600000007}, "Earley": {"lowerIsBetter": false, "filtered": 744.4391709999998, "unit": "score", "value": 744.4391709999998}, "Boyer": {"lowerIsBetter": false, "filtered": 46.94332638888892, "unit": "score", "value": 46.94332638888892}, "RayTrace": {"lowerIsBetter": false, "filtered": 569.7915299999997, "unit": "score", "value": 569.7915299999997}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0052.e"}, "testrun": {"date": 1447091182, "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": "20151109064656", "branch": "Fx-Team", "revision": "a02cf2019a51f59e1eb712ab3d306f70c86808c0"}}] 10:06:37 INFO - RETURN: dromaeo_css: 5921.65 10:06:37 INFO - RETURN: kraken: 1794.40 10:06:37 INFO - RETURN: v8_7: 17136.82 10:06:37 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,57]]", "result": "17136.82"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,57]]", "result": "1794.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,57]]", "result": "5921.65"}}} 10:06:37 INFO - Return code: 0 10:06:37 INFO - # TBPL SUCCESS # 10:06:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:06:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:06:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:06:37 INFO - 2015-11-09 10:06:37.159 screenresolution[1667:10839] starting screenresolution argv=screenresolution get 10:06:37 INFO - 2015-11-09 10:06:37.162 screenresolution[1667:10839] Display 0: 1600x1200x32@60 10:06:37 INFO - 2015-11-09 10:06:37.169 screenresolution[1668:10842] starting screenresolution argv=screenresolution list 10:06:37 INFO - Available Modes on Display 0 10:06:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:06:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:06:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:06:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:06:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:06:37 INFO - Intel HD Graphics 3000: 10:06:37 INFO - Chipset Model: Intel HD Graphics 3000 10:06:37 INFO - Type: GPU 10:06:37 INFO - Bus: Built-In 10:06:37 INFO - VRAM (Total): 512 MB 10:06:37 INFO - VRAM (Dynamic, Max): 10 10:06:37 INFO - Vendor: Intel (0x8086) 10:06:37 INFO - Device ID: 0x0116 10:06:37 INFO - Revision ID: 0x0009 10:06:37 INFO - Displays: 10:06:37 INFO - Display: 10:06:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:06:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:06:37 INFO - Display Serial Number: 1600x1200 60 10:06:37 INFO - Main Display: Yes 10:06:37 INFO - Mirror: Off 10:06:37 INFO - Online: Yes 10:06:37 INFO - Rotation: Supported 10:06:37 INFO - Return code: 0 10:06:37 INFO - Running post-action listener: _resource_record_post_action 10:06:37 INFO - Running post-run listener: _resource_record_post_run 10:06:38 INFO - Total resource usage - Wall time: 1256s; CPU: 30.0%; Read bytes: 41075712; Write bytes: 689325056; Read time: 6985; Write time: 70035 10:06:38 INFO - install - Wall time: 41s; CPU: 30.0%; Read bytes: 336556544; Write bytes: 334440448; Read time: 35412; Write time: 5524 10:06:38 INFO - run-tests - Wall time: 1216s; CPU: 30.0%; Read bytes: 40133632; Write bytes: 344472576; Read time: 6473; Write time: 62705 10:06:38 INFO - Running post-run listener: _upload_blobber_files 10:06:38 INFO - Blob upload gear active. 10:06:38 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 10:06:38 INFO - Copying logs to upload dir... 10:06:38 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1332.288889 ========= master_lag: 35.50 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 47 secs) (at 2015-11-09 10:07:14.063838) ========= ========= Started set props: build_url (results: 0, elapsed: 2 secs) (at 2015-11-09 10:07:14.067753) ========= 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.PKT1zRx2xT/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.ax09RrBbVM/Listeners TMPDIR=/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/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/vm0kCyZpQ-Kv_wn5ZIxzjg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010099 build_url: 'https://queue.taskcluster.net/v1/task/vm0kCyZpQ-Kv_wn5ZIxzjg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 2.49 ========= ========= Finished set props: build_url (results: 0, elapsed: 2 secs) (at 2015-11-09 10:07:16.570779) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 10:07:16.571273) ========= 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.PKT1zRx2xT/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.ax09RrBbVM/Listeners TMPDIR=/var/folders/35/xydj_qfn10ngq8grvh_2z8dh00000w/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.005392 ========= master_lag: 0.29 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 10:07:16.862516) ========= ========= Started reboot skipped (results: 3, elapsed: 3 secs) (at 2015-11-09 10:07:16.862886) ========= ========= Finished reboot skipped (results: 3, elapsed: 3 secs) (at 2015-11-09 10:07:20.490368) ========= ========= Total master_lag: 38.71 =========