builder: mozilla-aurora_yosemite_test-dromaeojs-e10s slave: t-yosemite-r5-0049 starttime: 1449209395.41 results: success (0) buildid: 20151203200703 builduid: e10b456502284880814434de3fd7511b revision: 858b1b930b16a5c46634e3dad2650c517e150cb0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-03 22:09:55.410481) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-03 22:09:55.411149) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 22:09:55.411612) ========= 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.6lR4A4aZB5/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.awyCeVUYhu/Listeners TMPDIR=/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/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.005591 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 22:09:55.440527) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 22:09:55.440884) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 22:09:55.456810) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 22:09:55.457175) ========= 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.6lR4A4aZB5/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.awyCeVUYhu/Listeners TMPDIR=/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/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.035292 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 22:09:55.509180) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-03 22:09:55.509856) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-03 22:09:55.511038) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 22:09:55.511622) ========= 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.6lR4A4aZB5/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.awyCeVUYhu/Listeners TMPDIR=/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/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-12-03 22:09:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.13G=0s 2015-12-03 22:09:55 (1.13 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.205866 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 22:09:55.728671) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 22:09:55.729029) ========= 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.6lR4A4aZB5/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.awyCeVUYhu/Listeners TMPDIR=/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/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.102287 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 22:09:55.841686) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 22:09:55.842077) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 858b1b930b16a5c46634e3dad2650c517e150cb0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 858b1b930b16a5c46634e3dad2650c517e150cb0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6lR4A4aZB5/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.awyCeVUYhu/Listeners TMPDIR=/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/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-12-03 22:09:55,932 truncating revision to first 12 chars 2015-12-03 22:09:55,932 Setting DEBUG logging. 2015-12-03 22:09:55,932 attempt 1/10 2015-12-03 22:09:55,932 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/858b1b930b16?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-03 22:09:56,193 unpacking tar archive at: mozilla-aurora-858b1b930b16/testing/mozharness/ program finished with exit code 0 elapsedTime=0.527187 ========= master_lag: 0.10 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 22:09:56.464643) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 22:09:56.465012) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 22:09:56.473852) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-03 22:09:56.474157) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-03 22:09:56.474614) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 40 secs) (at 2015-12-03 22:09:56.474941) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6lR4A4aZB5/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.awyCeVUYhu/Listeners TMPDIR=/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/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 22:09:56 INFO - MultiFileLogger online at 20151203 22:09:56 in /builds/slave/test 22:09:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 22:09:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:09:56 INFO - {'append_to_log': False, 22:09:56 INFO - 'base_work_dir': '/builds/slave/test', 22:09:56 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 22:09:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:09:56 INFO - 'branch': 'Mozilla-Aurora', 22:09:56 INFO - 'buildbot_json_path': 'buildprops.json', 22:09:56 INFO - 'config_files': ('talos/mac_config.py',), 22:09:56 INFO - 'default_actions': ('clobber', 22:09:56 INFO - 'read-buildbot-config', 22:09:56 INFO - 'download-and-extract', 22:09:56 INFO - 'populate-webroot', 22:09:56 INFO - 'create-virtualenv', 22:09:56 INFO - 'install', 22:09:56 INFO - 'run-tests'), 22:09:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:09:56 INFO - 'download_minidump_stackwalk': True, 22:09:56 INFO - 'download_symbols': 'ondemand', 22:09:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:09:56 INFO - 'tooltool.py': '/tools/tooltool.py', 22:09:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:09:56 INFO - '/tools/misc-python/virtualenv.py')}, 22:09:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:09:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:09:56 INFO - 'installer_path': 'installer.exe', 22:09:56 INFO - 'log_level': 'info', 22:09:56 INFO - 'log_name': 'talos', 22:09:56 INFO - 'log_to_console': True, 22:09:56 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 22:09:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 22:09:56 INFO - 'opt_config_files': (), 22:09:56 INFO - 'pip_index': False, 22:09:56 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:09:56 INFO - 'cmd': ('bash', 22:09:56 INFO - '-c', 22:09:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:09:56 INFO - 'enabled': True, 22:09:56 INFO - 'halt_on_failure': False, 22:09:56 INFO - 'name': 'check_screen_resolution'},), 22:09:56 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:09:56 INFO - 'cmd': ('bash', 22:09:56 INFO - '-c', 22:09:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:09:56 INFO - 'enabled': True, 22:09:56 INFO - 'halt_on_failure': False, 22:09:56 INFO - 'name': 'check_screen_resolution'},), 22:09:56 INFO - 'run_cmd_checks_enabled': True, 22:09:56 INFO - 'sps_profile': False, 22:09:56 INFO - 'sps_profile_interval': 0, 22:09:56 INFO - 'suite': 'dromaeojs-e10s', 22:09:56 INFO - 'system_bits': '64', 22:09:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:09:56 INFO - 'title': 't-yosemite-r5-0049', 22:09:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:09:56 INFO - 'use_talos_json': True, 22:09:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:09:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:09:56 INFO - 'work_dir': 'build'} 22:09:56 INFO - ##### 22:09:56 INFO - ##### Running clobber step. 22:09:56 INFO - ##### 22:09:56 INFO - Running pre-action listener: _resource_record_pre_action 22:09:56 INFO - Running main action method: clobber 22:09:56 INFO - rmtree: /builds/slave/test/build 22:09:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:10:01 INFO - Running post-action listener: _resource_record_post_action 22:10:01 INFO - ##### 22:10:01 INFO - ##### Running read-buildbot-config step. 22:10:01 INFO - ##### 22:10:01 INFO - Running pre-action listener: _resource_record_pre_action 22:10:01 INFO - Running main action method: read_buildbot_config 22:10:01 INFO - Using buildbot properties: 22:10:01 INFO - { 22:10:01 INFO - "properties": { 22:10:01 INFO - "buildnumber": 4, 22:10:01 INFO - "product": "firefox", 22:10:01 INFO - "script_repo_revision": "production", 22:10:01 INFO - "builddir": "mozilla-aurora_yosemite_test-dromaeojs-e10s", 22:10:01 INFO - "repository": "", 22:10:01 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-aurora talos dromaeojs-e10s", 22:10:01 INFO - "buildid": "20151203200703", 22:10:01 INFO - "slavename": "t-yosemite-r5-0049", 22:10:01 INFO - "pgo_build": "False", 22:10:01 INFO - "basedir": "/builds/slave/test", 22:10:01 INFO - "project": "", 22:10:01 INFO - "platform": "yosemite", 22:10:01 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 22:10:01 INFO - "slavebuilddir": "test", 22:10:01 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 22:10:01 INFO - "branch": "mozilla-aurora", 22:10:01 INFO - "repo_path": "releases/mozilla-aurora", 22:10:01 INFO - "stage_platform": "macosx64", 22:10:01 INFO - "builduid": "e10b456502284880814434de3fd7511b", 22:10:01 INFO - "revision": "858b1b930b16a5c46634e3dad2650c517e150cb0" 22:10:01 INFO - }, 22:10:01 INFO - "sourcestamp": { 22:10:01 INFO - "repository": "", 22:10:01 INFO - "hasPatch": false, 22:10:01 INFO - "project": "", 22:10:01 INFO - "branch": "mozilla-aurora-macosx64-talos", 22:10:01 INFO - "changes": [ 22:10:01 INFO - { 22:10:01 INFO - "category": null, 22:10:01 INFO - "files": [ 22:10:01 INFO - { 22:10:01 INFO - "url": null, 22:10:01 INFO - "name": "https://queue.taskcluster.net/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg" 22:10:01 INFO - } 22:10:01 INFO - ], 22:10:01 INFO - "repository": "", 22:10:01 INFO - "rev": "858b1b930b16a5c46634e3dad2650c517e150cb0", 22:10:01 INFO - "who": "maglione.k@gmail.com", 22:10:01 INFO - "when": 1449208311, 22:10:01 INFO - "number": 6743158, 22:10:01 INFO - "comments": "Bug 1218443: [webext] Fix some instances of window listeners not being added correctly. r=billm a=ritu", 22:10:01 INFO - "project": "", 22:10:01 INFO - "at": "Thu 03 Dec 2015 21:51:51", 22:10:01 INFO - "branch": "mozilla-aurora-macosx64-talos", 22:10:01 INFO - "revlink": "", 22:10:01 INFO - "properties": [ 22:10:01 INFO - [ 22:10:01 INFO - "buildid", 22:10:01 INFO - "20151203200703", 22:10:01 INFO - "Change" 22:10:01 INFO - ], 22:10:01 INFO - [ 22:10:01 INFO - "builduid", 22:10:01 INFO - "e10b456502284880814434de3fd7511b", 22:10:01 INFO - "Change" 22:10:01 INFO - ], 22:10:01 INFO - [ 22:10:01 INFO - "pgo_build", 22:10:01 INFO - "False", 22:10:01 INFO - "Change" 22:10:01 INFO - ] 22:10:01 INFO - ], 22:10:01 INFO - "revision": "858b1b930b16a5c46634e3dad2650c517e150cb0" 22:10:01 INFO - } 22:10:01 INFO - ], 22:10:01 INFO - "revision": "858b1b930b16a5c46634e3dad2650c517e150cb0" 22:10:01 INFO - } 22:10:01 INFO - } 22:10:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg. 22:10:01 INFO - Running post-action listener: _resource_record_post_action 22:10:01 INFO - ##### 22:10:01 INFO - ##### Running download-and-extract step. 22:10:01 INFO - ##### 22:10:01 INFO - Running pre-action listener: _resource_record_pre_action 22:10:01 INFO - Running main action method: download_and_extract 22:10:01 INFO - mkdir: /builds/slave/test/build/tests 22:10: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')]} 22:10:01 INFO - https://queue.taskcluster.net/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:10:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/test_packages.json 22:10:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/test_packages.json 22:10:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 22:10:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 22:10:01 INFO - Downloaded 1149 bytes. 22:10:01 INFO - Reading from file /builds/slave/test/build/test_packages.json 22:10:01 INFO - Using the following test package requirements: 22:10:01 INFO - {u'common': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 22:10:01 INFO - u'cppunittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 22:10:01 INFO - u'firefox-44.0a2.en-US.mac.cppunittest.tests.zip'], 22:10:01 INFO - u'jittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 22:10:01 INFO - u'jsshell-mac.zip'], 22:10:01 INFO - u'mochitest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 22:10:01 INFO - u'firefox-44.0a2.en-US.mac.mochitest.tests.zip'], 22:10:01 INFO - u'mozbase': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 22:10:01 INFO - u'reftest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 22:10:01 INFO - u'firefox-44.0a2.en-US.mac.reftest.tests.zip'], 22:10:01 INFO - u'talos': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 22:10:01 INFO - u'firefox-44.0a2.en-US.mac.talos.tests.zip'], 22:10:01 INFO - u'web-platform': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 22:10:01 INFO - u'firefox-44.0a2.en-US.mac.web-platform.tests.zip'], 22:10:01 INFO - u'webapprt': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 22:10:01 INFO - u'xpcshell': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 22:10:01 INFO - u'firefox-44.0a2.en-US.mac.xpcshell.tests.zip']} 22:10:01 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip'] for test suite category: common 22:10: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')]} 22:10:01 INFO - https://queue.taskcluster.net/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 22:10:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 22:10:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 22:10:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 22:10:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'}, attempt #1 22:10:03 INFO - Downloaded 17490132 bytes. 22:10:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 22:10:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 22:10:03 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 22:10:07 INFO - Return code: 0 22:10:07 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip', u'firefox-44.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 22:10: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')]} 22:10:07 INFO - https://queue.taskcluster.net/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 22:10:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 22:10:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 22:10:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 22:10:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'}, attempt #1 22:10:09 INFO - Downloaded 17490132 bytes. 22:10:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 22:10:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 22:10:09 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 22:10:14 INFO - Return code: 0 22:10: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')]} 22:10:14 INFO - https://queue.taskcluster.net/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 22:10:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 22:10:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 22:10:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 22:10:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'}, attempt #1 22:10:15 INFO - Downloaded 11131307 bytes. 22:10:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 22:10:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 22:10:15 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] with output_timeout 1760 22:10:15 INFO - Return code: 0 22:10:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:10:15 INFO - https://queue.taskcluster.net/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 22:10:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 22:10:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 22:10:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg 22:10:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg'}, attempt #1 22:10:19 INFO - Downloaded 108689100 bytes. 22:10:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 22:10:19 INFO - mkdir: /builds/slave/test/properties 22:10:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:10:19 INFO - Writing to file /builds/slave/test/properties/build_url 22:10:19 INFO - Contents: 22:10:19 INFO - build_url:https://queue.taskcluster.net/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 22:10:19 INFO - Running post-action listener: _resource_record_post_action 22:10:19 INFO - Running post-action listener: set_extra_try_arguments 22:10:19 INFO - ##### 22:10:19 INFO - ##### Running populate-webroot step. 22:10:19 INFO - ##### 22:10:19 INFO - Running pre-action listener: _resource_record_pre_action 22:10:19 INFO - Running main action method: populate_webroot 22:10:19 INFO - Guessing talos json url... 22:10:19 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')]} 22:10:19 INFO - https://queue.taskcluster.net/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.txt matches https://queue.taskcluster.net 22:10:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 22:10:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 22:10:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.txt to /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 22:10:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.txt', 'file_name': '/builds/slave/test/build/firefox-44.0a2.en-US.mac.txt'}, attempt #1 22:10:20 INFO - Downloaded 107 bytes. 22:10:20 INFO - Reading from file /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 22:10:20 INFO - Contents: 22:10:20 INFO - 20151203200703 22:10:20 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/858b1b930b16a5c46634e3dad2650c517e150cb0 22:10: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')]} 22:10:20 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/858b1b930b/testing/talos/talos.json 22:10:20 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/858b1b930b/testing/talos/talos.json to /builds/slave/test/build/talos.json 22:10:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/releases/mozilla-aurora/raw-file/858b1b930b/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 22:10:20 INFO - Downloaded 4264 bytes. 22:10:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:10:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:10:20 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 22:10:20 INFO - '../fennec_ids.txt'], 22:10:20 INFO - 'tests': ['tcheck2']}, 22:10:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:10:20 INFO - '--tppagecycles', 22:10:20 INFO - '7'], 22:10:20 INFO - 'tests': ['tsvgm']}}, 22:10:20 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:10:20 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:10:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:10:20 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:10:20 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:10:20 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:10:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:10:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:10:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:10:20 INFO - 'talos_options': ['--e10s'], 22:10:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:10:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:10:20 INFO - 'tests': ['damp', 'tps']}, 22:10:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:10:20 INFO - 'talos_options': ['--e10s'], 22:10:20 INFO - 'tests': ['damp', 'tps']}, 22:10:20 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:10:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:10:20 INFO - 'other': {'tests': ['a11yr', 22:10:20 INFO - 'ts_paint', 22:10:20 INFO - 'tpaint', 22:10:20 INFO - 'sessionrestore', 22:10:20 INFO - 'sessionrestore_no_auto_restore']}, 22:10:20 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:10:20 INFO - 'tests': ['a11yr', 22:10:20 INFO - 'ts_paint', 22:10:20 INFO - 'tpaint', 22:10:20 INFO - 'sessionrestore', 22:10:20 INFO - 'sessionrestore_no_auto_restore']}, 22:10:20 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:10:20 INFO - 'tests': ['a11yr', 22:10:20 INFO - 'ts_paint', 22:10:20 INFO - 'tpaint', 22:10:20 INFO - 'sessionrestore', 22:10:20 INFO - 'sessionrestore_no_auto_restore']}, 22:10:20 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:10:20 INFO - 'tests': ['a11yr', 22:10:20 INFO - 'ts_paint', 22:10:20 INFO - 'tpaint', 22:10:20 INFO - 'sessionrestore', 22:10:20 INFO - 'sessionrestore_no_auto_restore']}, 22:10:20 INFO - 'other_l64': {'tests': ['a11yr', 22:10:20 INFO - 'ts_paint', 22:10:20 INFO - 'tpaint', 22:10:20 INFO - 'sessionrestore', 22:10:20 INFO - 'sessionrestore_no_auto_restore']}, 22:10:20 INFO - 'other_nol64': {'tests': ['a11yr', 22:10:20 INFO - 'ts_paint', 22:10:20 INFO - 'tpaint', 22:10:20 INFO - 'sessionrestore', 22:10:20 INFO - 'sessionrestore_no_auto_restore']}, 22:10:20 INFO - 'svgr': {'tests': ['tsvgx', 22:10:20 INFO - 'tsvgr_opacity', 22:10:20 INFO - 'tart', 22:10:20 INFO - 'tscrollx', 22:10:20 INFO - 'cart']}, 22:10:20 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:10:20 INFO - 'tests': ['tsvgx', 22:10:20 INFO - 'tsvgr_opacity', 22:10:20 INFO - 'tart', 22:10:20 INFO - 'tscrollx', 22:10:20 INFO - 'cart']}, 22:10:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:10:20 INFO - 'tests': ['tp5o']}, 22:10:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:10:20 INFO - 'talos_options': ['--e10s'], 22:10:20 INFO - 'tests': ['tp5o']}, 22:10:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:10:20 INFO - 'talos_options': ['--xperf_path', 22:10:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:10:20 INFO - 'tests': ['tp5n']}, 22:10:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:10:20 INFO - 'talos_options': ['--e10s', 22:10:20 INFO - '--xperf_path', 22:10:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 22:10:20 INFO - 'C:/slave/talos-data/talos/xperf.config'], 22:10:20 INFO - 'tests': ['tp5n']}}, 22:10:20 INFO - 'talos.zip': {'path': '', 22:10:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:10:20 INFO - Running post-action listener: _resource_record_post_action 22:10:20 INFO - ##### 22:10:20 INFO - ##### Running create-virtualenv step. 22:10:20 INFO - ##### 22:10:20 INFO - Running pre-action listener: _resource_record_pre_action 22:10:20 INFO - Running main action method: create_virtualenv 22:10:20 INFO - Creating virtualenv /builds/slave/test/build/venv 22:10:20 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 22:10:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:10:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:10:20 INFO - Using real prefix '/tools/python27' 22:10:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:10:21 INFO - Installing distribute.............................................................................................................................................................................................done. 22:10:25 INFO - Installing pip.................done. 22:10:25 INFO - Return code: 0 22:10:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:10:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:10:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:10:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:10:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10:25 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 0x10ae05a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae72228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9149702d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10adba9f0>, '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 0x10ab19cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad84990>, '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.6lR4A4aZB5/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.awyCeVUYhu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/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 22:10:25 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 22:10:25 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 22:10:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6lR4A4aZB5/Render', 22:10:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:10:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:10:25 INFO - 'HOME': '/Users/cltbld', 22:10:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:10:25 INFO - 'LOGNAME': 'cltbld', 22:10:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:10:25 INFO - 'MOZ_NO_REMOTE': '1', 22:10:25 INFO - 'NO_EM_RESTART': '1', 22:10:25 INFO - 'PAGER': '/bin/cat', 22:10:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:10:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:10:25 INFO - 'PWD': '/builds/slave/test', 22:10:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:10:25 INFO - 'SHELL': '/bin/bash', 22:10:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.awyCeVUYhu/Listeners', 22:10:25 INFO - 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/', 22:10:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:10:25 INFO - 'USER': 'cltbld', 22:10:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:10:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:10:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:10:25 INFO - 'XPC_FLAGS': '0x0', 22:10:25 INFO - 'XPC_SERVICE_NAME': '0', 22:10:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:10:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:10:26 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 22:10:26 INFO - Cleaning up... 22:10:26 INFO - Return code: 0 22:10:26 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:10:26 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')]} 22:10:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:10:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10:26 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')]} 22:10:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:10:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10:26 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 0x10ae05a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae72228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9149702d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10adba9f0>, '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 0x10ab19cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad84990>, '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.6lR4A4aZB5/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.awyCeVUYhu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/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 22:10:26 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 22:10:26 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 22:10:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6lR4A4aZB5/Render', 22:10:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:10:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:10:26 INFO - 'HOME': '/Users/cltbld', 22:10:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:10:26 INFO - 'LOGNAME': 'cltbld', 22:10:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:10:26 INFO - 'MOZ_NO_REMOTE': '1', 22:10:26 INFO - 'NO_EM_RESTART': '1', 22:10:26 INFO - 'PAGER': '/bin/cat', 22:10:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:10:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:10:26 INFO - 'PWD': '/builds/slave/test', 22:10:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:10:26 INFO - 'SHELL': '/bin/bash', 22:10:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.awyCeVUYhu/Listeners', 22:10:26 INFO - 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/', 22:10:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:10:26 INFO - 'USER': 'cltbld', 22:10:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:10:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:10:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:10:26 INFO - 'XPC_FLAGS': '0x0', 22:10:26 INFO - 'XPC_SERVICE_NAME': '0', 22:10:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:10:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:10:26 INFO - Downloading/unpacking psutil>=0.7.1 22:10: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 22:10: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 22:10: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 22:10: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 22:10: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 22:10: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 22:10:29 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 22:10:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 22:10:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:10:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:10:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:10:29 INFO - Installing collected packages: psutil 22:10:29 INFO - Running setup.py install for psutil 22:10:29 INFO - building 'psutil._psutil_osx' extension 22:10:29 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 22:10:31 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 22:10:31 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 22:10:31 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 22:10:31 INFO - building 'psutil._psutil_posix' extension 22:10:31 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 22:10:31 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 22:10:31 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 22:10:31 INFO - ^ 22:10:31 INFO - 1 warning generated. 22:10:31 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 22:10:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:10:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:10:32 INFO - Successfully installed psutil 22:10:32 INFO - Cleaning up... 22:10:32 INFO - Return code: 0 22:10:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:10:32 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')]} 22:10:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:10:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10:32 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')]} 22:10:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:10:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10:32 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 0x10ae05a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae72228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9149702d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10adba9f0>, '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 0x10ab19cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad84990>, '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.6lR4A4aZB5/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.awyCeVUYhu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/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 22:10:32 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 22:10:32 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 22:10:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6lR4A4aZB5/Render', 22:10:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:10:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:10:32 INFO - 'HOME': '/Users/cltbld', 22:10:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:10:32 INFO - 'LOGNAME': 'cltbld', 22:10:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:10:32 INFO - 'MOZ_NO_REMOTE': '1', 22:10:32 INFO - 'NO_EM_RESTART': '1', 22:10:32 INFO - 'PAGER': '/bin/cat', 22:10:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:10:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:10:32 INFO - 'PWD': '/builds/slave/test', 22:10:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:10:32 INFO - 'SHELL': '/bin/bash', 22:10:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.awyCeVUYhu/Listeners', 22:10:32 INFO - 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/', 22:10:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:10:32 INFO - 'USER': 'cltbld', 22:10:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:10:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:10:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:10:32 INFO - 'XPC_FLAGS': '0x0', 22:10:32 INFO - 'XPC_SERVICE_NAME': '0', 22:10:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:10:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:10:32 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:10:32 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 22:10:32 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 22:10:32 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 22:10:32 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 22:10:32 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 22:10:32 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 22:10:34 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:10:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:10:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:10:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:10:35 INFO - Installing collected packages: mozsystemmonitor 22:10:35 INFO - Running setup.py install for mozsystemmonitor 22:10:35 INFO - Successfully installed mozsystemmonitor 22:10:35 INFO - Cleaning up... 22:10:35 INFO - Return code: 0 22:10:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:10:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:10:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:10:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:10:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:10:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10:35 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 0x10ae05a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae72228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9149702d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10adba9f0>, '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 0x10ab19cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad84990>, '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.6lR4A4aZB5/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.awyCeVUYhu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/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 22:10:35 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 22:10:35 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 22:10:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6lR4A4aZB5/Render', 22:10:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:10:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:10:35 INFO - 'HOME': '/Users/cltbld', 22:10:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:10:35 INFO - 'LOGNAME': 'cltbld', 22:10:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:10:35 INFO - 'MOZ_NO_REMOTE': '1', 22:10:35 INFO - 'NO_EM_RESTART': '1', 22:10:35 INFO - 'PAGER': '/bin/cat', 22:10:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:10:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:10:35 INFO - 'PWD': '/builds/slave/test', 22:10:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:10:35 INFO - 'SHELL': '/bin/bash', 22:10:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.awyCeVUYhu/Listeners', 22:10:35 INFO - 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/', 22:10:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:10:35 INFO - 'USER': 'cltbld', 22:10:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:10:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:10:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:10:35 INFO - 'XPC_FLAGS': '0x0', 22:10:35 INFO - 'XPC_SERVICE_NAME': '0', 22:10:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:10:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:10:35 INFO - Downloading/unpacking blobuploader==1.2.4 22:10:35 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 22:10:35 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 22:10:35 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 22:10:35 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 22:10:35 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 22:10:35 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 22:10:37 INFO - Downloading blobuploader-1.2.4.tar.gz 22:10:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 22:10:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:10:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:10:38 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 22:10:38 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 22:10:38 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 22:10:38 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 22:10:38 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 22:10:38 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 22:10:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:10:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:10:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:10:38 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 22:10:38 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 22:10:38 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 22:10:38 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 22:10:38 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 22:10:38 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 22:10:39 INFO - Downloading docopt-0.6.1.tar.gz 22:10:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:10:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:10:39 INFO - Installing collected packages: blobuploader, requests, docopt 22:10:39 INFO - Running setup.py install for blobuploader 22:10:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:10:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:10:39 INFO - Running setup.py install for requests 22:10:40 INFO - Running setup.py install for docopt 22:10:40 INFO - Successfully installed blobuploader requests docopt 22:10:40 INFO - Cleaning up... 22:10:40 INFO - Return code: 0 22:10:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:10: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')]} 22:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:10:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10: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')]} 22:10:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:10:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10:40 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 0x10ae05a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae72228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9149702d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10adba9f0>, '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 0x10ab19cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad84990>, '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.6lR4A4aZB5/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.awyCeVUYhu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/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 22:10:40 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 22:10:40 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 22:10:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6lR4A4aZB5/Render', 22:10:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:10:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:10:40 INFO - 'HOME': '/Users/cltbld', 22:10:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:10:40 INFO - 'LOGNAME': 'cltbld', 22:10:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:10:40 INFO - 'MOZ_NO_REMOTE': '1', 22:10:40 INFO - 'NO_EM_RESTART': '1', 22:10:40 INFO - 'PAGER': '/bin/cat', 22:10:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:10:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:10:40 INFO - 'PWD': '/builds/slave/test', 22:10:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:10:40 INFO - 'SHELL': '/bin/bash', 22:10:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.awyCeVUYhu/Listeners', 22:10:40 INFO - 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/', 22:10:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:10:40 INFO - 'USER': 'cltbld', 22:10:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:10:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:10:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:10:40 INFO - 'XPC_FLAGS': '0x0', 22:10:40 INFO - 'XPC_SERVICE_NAME': '0', 22:10:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:10:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:10:40 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-4M1Rcd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:10:40 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-I1_n_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:10:40 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-vig5mz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:10:41 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-W_tpZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:10:41 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-xxgTtb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:10:41 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-LuzyYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:10:41 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-D1FUS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:10:41 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-TTOJwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:10:41 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-b2YgDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:10:41 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-u7sW19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:10:41 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-Eyi1A7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:10:42 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-44Hnwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:10:42 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-VqXoCy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:10:42 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-NcZq0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:10:42 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-Nzd5nC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:10:42 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-2TyAkX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:10:42 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-cpt4Nt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:10:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:10:42 INFO - Running setup.py install for manifestparser 22:10:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:10:42 INFO - Running setup.py install for mozcrash 22:10:43 INFO - Running setup.py install for mozdebug 22:10:43 INFO - Running setup.py install for mozdevice 22:10:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:10:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:10:43 INFO - Running setup.py install for mozfile 22:10:43 INFO - Running setup.py install for mozhttpd 22:10:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:10:43 INFO - Running setup.py install for mozinfo 22:10:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:10:43 INFO - Running setup.py install for mozInstall 22:10:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:10:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:10:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:10:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:10:44 INFO - Running setup.py install for mozleak 22:10:44 INFO - Running setup.py install for mozlog 22:10:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:10:44 INFO - Running setup.py install for moznetwork 22:10:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:10:44 INFO - Running setup.py install for mozprocess 22:10:44 INFO - Running setup.py install for mozprofile 22:10:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:10:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:10:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:10:45 INFO - Running setup.py install for mozrunner 22:10:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:10:45 INFO - Running setup.py install for mozscreenshot 22:10:45 INFO - Running setup.py install for moztest 22:10:45 INFO - Running setup.py install for mozversion 22:10:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:10:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:10:45 INFO - Cleaning up... 22:10:45 INFO - Return code: 0 22:10:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:10:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:10:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:10:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:10:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:10:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x10ae05a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae72228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9149702d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10adba9f0>, '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 0x10ab19cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad84990>, '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.6lR4A4aZB5/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.awyCeVUYhu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/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 22:10:45 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 22:10:45 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 22:10:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6lR4A4aZB5/Render', 22:10:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:10:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:10:45 INFO - 'HOME': '/Users/cltbld', 22:10:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:10:45 INFO - 'LOGNAME': 'cltbld', 22:10:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:10:45 INFO - 'MOZ_NO_REMOTE': '1', 22:10:45 INFO - 'NO_EM_RESTART': '1', 22:10:45 INFO - 'PAGER': '/bin/cat', 22:10:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:10:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:10:45 INFO - 'PWD': '/builds/slave/test', 22:10:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:10:45 INFO - 'SHELL': '/bin/bash', 22:10:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.awyCeVUYhu/Listeners', 22:10:45 INFO - 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/', 22:10:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:10:45 INFO - 'USER': 'cltbld', 22:10:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:10:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:10:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:10:45 INFO - 'XPC_FLAGS': '0x0', 22:10:45 INFO - 'XPC_SERVICE_NAME': '0', 22:10:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:10:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:10:46 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-XzXiRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:10:46 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)) 22:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:10:46 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-9nejw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:10:46 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)) 22:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:10:46 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-usmxvK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:10:46 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)) 22:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:10:46 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-4Yv3g1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:10:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 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)) 22:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:10:46 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-UhzMNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:10:46 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)) 22:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:10:46 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-67TY1B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:10:46 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)) 22:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:10:46 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-40kW5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:10:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.8 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)) 22:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:10:46 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-1e2O2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:10:47 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)) 22:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:10:47 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-fTSMWt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:10:47 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)) 22:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:10:47 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-IZUv_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:10:47 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)) 22:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:10:47 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-dnSVDu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:10:47 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)) 22:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:10:47 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-x6sQkl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:10:47 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)) 22:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:10:47 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-qjkmJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:10:47 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)) 22:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:10:47 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-PIFvxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:10:47 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)) 22:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:10:47 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-dakxb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:10:47 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)) 22:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:10:48 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-olItS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:10:48 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)) 22:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:10:48 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-sJN29_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:10:48 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)) 22:10:48 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)) 22:10:48 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)) 22:10:48 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)) 22:10:48 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.46->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:10:48 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.46->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:10:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:10:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:10:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:10:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:10:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:10:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:10:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:10:50 INFO - Downloading blessings-1.5.1.tar.gz 22:10:50 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 22:10:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:10:50 INFO - Installing collected packages: blessings 22:10:50 INFO - Running setup.py install for blessings 22:10:51 INFO - Successfully installed blessings 22:10:51 INFO - Cleaning up... 22:10:51 INFO - Return code: 0 22:10:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:10:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:10:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:10:51 INFO - Reading from file tmpfile_stdout 22:10:51 INFO - Current package versions: 22:10:51 INFO - blessings == 1.5.1 22:10:51 INFO - blobuploader == 1.2.4 22:10:51 INFO - docopt == 0.6.1 22:10:51 INFO - manifestparser == 1.1 22:10:51 INFO - mozInstall == 1.12 22:10:51 INFO - mozcrash == 0.16 22:10:51 INFO - mozdebug == 0.1 22:10:51 INFO - mozdevice == 0.46 22:10:51 INFO - mozfile == 1.2 22:10:51 INFO - mozhttpd == 0.7 22:10:51 INFO - mozinfo == 0.8 22:10:51 INFO - mozleak == 0.1 22:10:51 INFO - mozlog == 3.0 22:10:51 INFO - moznetwork == 0.27 22:10:51 INFO - mozprocess == 0.22 22:10:51 INFO - mozprofile == 0.27 22:10:51 INFO - mozrunner == 6.11 22:10:51 INFO - mozscreenshot == 0.1 22:10:51 INFO - mozsystemmonitor == 0.0 22:10:51 INFO - moztest == 0.7 22:10:51 INFO - mozversion == 1.4 22:10:51 INFO - psutil == 3.1.1 22:10:51 INFO - requests == 1.2.3 22:10:51 INFO - wsgiref == 0.1.2 22:10:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:10:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:10:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:10:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:10:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:10:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10:51 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 0x10ae05a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae72228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9149702d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10adba9f0>, '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 0x10ab19cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad84990>, '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.6lR4A4aZB5/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.awyCeVUYhu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/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 22:10:51 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 22:10:51 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 22:10:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6lR4A4aZB5/Render', 22:10:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:10:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:10:51 INFO - 'HOME': '/Users/cltbld', 22:10:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:10:51 INFO - 'LOGNAME': 'cltbld', 22:10:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:10:51 INFO - 'MOZ_NO_REMOTE': '1', 22:10:51 INFO - 'NO_EM_RESTART': '1', 22:10:51 INFO - 'PAGER': '/bin/cat', 22:10:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:10:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:10:51 INFO - 'PWD': '/builds/slave/test', 22:10:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:10:51 INFO - 'SHELL': '/bin/bash', 22:10:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.awyCeVUYhu/Listeners', 22:10:51 INFO - 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/', 22:10:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:10:51 INFO - 'USER': 'cltbld', 22:10:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:10:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:10:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:10:51 INFO - 'XPC_FLAGS': '0x0', 22:10:51 INFO - 'XPC_SERVICE_NAME': '0', 22:10:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:10:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:10:51 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)) 22:10:51 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)) 22:10:51 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)) 22:10:51 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)) 22:10:51 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)) 22:10:51 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)) 22:10:51 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)) 22:10:51 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)) 22:10:51 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)) 22:10:51 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)) 22:10:51 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)) 22:10:51 INFO - Cleaning up... 22:10:51 INFO - Return code: 0 22:10:51 INFO - Running post-action listener: _resource_record_post_action 22:10:51 INFO - Running post-action listener: _start_resource_monitoring 22:10:51 INFO - Starting resource monitoring. 22:10:51 INFO - ##### 22:10:51 INFO - ##### Running install step. 22:10:51 INFO - ##### 22:10:51 INFO - Running pre-action listener: _resource_record_pre_action 22:10:51 INFO - Running main action method: install 22:10:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:10:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:10:52 INFO - Reading from file tmpfile_stdout 22:10:52 INFO - Detecting whether we're running mozinstall >=1.0... 22:10:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:10:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:10:52 INFO - Reading from file tmpfile_stdout 22:10:52 INFO - Output received: 22:10:52 INFO - Usage: mozinstall [options] installer 22:10:52 INFO - Options: 22:10:52 INFO - -h, --help show this help message and exit 22:10:52 INFO - -d DEST, --destination=DEST 22:10:52 INFO - Directory to install application into. [default: 22:10:52 INFO - "/builds/slave/test"] 22:10:52 INFO - --app=APP Application being installed. [default: firefox] 22:10:52 INFO - mkdir: /builds/slave/test/build/application 22:10:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 22:10:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 22:11:29 INFO - Reading from file tmpfile_stdout 22:11:29 INFO - Output received: 22:11:29 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 22:11:29 INFO - Running post-action listener: _resource_record_post_action 22:11:29 INFO - ##### 22:11:29 INFO - ##### Running run-tests step. 22:11:29 INFO - ##### 22:11:29 INFO - Running pre-action listener: _resource_record_pre_action 22:11:29 INFO - Running main action method: run_tests 22:11:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:11:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:11:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:11:29 INFO - 2015-12-03 22:11:29.730 screenresolution[1641:7577] starting screenresolution argv=screenresolution get 22:11:29 INFO - 2015-12-03 22:11:29.734 screenresolution[1641:7577] Display 0: 1600x1200x32@60 22:11:29 INFO - 2015-12-03 22:11:29.740 screenresolution[1642:7579] starting screenresolution argv=screenresolution list 22:11:29 INFO - Available Modes on Display 0 22:11:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:11:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:11:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:11:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:11:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:11:29 INFO - Intel HD Graphics 3000: 22:11:29 INFO - Chipset Model: Intel HD Graphics 3000 22:11:29 INFO - Type: GPU 22:11:29 INFO - Bus: Built-In 22:11:29 INFO - VRAM (Total): 512 MB 22:11:29 INFO - VRAM (Dynamic, Max): 10 22:11:29 INFO - Vendor: Intel (0x8086) 22:11:29 INFO - Device ID: 0x0116 22:11:29 INFO - Revision ID: 0x0009 22:11:29 INFO - Displays: 22:11:29 INFO - Display: 22:11:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:11:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:11:29 INFO - Display Serial Number: 1600x1200 60 22:11:29 INFO - Main Display: Yes 22:11:29 INFO - Mirror: Off 22:11:29 INFO - Online: Yes 22:11:29 INFO - Rotation: Supported 22:11:29 INFO - Return code: 0 22:11:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:11:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:11:30 INFO - Python 2.7.3 22:11:30 INFO - Return code: 0 22:11:30 INFO - grabbing minidump binary from tooltool 22:11: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')]} 22:11:30 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 0x10adba9f0>, '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 0x10ab19cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad84990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:11:30 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 22:11:30 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 22:11:30 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:11:30 INFO - Return code: 0 22:11:30 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 22:11:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:11:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:11:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 22:11:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:11:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0049', '--webServer', 'localhost'] in /builds/slave/test/build 22:11:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0049 --webServer localhost 22:11:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6lR4A4aZB5/Render', 22:11:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:11:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:11:30 INFO - 'HOME': '/Users/cltbld', 22:11:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:11:30 INFO - 'LOGNAME': 'cltbld', 22:11:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:11:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 22:11:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:30 INFO - 'MOZ_NO_REMOTE': '1', 22:11:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:11:30 INFO - 'NO_EM_RESTART': '1', 22:11:30 INFO - 'PAGER': '/bin/cat', 22:11:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:11:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:11:30 INFO - 'PWD': '/builds/slave/test', 22:11:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:11:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:11:30 INFO - 'SHELL': '/bin/bash', 22:11:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.awyCeVUYhu/Listeners', 22:11:30 INFO - 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/', 22:11:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:11:30 INFO - 'USER': 'cltbld', 22:11:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:11:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:11:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:30 INFO - 'XPC_FLAGS': '0x0', 22:11:30 INFO - 'XPC_SERVICE_NAME': '0', 22:11:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:11:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0049', '--webServer', 'localhost'] with output_timeout 3600 22:11:30 INFO - mozversion INFO | application_buildid: 20151203200703 22:11:30 INFO - mozversion INFO | application_changeset: 858b1b930b16a5c46634e3dad2650c517e150cb0 22:11:30 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 22:11:30 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:11:30 INFO - mozversion INFO | application_name: Firefox 22:11:30 INFO - mozversion INFO | application_remotingname: firefox-dev 22:11:30 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 22:11:30 INFO - mozversion INFO | application_vendor: Mozilla 22:11:30 INFO - mozversion INFO | application_version: 44.0a2 22:11:30 INFO - mozversion INFO | platform_buildid: 20151203200703 22:11:30 INFO - mozversion INFO | platform_changeset: 858b1b930b16a5c46634e3dad2650c517e150cb0 22:11:30 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 22:11:30 INFO - mozversion INFO | platform_version: 44.0a2 22:11:30 INFO - 2015-12-03 22:11:30,409 DEBUG : using testdate: 1449209490 22:11:30 INFO - 2015-12-03 22:11:30,409 DEBUG : actual date: 1449209490 22:11:30 INFO - 2015-12-03 22:11:30,485 INFO : starting webserver on 'localhost:49294' 22:11:30 INFO - 2015-12-03 22:11:30,486 INFO : Starting test suite t-yosemite-r5-0049.e 22:11:30 INFO - 2015-12-03 22:11:30,486 INFO : Starting test dromaeo_css 22:11:30 INFO - 2015-12-03 22:11:30,486 DEBUG : operating with platform_type : mac_ 22:11:30 INFO - 2015-12-03 22:11:30,487 INFO : Initialising browser for dromaeo_css test... 22:11:30 INFO - 2015-12-03 22:11:30,501 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/tmpab1b_u/profile http://localhost:49294/getInfo.html 22:11:33 INFO - 2015-12-03 22:11:33,739 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:11:33 INFO - 2015-12-03 22:11:33,739 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:11:33 INFO - 2015-12-03 22:11:33,739 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 22:11:33 INFO - 2015-12-03 22:11:33,739 DEBUG : BROWSER_OUTPUT: __metrics 22:11:34 INFO - 2015-12-03 22:11:34,340 INFO : Browser initialized. 22:11:34 INFO - 2015-12-03 22:11:34,341 INFO : Running cycle 1/1 for dromaeo_css test... 22:11:34 INFO - 2015-12-03 22:11:34,341 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/tmpab1b_u/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:11:46 INFO - 2015-12-03 22:11:46,246 DEBUG : BROWSER_OUTPUT: RSS: Main: 210821120 22:11:46 INFO - 2015-12-03 22:11:46,246 DEBUG : BROWSER_OUTPUT: 22:12:36 INFO - 2015-12-03 22:12:36,080 DEBUG : BROWSER_OUTPUT: 1449209556076 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] 22:14:46 INFO - 2015-12-03 22:14:46,633 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49294/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49294/tests/dromaeo/cssquery-ext.html) 22:14:47 INFO - 2015-12-03 22:14:47,746 DEBUG : BROWSER_OUTPUT: RSS: Main: 235597824 22:14:47 INFO - 2015-12-03 22:14:47,746 DEBUG : BROWSER_OUTPUT: 22:17:49 INFO - 2015-12-03 22:17:49,850 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49294/tests/dromaeo/cssquery-ext.html (next: http://localhost:49294/tests/dromaeo/cssquery-jquery.html) 22:17:50 INFO - 2015-12-03 22:17:50,434 DEBUG : BROWSER_OUTPUT: RSS: Main: 239149056 22:17:50 INFO - 2015-12-03 22:17:50,434 DEBUG : BROWSER_OUTPUT: 22:20:52 INFO - 2015-12-03 22:20:52,009 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49294/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49294/tests/dromaeo/cssquery-mootools.html) 22:20:52 INFO - 2015-12-03 22:20:52,590 DEBUG : BROWSER_OUTPUT: RSS: Main: 244596736 22:20:52 INFO - 2015-12-03 22:20:52,590 DEBUG : BROWSER_OUTPUT: 22:23:54 INFO - 2015-12-03 22:23:54,222 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49294/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49294/tests/dromaeo/cssquery-prototype.html) 22:23:54 INFO - 2015-12-03 22:23:54,811 DEBUG : BROWSER_OUTPUT: RSS: Main: 247599104 22:23:54 INFO - 2015-12-03 22:23:54,811 DEBUG : BROWSER_OUTPUT: 22:26:57 INFO - 2015-12-03 22:26:57,263 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49294/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49294/tests/dromaeo/cssquery-yui.html) 22:26:57 INFO - 2015-12-03 22:26:57,894 DEBUG : BROWSER_OUTPUT: RSS: Main: 252796928 22:26:57 INFO - 2015-12-03 22:26:57,894 DEBUG : BROWSER_OUTPUT: 22:29:59 INFO - 2015-12-03 22:29:59,994 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49294/tests/dromaeo/cssquery-yui.html (next: http://localhost:49294/tests/dromaeo/cssquery-dojo.html) 22:30:00 INFO - 2015-12-03 22:30:00,252 DEBUG : BROWSER_OUTPUT: RSS: Main: 258494464 22:30:00 INFO - 2015-12-03 22:30:00,252 DEBUG : BROWSER_OUTPUT: 22:30:00 INFO - 2015-12-03 22:30:00,253 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:30:00 INFO - 2015-12-03 22:30:00,253 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:30:00 INFO - 2015-12-03 22:30:00,253 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:30:00 INFO - 2015-12-03 22:30:00,253 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:30:00 INFO - 2015-12-03 22:30:00,253 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3168.8732450701964;3185.267388500646;3219.2112932331584;3226.403115423647;3229.0635715642466;5418.729063546826;5425.2404663347115;5450.373207081187;5458.317710286215;5472.34331880175;5365.436629153932;5371.355437347514;5395.946040539593;5397.055515284819;5485.561155107592;4922.384701912261;4964.801407943678;5013.5989120870245;5033.043721692885;5036.949630503703;4811.566958973692;4875.488073752258;4943.9752801235945;4953.405591329046;4997.025580011899;4996.400431948153;4999.500049994989;5002.149634562115;5006.474320196382;5038.6724862883975;4983.800647974095;5010.173321401964;5018.021485810268;5059.6458247922665;5087.720175390389;4843.830465933711;4855.344528488644;4893.486183950705;4950.702957822542;5017.84946451607;5114.488551144893;5243.501867322599;5300.443453437372;5356.598255130881;5421.105517589593;5544.889102217973;5723.141528770676;5747.655140691572;5751.022326204514;5754.539636829044;5691.146328050784;5749.223854779593;5757.539396848242;5762.423757624246;5784.942150578525;5418.512333889968;5420.566354691655;5435.021696094701;5453.400125986138;5454.8909021819345;5747.885042299215;5894.941050589439;5927.525797936155;5928.584999050111;5930.466258036798;5574.777008919679;5631.042722737145;5632.577556683265;5653.406392328829;5675.886482270332;5673.77304907799;5738.856528586819;5754.942450575524;5759.539236861041;5760.971195143998;5565.276514053147;5625.549956003591;5658.91511627326;5674.319081710139;5685.516731077904;5733.483986441241;5738.971305143447;5745.9425405745405;5747.827565173052;5750.4249575042995;4449.132419178294;4460.910781784346;4478.798454069574;4489.708168969007;4500.797464114123;3947.2500224957166;3962.881113566598;4036.4348991141264;4044.4742183515955;4112.157007813391;5439.265699130646;5501.944980550144;5506.03644362235;5518.834434966958;5519.503244707996;5918.526517878559;5924.348321684612;5934.43622855828;5938.49522790559;5951.226340575698;5256.342957130359;5375.220593014069;5393.83818485446;5505.339359276913;5515.117581186991;5068.037072956126;5070.974645126751;5072.289879416885;5075.11185542536;5090.26191202281;5862.12068189775;5864.706764661835;5865.677387743715;5901.144334071536;5915.733791979371;5591.412901645269;5673;5676.9432305678065;5697.544196464356;5719.3136823581435;5828.6211396259105;5937.465628093492;5947;5952.077427998667;5953.791617293374;5551.417101204315;5791.391903850035;5795.420457954171;5800.535957123336;5817.127430885232;5762.279715035621;5782.363939966516;5821.98115329824;5824.650520968756;5867.090600956859;5651.802186923603;5658.03813351723;5663.66018038919;5676.9432305678065;5713.714314284186;5460.071787796005;5476.315460567429;5606.187102870143;5670.546356291405;5671.234383358194;5437.53186639613;5439.891202176013;5455.208994695826;5473.425290344457;5494.697791621339;5548.889022219614;5624.493795558419;5626.521745651502;5637.577181711306;5642.971785141048;5403.783848646168;5474.343078830566;5523.861903452445;5524.75138618755;5577.888442231214 22:30:00 INFO - 2015-12-03 22:30:00,253 DEBUG : BROWSER_OUTPUT: |1;ext.html;542.6140787120701;571.2687759667627;581.2356750872601;591.9792807251746;592.8103007037749;40265.3960190597;40911.18177636446;41130.38304425436;41417.96455088621;41627.58372416275;44441;44798.77600611992;44818.77590612051;44999;45453;9308.720738377859;9506;9517.048295170462;9531.428114313128;9630.614775408976;9245.72262832116;9331.626734930594;9349.532523373839;9363.016883227265;9435.38669986452;9477.241820654366;9483.668071617494;9505.906820715638;9526.28552858535;9602.231821454267;9321.62713491463;9388.061193880625;9438.528073596293;9448.81102377952;9520.143187113194;9144.45133291998;9268.073192680746;9292.767680807967;9306.348555601111;9347.252219822398;41275.793621032004;41642.79178604088;42159.36760948588;42260.36609450861;42289;2979.5679626454044;3152.747780177603;3218.452863013293;3435.914102147441;3675.4854320395166;28601.570976435163;29229.415411691858;29288.121356359345;29866.10401687953;30019.699803002128;2436.780689737932;2449.09383528094;2504.423982484039;2535.378832186108;2574.4979728952862;283891;289439;290499;291081;291185;61703;63045.369546304864;65118;65511;69637.65181174062;66191.33808661948;66599;66885;67134.66432667903;67250;18469.53826154357;18653.44039678812;18655.720164197548;18680;18702;11971.10216733731;11982.880171198176;11985.64043078709;12008.579699710468;12182.512699492097;21613.02741376642;22045.889770551046;22086.88956555207;22102.336929892128;22203.44491387696;9174.908250917539;9433.292503062297;9445.763855903657;9463;9480.099390557885;915.3866909170871;995.7908839143716;1028.1517747857897;1052.3580615824342;1157.5935238685038;29718.851405742833;29821.254468638024;29858.701412986025;30215.546766798514;30223.395532089235;919.6321471411355;1070.2668671959732;1087.499750114956;1153.2042890405594;1262.9557965471165;12752.80870786939;14624.488142914946;15177.089374637337;15275.770863437057;15513.767293490606;422898;430115;430773;431024;432344;61150;61280.38719612836;61368.38631613627;61494.385056148865;61997;1459.7226526959844;1467.2663668165917;1468.7282852672076;1475;1478.719043381754;29639.703602963695;30366.848165759915;33061.50407743934;33513.83243083769;33561;54868.72565637306;55446.44553554413;55603.165952511554;55751.442485574626;56006.719966399905;310019;313396;314240.43038279127;314751;315931;44129.33805992977;44142.558574413844;44554.77722611496;44587;44737.776311118236;45659.77170114128;46012.76993615011;46079.3088103672;46538.30192547047;47017;36764.44853327256;38512.22975540529;38715.612843871204;39062.4140637885;39836.80081599573;38205.80897095497;38231.808840955615;38391;38590.4211436823;38745.2250954985;41635.16729665329;41750.16499669929;41782.164356712085;42653.57346426496;42760.78619606882;32827.34345313128;33145;35448.82275588605;35717;36859.447108293934;25846;25980.8700956494;27202.183934481996;27476.17571472859;27676.861615691792 22:30:00 INFO - 2015-12-03 22:30:00,254 DEBUG : BROWSER_OUTPUT: |2;jquery.html;352.5839509378932;360.1644185489665;364.65357909985505;365.68916421042115;367.92641471705656;15486.457973970913;17763.20065597048;18159.54601134972;19066.904665476686;19752.604947901033;17928.462146135604;18075;18330;18364;18569.071546422692;5418.647787893784;5522.144067669517;5537.640053396516;5584.078627026536;5584.553235741151;4135.834566617346;5437.211604317391;5953.910691339612;6112.724927378256;6173.228346456693;5999.880002399949;6044.3955604439425;6058.182145410379;6107.083937409379;6107.969460152693;6022.397760223987;6035.064564992434;6076.817695469143;6116.541259405541;6123.295820980555;4090.365993271018;5246.947530524684;5281.86795330116;5304.602154838402;5330.680159190461;13594.184348938996;13785.931070344684;13798;13829.446822127104;13911.304434778322;1935.854810889189;1940.2433051110079;2008.9598208035904;2106.8419868509923;2139.1871088986086;10089.798204035878;10116;10196.133328667072;10289.12542433894;10498.220640569361;1624.6831867785786;1636.8444997725317;1652.9256183471653;1700.4218565687725;1706.436875830973;60630.696846515486;61520.384796152364;62355.6882215586;63974;65106;6956.965215173892;6965.407940325028;6984.650767461607;7030.226675065739;7033.718651253995;8050.557219352875;8060.758177254692;8068.677252909818;8079.555624440594;8100.797480062928;5612.961602103543;5718.428157184248;5867.823965281048;5890.116482527569;5915.881682366328;6229.221347331583;6238.1266622672865;6251.78118765841;6270.7491700331475;6273.654948977759;3098.752099832008;3141.7800753947004;3142.214446388403;3147.3390587976323;3153.0856051744736;3425.5718035245595;3465.4455287153933;3544.3442963051916;3667.6796353312784;3718.2377612589353;459.74254417526294;461.52462963148014;472.6077355794682;476.4378033920008;478.93198168085365;11938.582149624895;12308.50765969369;12341.814872776915;12476.75046499065;12581.622551323475;481.3573878871745;487.89998050399583;491.5084915084915;492.86938961175315;515.8993996170785;6679.4990375721045;6839.452843772487;6883.586984780929;6899.793006209822;6940.09778728762;613825;628387;636790;636837;645592;75853;76702;76720;77020.61489692515;77262.22737772662;523.7093413155659;524.2372348233312;524.3105316508779;525.519149977766;525.8580183350474;11530.250533715282;11544.769104618028;11678.70803229926;11824.349660768741;11890.643280701594;36284;36471;37096.258074838894;37295;38042.23915521729;46717.76641116773;48256.276155858395;48938.75530622324;49598.25602615892;49715.75142124266;6578.440832529289;6701.731930722716;6706.128203333536;6707.564008339637;6789.762358317435;11898.643040708792;12209.328486933304;12255.816162757388;12387.07096967713;12612.621621351374;10297.9485102574;10390.012948769854;10550.103241224582;10616.309939853885;10706.411147386969;10178.440185789557;10307.587696492057;10505.894941050798;10685.839712404164;10715.089217416607;10839.403832788958;10931.344119352865;10944.835827462435;11076.5569377224;11097.33415995043;6683.565568238049;6706;6777.6272305023695;6783.525153239226;6803.965980170067;10917.290376125526;11061.336319820837;11124.666260012213;11163.106951443702;11178.27341222818 22:30:00 INFO - 2015-12-03 22:30:00,258 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1402.5511836212415;1414.9858501414983;1586.2544604036113;1804.3143605429937;1838.7885393179783;6970.930290697092;7046.013558101857;7634.847303053943;7817.687292508307;7917.722879699211;7404.259574042607;7550.6979720811105;7569.053868266466;7573.924260757391;7640.96179519103;2271.931842044737;2311.202635090891;2315.4558678710573;2316.8609883406966;2327.278543651465;2290.828187885907;2337.801286890616;2340.426595484109;2342.367560758594;2355.7879790818824;2251;2265.886705664718;2280.794728474437;2294.8640422990643;2297.6208925527267;2234.4748983988748;2274.363178310076;2295.414669259345;2299.6435552489475;2305.2738387408;2305.377548062014;2327.2320134355623;2327.325075728037;2337.1936681844736;2349.025154560872;7686.116096648845;7747.109082455533;7747.690092396354;7838.647260873217;7842.215778422112;4412.183746006966;4732.621390288768;4804.807807687688;4822.903541929177;4864.124457597631;2495.36368226103;2936.5595160725848;2940.4119176164854;2946.3370741583185;2988.5517172424093;881.951492667903;890.8663700444985;892.8392889279927;907.9046700096461;911.7766147293955;9792.706218813375;9862.802743945082;9864.062914023085;9894.257930655229;9954.153896918771;4281.357796330575;4323.913521729548;4335.761533115646;4356.738595684205;4424.756638384855;9026.548672566345;9026.86459703105;9046.954765226263;9159.496227707406;9171.678991235274;4920.21276595743;4940.802367905316;4957.801687932514;4962.776675049631;4981.775820088104;4491.056878055645;4501.414816073955;4501.932471012938;4540.091981603627;4544.97727511367;3560.0241865764233;3601.2797440511476;3608.4587311903424;3637.927241455156;3655.1593133579427;1158.3339579741682;1166.632510759108;1170.9414529273502;1173.4543437301695;1175.8588969323564;1064.882862885082;1071.1698433713934;1075.1828610256262;1188.8276199950958;1214.6173955204083;7306.8173295666975;7334;7366.484346095722;7388.630568471555;7415.517991330654;468.6180762678474;471.65569134531984;473.3349643750536;1248.6316536621719;1288.7229245712217;5684.147377893349;5828.708564571754;5902.380250073767;5941.851453713692;6009.939900601025;8868.822623547492;9074.546272686339;9131.452112873249;9134.908650913405;9167.358284919992;8967.282617390592;9079.273658107335;9109.407888487227;9170.266378689688;9201.49391783445;7138.107736532934;7310.305520975498;7310.96344518274;7323.487355885037;7409.851802963911;7068.29317068289;7183.748568800067;7186.820329491805;7213.458990575623;7292.34368906801;7971.362291016821;8137.75586732399;8180.9590952044855;8278.296344810758;8286.544240066854;8260.958695206726;8268.131846156308;8274.23167848692;8349.499030058216;8382.790430239293;6989;7079.929200707927;7081.610511421921;7098.25468325839;7145.356917877416;7491.10106787189;7547.245275472409;7556.8488630228185;7557.773266802004;7610.277023682741;6819.522633415613;6872.450203983769;7021.122359705037;7121.643917804193;7218.205997340184;6771.370363175554;6871.828204294733;6947.513674042769;6967.1291088613925;6999.965000174967;7070.39901608369;7074;7086.645667716697;7104.147502299757;7157.141143062866;6425.45383642377;6442.549021568445;6442.90335644975;6486.286508484157;6519.282878883414;6530.934690653033;6540.803775886731;6543.083968244355;6545.37818907203;6575.27671956094 22:30:00 INFO - 2015-12-03 22:30:00,258 DEBUG : BROWSER_OUTPUT: |4;prototype.html;338.2153404102482;339;340.68146283225184;344.84137296843465;349.3240579478708;6234.688265586725;6340.302566717657;6374.3944325289085;6380.649064301461;6429.228492580891;6195.907061394083;6252.499800015999;6264.185655864742;6285.654289014114;6333.5883167594075;4809.086273608021;4811.08589368019;4826.638002149835;4840.782164802592;4858.611311095122;4805.279208118793;4822.71063736177;4858.222684370501;4864.294677271793;4868.367112275399;4620.260758278676;4772.522747725217;4781.354517140194;4832;4844.20070688336;4759.762011899408;4796.472388037348;4833.806647734086;4845.612351011928;4871.098846713369;4168.24971505129;4174.478190226222;4176.728512646669;4188.643965262956;4211.473565804275;6114.541409394314;6120.081987701836;6153.569250152491;6161.075838624198;6180.258368995749;5249.842504724865;5328.49379308965;5345.679259244419;5356.330458692663;5418.4039755626845;6491.123698300717;6504.317046710122;6507.479401647857;6571.112899758519;6582.144321238256;4410.691251612388;4416.028473735773;4422.09347083847;4452.753229095858;4460.576245256695;6692.83267918306;6756;6805.489588280899;6824.283450237704;6922.238553759083;4489.461264648263;4504.054148628759;4512.210363186429;4516.07420478801;4563.794629241692;4598.954010459853;4604.539546045368;4614.561616646413;4629.189891768994;4644.953550464452;5367.677939323653;5373.570114390917;5391.191321301758;5396.64921780083;5419.810306639249;6441.935580644134;6537.607743535403;6566.606003639797;6634.668266586651;6656.667166641649;1626.3738460692718;1635.1824087956022;1657.767912492252;1661.2856471717278;1662.9750553741703;1065.9680209593726;1069.5828626835541;1069.8876617955002;1071.908887744535;1083.0793825248477;6189.226346706661;6212.47193988516;6216.658083805343;6263.498920086473;6291.6854157291955;6785.796426107225;6787.151606049244;6820.908654615337;6851.897221541681;6898.758543450955;6137.9079313810325;6287.654179020198;6293.622382657055;6353.682315884187;6386.712597933104;3774.9622503774613;3793.3740932745786;3794.165283637595;3797.240551889633;3851;6948.166220053626;6948.478864085214;6995.580265184105;7011.1586609607175;7032.367086962198;6840.760573379908;7000.474964377692;7016.684249208798;7063.364297213276;7112.502124851314;6905.620190889449;6912.654367281616;6948.305169483112;6981.685824137926;7001.859962800715;6832.145981752281;6847.897281540881;6910.8617827644175;6925.792226233221;6936.237013928565;6581.506387020897;6696.698648560729;6701.363370479797;6716.1604799400075;6761.560498567577;6904.620245886324;6918.584884906721;6945.0971373721095;6964.233934267125;7014.228434872262;4546.977265113654;4565.3608494811415;4569.268916973401;4587.931181032221;4588.7246765194195;6641.50188735837;6663.200415950117;6814.2163651180745;6854.246032936473;6904.240533541407;6645.235797883305;6646.667666616747;6672.866542669217;6681.064650948774;6754.96622516904;6633.734650614115;6638.701258443285;6644.069830223676;6644.867102658017;6729.0915726376315;6334.90497642545;6484.059811327425;6565.409113179646;6578.276389597237;6587.374199451045;6652.334766523502;6722;6729.091572637827;6766.391024807791;6830.931690683228;6560.179977502812;6567.343265673395;6584.8353791155605;6668.933310666831;6672.466202703869 22:30:00 INFO - 2015-12-03 22:30:00,260 DEBUG : BROWSER_OUTPUT: |5;yui.html;759.5480688990049;767.9001729775129;772.5094564951257;773.6054612147803;802.3982013489882;14580;14843.480478183266;14928.999999999987;14983.17592532413;15123.470678526253;13775.51785687501;13777.448902043907;13786.03497755155;13792;13874.514391996283;728.5628622826289;745.3180339988903;899.2176806178634;908.9818203635923;943.6319835264252;905.3345790843724;911.9589618467152;918.1828172926101;921.4379228670506;925.9490728009956;968.0851595242499;977.1645243316933;981.2150279776187;986.6990567876795;991.7124034030159;972.027972027972;976.9267304952157;979.0698836105693;986.013986013986;988.2489308125804;726.3680597879878;726.8400951790597;727.2836256287552;732.0081289852227;733.8568979049088;14142.858571414257;14216.360263788154;14228.359723812453;14270.286485675779;14388.424463021467;11856.229345092628;12126.27242365461;12261.325627090506;12511.74976500474;12563.685907852285;9260.536973151315;9264.72205833826;9420.717378478657;9602.90397096034;10015.44915029673;3403.676650718178;3403.795772253648;3428.142964258935;3434.690877820983;3439.105832483547;49917;49944.75027624875;49997.500024999645;49998.25002624963;50066.249006264574;7293.197748247689;9367.437953722798;9458.621655133855;9511.952440237894;9558.426494410218;11765.588204412805;11769.176157669051;11886.108541859396;11903.821442678367;11910.583129590595;5766.394528574523;5877.94122058774;6059.606125601822;6376.107344971708;6530.412262896362;3999.5400528938962;4021.4168945503325;4050.3924411338535;4071.3485842265095;4096.91806163881;2827.872745726447;2834.376437183816;2835.9858200709277;2847.4874522586133;2870.167651381076;414.2708832454901;416.0389500254422;418.76549132485906;420.7517564636879;422.2399680574953;470.6893450322839;472.9645276604268;479.8320587794244;586.2642383808293;604.0787798607072;8223.177682231848;8225.259726624512;8282.71010514629;8418.747437576883;8432.325413966868;502.92204708270276;514.6989011428282;628.5474458389951;638.8339031851752;641.4579680170249;3663.9633603664156;3945.309570825094;3996.220736956324;4083.448734420815;4105.712600118023;62931.37068629346;63746.68126659337;63957;64235.678821606525;64335;53559.732201338746;54383.72808135934;54569.72715136479;54772.178417323776;54782.726086369315;48239.27641085457;48889.75555122201;49094.75452622714;49129.75435122802;49735;7044.718211271492;7164.570125792469;8209;8378.413511054412;8455.534945578052;35252.118697032776;35567.64432355747;35932;37808;37857.24285514219;43529.56470435255;44635.330470042325;47163.528364715916;47957.28064079111;50200;7725.845483090419;8014.118446970945;8034.718784842503;8042.276195142465;8258.339332853237;11223.270487418291;11634.70913227176;11840.881591184323;11862.644120676394;12048.75902481928;10468.371897686164;10613;10763.623273185402;11212.83180752273;11598.130140239684;10810.837837432602;10832.5125369357;10891.237613366988;10948.178886583379;11061.889381106408;10341.63804266847;10451.738706532398;10495.52770125331;10545.156387488829;10604.416757078126;9458.148766611039;9677.22582193437;9720.611175553182;9953.552090156105;9996.400215987063;9542.188913942115;9590.424574525272;9636.22910167171;9687;9738.074882886114 22:30:00 INFO - 2015-12-03 22:30:00,260 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:30:00 INFO - 2015-12-03 22:30:00,260 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:30:00 INFO - 2015-12-03 22:30:00,260 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,269 22:30:00 INFO - 2015-12-03 22:30:00,260 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:30:00 INFO - 2015-12-03 22:30:00,260 DEBUG : BROWSER_OUTPUT: __startTimestamp1449210600246__endTimestamp 22:30:00 INFO - 2015-12-03 22:30:00,261 DEBUG : BROWSER_OUTPUT: 22:30:00 INFO - 2015-12-03 22:30:00,261 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:30:00 INFO - 2015-12-03 22:30:00,261 DEBUG : BROWSER_OUTPUT: Number of tests: 6 22:30:00 INFO - 2015-12-03 22:30:00,261 DEBUG : BROWSER_OUTPUT: 22:30:00 INFO - 2015-12-03 22:30:00,261 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5364.09 Median:5518.83 stddev:573.58 (10.4%) stddev-sans-first:548.88 22:30:00 INFO - 2015-12-03 22:30:00,263 DEBUG : BROWSER_OUTPUT: Values: 3168.9 3185.3 3219.2 3226.4 3229.1 5418.7 5425.2 5450.4 5458.3 5472.3 5365.4 5371.4 5395.9 5397.1 5485.6 4922.4 4964.8 5013.6 5033.0 5036.9 4811.6 4875.5 4944.0 4953.4 4997.0 4996.4 4999.5 5002.1 5006.5 5038.7 4983.8 5010.2 5018.0 5059.6 5087.7 4843.8 4855.3 4893.5 4950.7 5017.8 5114.5 5243.5 5300.4 5356.6 5421.1 5544.9 5723.1 5747.7 5751.0 5754.5 5691.1 5749.2 5757.5 5762.4 5784.9 5418.5 5420.6 5435.0 5453.4 5454.9 5747.9 5894.9 5927.5 5928.6 5930.5 5574.8 5631.0 5632.6 5653.4 5675.9 5673.8 5738.9 5754.9 5759.5 5761.0 5565.3 5625.5 5658.9 5674.3 5685.5 5733.5 5739.0 5745.9 5747.8 5750.4 4449.1 4460.9 4478.8 4489.7 4500.8 3947.3 3962.9 4036.4 4044.5 4112.2 5439.3 5501.9 5506.0 5518.8 5519.5 5918.5 5924.3 5934.4 5938.5 5951.2 5256.3 5375.2 5393.8 5505.3 5515.1 5068.0 5071.0 5072.3 5075.1 5090.3 5862.1 5864.7 5865.7 5901.1 5915.7 5591.4 5673.0 5676.9 5697.5 5719.3 5828.6 5937.5 5947.0 5952.1 5953.8 5551.4 5791.4 5795.4 5800.5 5817.1 5762.3 5782.4 5822.0 5824.7 5867.1 5651.8 5658.0 5663.7 5676.9 5713.7 5460.1 5476.3 5606.2 5670.5 5671.2 5437.5 5439.9 5455.2 5473.4 5494.7 5548.9 5624.5 5626.5 5637.6 5643.0 5403.8 5474.3 5523.9 5524.8 5577.9 22:30:00 INFO - 2015-12-03 22:30:00,263 DEBUG : BROWSER_OUTPUT: 22:30:00 INFO - 2015-12-03 22:30:00,263 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:52934.38 Median:41346.88 stddev:91837.29 (222.1%) stddev-sans-first:92010.67 22:30:00 INFO - 2015-12-03 22:30:00,265 DEBUG : BROWSER_OUTPUT: Values: 542.6 571.3 581.2 592.0 592.8 40265.4 40911.2 41130.4 41418.0 41627.6 44441.0 44798.8 44818.8 44999.0 45453.0 9308.7 9506.0 9517.0 9531.4 9630.6 9245.7 9331.6 9349.5 9363.0 9435.4 9477.2 9483.7 9505.9 9526.3 9602.2 9321.6 9388.1 9438.5 9448.8 9520.1 9144.5 9268.1 9292.8 9306.3 9347.3 41275.8 41642.8 42159.4 42260.4 42289.0 2979.6 3152.7 3218.5 3435.9 3675.5 28601.6 29229.4 29288.1 29866.1 30019.7 2436.8 2449.1 2504.4 2535.4 2574.5 283891.0 289439.0 290499.0 291081.0 291185.0 61703.0 63045.4 65118.0 65511.0 69637.7 66191.3 66599.0 66885.0 67134.7 67250.0 18469.5 18653.4 18655.7 18680.0 18702.0 11971.1 11982.9 11985.6 12008.6 12182.5 21613.0 22045.9 22086.9 22102.3 22203.4 9174.9 9433.3 9445.8 9463.0 9480.1 915.4 995.8 1028.2 1052.4 1157.6 29718.9 29821.3 29858.7 30215.5 30223.4 919.6 1070.3 1087.5 1153.2 1263.0 12752.8 14624.5 15177.1 15275.8 15513.8 422898.0 430115.0 430773.0 431024.0 432344.0 61150.0 61280.4 61368.4 61494.4 61997.0 1459.7 1467.3 1468.7 1475.0 1478.7 29639.7 30366.8 33061.5 33513.8 33561.0 54868.7 55446.4 55603.2 55751.4 56006.7 310019.0 313396.0 314240.4 314751.0 315931.0 44129.3 44142.6 44554.8 44587.0 44737.8 45659.8 46012.8 46079.3 46538.3 47017.0 36764.4 38512.2 38715.6 39062.4 39836.8 38205.8 38231.8 38391.0 38590.4 38745.2 41635.2 41750.2 41782.2 42653.6 42760.8 32827.3 33145.0 35448.8 35717.0 36859.4 25846.0 25980.9 27202.2 27476.2 27676.9 22:30:00 INFO - 2015-12-03 22:30:00,265 DEBUG : BROWSER_OUTPUT: 22:30:00 INFO - 2015-12-03 22:30:00,265 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:30139.22 Median:474.52 stddev:103450.96 (21801.1%) stddev-sans-first:103716.98 22:30:00 INFO - 2015-12-03 22:30:00,265 DEBUG : BROWSER_OUTPUT: Values: 352.6 360.2 364.7 365.7 367.9 15486.5 17763.2 18159.5 19066.9 19752.6 17928.5 18075.0 18330.0 18364.0 18569.1 5418.6 5522.1 5537.6 5584.1 5584.6 4135.8 5437.2 5953.9 6112.7 6173.2 5999.9 6044.4 6058.2 6107.1 6108.0 6022.4 6035.1 6076.8 6116.5 6123.3 4090.4 5246.9 5281.9 5304.6 5330.7 13594.2 13785.9 13798.0 13829.4 13911.3 1935.9 1940.2 2009.0 2106.8 2139.2 10089.8 10116.0 10196.1 10289.1 10498.2 1624.7 1636.8 1652.9 1700.4 1706.4 60630.7 61520.4 62355.7 63974.0 65106.0 6957.0 6965.4 6984.7 7030.2 7033.7 8050.6 8060.8 8068.7 8079.6 8100.8 5613.0 5718.4 5867.8 5890.1 5915.9 6229.2 6238.1 6251.8 6270.7 6273.7 3098.8 3141.8 3142.2 3147.3 3153.1 3425.6 3465.4 3544.3 3667.7 3718.2 459.7 461.5 472.6 476.4 478.9 11938.6 12308.5 12341.8 12476.8 12581.6 481.4 487.9 491.5 492.9 515.9 6679.5 6839.5 6883.6 6899.8 6940.1 613825.0 628387.0 636790.0 636837.0 645592.0 75853.0 76702.0 76720.0 77020.6 77262.2 523.7 524.2 524.3 525.5 525.9 11530.3 11544.8 11678.7 11824.3 11890.6 36284.0 36471.0 37096.3 37295.0 38042.2 46717.8 48256.3 48938.8 49598.3 49715.8 6578.4 6701.7 6706.1 6707.6 6789.8 11898.6 12209.3 12255.8 12387.1 12612.6 10297.9 10390.0 10550.1 10616.3 10706.4 10178.4 10307.6 10505.9 10685.8 10715.1 10839.4 10931.3 10944.8 11076.6 11097.3 6683.6 6706.0 6777.6 6783.5 6804.0 10917.3 11061.3 11124.7 11163.1 11178.3 22:30:00 INFO - 2015-12-03 22:30:00,265 DEBUG : BROWSER_OUTPUT: 22:30:00 INFO - 2015-12-03 22:30:00,266 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5414.90 Median:6795.45 stddev:2760.08 (40.6%) stddev-sans-first:2751.34 22:30:00 INFO - 2015-12-03 22:30:00,267 DEBUG : BROWSER_OUTPUT: Values: 1402.6 1415.0 1586.3 1804.3 1838.8 6970.9 7046.0 7634.8 7817.7 7917.7 7404.3 7550.7 7569.1 7573.9 7641.0 2271.9 2311.2 2315.5 2316.9 2327.3 2290.8 2337.8 2340.4 2342.4 2355.8 2251.0 2265.9 2280.8 2294.9 2297.6 2234.5 2274.4 2295.4 2299.6 2305.3 2305.4 2327.2 2327.3 2337.2 2349.0 7686.1 7747.1 7747.7 7838.6 7842.2 4412.2 4732.6 4804.8 4822.9 4864.1 2495.4 2936.6 2940.4 2946.3 2988.6 882.0 890.9 892.8 907.9 911.8 9792.7 9862.8 9864.1 9894.3 9954.2 4281.4 4323.9 4335.8 4356.7 4424.8 9026.5 9026.9 9047.0 9159.5 9171.7 4920.2 4940.8 4957.8 4962.8 4981.8 4491.1 4501.4 4501.9 4540.1 4545.0 3560.0 3601.3 3608.5 3637.9 3655.2 1158.3 1166.6 1170.9 1173.5 1175.9 1064.9 1071.2 1075.2 1188.8 1214.6 7306.8 7334.0 7366.5 7388.6 7415.5 468.6 471.7 473.3 1248.6 1288.7 5684.1 5828.7 5902.4 5941.9 6009.9 8868.8 9074.5 9131.5 9134.9 9167.4 8967.3 9079.3 9109.4 9170.3 9201.5 7138.1 7310.3 7311.0 7323.5 7409.9 7068.3 7183.7 7186.8 7213.5 7292.3 7971.4 8137.8 8181.0 8278.3 8286.5 8261.0 8268.1 8274.2 8349.5 8382.8 6989.0 7079.9 7081.6 7098.3 7145.4 7491.1 7547.2 7556.8 7557.8 7610.3 6819.5 6872.5 7021.1 7121.6 7218.2 6771.4 6871.8 6947.5 6967.1 7000.0 7070.4 7074.0 7086.6 7104.1 7157.1 6425.5 6442.5 6442.9 6486.3 6519.3 6530.9 6540.8 6543.1 6545.4 6575.3 22:30:00 INFO - 2015-12-03 22:30:00,267 DEBUG : BROWSER_OUTPUT: 22:30:00 INFO - 2015-12-03 22:30:00,267 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5518.09 Median:6289.67 stddev:1672.47 (26.6%) stddev-sans-first:1631.35 22:30:00 INFO - 2015-12-03 22:30:00,267 DEBUG : BROWSER_OUTPUT: Values: 338.2 339.0 340.7 344.8 349.3 6234.7 6340.3 6374.4 6380.6 6429.2 6195.9 6252.5 6264.2 6285.7 6333.6 4809.1 4811.1 4826.6 4840.8 4858.6 4805.3 4822.7 4858.2 4864.3 4868.4 4620.3 4772.5 4781.4 4832.0 4844.2 4759.8 4796.5 4833.8 4845.6 4871.1 4168.2 4174.5 4176.7 4188.6 4211.5 6114.5 6120.1 6153.6 6161.1 6180.3 5249.8 5328.5 5345.7 5356.3 5418.4 6491.1 6504.3 6507.5 6571.1 6582.1 4410.7 4416.0 4422.1 4452.8 4460.6 6692.8 6756.0 6805.5 6824.3 6922.2 4489.5 4504.1 4512.2 4516.1 4563.8 4599.0 4604.5 4614.6 4629.2 4645.0 5367.7 5373.6 5391.2 5396.6 5419.8 6441.9 6537.6 6566.6 6634.7 6656.7 1626.4 1635.2 1657.8 1661.3 1663.0 1066.0 1069.6 1069.9 1071.9 1083.1 6189.2 6212.5 6216.7 6263.5 6291.7 6785.8 6787.2 6820.9 6851.9 6898.8 6137.9 6287.7 6293.6 6353.7 6386.7 3775.0 3793.4 3794.2 3797.2 3851.0 6948.2 6948.5 6995.6 7011.2 7032.4 6840.8 7000.5 7016.7 7063.4 7112.5 6905.6 6912.7 6948.3 6981.7 7001.9 6832.1 6847.9 6910.9 6925.8 6936.2 6581.5 6696.7 6701.4 6716.2 6761.6 6904.6 6918.6 6945.1 6964.2 7014.2 4547.0 4565.4 4569.3 4587.9 4588.7 6641.5 6663.2 6814.2 6854.2 6904.2 6645.2 6646.7 6672.9 6681.1 6755.0 6633.7 6638.7 6644.1 6644.9 6729.1 6334.9 6484.1 6565.4 6578.3 6587.4 6652.3 6722.0 6729.1 6766.4 6830.9 6560.2 6567.3 6584.8 6668.9 6672.5 22:30:00 INFO - 2015-12-03 22:30:00,267 DEBUG : BROWSER_OUTPUT: 22:30:00 INFO - 2015-12-03 22:30:00,268 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13911.71 Median:49997.88 stddev:17153.28 (34.3%) stddev-sans-first:17172.97 22:30:00 INFO - 2015-12-03 22:30:00,269 DEBUG : BROWSER_OUTPUT: Values: 759.5 767.9 772.5 773.6 802.4 14580.0 14843.5 14929.0 14983.2 15123.5 13775.5 13777.4 13786.0 13792.0 13874.5 728.6 745.3 899.2 909.0 943.6 905.3 912.0 918.2 921.4 925.9 968.1 977.2 981.2 986.7 991.7 972.0 976.9 979.1 986.0 988.2 726.4 726.8 727.3 732.0 733.9 14142.9 14216.4 14228.4 14270.3 14388.4 11856.2 12126.3 12261.3 12511.7 12563.7 9260.5 9264.7 9420.7 9602.9 10015.4 3403.7 3403.8 3428.1 3434.7 3439.1 49917.0 49944.8 49997.5 49998.3 50066.2 7293.2 9367.4 9458.6 9512.0 9558.4 11765.6 11769.2 11886.1 11903.8 11910.6 5766.4 5877.9 6059.6 6376.1 6530.4 3999.5 4021.4 4050.4 4071.3 4096.9 2827.9 2834.4 2836.0 2847.5 2870.2 414.3 416.0 418.8 420.8 422.2 470.7 473.0 479.8 586.3 604.1 8223.2 8225.3 8282.7 8418.7 8432.3 502.9 514.7 628.5 638.8 641.5 3664.0 3945.3 3996.2 4083.4 4105.7 62931.4 63746.7 63957.0 64235.7 64335.0 53559.7 54383.7 54569.7 54772.2 54782.7 48239.3 48889.8 49094.8 49129.8 49735.0 7044.7 7164.6 8209.0 8378.4 8455.5 35252.1 35567.6 35932.0 37808.0 37857.2 43529.6 44635.3 47163.5 47957.3 50200.0 7725.8 8014.1 8034.7 8042.3 8258.3 11223.3 11634.7 11840.9 11862.6 12048.8 10468.4 10613.0 10763.6 11212.8 11598.1 10810.8 10832.5 10891.2 10948.2 11061.9 10341.6 10451.7 10495.5 10545.2 10604.4 9458.1 9677.2 9720.6 9953.6 9996.4 9542.2 9590.4 9636.2 9687.0 9738.1 22:30:00 INFO - 2015-12-03 22:30:00,269 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:30:00 INFO - 2015-12-03 22:30:00,269 DEBUG : BROWSER_OUTPUT: 22:30:00 INFO - 2015-12-03 22:30:00,681 INFO : Browser exited with error code: 0 22:30:00 INFO - 2015-12-03 22:30:00,708 INFO : Completed test dromaeo_css (00:18:30) 22:30:00 INFO - 2015-12-03 22:30:00,709 INFO : Starting test kraken 22:30:00 INFO - 2015-12-03 22:30:00,709 DEBUG : operating with platform_type : mac_ 22:30:00 INFO - 2015-12-03 22:30:00,709 INFO : Initialising browser for kraken test... 22:30:00 INFO - 2015-12-03 22:30:00,722 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/tmpkgNXnm/profile http://localhost:49294/getInfo.html 22:30:03 INFO - 2015-12-03 22:30:03,352 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:30:03 INFO - 2015-12-03 22:30:03,352 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:30:03 INFO - 2015-12-03 22:30:03,352 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 22:30:03 INFO - 2015-12-03 22:30:03,353 DEBUG : BROWSER_OUTPUT: __metrics 22:30:03 INFO - 2015-12-03 22:30:03,910 INFO : Browser initialized. 22:30:03 INFO - 2015-12-03 22:30:03,911 INFO : Running cycle 1/1 for kraken test... 22:30:03 INFO - 2015-12-03 22:30:03,911 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/tmpkgNXnm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:30:15 INFO - 2015-12-03 22:30:15,777 DEBUG : BROWSER_OUTPUT: RSS: Main: 209481728 22:30:15 INFO - 2015-12-03 22:30:15,777 DEBUG : BROWSER_OUTPUT: 22:30:18 INFO - 2015-12-03 22:30:18,476 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49294/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49294/tests/kraken/driver.html?testName=audio-beat-detection) 22:30:19 INFO - 2015-12-03 22:30:19,085 DEBUG : BROWSER_OUTPUT: RSS: Main: 229662720 22:30:19 INFO - 2015-12-03 22:30:19,086 DEBUG : BROWSER_OUTPUT: 22:30:21 INFO - 2015-12-03 22:30:21,676 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49294/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49294/tests/kraken/driver.html?testName=audio-dft) 22:30:22 INFO - 2015-12-03 22:30:22,274 DEBUG : BROWSER_OUTPUT: RSS: Main: 236941312 22:30:22 INFO - 2015-12-03 22:30:22,274 DEBUG : BROWSER_OUTPUT: 22:30:25 INFO - 2015-12-03 22:30:25,128 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49294/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49294/tests/kraken/driver.html?testName=audio-fft) 22:30:25 INFO - 2015-12-03 22:30:25,716 DEBUG : BROWSER_OUTPUT: RSS: Main: 237416448 22:30:25 INFO - 2015-12-03 22:30:25,716 DEBUG : BROWSER_OUTPUT: 22:30:27 INFO - 2015-12-03 22:30:27,737 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49294/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49294/tests/kraken/driver.html?testName=audio-oscillator) 22:30:28 INFO - 2015-12-03 22:30:28,324 DEBUG : BROWSER_OUTPUT: RSS: Main: 236806144 22:30:28 INFO - 2015-12-03 22:30:28,324 DEBUG : BROWSER_OUTPUT: 22:30:30 INFO - 2015-12-03 22:30:30,454 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49294/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49294/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:30:31 INFO - 2015-12-03 22:30:31,041 DEBUG : BROWSER_OUTPUT: RSS: Main: 237301760 22:30:31 INFO - 2015-12-03 22:30:31,041 DEBUG : BROWSER_OUTPUT: 22:30:34 INFO - 2015-12-03 22:30:34,015 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49294/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49294/tests/kraken/driver.html?testName=imaging-darkroom) 22:30:34 INFO - 2015-12-03 22:30:34,600 DEBUG : BROWSER_OUTPUT: RSS: Main: 235556864 22:30:34 INFO - 2015-12-03 22:30:34,600 DEBUG : BROWSER_OUTPUT: 22:30:37 INFO - 2015-12-03 22:30:37,691 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49294/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49294/tests/kraken/driver.html?testName=imaging-desaturate) 22:30:38 INFO - 2015-12-03 22:30:38,279 DEBUG : BROWSER_OUTPUT: RSS: Main: 236548096 22:30:38 INFO - 2015-12-03 22:30:38,279 DEBUG : BROWSER_OUTPUT: 22:30:41 INFO - 2015-12-03 22:30:41,191 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49294/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49294/tests/kraken/driver.html?testName=json-parse-financial) 22:30:41 INFO - 2015-12-03 22:30:41,777 DEBUG : BROWSER_OUTPUT: RSS: Main: 237006848 22:30:41 INFO - 2015-12-03 22:30:41,777 DEBUG : BROWSER_OUTPUT: 22:30:43 INFO - 2015-12-03 22:30:43,388 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49294/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49294/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:30:43 INFO - 2015-12-03 22:30:43,958 DEBUG : BROWSER_OUTPUT: RSS: Main: 236883968 22:30:43 INFO - 2015-12-03 22:30:43,959 DEBUG : BROWSER_OUTPUT: 22:30:45 INFO - 2015-12-03 22:30:45,763 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49294/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49294/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:30:46 INFO - 2015-12-03 22:30:46,389 DEBUG : BROWSER_OUTPUT: RSS: Main: 235675648 22:30:46 INFO - 2015-12-03 22:30:46,389 DEBUG : BROWSER_OUTPUT: 22:30:48 INFO - 2015-12-03 22:30:48,422 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49294/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49294/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:30:49 INFO - 2015-12-03 22:30:49,011 DEBUG : BROWSER_OUTPUT: RSS: Main: 238043136 22:30:49 INFO - 2015-12-03 22:30:49,012 DEBUG : BROWSER_OUTPUT: 22:30:51 INFO - 2015-12-03 22:30:51,492 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49294/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49294/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:30:52 INFO - 2015-12-03 22:30:52,081 DEBUG : BROWSER_OUTPUT: RSS: Main: 237543424 22:30:52 INFO - 2015-12-03 22:30:52,082 DEBUG : BROWSER_OUTPUT: 22:30:54 INFO - 2015-12-03 22:30:54,614 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49294/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49294/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:30:55 INFO - 2015-12-03 22:30:55,198 DEBUG : BROWSER_OUTPUT: RSS: Main: 238211072 22:30:55 INFO - 2015-12-03 22:30:55,198 DEBUG : BROWSER_OUTPUT: 22:30:56 INFO - 2015-12-03 22:30:56,889 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49294/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49294/tests/kraken/driver.html?testName=ai-astar) 22:30:57 INFO - 2015-12-03 22:30:57,138 DEBUG : BROWSER_OUTPUT: RSS: Main: 238489600 22:30:57 INFO - 2015-12-03 22:30:57,138 DEBUG : BROWSER_OUTPUT: 22:30:57 INFO - 2015-12-03 22:30:57,138 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:30:57 INFO - 2015-12-03 22:30:57,139 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:30:57 INFO - 2015-12-03 22:30:57,140 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:30:57 INFO - 2015-12-03 22:30:57,140 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:30:57 INFO - 2015-12-03 22:30:57,140 DEBUG : BROWSER_OUTPUT: |0;ai-astar;114;102;110;109;112;121;110;111;109;109 22:30:57 INFO - 2015-12-03 22:30:57,140 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;152;127;157;150;126;147;127;158;148;125 22:30:57 INFO - 2015-12-03 22:30:57,140 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;165;165;165;166;166;167;168;166;166 22:30:57 INFO - 2015-12-03 22:30:57,140 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;75;83;115;66;66;70;71;116;65 22:30:57 INFO - 2015-12-03 22:30:57,140 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;89;90;129;86;88;89;132;89;89;132 22:30:57 INFO - 2015-12-03 22:30:57,140 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;121;116;120;115;115;115;115;115;115;114 22:30:57 INFO - 2015-12-03 22:30:57,141 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;126;125;125;125;125;125;126;126;126;135 22:30:57 INFO - 2015-12-03 22:30:57,141 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;104;104;105;103;106;104;114;113;121;112 22:30:57 INFO - 2015-12-03 22:30:57,141 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;61;66;66;66;66;67;66;73;61;61 22:30:57 INFO - 2015-12-03 22:30:57,141 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;68;67;67;67;67;67;69;68 22:30:57 INFO - 2015-12-03 22:30:57,141 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;83;83;84;86;83;81;84;84;87 22:30:57 INFO - 2015-12-03 22:30:57,141 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;119;128;120;118;119;122;118;125;122;121 22:30:57 INFO - 2015-12-03 22:30:57,141 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;146;143;146;144;146;146;148;147;149;146 22:30:57 INFO - 2015-12-03 22:30:57,141 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;68;70;68;68;69;69;70;68;68 22:30:57 INFO - 2015-12-03 22:30:57,141 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:30:57 INFO - 2015-12-03 22:30:57,142 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:30:57 INFO - 2015-12-03 22:30:57,142 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,688 22:30:57 INFO - 2015-12-03 22:30:57,142 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:30:57 INFO - 2015-12-03 22:30:57,142 DEBUG : BROWSER_OUTPUT: __startTimestamp1449210657137__endTimestamp 22:30:57 INFO - 2015-12-03 22:30:57,142 DEBUG : BROWSER_OUTPUT: 22:30:57 INFO - 2015-12-03 22:30:57,143 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:30:57 INFO - 2015-12-03 22:30:57,144 DEBUG : BROWSER_OUTPUT: Number of tests: 14 22:30:57 INFO - 2015-12-03 22:30:57,144 DEBUG : BROWSER_OUTPUT: 22:30:57 INFO - 2015-12-03 22:30:57,144 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.70 Median:110.50 stddev:4.76 (4.3%) stddev-sans-first:4.90 22:30:57 INFO - 2015-12-03 22:30:57,144 DEBUG : BROWSER_OUTPUT: Values: 114.0 102.0 110.0 109.0 112.0 121.0 110.0 111.0 109.0 109.0 22:30:57 INFO - 2015-12-03 22:30:57,145 DEBUG : BROWSER_OUTPUT: 22:30:57 INFO - 2015-12-03 22:30:57,145 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.70 Median:149.00 stddev:13.74 (9.2%) stddev-sans-first:14.06 22:30:57 INFO - 2015-12-03 22:30:57,145 DEBUG : BROWSER_OUTPUT: Values: 152.0 127.0 157.0 150.0 126.0 147.0 127.0 158.0 148.0 125.0 22:30:57 INFO - 2015-12-03 22:30:57,145 DEBUG : BROWSER_OUTPUT: 22:30:57 INFO - 2015-12-03 22:30:57,145 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:165.70 Median:166.00 stddev:1.34 (0.8%) stddev-sans-first:1.00 22:30:57 INFO - 2015-12-03 22:30:57,145 DEBUG : BROWSER_OUTPUT: Values: 163.0 165.0 165.0 165.0 166.0 166.0 167.0 168.0 166.0 166.0 22:30:57 INFO - 2015-12-03 22:30:57,146 DEBUG : BROWSER_OUTPUT: 22:30:57 INFO - 2015-12-03 22:30:57,146 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.90 Median:70.50 stddev:19.48 (27.6%) stddev-sans-first:20.46 22:30:57 INFO - 2015-12-03 22:30:57,146 DEBUG : BROWSER_OUTPUT: Values: 72.0 75.0 83.0 115.0 66.0 66.0 70.0 71.0 116.0 65.0 22:30:57 INFO - 2015-12-03 22:30:57,146 DEBUG : BROWSER_OUTPUT: 22:30:57 INFO - 2015-12-03 22:30:57,146 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:101.30 Median:89.00 stddev:20.54 (23.1%) stddev-sans-first:21.30 22:30:57 INFO - 2015-12-03 22:30:57,146 DEBUG : BROWSER_OUTPUT: Values: 89.0 90.0 129.0 86.0 88.0 89.0 132.0 89.0 89.0 132.0 22:30:57 INFO - 2015-12-03 22:30:57,147 DEBUG : BROWSER_OUTPUT: 22:30:57 INFO - 2015-12-03 22:30:57,147 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:116.10 Median:115.00 stddev:2.38 (2.1%) stddev-sans-first:1.74 22:30:57 INFO - 2015-12-03 22:30:57,147 DEBUG : BROWSER_OUTPUT: Values: 121.0 116.0 120.0 115.0 115.0 115.0 115.0 115.0 115.0 114.0 22:30:57 INFO - 2015-12-03 22:30:57,147 DEBUG : BROWSER_OUTPUT: 22:30:57 INFO - 2015-12-03 22:30:57,147 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:126.40 Median:126.00 stddev:3.06 (2.4%) stddev-sans-first:3.24 22:30:57 INFO - 2015-12-03 22:30:57,147 DEBUG : BROWSER_OUTPUT: Values: 126.0 125.0 125.0 125.0 125.0 125.0 126.0 126.0 126.0 135.0 22:30:57 INFO - 2015-12-03 22:30:57,148 DEBUG : BROWSER_OUTPUT: 22:30:57 INFO - 2015-12-03 22:30:57,148 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:108.60 Median:109.00 stddev:6.04 (5.5%) stddev-sans-first:6.17 22:30:57 INFO - 2015-12-03 22:30:57,148 DEBUG : BROWSER_OUTPUT: Values: 104.0 104.0 105.0 103.0 106.0 104.0 114.0 113.0 121.0 112.0 22:30:57 INFO - 2015-12-03 22:30:57,148 DEBUG : BROWSER_OUTPUT: 22:30:57 INFO - 2015-12-03 22:30:57,148 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:65.30 Median:66.00 stddev:3.65 (5.5%) stddev-sans-first:3.53 22:30:57 INFO - 2015-12-03 22:30:57,148 DEBUG : BROWSER_OUTPUT: Values: 61.0 66.0 66.0 66.0 66.0 67.0 66.0 73.0 61.0 61.0 22:30:57 INFO - 2015-12-03 22:30:57,148 DEBUG : BROWSER_OUTPUT: 22:30:57 INFO - 2015-12-03 22:30:57,148 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:68.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 22:30:57 INFO - 2015-12-03 22:30:57,148 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 68.0 67.0 67.0 67.0 67.0 67.0 69.0 68.0 22:30:57 INFO - 2015-12-03 22:30:57,149 DEBUG : BROWSER_OUTPUT: 22:30:57 INFO - 2015-12-03 22:30:57,150 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:84.00 stddev:1.66 (2.0%) stddev-sans-first:1.76 22:30:57 INFO - 2015-12-03 22:30:57,150 DEBUG : BROWSER_OUTPUT: Values: 84.0 83.0 83.0 84.0 86.0 83.0 81.0 84.0 84.0 87.0 22:30:57 INFO - 2015-12-03 22:30:57,150 DEBUG : BROWSER_OUTPUT: 22:30:57 INFO - 2015-12-03 22:30:57,150 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.20 Median:121.50 stddev:3.22 (2.7%) stddev-sans-first:3.32 22:30:57 INFO - 2015-12-03 22:30:57,150 DEBUG : BROWSER_OUTPUT: Values: 119.0 128.0 120.0 118.0 119.0 122.0 118.0 125.0 122.0 121.0 22:30:57 INFO - 2015-12-03 22:30:57,151 DEBUG : BROWSER_OUTPUT: 22:30:57 INFO - 2015-12-03 22:30:57,151 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.10 Median:146.00 stddev:1.73 (1.2%) stddev-sans-first:1.83 22:30:57 INFO - 2015-12-03 22:30:57,151 DEBUG : BROWSER_OUTPUT: Values: 146.0 143.0 146.0 144.0 146.0 146.0 148.0 147.0 149.0 146.0 22:30:57 INFO - 2015-12-03 22:30:57,151 DEBUG : BROWSER_OUTPUT: 22:30:57 INFO - 2015-12-03 22:30:57,151 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.00 stddev:0.92 (1.3%) stddev-sans-first:0.87 22:30:57 INFO - 2015-12-03 22:30:57,151 DEBUG : BROWSER_OUTPUT: Values: 70.0 68.0 70.0 68.0 68.0 69.0 69.0 70.0 68.0 68.0 22:30:57 INFO - 2015-12-03 22:30:57,151 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:30:57 INFO - 2015-12-03 22:30:57,151 DEBUG : BROWSER_OUTPUT: 22:30:57 INFO - 2015-12-03 22:30:57,707 INFO : Browser exited with error code: 0 22:30:57 INFO - 2015-12-03 22:30:57,754 INFO : Completed test kraken (00:00:57) 22:30:57 INFO - 2015-12-03 22:30:57,754 INFO : Starting test v8_7 22:30:57 INFO - 2015-12-03 22:30:57,754 DEBUG : operating with platform_type : mac_ 22:30:57 INFO - 2015-12-03 22:30:57,754 INFO : Initialising browser for v8_7 test... 22:30:57 INFO - 2015-12-03 22:30:57,767 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/tmpl3BQ1I/profile http://localhost:49294/getInfo.html 22:31:00 INFO - 2015-12-03 22:31:00,312 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:31:00 INFO - 2015-12-03 22:31:00,312 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:31:00 INFO - 2015-12-03 22:31:00,312 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 22:31:00 INFO - 2015-12-03 22:31:00,312 DEBUG : BROWSER_OUTPUT: __metrics 22:31:00 INFO - 2015-12-03 22:31:00,909 INFO : Browser initialized. 22:31:00 INFO - 2015-12-03 22:31:00,909 INFO : Running cycle 1/1 for v8_7 test... 22:31:00 INFO - 2015-12-03 22:31:00,909 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/tmpl3BQ1I/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:31:12 INFO - 2015-12-03 22:31:12,742 DEBUG : BROWSER_OUTPUT: RSS: Main: 209739776 22:31:12 INFO - 2015-12-03 22:31:12,742 DEBUG : BROWSER_OUTPUT: 22:31:34 INFO - 2015-12-03 22:31:34,318 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49294/tests/v8_7/run.html (next: http://localhost:49294/tests/v8_7/run.html) 22:31:34 INFO - 2015-12-03 22:31:34,572 DEBUG : BROWSER_OUTPUT: RSS: Main: 226590720 22:31:34 INFO - 2015-12-03 22:31:34,572 DEBUG : BROWSER_OUTPUT: 22:31:34 INFO - 2015-12-03 22:31:34,572 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:31:34 INFO - 2015-12-03 22:31:34,572 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:31:34 INFO - 2015-12-03 22:31:34,572 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:31:34 INFO - 2015-12-03 22:31:34,572 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:31:34 INFO - 2015-12-03 22:31:34,573 DEBUG : BROWSER_OUTPUT: |0;Richards;166.22340425531914 22:31:34 INFO - 2015-12-03 22:31:34,573 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;188.64365214110546 22:31:34 INFO - 2015-12-03 22:31:34,573 DEBUG : BROWSER_OUTPUT: |2;Encrypt;324.25421530479895 22:31:34 INFO - 2015-12-03 22:31:34,573 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5837.209302325581 22:31:34 INFO - 2015-12-03 22:31:34,573 DEBUG : BROWSER_OUTPUT: |4;RayTrace;978.4735812133073 22:31:34 INFO - 2015-12-03 22:31:34,573 DEBUG : BROWSER_OUTPUT: |5;Earley;659.6306068601583 22:31:34 INFO - 2015-12-03 22:31:34,573 DEBUG : BROWSER_OUTPUT: |6;Boyer;12734.177215189873 22:31:34 INFO - 2015-12-03 22:31:34,573 DEBUG : BROWSER_OUTPUT: |7;RegExp;29171.428571428572 22:31:34 INFO - 2015-12-03 22:31:34,573 DEBUG : BROWSER_OUTPUT: |8;Splay;608.9588377723971 22:31:34 INFO - 2015-12-03 22:31:34,573 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;5803.468208092486 22:31:34 INFO - 2015-12-03 22:31:34,574 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:31:34 INFO - 2015-12-03 22:31:34,574 DEBUG : BROWSER_OUTPUT: __startTimestamp1449210694569__endTimestamp 22:31:34 INFO - 2015-12-03 22:31:34,574 DEBUG : BROWSER_OUTPUT: 22:31:34 INFO - 2015-12-03 22:31:34,574 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:31:34 INFO - 2015-12-03 22:31:34,574 DEBUG : BROWSER_OUTPUT: Number of tests: 10 22:31:34 INFO - 2015-12-03 22:31:34,574 DEBUG : BROWSER_OUTPUT: 22:31:34 INFO - 2015-12-03 22:31:34,574 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.22 Median:166.22 stddev:0.00 (0.0%) 22:31:34 INFO - 2015-12-03 22:31:34,574 DEBUG : BROWSER_OUTPUT: Values: 166.2 22:31:34 INFO - 2015-12-03 22:31:34,574 DEBUG : BROWSER_OUTPUT: 22:31:34 INFO - 2015-12-03 22:31:34,574 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:188.64 Median:188.64 stddev:0.00 (0.0%) 22:31:34 INFO - 2015-12-03 22:31:34,574 DEBUG : BROWSER_OUTPUT: Values: 188.6 22:31:34 INFO - 2015-12-03 22:31:34,575 DEBUG : BROWSER_OUTPUT: 22:31:34 INFO - 2015-12-03 22:31:34,575 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:324.25 Median:324.25 stddev:0.00 (0.0%) 22:31:34 INFO - 2015-12-03 22:31:34,575 DEBUG : BROWSER_OUTPUT: Values: 324.3 22:31:34 INFO - 2015-12-03 22:31:34,575 DEBUG : BROWSER_OUTPUT: 22:31:34 INFO - 2015-12-03 22:31:34,575 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5837.21 Median:5837.21 stddev:0.00 (0.0%) 22:31:34 INFO - 2015-12-03 22:31:34,575 DEBUG : BROWSER_OUTPUT: Values: 5837.2 22:31:34 INFO - 2015-12-03 22:31:34,575 DEBUG : BROWSER_OUTPUT: 22:31:34 INFO - 2015-12-03 22:31:34,576 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:978.47 Median:978.47 stddev:0.00 (0.0%) 22:31:34 INFO - 2015-12-03 22:31:34,576 DEBUG : BROWSER_OUTPUT: Values: 978.5 22:31:34 INFO - 2015-12-03 22:31:34,576 DEBUG : BROWSER_OUTPUT: 22:31:34 INFO - 2015-12-03 22:31:34,576 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:659.63 Median:659.63 stddev:0.00 (0.0%) 22:31:34 INFO - 2015-12-03 22:31:34,576 DEBUG : BROWSER_OUTPUT: Values: 659.6 22:31:34 INFO - 2015-12-03 22:31:34,576 DEBUG : BROWSER_OUTPUT: 22:31:34 INFO - 2015-12-03 22:31:34,576 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12734.18 Median:12734.18 stddev:0.00 (0.0%) 22:31:34 INFO - 2015-12-03 22:31:34,576 DEBUG : BROWSER_OUTPUT: Values: 12734.2 22:31:34 INFO - 2015-12-03 22:31:34,576 DEBUG : BROWSER_OUTPUT: 22:31:34 INFO - 2015-12-03 22:31:34,577 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:29171.43 Median:29171.43 stddev:0.00 (0.0%) 22:31:34 INFO - 2015-12-03 22:31:34,577 DEBUG : BROWSER_OUTPUT: Values: 29171.4 22:31:34 INFO - 2015-12-03 22:31:34,577 DEBUG : BROWSER_OUTPUT: 22:31:34 INFO - 2015-12-03 22:31:34,577 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:608.96 Median:608.96 stddev:0.00 (0.0%) 22:31:34 INFO - 2015-12-03 22:31:34,577 DEBUG : BROWSER_OUTPUT: Values: 609.0 22:31:34 INFO - 2015-12-03 22:31:34,577 DEBUG : BROWSER_OUTPUT: 22:31:34 INFO - 2015-12-03 22:31:34,577 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:5803.47 Median:5803.47 stddev:0.00 (0.0%) 22:31:34 INFO - 2015-12-03 22:31:34,577 DEBUG : BROWSER_OUTPUT: Values: 5803.5 22:31:34 INFO - 2015-12-03 22:31:34,578 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:31:34 INFO - 2015-12-03 22:31:34,578 DEBUG : BROWSER_OUTPUT: 22:31:35 INFO - 2015-12-03 22:31:35,124 INFO : Browser exited with error code: 0 22:31:35 INFO - 2015-12-03 22:31:35,143 INFO : Completed test v8_7 (00:00:37) 22:31:35 INFO - 2015-12-03 22:31:35,167 INFO : Completed test suite (00:20:04) 22:31:35 INFO - 2015-12-03 22:31:35,167 DEBUG : Working with test: dromaeo_css 22:31:35 INFO - 2015-12-03 22:31:35,167 DEBUG : Generating results file: dromaeo_css 22:31:35 INFO - 2015-12-03 22:31:35,168 DEBUG : Working with test: kraken 22:31:35 INFO - 2015-12-03 22:31:35,168 DEBUG : Generating results file: kraken 22:31:35 INFO - 2015-12-03 22:31:35,168 INFO : javascript benchmark 22:31:35 INFO - 2015-12-03 22:31:35,168 DEBUG : Working with test: v8_7 22:31:35 INFO - 2015-12-03 22:31:35,168 DEBUG : Generating results file: v8_7 22:31:35 INFO - 2015-12-03 22:31:35,168 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:31:35 INFO - 2015-12-03 22:31:35,235 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,57]] 22:31:35 INFO - 2015-12-03 22:31:35,235 DEBUG : process_Request line: dromaeo_css 6894.74 graph.html#tests=[[72,52,57]] 22:31:35 INFO - 2015-12-03 22:31:35,236 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:31:35 INFO - 2015-12-03 22:31:35,262 DEBUG : process_Request line: kraken 1503.40 graph.html#tests=[[232,52,57]] 22:31:35 INFO - 2015-12-03 22:31:35,262 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:31:35 INFO - 2015-12-03 22:31:35,294 DEBUG : process_Request line: v8_7 20396.96 graph.html#tests=[[230,52,57]] 22:31:35 INFO - 2015-12-03 22:31:35,295 INFO : javascript benchmark 22:31:35 INFO - 2015-12-03 22:31:35,297 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [352.5839509378932, 360.1644185489665, 364.65357909985505, 365.68916421042115, 367.92641471705656, 15486.457973970913, 17763.20065597048, 18159.54601134972, 19066.904665476686, 19752.604947901033, 17928.462146135604, 18075.0, 18330.0, 18364.0, 18569.071546422692, 5418.647787893784, 5522.144067669517, 5537.640053396516, 5584.078627026536, 5584.553235741151, 4135.834566617346, 5437.211604317391, 5953.910691339612, 6112.724927378256, 6173.228346456693, 5999.880002399949, 6044.3955604439425, 6058.182145410379, 6107.083937409379, 6107.969460152693, 6022.397760223987, 6035.064564992434, 6076.817695469143, 6116.541259405541, 6123.295820980555, 4090.365993271018, 5246.947530524684, 5281.86795330116, 5304.602154838402, 5330.680159190461, 13594.184348938996, 13785.931070344684, 13798.0, 13829.446822127104, 13911.304434778322, 1935.854810889189, 1940.2433051110079, 2008.9598208035904, 2106.8419868509923, 2139.1871088986086, 10089.798204035878, 10116.0, 10196.133328667072, 10289.12542433894, 10498.220640569361, 1624.6831867785786, 1636.8444997725317, 1652.9256183471653, 1700.4218565687725, 1706.436875830973, 60630.696846515486, 61520.384796152364, 62355.6882215586, 63974.0, 65106.0, 6956.965215173892, 6965.407940325028, 6984.650767461607, 7030.226675065739, 7033.718651253995, 8050.557219352875, 8060.758177254692, 8068.677252909818, 8079.555624440594, 8100.797480062928, 5612.961602103543, 5718.428157184248, 5867.823965281048, 5890.116482527569, 5915.881682366328, 6229.221347331583, 6238.1266622672865, 6251.78118765841, 6270.7491700331475, 6273.654948977759, 3098.752099832008, 3141.7800753947004, 3142.214446388403, 3147.3390587976323, 3153.0856051744736, 3425.5718035245595, 3465.4455287153933, 3544.3442963051916, 3667.6796353312784, 3718.2377612589353, 459.74254417526294, 461.52462963148014, 472.6077355794682, 476.4378033920008, 478.93198168085365, 11938.582149624895, 12308.50765969369, 12341.814872776915, 12476.75046499065, 12581.622551323475, 481.3573878871745, 487.89998050399583, 491.5084915084915, 492.86938961175315, 515.8993996170785, 6679.4990375721045, 6839.452843772487, 6883.586984780929, 6899.793006209822, 6940.09778728762, 613825.0, 628387.0, 636790.0, 636837.0, 645592.0, 75853.0, 76702.0, 76720.0, 77020.61489692515, 77262.22737772662, 523.7093413155659, 524.2372348233312, 524.3105316508779, 525.519149977766, 525.8580183350474, 11530.250533715282, 11544.769104618028, 11678.70803229926, 11824.349660768741, 11890.643280701594, 36284.0, 36471.0, 37096.258074838894, 37295.0, 38042.23915521729, 46717.76641116773, 48256.276155858395, 48938.75530622324, 49598.25602615892, 49715.75142124266, 6578.440832529289, 6701.731930722716, 6706.128203333536, 6707.564008339637, 6789.762358317435, 11898.643040708792, 12209.328486933304, 12255.816162757388, 12387.07096967713, 12612.621621351374, 10297.9485102574, 10390.012948769854, 10550.103241224582, 10616.309939853885, 10706.411147386969, 10178.440185789557, 10307.587696492057, 10505.894941050798, 10685.839712404164, 10715.089217416607, 10839.403832788958, 10931.344119352865, 10944.835827462435, 11076.5569377224, 11097.33415995043, 6683.565568238049, 6706.0, 6777.6272305023695, 6783.525153239226, 6803.965980170067, 10917.290376125526, 11061.336319820837, 11124.666260012213, 11163.106951443702, 11178.27341222818], "dojo.html": [3168.8732450701964, 3185.267388500646, 3219.2112932331584, 3226.403115423647, 3229.0635715642466, 5418.729063546826, 5425.2404663347115, 5450.373207081187, 5458.317710286215, 5472.34331880175, 5365.436629153932, 5371.355437347514, 5395.946040539593, 5397.055515284819, 5485.561155107592, 4922.384701912261, 4964.801407943678, 5013.5989120870245, 5033.043721692885, 5036.949630503703, 4811.566958973692, 4875.488073752258, 4943.9752801235945, 4953.405591329046, 4997.025580011899, 4996.400431948153, 4999.500049994989, 5002.149634562115, 5006.474320196382, 5038.6724862883975, 4983.800647974095, 5010.173321401964, 5018.021485810268, 5059.6458247922665, 5087.720175390389, 4843.830465933711, 4855.344528488644, 4893.486183950705, 4950.702957822542, 5017.84946451607, 5114.488551144893, 5243.501867322599, 5300.443453437372, 5356.598255130881, 5421.105517589593, 5544.889102217973, 5723.141528770676, 5747.655140691572, 5751.022326204514, 5754.539636829044, 5691.146328050784, 5749.223854779593, 5757.539396848242, 5762.423757624246, 5784.942150578525, 5418.512333889968, 5420.566354691655, 5435.021696094701, 5453.400125986138, 5454.8909021819345, 5747.885042299215, 5894.941050589439, 5927.525797936155, 5928.584999050111, 5930.466258036798, 5574.777008919679, 5631.042722737145, 5632.577556683265, 5653.406392328829, 5675.886482270332, 5673.77304907799, 5738.856528586819, 5754.942450575524, 5759.539236861041, 5760.971195143998, 5565.276514053147, 5625.549956003591, 5658.91511627326, 5674.319081710139, 5685.516731077904, 5733.483986441241, 5738.971305143447, 5745.9425405745405, 5747.827565173052, 5750.4249575042995, 4449.132419178294, 4460.910781784346, 4478.798454069574, 4489.708168969007, 4500.797464114123, 3947.2500224957166, 3962.881113566598, 4036.4348991141264, 4044.4742183515955, 4112.157007813391, 5439.265699130646, 5501.944980550144, 5506.03644362235, 5518.834434966958, 5519.503244707996, 5918.526517878559, 5924.348321684612, 5934.43622855828, 5938.49522790559, 5951.226340575698, 5256.342957130359, 5375.220593014069, 5393.83818485446, 5505.339359276913, 5515.117581186991, 5068.037072956126, 5070.974645126751, 5072.289879416885, 5075.11185542536, 5090.26191202281, 5862.12068189775, 5864.706764661835, 5865.677387743715, 5901.144334071536, 5915.733791979371, 5591.412901645269, 5673.0, 5676.9432305678065, 5697.544196464356, 5719.3136823581435, 5828.6211396259105, 5937.465628093492, 5947.0, 5952.077427998667, 5953.791617293374, 5551.417101204315, 5791.391903850035, 5795.420457954171, 5800.535957123336, 5817.127430885232, 5762.279715035621, 5782.363939966516, 5821.98115329824, 5824.650520968756, 5867.090600956859, 5651.802186923603, 5658.03813351723, 5663.66018038919, 5676.9432305678065, 5713.714314284186, 5460.071787796005, 5476.315460567429, 5606.187102870143, 5670.546356291405, 5671.234383358194, 5437.53186639613, 5439.891202176013, 5455.208994695826, 5473.425290344457, 5494.697791621339, 5548.889022219614, 5624.493795558419, 5626.521745651502, 5637.577181711306, 5642.971785141048, 5403.783848646168, 5474.343078830566, 5523.861903452445, 5524.75138618755, 5577.888442231214], "mootools.html": [1402.5511836212415, 1414.9858501414983, 1586.2544604036113, 1804.3143605429937, 1838.7885393179783, 6970.930290697092, 7046.013558101857, 7634.847303053943, 7817.687292508307, 7917.722879699211, 7404.259574042607, 7550.6979720811105, 7569.053868266466, 7573.924260757391, 7640.96179519103, 2271.931842044737, 2311.202635090891, 2315.4558678710573, 2316.8609883406966, 2327.278543651465, 2290.828187885907, 2337.801286890616, 2340.426595484109, 2342.367560758594, 2355.7879790818824, 2251.0, 2265.886705664718, 2280.794728474437, 2294.8640422990643, 2297.6208925527267, 2234.4748983988748, 2274.363178310076, 2295.414669259345, 2299.6435552489475, 2305.2738387408, 2305.377548062014, 2327.2320134355623, 2327.325075728037, 2337.1936681844736, 2349.025154560872, 7686.116096648845, 7747.109082455533, 7747.690092396354, 7838.647260873217, 7842.215778422112, 4412.183746006966, 4732.621390288768, 4804.807807687688, 4822.903541929177, 4864.124457597631, 2495.36368226103, 2936.5595160725848, 2940.4119176164854, 2946.3370741583185, 2988.5517172424093, 881.951492667903, 890.8663700444985, 892.8392889279927, 907.9046700096461, 911.7766147293955, 9792.706218813375, 9862.802743945082, 9864.062914023085, 9894.257930655229, 9954.153896918771, 4281.357796330575, 4323.913521729548, 4335.761533115646, 4356.738595684205, 4424.756638384855, 9026.548672566345, 9026.86459703105, 9046.954765226263, 9159.496227707406, 9171.678991235274, 4920.21276595743, 4940.802367905316, 4957.801687932514, 4962.776675049631, 4981.775820088104, 4491.056878055645, 4501.414816073955, 4501.932471012938, 4540.091981603627, 4544.97727511367, 3560.0241865764233, 3601.2797440511476, 3608.4587311903424, 3637.927241455156, 3655.1593133579427, 1158.3339579741682, 1166.632510759108, 1170.9414529273502, 1173.4543437301695, 1175.8588969323564, 1064.882862885082, 1071.1698433713934, 1075.1828610256262, 1188.8276199950958, 1214.6173955204083, 7306.8173295666975, 7334.0, 7366.484346095722, 7388.630568471555, 7415.517991330654, 468.6180762678474, 471.65569134531984, 473.3349643750536, 1248.6316536621719, 1288.7229245712217, 5684.147377893349, 5828.708564571754, 5902.380250073767, 5941.851453713692, 6009.939900601025, 8868.822623547492, 9074.546272686339, 9131.452112873249, 9134.908650913405, 9167.358284919992, 8967.282617390592, 9079.273658107335, 9109.407888487227, 9170.266378689688, 9201.49391783445, 7138.107736532934, 7310.305520975498, 7310.96344518274, 7323.487355885037, 7409.851802963911, 7068.29317068289, 7183.748568800067, 7186.820329491805, 7213.458990575623, 7292.34368906801, 7971.362291016821, 8137.75586732399, 8180.9590952044855, 8278.296344810758, 8286.544240066854, 8260.958695206726, 8268.131846156308, 8274.23167848692, 8349.499030058216, 8382.790430239293, 6989.0, 7079.929200707927, 7081.610511421921, 7098.25468325839, 7145.356917877416, 7491.10106787189, 7547.245275472409, 7556.8488630228185, 7557.773266802004, 7610.277023682741, 6819.522633415613, 6872.450203983769, 7021.122359705037, 7121.643917804193, 7218.205997340184, 6771.370363175554, 6871.828204294733, 6947.513674042769, 6967.1291088613925, 6999.965000174967, 7070.39901608369, 7074.0, 7086.645667716697, 7104.147502299757, 7157.141143062866, 6425.45383642377, 6442.549021568445, 6442.90335644975, 6486.286508484157, 6519.282878883414, 6530.934690653033, 6540.803775886731, 6543.083968244355, 6545.37818907203, 6575.27671956094], "ext.html": [542.6140787120701, 571.2687759667627, 581.2356750872601, 591.9792807251746, 592.8103007037749, 40265.3960190597, 40911.18177636446, 41130.38304425436, 41417.96455088621, 41627.58372416275, 44441.0, 44798.77600611992, 44818.77590612051, 44999.0, 45453.0, 9308.720738377859, 9506.0, 9517.048295170462, 9531.428114313128, 9630.614775408976, 9245.72262832116, 9331.626734930594, 9349.532523373839, 9363.016883227265, 9435.38669986452, 9477.241820654366, 9483.668071617494, 9505.906820715638, 9526.28552858535, 9602.231821454267, 9321.62713491463, 9388.061193880625, 9438.528073596293, 9448.81102377952, 9520.143187113194, 9144.45133291998, 9268.073192680746, 9292.767680807967, 9306.348555601111, 9347.252219822398, 41275.793621032004, 41642.79178604088, 42159.36760948588, 42260.36609450861, 42289.0, 2979.5679626454044, 3152.747780177603, 3218.452863013293, 3435.914102147441, 3675.4854320395166, 28601.570976435163, 29229.415411691858, 29288.121356359345, 29866.10401687953, 30019.699803002128, 2436.780689737932, 2449.09383528094, 2504.423982484039, 2535.378832186108, 2574.4979728952862, 283891.0, 289439.0, 290499.0, 291081.0, 291185.0, 61703.0, 63045.369546304864, 65118.0, 65511.0, 69637.65181174062, 66191.33808661948, 66599.0, 66885.0, 67134.66432667903, 67250.0, 18469.53826154357, 18653.44039678812, 18655.720164197548, 18680.0, 18702.0, 11971.10216733731, 11982.880171198176, 11985.64043078709, 12008.579699710468, 12182.512699492097, 21613.02741376642, 22045.889770551046, 22086.88956555207, 22102.336929892128, 22203.44491387696, 9174.908250917539, 9433.292503062297, 9445.763855903657, 9463.0, 9480.099390557885, 915.3866909170871, 995.7908839143716, 1028.1517747857897, 1052.3580615824342, 1157.5935238685038, 29718.851405742833, 29821.254468638024, 29858.701412986025, 30215.546766798514, 30223.395532089235, 919.6321471411355, 1070.2668671959732, 1087.499750114956, 1153.2042890405594, 1262.9557965471165, 12752.80870786939, 14624.488142914946, 15177.089374637337, 15275.770863437057, 15513.767293490606, 422898.0, 430115.0, 430773.0, 431024.0, 432344.0, 61150.0, 61280.38719612836, 61368.38631613627, 61494.385056148865, 61997.0, 1459.7226526959844, 1467.2663668165917, 1468.7282852672076, 1475.0, 1478.719043381754, 29639.703602963695, 30366.848165759915, 33061.50407743934, 33513.83243083769, 33561.0, 54868.72565637306, 55446.44553554413, 55603.165952511554, 55751.442485574626, 56006.719966399905, 310019.0, 313396.0, 314240.43038279127, 314751.0, 315931.0, 44129.33805992977, 44142.558574413844, 44554.77722611496, 44587.0, 44737.776311118236, 45659.77170114128, 46012.76993615011, 46079.3088103672, 46538.30192547047, 47017.0, 36764.44853327256, 38512.22975540529, 38715.612843871204, 39062.4140637885, 39836.80081599573, 38205.80897095497, 38231.808840955615, 38391.0, 38590.4211436823, 38745.2250954985, 41635.16729665329, 41750.16499669929, 41782.164356712085, 42653.57346426496, 42760.78619606882, 32827.34345313128, 33145.0, 35448.82275588605, 35717.0, 36859.447108293934, 25846.0, 25980.8700956494, 27202.183934481996, 27476.17571472859, 27676.861615691792], "prototype.html": [338.2153404102482, 339.0, 340.68146283225184, 344.84137296843465, 349.3240579478708, 6234.688265586725, 6340.302566717657, 6374.3944325289085, 6380.649064301461, 6429.228492580891, 6195.907061394083, 6252.499800015999, 6264.185655864742, 6285.654289014114, 6333.5883167594075, 4809.086273608021, 4811.08589368019, 4826.638002149835, 4840.782164802592, 4858.611311095122, 4805.279208118793, 4822.71063736177, 4858.222684370501, 4864.294677271793, 4868.367112275399, 4620.260758278676, 4772.522747725217, 4781.354517140194, 4832.0, 4844.20070688336, 4759.762011899408, 4796.472388037348, 4833.806647734086, 4845.612351011928, 4871.098846713369, 4168.24971505129, 4174.478190226222, 4176.728512646669, 4188.643965262956, 4211.473565804275, 6114.541409394314, 6120.081987701836, 6153.569250152491, 6161.075838624198, 6180.258368995749, 5249.842504724865, 5328.49379308965, 5345.679259244419, 5356.330458692663, 5418.4039755626845, 6491.123698300717, 6504.317046710122, 6507.479401647857, 6571.112899758519, 6582.144321238256, 4410.691251612388, 4416.028473735773, 4422.09347083847, 4452.753229095858, 4460.576245256695, 6692.83267918306, 6756.0, 6805.489588280899, 6824.283450237704, 6922.238553759083, 4489.461264648263, 4504.054148628759, 4512.210363186429, 4516.07420478801, 4563.794629241692, 4598.954010459853, 4604.539546045368, 4614.561616646413, 4629.189891768994, 4644.953550464452, 5367.677939323653, 5373.570114390917, 5391.191321301758, 5396.64921780083, 5419.810306639249, 6441.935580644134, 6537.607743535403, 6566.606003639797, 6634.668266586651, 6656.667166641649, 1626.3738460692718, 1635.1824087956022, 1657.767912492252, 1661.2856471717278, 1662.9750553741703, 1065.9680209593726, 1069.5828626835541, 1069.8876617955002, 1071.908887744535, 1083.0793825248477, 6189.226346706661, 6212.47193988516, 6216.658083805343, 6263.498920086473, 6291.6854157291955, 6785.796426107225, 6787.151606049244, 6820.908654615337, 6851.897221541681, 6898.758543450955, 6137.9079313810325, 6287.654179020198, 6293.622382657055, 6353.682315884187, 6386.712597933104, 3774.9622503774613, 3793.3740932745786, 3794.165283637595, 3797.240551889633, 3851.0, 6948.166220053626, 6948.478864085214, 6995.580265184105, 7011.1586609607175, 7032.367086962198, 6840.760573379908, 7000.474964377692, 7016.684249208798, 7063.364297213276, 7112.502124851314, 6905.620190889449, 6912.654367281616, 6948.305169483112, 6981.685824137926, 7001.859962800715, 6832.145981752281, 6847.897281540881, 6910.8617827644175, 6925.792226233221, 6936.237013928565, 6581.506387020897, 6696.698648560729, 6701.363370479797, 6716.1604799400075, 6761.560498567577, 6904.620245886324, 6918.584884906721, 6945.0971373721095, 6964.233934267125, 7014.228434872262, 4546.977265113654, 4565.3608494811415, 4569.268916973401, 4587.931181032221, 4588.7246765194195, 6641.50188735837, 6663.200415950117, 6814.2163651180745, 6854.246032936473, 6904.240533541407, 6645.235797883305, 6646.667666616747, 6672.866542669217, 6681.064650948774, 6754.96622516904, 6633.734650614115, 6638.701258443285, 6644.069830223676, 6644.867102658017, 6729.0915726376315, 6334.90497642545, 6484.059811327425, 6565.409113179646, 6578.276389597237, 6587.374199451045, 6652.334766523502, 6722.0, 6729.091572637827, 6766.391024807791, 6830.931690683228, 6560.179977502812, 6567.343265673395, 6584.8353791155605, 6668.933310666831, 6672.466202703869], "yui.html": [759.5480688990049, 767.9001729775129, 772.5094564951257, 773.6054612147803, 802.3982013489882, 14580.0, 14843.480478183266, 14928.999999999987, 14983.17592532413, 15123.470678526253, 13775.51785687501, 13777.448902043907, 13786.03497755155, 13792.0, 13874.514391996283, 728.5628622826289, 745.3180339988903, 899.2176806178634, 908.9818203635923, 943.6319835264252, 905.3345790843724, 911.9589618467152, 918.1828172926101, 921.4379228670506, 925.9490728009956, 968.0851595242499, 977.1645243316933, 981.2150279776187, 986.6990567876795, 991.7124034030159, 972.027972027972, 976.9267304952157, 979.0698836105693, 986.013986013986, 988.2489308125804, 726.3680597879878, 726.8400951790597, 727.2836256287552, 732.0081289852227, 733.8568979049088, 14142.858571414257, 14216.360263788154, 14228.359723812453, 14270.286485675779, 14388.424463021467, 11856.229345092628, 12126.27242365461, 12261.325627090506, 12511.74976500474, 12563.685907852285, 9260.536973151315, 9264.72205833826, 9420.717378478657, 9602.90397096034, 10015.44915029673, 3403.676650718178, 3403.795772253648, 3428.142964258935, 3434.690877820983, 3439.105832483547, 49917.0, 49944.75027624875, 49997.500024999645, 49998.25002624963, 50066.249006264574, 7293.197748247689, 9367.437953722798, 9458.621655133855, 9511.952440237894, 9558.426494410218, 11765.588204412805, 11769.176157669051, 11886.108541859396, 11903.821442678367, 11910.583129590595, 5766.394528574523, 5877.94122058774, 6059.606125601822, 6376.107344971708, 6530.412262896362, 3999.5400528938962, 4021.4168945503325, 4050.3924411338535, 4071.3485842265095, 4096.91806163881, 2827.872745726447, 2834.376437183816, 2835.9858200709277, 2847.4874522586133, 2870.167651381076, 414.2708832454901, 416.0389500254422, 418.76549132485906, 420.7517564636879, 422.2399680574953, 470.6893450322839, 472.9645276604268, 479.8320587794244, 586.2642383808293, 604.0787798607072, 8223.177682231848, 8225.259726624512, 8282.71010514629, 8418.747437576883, 8432.325413966868, 502.92204708270276, 514.6989011428282, 628.5474458389951, 638.8339031851752, 641.4579680170249, 3663.9633603664156, 3945.309570825094, 3996.220736956324, 4083.448734420815, 4105.712600118023, 62931.37068629346, 63746.68126659337, 63957.0, 64235.678821606525, 64335.0, 53559.732201338746, 54383.72808135934, 54569.72715136479, 54772.178417323776, 54782.726086369315, 48239.27641085457, 48889.75555122201, 49094.75452622714, 49129.75435122802, 49735.0, 7044.718211271492, 7164.570125792469, 8209.0, 8378.413511054412, 8455.534945578052, 35252.118697032776, 35567.64432355747, 35932.0, 37808.0, 37857.24285514219, 43529.56470435255, 44635.330470042325, 47163.528364715916, 47957.28064079111, 50200.0, 7725.845483090419, 8014.118446970945, 8034.718784842503, 8042.276195142465, 8258.339332853237, 11223.270487418291, 11634.70913227176, 11840.881591184323, 11862.644120676394, 12048.75902481928, 10468.371897686164, 10613.0, 10763.623273185402, 11212.83180752273, 11598.130140239684, 10810.837837432602, 10832.5125369357, 10891.237613366988, 10948.178886583379, 11061.889381106408, 10341.63804266847, 10451.738706532398, 10495.52770125331, 10545.156387488829, 10604.416757078126, 9458.148766611039, 9677.22582193437, 9720.611175553182, 9953.552090156105, 9996.400215987063, 9542.188913942115, 9590.424574525272, 9636.22910167171, 9687.0, 9738.074882886114]}, "summary": {"suite": 6894.737780242984, "subtests": {"jquery.html": {"filtered": 7530.500657812561, "value": 7530.500657812561}, "dojo.html": {"filtered": 5327.781548105526, "value": 5327.781548105526}, "mootools.html": {"filtered": 4426.551005745619, "value": 4426.551005745619}, "ext.html": {"filtered": 19925.25924741512, "value": 19925.25924741512}, "prototype.html": {"filtered": 4967.579487707927, "value": 4967.579487707927}, "yui.html": {"filtered": 6110.578639945664, "value": 6110.578639945664}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0049.e"}, "testrun": {"date": 1449209490, "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": "44.0a2", "id": "20151203200703", "branch": "Mozilla-Aurora", "revision": "858b1b930b16a5c46634e3dad2650c517e150cb0"}}, {"talos_counters": {}, "results": {"audio-dft": [163.0, 165.0, 165.0, 165.0, 166.0, 166.0, 167.0, 168.0, 166.0, 166.0], "ai-astar": [114.0, 102.0, 110.0, 109.0, 112.0, 121.0, 110.0, 111.0, 109.0, 109.0], "imaging-gaussian-blur": [121.0, 116.0, 120.0, 115.0, 115.0, 115.0, 115.0, 115.0, 115.0, 114.0], "audio-beat-detection": [152.0, 127.0, 157.0, 150.0, 126.0, 147.0, 127.0, 158.0, 148.0, 125.0], "json-stringify-tinderbox": [68.0, 69.0, 68.0, 67.0, 67.0, 67.0, 67.0, 67.0, 69.0, 68.0], "stanford-crypto-pbkdf2": [146.0, 143.0, 146.0, 144.0, 146.0, 146.0, 148.0, 147.0, 149.0, 146.0], "json-parse-financial": [61.0, 66.0, 66.0, 66.0, 66.0, 67.0, 66.0, 73.0, 61.0, 61.0], "stanford-crypto-sha256-iterative": [70.0, 68.0, 70.0, 68.0, 68.0, 69.0, 69.0, 70.0, 68.0, 68.0], "audio-fft": [72.0, 75.0, 83.0, 115.0, 66.0, 66.0, 70.0, 71.0, 116.0, 65.0], "imaging-darkroom": [126.0, 125.0, 125.0, 125.0, 125.0, 125.0, 126.0, 126.0, 126.0, 135.0], "stanford-crypto-ccm": [119.0, 128.0, 120.0, 118.0, 119.0, 122.0, 118.0, 125.0, 122.0, 121.0], "audio-oscillator": [89.0, 90.0, 129.0, 86.0, 88.0, 89.0, 132.0, 89.0, 89.0, 132.0], "stanford-crypto-aes": [84.0, 83.0, 83.0, 84.0, 86.0, 83.0, 81.0, 84.0, 84.0, 87.0], "imaging-desaturate": [104.0, 104.0, 105.0, 103.0, 106.0, 104.0, 114.0, 113.0, 121.0, 112.0]}, "summary": {"suite": 1503.3999999999999, "subtests": {"audio-fft": {"filtered": 79.9, "value": 79.9}, "stanford-crypto-pbkdf2": {"filtered": 146.1, "value": 146.1}, "audio-beat-detection": {"filtered": 141.7, "value": 141.7}, "stanford-crypto-ccm": {"filtered": 121.2, "value": 121.2}, "imaging-darkroom": {"filtered": 126.4, "value": 126.4}, "json-parse-financial": {"filtered": 65.3, "value": 65.3}, "audio-oscillator": {"filtered": 101.3, "value": 101.3}, "ai-astar": {"filtered": 110.7, "value": 110.7}, "audio-dft": {"filtered": 165.7, "value": 165.7}, "stanford-crypto-sha256-iterative": {"filtered": 68.8, "value": 68.8}, "json-stringify-tinderbox": {"filtered": 67.7, "value": 67.7}, "imaging-gaussian-blur": {"filtered": 116.1, "value": 116.1}, "stanford-crypto-aes": {"filtered": 83.9, "value": 83.9}, "imaging-desaturate": {"filtered": 108.6, "value": 108.6}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0049.e"}, "testrun": {"date": 1449209490, "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": "44.0a2", "id": "20151203200703", "branch": "Mozilla-Aurora", "revision": "858b1b930b16a5c46634e3dad2650c517e150cb0"}}, {"talos_counters": {}, "results": {"DeltaBlue": [188.64365214110546], "Encrypt": [324.25421530479895], "NavierStokes": [5803.468208092486], "Decrypt": [5837.209302325581], "Splay": [608.9588377723971], "Richards": [166.22340425531914], "RegExp": [29171.428571428572], "Earley": [659.6306068601583], "Boyer": [12734.177215189873], "RayTrace": [978.4735812133073]}, "summary": {"suite": 20396.95587210739, "subtests": {"DeltaBlue": {"filtered": 350.49151800000004, "value": 350.49151800000004}, "Encrypt": {"filtered": 820.9022040000002, "value": 820.9022040000002}, "NavierStokes": {"filtered": 255.70916334661337, "value": 255.70916334661337}, "Decrypt": {"filtered": 45.600729083665335, "value": 45.600729083665335}, "Splay": {"filtered": 133.82021073558644, "value": 133.82021073558644}, "RegExp": {"filtered": 31.228672869735533, "value": 31.228672869735533}, "Richards": {"filtered": 212.37683199999995, "value": 212.37683199999995}, "Earley": {"filtered": 1010.3579079999996, "value": 1010.3579079999996}, "Boyer": {"filtered": 52.33655765407553, "value": 52.33655765407553}, "RayTrace": {"filtered": 756.2687579999996, "value": 756.2687579999996}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0049.e"}, "testrun": {"date": 1449209490, "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": "44.0a2", "id": "20151203200703", "branch": "Mozilla-Aurora", "revision": "858b1b930b16a5c46634e3dad2650c517e150cb0"}}] 22:31:35 INFO - RETURN: dromaeo_css: 6894.74 22:31:35 INFO - RETURN: kraken: 1503.40 22:31:35 INFO - RETURN: v8_7: 20396.96 22:31:35 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,57]]", "result": "20396.96"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,57]]", "result": "1503.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,57]]", "result": "6894.74"}}} 22:31:35 INFO - Return code: 0 22:31:35 INFO - # TBPL SUCCESS # 22:31:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:31:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:31:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:31:35 INFO - 2015-12-03 22:31:35.422 screenresolution[1677:10801] starting screenresolution argv=screenresolution get 22:31:35 INFO - 2015-12-03 22:31:35.426 screenresolution[1677:10801] Display 0: 1600x1200x32@60 22:31:35 INFO - 2015-12-03 22:31:35.432 screenresolution[1678:10804] starting screenresolution argv=screenresolution list 22:31:35 INFO - Available Modes on Display 0 22:31:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:31:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:31:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:31:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:31:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:31:35 INFO - Intel HD Graphics 3000: 22:31:35 INFO - Chipset Model: Intel HD Graphics 3000 22:31:35 INFO - Type: GPU 22:31:35 INFO - Bus: Built-In 22:31:35 INFO - VRAM (Total): 512 MB 22:31:35 INFO - VRAM (Dynamic, Max): 10 22:31:35 INFO - Vendor: Intel (0x8086) 22:31:35 INFO - Device ID: 0x0116 22:31:35 INFO - Revision ID: 0x0009 22:31:35 INFO - Displays: 22:31:35 INFO - Display: 22:31:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:31:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:31:35 INFO - Display Serial Number: 1600x1200 60 22:31:35 INFO - Main Display: Yes 22:31:35 INFO - Mirror: Off 22:31:35 INFO - Online: Yes 22:31:35 INFO - Rotation: Supported 22:31:35 INFO - Return code: 0 22:31:35 INFO - Running post-action listener: _resource_record_post_action 22:31:35 INFO - Running post-run listener: _resource_record_post_run 22:31:36 INFO - Total resource usage - Wall time: 1244s; CPU: 30.0%; Read bytes: 39834624; Write bytes: 689240064; Read time: 4963; Write time: 64405 22:31:36 INFO - install - Wall time: 38s; CPU: 30.0%; Read bytes: 335925760; Write bytes: 337592320; Read time: 32532; Write time: 8151 22:31:36 INFO - run-tests - Wall time: 1206s; CPU: 30.0%; Read bytes: 38310912; Write bytes: 341383168; Read time: 4339; Write time: 54526 22:31:36 INFO - Running post-run listener: _upload_blobber_files 22:31:36 INFO - Blob upload gear active. 22:31:36 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 22:31:36 INFO - Copying logs to upload dir... 22:31:36 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1300.332722 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 40 secs) (at 2015-12-03 22:31:36.846371) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-03 22:31:36.850030) ========= 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.6lR4A4aZB5/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.awyCeVUYhu/Listeners TMPDIR=/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/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/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010142 build_url: 'https://queue.taskcluster.net/v1/task/snPNM1ORRSKG_-NKNZS_dg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-03 22:31:36.872068) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 22:31:36.872389) ========= 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.6lR4A4aZB5/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.awyCeVUYhu/Listeners TMPDIR=/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/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.005477 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 22:31:36.924334) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 22:31:36.925068) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 22:31:36.925950) ========= ========= Total master_lag: 0.25 =========