builder: mozilla-aurora_yosemite_test-dromaeojs slave: t-yosemite-r5-0032 starttime: 1448556108.14 results: success (0) buildid: 20151126064410 builduid: a5dbfb4cef6b42c5aaae83f695e1111d revision: 1624a69d46d7d711c6a3abfdfb604989baf70ac9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-26 08:41:48.142935) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-26 08:41:48.143358) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-26 08:41:48.143743) ========= 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.nV0LTZUh3g/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.hvuQ0HU8O2/Listeners TMPDIR=/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/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.005361 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-26 08:41:48.175256) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-26 08:41:48.175711) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-26 08:41:48.188781) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 08:41:48.189112) ========= 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.nV0LTZUh3g/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.hvuQ0HU8O2/Listeners TMPDIR=/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/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.005274 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 08:41:48.237373) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-26 08:41:48.240717) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-26 08:41:48.241080) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 08:41:48.241355) ========= 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.nV0LTZUh3g/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.hvuQ0HU8O2/Listeners TMPDIR=/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False --2015-11-26 08:41:48-- 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, 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-11-26 08:41:48 (1.13 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.408377 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 08:41:48.662304) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 08:41:48.662717) ========= 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.nV0LTZUh3g/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.hvuQ0HU8O2/Listeners TMPDIR=/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/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.019509 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 08:41:48.716788) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 08:41:48.717352) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1624a69d46d7d711c6a3abfdfb604989baf70ac9 --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 1624a69d46d7d711c6a3abfdfb604989baf70ac9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nV0LTZUh3g/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.hvuQ0HU8O2/Listeners TMPDIR=/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 2015-11-26 08:41:48,793 truncating revision to first 12 chars 2015-11-26 08:41:48,794 Setting DEBUG logging. 2015-11-26 08:41:48,794 attempt 1/10 2015-11-26 08:41:48,794 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1624a69d46d7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-26 08:41:49,060 unpacking tar archive at: mozilla-aurora-1624a69d46d7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.534633 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 08:41:49.268071) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-26 08:41:49.268406) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-26 08:41:49.276171) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-26 08:41:49.276460) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-26 08:41:49.276853) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2015-11-26 08:41:49.277157) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.nV0LTZUh3g/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.hvuQ0HU8O2/Listeners TMPDIR=/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/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 08:41:49 INFO - MultiFileLogger online at 20151126 08:41:49 in /builds/slave/test 08:41:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 08:41:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:41:49 INFO - {'append_to_log': False, 08:41:49 INFO - 'base_work_dir': '/builds/slave/test', 08:41:49 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:41:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:41:49 INFO - 'branch': 'Mozilla-Aurora', 08:41:49 INFO - 'buildbot_json_path': 'buildprops.json', 08:41:49 INFO - 'config_files': ('talos/mac_config.py',), 08:41:49 INFO - 'default_actions': ('clobber', 08:41:49 INFO - 'read-buildbot-config', 08:41:49 INFO - 'download-and-extract', 08:41:49 INFO - 'populate-webroot', 08:41:49 INFO - 'create-virtualenv', 08:41:49 INFO - 'install', 08:41:49 INFO - 'run-tests'), 08:41:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:41:49 INFO - 'download_minidump_stackwalk': True, 08:41:49 INFO - 'download_symbols': 'ondemand', 08:41:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:41:49 INFO - 'tooltool.py': '/tools/tooltool.py', 08:41:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:41:49 INFO - '/tools/misc-python/virtualenv.py')}, 08:41:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:41:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:41:49 INFO - 'installer_path': 'installer.exe', 08:41:49 INFO - 'log_level': 'info', 08:41:49 INFO - 'log_name': 'talos', 08:41:49 INFO - 'log_to_console': True, 08:41:49 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:41:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:41:49 INFO - 'opt_config_files': (), 08:41:49 INFO - 'pip_index': False, 08:41:49 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:41:49 INFO - 'cmd': ('bash', 08:41:49 INFO - '-c', 08:41:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:41:49 INFO - 'enabled': True, 08:41:49 INFO - 'halt_on_failure': False, 08:41:49 INFO - 'name': 'check_screen_resolution'},), 08:41:49 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:41:49 INFO - 'cmd': ('bash', 08:41:49 INFO - '-c', 08:41:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:41:49 INFO - 'enabled': True, 08:41:49 INFO - 'halt_on_failure': False, 08:41:49 INFO - 'name': 'check_screen_resolution'},), 08:41:49 INFO - 'run_cmd_checks_enabled': True, 08:41:49 INFO - 'sps_profile': False, 08:41:49 INFO - 'sps_profile_interval': 0, 08:41:49 INFO - 'suite': 'dromaeojs', 08:41:49 INFO - 'system_bits': '64', 08:41:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:41:49 INFO - 'title': 't-yosemite-r5-0032', 08:41:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:41:49 INFO - 'use_talos_json': True, 08:41:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:41:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:41:49 INFO - 'work_dir': 'build'} 08:41:49 INFO - ##### 08:41:49 INFO - ##### Running clobber step. 08:41:49 INFO - ##### 08:41:49 INFO - Running pre-action listener: _resource_record_pre_action 08:41:49 INFO - Running main action method: clobber 08:41:49 INFO - rmtree: /builds/slave/test/build 08:41:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:41:51 INFO - Running post-action listener: _resource_record_post_action 08:41:51 INFO - ##### 08:41:51 INFO - ##### Running read-buildbot-config step. 08:41:51 INFO - ##### 08:41:51 INFO - Running pre-action listener: _resource_record_pre_action 08:41:51 INFO - Running main action method: read_buildbot_config 08:41:51 INFO - Using buildbot properties: 08:41:51 INFO - { 08:41:51 INFO - "properties": { 08:41:51 INFO - "buildnumber": 440, 08:41:51 INFO - "product": "firefox", 08:41:51 INFO - "script_repo_revision": "production", 08:41:51 INFO - "builddir": "mozilla-aurora_yosemite_test-dromaeojs", 08:41:51 INFO - "repository": "", 08:41:51 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-aurora talos dromaeojs", 08:41:51 INFO - "buildid": "20151126064410", 08:41:51 INFO - "slavename": "t-yosemite-r5-0032", 08:41:51 INFO - "pgo_build": "False", 08:41:51 INFO - "basedir": "/builds/slave/test", 08:41:51 INFO - "project": "", 08:41:51 INFO - "platform": "yosemite", 08:41:51 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 08:41:51 INFO - "slavebuilddir": "test", 08:41:51 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:41:51 INFO - "branch": "mozilla-aurora", 08:41:51 INFO - "repo_path": "releases/mozilla-aurora", 08:41:51 INFO - "stage_platform": "macosx64", 08:41:51 INFO - "builduid": "a5dbfb4cef6b42c5aaae83f695e1111d", 08:41:51 INFO - "revision": "1624a69d46d7d711c6a3abfdfb604989baf70ac9" 08:41:51 INFO - }, 08:41:51 INFO - "sourcestamp": { 08:41:51 INFO - "repository": "", 08:41:51 INFO - "hasPatch": false, 08:41:51 INFO - "project": "", 08:41:51 INFO - "branch": "mozilla-aurora-macosx64-talos", 08:41:51 INFO - "changes": [ 08:41:51 INFO - { 08:41:51 INFO - "category": null, 08:41:51 INFO - "files": [ 08:41:51 INFO - { 08:41:51 INFO - "url": null, 08:41:51 INFO - "name": "https://queue.taskcluster.net/v1/task/WOOimwXkSYuHZgkoPua15Q/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg" 08:41:51 INFO - } 08:41:51 INFO - ], 08:41:51 INFO - "repository": "", 08:41:51 INFO - "rev": "1624a69d46d7d711c6a3abfdfb604989baf70ac9", 08:41:51 INFO - "who": "cbook@mozilla.com", 08:41:51 INFO - "when": 1448556051, 08:41:51 INFO - "number": 6711503, 08:41:51 INFO - "comments": "Backed out changeset b02dc2a2305e (bug 1222617) for failing on own tests", 08:41:51 INFO - "project": "", 08:41:51 INFO - "at": "Thu 26 Nov 2015 08:40:51", 08:41:51 INFO - "branch": "mozilla-aurora-macosx64-talos", 08:41:51 INFO - "revlink": "", 08:41:51 INFO - "properties": [ 08:41:51 INFO - [ 08:41:51 INFO - "buildid", 08:41:51 INFO - "20151126064410", 08:41:51 INFO - "Change" 08:41:51 INFO - ], 08:41:51 INFO - [ 08:41:51 INFO - "builduid", 08:41:51 INFO - "a5dbfb4cef6b42c5aaae83f695e1111d", 08:41:51 INFO - "Change" 08:41:51 INFO - ], 08:41:51 INFO - [ 08:41:51 INFO - "pgo_build", 08:41:51 INFO - "False", 08:41:51 INFO - "Change" 08:41:51 INFO - ] 08:41:51 INFO - ], 08:41:51 INFO - "revision": "1624a69d46d7d711c6a3abfdfb604989baf70ac9" 08:41:51 INFO - } 08:41:51 INFO - ], 08:41:51 INFO - "revision": "1624a69d46d7d711c6a3abfdfb604989baf70ac9" 08:41:51 INFO - } 08:41:51 INFO - } 08:41:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/WOOimwXkSYuHZgkoPua15Q/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg. 08:41:51 INFO - Running post-action listener: _resource_record_post_action 08:41:51 INFO - ##### 08:41:51 INFO - ##### Running download-and-extract step. 08:41:51 INFO - ##### 08:41:51 INFO - Running pre-action listener: _resource_record_pre_action 08:41:51 INFO - Running main action method: download_and_extract 08:41:51 INFO - mkdir: /builds/slave/test/build/tests 08:41: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')]} 08:41:51 INFO - https://queue.taskcluster.net/v1/task/WOOimwXkSYuHZgkoPua15Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:41:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOOimwXkSYuHZgkoPua15Q/artifacts/public/build/test_packages.json 08:41:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOOimwXkSYuHZgkoPua15Q/artifacts/public/build/test_packages.json 08:41:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOOimwXkSYuHZgkoPua15Q/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 08:41:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOOimwXkSYuHZgkoPua15Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 08:41:52 INFO - Downloaded 1149 bytes. 08:41:52 INFO - Reading from file /builds/slave/test/build/test_packages.json 08:41:52 INFO - Using the following test package requirements: 08:41:52 INFO - {u'common': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 08:41:52 INFO - u'cppunittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 08:41:52 INFO - u'firefox-44.0a2.en-US.mac.cppunittest.tests.zip'], 08:41:52 INFO - u'jittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 08:41:52 INFO - u'jsshell-mac.zip'], 08:41:52 INFO - u'mochitest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 08:41:52 INFO - u'firefox-44.0a2.en-US.mac.mochitest.tests.zip'], 08:41:52 INFO - u'mozbase': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 08:41:52 INFO - u'reftest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 08:41:52 INFO - u'firefox-44.0a2.en-US.mac.reftest.tests.zip'], 08:41:52 INFO - u'talos': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 08:41:52 INFO - u'firefox-44.0a2.en-US.mac.talos.tests.zip'], 08:41:52 INFO - u'web-platform': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 08:41:52 INFO - u'firefox-44.0a2.en-US.mac.web-platform.tests.zip'], 08:41:52 INFO - u'webapprt': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 08:41:52 INFO - u'xpcshell': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 08:41:52 INFO - u'firefox-44.0a2.en-US.mac.xpcshell.tests.zip']} 08:41:52 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:41:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:52 INFO - https://queue.taskcluster.net/v1/task/WOOimwXkSYuHZgkoPua15Q/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:41:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOOimwXkSYuHZgkoPua15Q/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 08:41:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOOimwXkSYuHZgkoPua15Q/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 08:41:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOOimwXkSYuHZgkoPua15Q/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 08:41:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOOimwXkSYuHZgkoPua15Q/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 08:41:54 INFO - Downloaded 17490190 bytes. 08:41:54 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 08:41:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 08:41:54 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 08:41:59 INFO - Return code: 0 08:41:59 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 08:41:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:59 INFO - https://queue.taskcluster.net/v1/task/WOOimwXkSYuHZgkoPua15Q/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:41:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOOimwXkSYuHZgkoPua15Q/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 08:41:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOOimwXkSYuHZgkoPua15Q/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 08:41:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOOimwXkSYuHZgkoPua15Q/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 08:41:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOOimwXkSYuHZgkoPua15Q/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 08:42:00 INFO - Downloaded 17490190 bytes. 08:42:00 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 08:42:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 08:42:00 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 08:42:05 INFO - Return code: 0 08:42:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:05 INFO - https://queue.taskcluster.net/v1/task/WOOimwXkSYuHZgkoPua15Q/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 08:42:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOOimwXkSYuHZgkoPua15Q/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 08:42:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOOimwXkSYuHZgkoPua15Q/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 08:42:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOOimwXkSYuHZgkoPua15Q/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 08:42:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOOimwXkSYuHZgkoPua15Q/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 08:42:06 INFO - Downloaded 11131307 bytes. 08:42:06 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 08:42:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 08:42:06 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] with output_timeout 1760 08:42:07 INFO - Return code: 0 08:42: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')]} 08:42:07 INFO - https://queue.taskcluster.net/v1/task/WOOimwXkSYuHZgkoPua15Q/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 08:42:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOOimwXkSYuHZgkoPua15Q/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 08:42:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOOimwXkSYuHZgkoPua15Q/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 08:42:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOOimwXkSYuHZgkoPua15Q/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg 08:42:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOOimwXkSYuHZgkoPua15Q/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 08:42:16 INFO - Downloaded 107832122 bytes. 08:42:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WOOimwXkSYuHZgkoPua15Q/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 08:42:16 INFO - mkdir: /builds/slave/test/properties 08:42:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:42:16 INFO - Writing to file /builds/slave/test/properties/build_url 08:42:16 INFO - Contents: 08:42:16 INFO - build_url:https://queue.taskcluster.net/v1/task/WOOimwXkSYuHZgkoPua15Q/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 08:42:16 INFO - Running post-action listener: _resource_record_post_action 08:42:16 INFO - Running post-action listener: set_extra_try_arguments 08:42:16 INFO - ##### 08:42:16 INFO - ##### Running populate-webroot step. 08:42:16 INFO - ##### 08:42:16 INFO - Running pre-action listener: _resource_record_pre_action 08:42:16 INFO - Running main action method: populate_webroot 08:42:16 INFO - Guessing talos json url... 08:42:16 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')]} 08:42:16 INFO - https://queue.taskcluster.net/v1/task/WOOimwXkSYuHZgkoPua15Q/artifacts/public/build/firefox-44.0a2.en-US.mac.txt matches https://queue.taskcluster.net 08:42:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOOimwXkSYuHZgkoPua15Q/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 08:42:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOOimwXkSYuHZgkoPua15Q/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 08:42:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOOimwXkSYuHZgkoPua15Q/artifacts/public/build/firefox-44.0a2.en-US.mac.txt to /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 08:42:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOOimwXkSYuHZgkoPua15Q/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 08:42:16 INFO - Downloaded 107 bytes. 08:42:16 INFO - Reading from file /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 08:42:16 INFO - Contents: 08:42:16 INFO - 20151126064410 08:42:16 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/1624a69d46d7d711c6a3abfdfb604989baf70ac9 08:42:16 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')]} 08:42:16 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/1624a69d46/testing/talos/talos.json 08:42:16 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/1624a69d46/testing/talos/talos.json to /builds/slave/test/build/talos.json 08:42:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/releases/mozilla-aurora/raw-file/1624a69d46/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 08:42:17 INFO - Downloaded 4264 bytes. 08:42:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:42:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:42:17 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 08:42:17 INFO - '../fennec_ids.txt'], 08:42:17 INFO - 'tests': ['tcheck2']}, 08:42:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:42:17 INFO - '--tppagecycles', 08:42:17 INFO - '7'], 08:42:17 INFO - 'tests': ['tsvgm']}}, 08:42:17 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:42:17 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:42:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:42:17 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:42:17 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:42:17 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:42:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:42:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:17 INFO - 'talos_options': ['--e10s'], 08:42:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:42:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:17 INFO - 'tests': ['damp', 'tps']}, 08:42:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:17 INFO - 'talos_options': ['--e10s'], 08:42:17 INFO - 'tests': ['damp', 'tps']}, 08:42:17 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:42:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:42:17 INFO - 'other': {'tests': ['a11yr', 08:42:17 INFO - 'ts_paint', 08:42:17 INFO - 'tpaint', 08:42:17 INFO - 'sessionrestore', 08:42:17 INFO - 'sessionrestore_no_auto_restore']}, 08:42:17 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:42:17 INFO - 'tests': ['a11yr', 08:42:17 INFO - 'ts_paint', 08:42:17 INFO - 'tpaint', 08:42:17 INFO - 'sessionrestore', 08:42:17 INFO - 'sessionrestore_no_auto_restore']}, 08:42:17 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:42:17 INFO - 'tests': ['a11yr', 08:42:17 INFO - 'ts_paint', 08:42:17 INFO - 'tpaint', 08:42:17 INFO - 'sessionrestore', 08:42:17 INFO - 'sessionrestore_no_auto_restore']}, 08:42:17 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:42:17 INFO - 'tests': ['a11yr', 08:42:17 INFO - 'ts_paint', 08:42:17 INFO - 'tpaint', 08:42:17 INFO - 'sessionrestore', 08:42:17 INFO - 'sessionrestore_no_auto_restore']}, 08:42:17 INFO - 'other_l64': {'tests': ['a11yr', 08:42:17 INFO - 'ts_paint', 08:42:17 INFO - 'tpaint', 08:42:17 INFO - 'sessionrestore', 08:42:17 INFO - 'sessionrestore_no_auto_restore']}, 08:42:17 INFO - 'other_nol64': {'tests': ['a11yr', 08:42:17 INFO - 'ts_paint', 08:42:17 INFO - 'tpaint', 08:42:17 INFO - 'sessionrestore', 08:42:17 INFO - 'sessionrestore_no_auto_restore']}, 08:42:17 INFO - 'svgr': {'tests': ['tsvgx', 08:42:17 INFO - 'tsvgr_opacity', 08:42:17 INFO - 'tart', 08:42:17 INFO - 'tscrollx', 08:42:17 INFO - 'cart']}, 08:42:17 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:42:17 INFO - 'tests': ['tsvgx', 08:42:17 INFO - 'tsvgr_opacity', 08:42:17 INFO - 'tart', 08:42:17 INFO - 'tscrollx', 08:42:17 INFO - 'cart']}, 08:42:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:17 INFO - 'tests': ['tp5o']}, 08:42:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:17 INFO - 'talos_options': ['--e10s'], 08:42:17 INFO - 'tests': ['tp5o']}, 08:42:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:17 INFO - 'talos_options': ['--xperf_path', 08:42:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:42:17 INFO - 'tests': ['tp5n']}, 08:42:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:17 INFO - 'talos_options': ['--e10s', 08:42:17 INFO - '--xperf_path', 08:42:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 08:42:17 INFO - 'C:/slave/talos-data/talos/xperf.config'], 08:42:17 INFO - 'tests': ['tp5n']}}, 08:42:17 INFO - 'talos.zip': {'path': '', 08:42:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:42:17 INFO - Running post-action listener: _resource_record_post_action 08:42:17 INFO - ##### 08:42:17 INFO - ##### Running create-virtualenv step. 08:42:17 INFO - ##### 08:42:17 INFO - Running pre-action listener: _resource_record_pre_action 08:42:17 INFO - Running main action method: create_virtualenv 08:42:17 INFO - Creating virtualenv /builds/slave/test/build/venv 08:42:17 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 08:42:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:42:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:42:17 INFO - Using real prefix '/tools/python27' 08:42:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:42:18 INFO - Installing distribute.............................................................................................................................................................................................done. 08:42:21 INFO - Installing pip.................done. 08:42:21 INFO - Return code: 0 08:42:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:42:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:21 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 0x1054c7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105534228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec00e85900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10547c9f0>, '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 0x1051dbcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105446990>, '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.nV0LTZUh3g/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.hvuQ0HU8O2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/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 08:42:21 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 08:42:21 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 08:42:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nV0LTZUh3g/Render', 08:42:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:21 INFO - 'HOME': '/Users/cltbld', 08:42:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:21 INFO - 'LOGNAME': 'cltbld', 08:42:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:21 INFO - 'MOZ_NO_REMOTE': '1', 08:42:21 INFO - 'NO_EM_RESTART': '1', 08:42:21 INFO - 'PAGER': '/bin/cat', 08:42:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:21 INFO - 'PWD': '/builds/slave/test', 08:42:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:21 INFO - 'SHELL': '/bin/bash', 08:42:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hvuQ0HU8O2/Listeners', 08:42:21 INFO - 'TMPDIR': '/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/', 08:42:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:21 INFO - 'USER': 'cltbld', 08:42:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:21 INFO - 'XPC_FLAGS': '0x0', 08:42:21 INFO - 'XPC_SERVICE_NAME': '0', 08:42:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:42:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:22 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 08:42:22 INFO - Cleaning up... 08:42:22 INFO - Return code: 0 08:42:22 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:42:22 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')]} 08:42:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:22 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')]} 08:42:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:22 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 0x1054c7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105534228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec00e85900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10547c9f0>, '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 0x1051dbcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105446990>, '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.nV0LTZUh3g/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.hvuQ0HU8O2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/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 08:42:22 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 08:42:22 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 08:42:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nV0LTZUh3g/Render', 08:42:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:22 INFO - 'HOME': '/Users/cltbld', 08:42:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:22 INFO - 'LOGNAME': 'cltbld', 08:42:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:22 INFO - 'MOZ_NO_REMOTE': '1', 08:42:22 INFO - 'NO_EM_RESTART': '1', 08:42:22 INFO - 'PAGER': '/bin/cat', 08:42:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:22 INFO - 'PWD': '/builds/slave/test', 08:42:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:22 INFO - 'SHELL': '/bin/bash', 08:42:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hvuQ0HU8O2/Listeners', 08:42:22 INFO - 'TMPDIR': '/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/', 08:42:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:22 INFO - 'USER': 'cltbld', 08:42:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:22 INFO - 'XPC_FLAGS': '0x0', 08:42:22 INFO - 'XPC_SERVICE_NAME': '0', 08:42:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:42:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:22 INFO - Downloading/unpacking psutil>=0.7.1 08:42:22 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 08:42:22 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 08:42:22 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 08:42:22 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 08:42:22 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 08:42:22 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 08:42:25 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 08:42:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:42:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:42:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:42:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:42:25 INFO - Installing collected packages: psutil 08:42:25 INFO - Running setup.py install for psutil 08:42:25 INFO - building 'psutil._psutil_osx' extension 08:42:25 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 08:42:25 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 08:42:25 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 08:42:26 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 08:42:26 INFO - building 'psutil._psutil_posix' extension 08:42:26 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 08:42:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:42:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:42:26 INFO - ^ 08:42:26 INFO - 1 warning generated. 08:42:26 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 08:42:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:42:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:42:26 INFO - Successfully installed psutil 08:42:26 INFO - Cleaning up... 08:42:26 INFO - Return code: 0 08:42:26 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:42: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')]} 08:42:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42: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')]} 08:42:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42: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', '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 0x1054c7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105534228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec00e85900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10547c9f0>, '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 0x1051dbcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105446990>, '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.nV0LTZUh3g/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.hvuQ0HU8O2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/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 08:42: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 08:42: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 mozsystemmonitor==0.0.0 08:42:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nV0LTZUh3g/Render', 08:42:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:26 INFO - 'HOME': '/Users/cltbld', 08:42:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:26 INFO - 'LOGNAME': 'cltbld', 08:42:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:26 INFO - 'MOZ_NO_REMOTE': '1', 08:42:26 INFO - 'NO_EM_RESTART': '1', 08:42:26 INFO - 'PAGER': '/bin/cat', 08:42:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:26 INFO - 'PWD': '/builds/slave/test', 08:42:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:26 INFO - 'SHELL': '/bin/bash', 08:42:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hvuQ0HU8O2/Listeners', 08:42:26 INFO - 'TMPDIR': '/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/', 08:42:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:26 INFO - 'USER': 'cltbld', 08:42:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:26 INFO - 'XPC_FLAGS': '0x0', 08:42:26 INFO - 'XPC_SERVICE_NAME': '0', 08:42:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:42:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:26 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:42: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 08:42: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 08:42: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 08:42: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 08:42: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 08:42: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 08:42:29 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:42:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:42:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:42:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:42:29 INFO - Installing collected packages: mozsystemmonitor 08:42:29 INFO - Running setup.py install for mozsystemmonitor 08:42:29 INFO - Successfully installed mozsystemmonitor 08:42:29 INFO - Cleaning up... 08:42:29 INFO - Return code: 0 08:42:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:42:29 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')]} 08:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:29 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')]} 08:42:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:29 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 0x1054c7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105534228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec00e85900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10547c9f0>, '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 0x1051dbcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105446990>, '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.nV0LTZUh3g/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.hvuQ0HU8O2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/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 08:42:29 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 08:42:29 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 08:42:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nV0LTZUh3g/Render', 08:42:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:29 INFO - 'HOME': '/Users/cltbld', 08:42:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:29 INFO - 'LOGNAME': 'cltbld', 08:42:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:29 INFO - 'MOZ_NO_REMOTE': '1', 08:42:29 INFO - 'NO_EM_RESTART': '1', 08:42:29 INFO - 'PAGER': '/bin/cat', 08:42:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:29 INFO - 'PWD': '/builds/slave/test', 08:42:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:29 INFO - 'SHELL': '/bin/bash', 08:42:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hvuQ0HU8O2/Listeners', 08:42:29 INFO - 'TMPDIR': '/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/', 08:42:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:29 INFO - 'USER': 'cltbld', 08:42:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:29 INFO - 'XPC_FLAGS': '0x0', 08:42:29 INFO - 'XPC_SERVICE_NAME': '0', 08:42:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:42:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:30 INFO - Downloading/unpacking blobuploader==1.2.4 08:42:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:32 INFO - Downloading blobuploader-1.2.4.tar.gz 08:42:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:42:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:42:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:42: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 08:42: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 08:42: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 08:42: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 08:42: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 08:42: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 08:42:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:42:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:42:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:42:33 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 08:42:33 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 08:42:33 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 08:42:33 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 08:42:33 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 08:42:33 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 08:42:33 INFO - Downloading docopt-0.6.1.tar.gz 08:42:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:42:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:42:34 INFO - Installing collected packages: blobuploader, requests, docopt 08:42:34 INFO - Running setup.py install for blobuploader 08:42:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:42:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:42:34 INFO - Running setup.py install for requests 08:42:34 INFO - Running setup.py install for docopt 08:42:35 INFO - Successfully installed blobuploader requests docopt 08:42:35 INFO - Cleaning up... 08:42:35 INFO - Return code: 0 08:42:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:42: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')]} 08:42:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42: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')]} 08:42:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:35 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 0x1054c7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105534228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec00e85900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10547c9f0>, '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 0x1051dbcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105446990>, '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.nV0LTZUh3g/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.hvuQ0HU8O2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/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 08:42:35 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 08:42:35 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 08:42:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nV0LTZUh3g/Render', 08:42:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:35 INFO - 'HOME': '/Users/cltbld', 08:42:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:35 INFO - 'LOGNAME': 'cltbld', 08:42:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:35 INFO - 'MOZ_NO_REMOTE': '1', 08:42:35 INFO - 'NO_EM_RESTART': '1', 08:42:35 INFO - 'PAGER': '/bin/cat', 08:42:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:35 INFO - 'PWD': '/builds/slave/test', 08:42:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:35 INFO - 'SHELL': '/bin/bash', 08:42:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hvuQ0HU8O2/Listeners', 08:42:35 INFO - 'TMPDIR': '/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/', 08:42:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:35 INFO - 'USER': 'cltbld', 08:42:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:35 INFO - 'XPC_FLAGS': '0x0', 08:42:35 INFO - 'XPC_SERVICE_NAME': '0', 08:42:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:42:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:42:35 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-a5zlAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:42:35 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-MGVTma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:42:35 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-_PvPPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:42:35 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-AeeAtE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:42:35 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-f1r_JT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:42:36 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-m6B25X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:42:36 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-hNdwfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:42:36 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-cIj2xx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:42:36 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-zKpIUv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:42:36 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-b7BjC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:42:36 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-flplx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:42:36 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-SINuGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:42:37 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-SpAy6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:42:37 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-6vZS1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:37 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-eriAQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:42:37 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-CRJJk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:42:37 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-yS7tsu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:42:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:42:37 INFO - Running setup.py install for manifestparser 08:42:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:42:37 INFO - Running setup.py install for mozcrash 08:42:38 INFO - Running setup.py install for mozdebug 08:42:38 INFO - Running setup.py install for mozdevice 08:42:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:42:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:42:38 INFO - Running setup.py install for mozfile 08:42:38 INFO - Running setup.py install for mozhttpd 08:42:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:42:38 INFO - Running setup.py install for mozinfo 08:42:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:42:38 INFO - Running setup.py install for mozInstall 08:42:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:42:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:42:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:42:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:42:39 INFO - Running setup.py install for mozleak 08:42:39 INFO - Running setup.py install for mozlog 08:42:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:42:39 INFO - Running setup.py install for moznetwork 08:42:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:42:39 INFO - Running setup.py install for mozprocess 08:42:39 INFO - Running setup.py install for mozprofile 08:42:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:42:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:42:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:42:40 INFO - Running setup.py install for mozrunner 08:42:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:42:40 INFO - Running setup.py install for mozscreenshot 08:42:40 INFO - Running setup.py install for moztest 08:42:40 INFO - Running setup.py install for mozversion 08:42:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:42:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:42:40 INFO - Cleaning up... 08:42:40 INFO - Return code: 0 08:42:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:42: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')]} 08:42:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42: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')]} 08:42:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x1054c7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105534228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec00e85900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10547c9f0>, '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 0x1051dbcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105446990>, '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.nV0LTZUh3g/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.hvuQ0HU8O2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/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 08:42:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 08:42:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/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 08:42:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nV0LTZUh3g/Render', 08:42:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:40 INFO - 'HOME': '/Users/cltbld', 08:42:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:40 INFO - 'LOGNAME': 'cltbld', 08:42:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:40 INFO - 'MOZ_NO_REMOTE': '1', 08:42:40 INFO - 'NO_EM_RESTART': '1', 08:42:40 INFO - 'PAGER': '/bin/cat', 08:42:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:40 INFO - 'PWD': '/builds/slave/test', 08:42:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:40 INFO - 'SHELL': '/bin/bash', 08:42:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hvuQ0HU8O2/Listeners', 08:42:40 INFO - 'TMPDIR': '/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/', 08:42:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:40 INFO - 'USER': 'cltbld', 08:42:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:40 INFO - 'XPC_FLAGS': '0x0', 08:42:40 INFO - 'XPC_SERVICE_NAME': '0', 08:42:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:42:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:42:41 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-ZiI4bj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:42:41 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)) 08:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:42:41 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-WPV6Gy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:42:41 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)) 08:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:42:41 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-wK5SmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:42:41 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)) 08:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:42:41 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-g7cOtx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:42:41 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)) 08:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:42:41 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-2NhGv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:42:41 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)) 08:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:42:41 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-PFoquF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:42:42 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)) 08:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:42:42 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-SvF7ME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:42:42 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)) 08:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:42:42 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-tHrA3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:42:42 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)) 08:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:42:42 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-DbGTeW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:42:42 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)) 08:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:42:42 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-eJEs7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:42:42 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)) 08:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:42:42 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-fvT9Cw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:42:42 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)) 08:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:42:42 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-CcZrk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:42:42 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)) 08:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:42:42 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-k_iIha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:42:42 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)) 08:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:42:43 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-DvB9U6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:42:43 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)) 08:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:43 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-FjvQX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:43 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)) 08:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:42:43 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-3RJDIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:42:43 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)) 08:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:42:43 INFO - Running setup.py (path:/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/pip-f2DIyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:42:43 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)) 08:42:43 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)) 08:42:43 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)) 08:42:43 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)) 08:42:43 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)) 08:42:43 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)) 08:42:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:42:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:46 INFO - Downloading blessings-1.5.1.tar.gz 08:42:46 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 08:42:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:42:46 INFO - Installing collected packages: blessings 08:42:46 INFO - Running setup.py install for blessings 08:42:46 INFO - Successfully installed blessings 08:42:46 INFO - Cleaning up... 08:42:46 INFO - Return code: 0 08:42:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:42:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:42:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:42:46 INFO - Reading from file tmpfile_stdout 08:42:46 INFO - Current package versions: 08:42:46 INFO - blessings == 1.5.1 08:42:46 INFO - blobuploader == 1.2.4 08:42:46 INFO - docopt == 0.6.1 08:42:46 INFO - manifestparser == 1.1 08:42:46 INFO - mozInstall == 1.12 08:42:46 INFO - mozcrash == 0.16 08:42:46 INFO - mozdebug == 0.1 08:42:46 INFO - mozdevice == 0.46 08:42:46 INFO - mozfile == 1.2 08:42:46 INFO - mozhttpd == 0.7 08:42:46 INFO - mozinfo == 0.8 08:42:46 INFO - mozleak == 0.1 08:42:46 INFO - mozlog == 3.0 08:42:46 INFO - moznetwork == 0.27 08:42:46 INFO - mozprocess == 0.22 08:42:46 INFO - mozprofile == 0.27 08:42:46 INFO - mozrunner == 6.11 08:42:46 INFO - mozscreenshot == 0.1 08:42:46 INFO - mozsystemmonitor == 0.0 08:42:46 INFO - moztest == 0.7 08:42:46 INFO - mozversion == 1.4 08:42:46 INFO - psutil == 3.1.1 08:42:46 INFO - requests == 1.2.3 08:42:46 INFO - wsgiref == 0.1.2 08:42:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:42:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:46 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 0x1054c7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105534228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec00e85900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10547c9f0>, '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 0x1051dbcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105446990>, '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.nV0LTZUh3g/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.hvuQ0HU8O2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/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 08:42:46 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 08:42:46 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 08:42:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nV0LTZUh3g/Render', 08:42:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:46 INFO - 'HOME': '/Users/cltbld', 08:42:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:46 INFO - 'LOGNAME': 'cltbld', 08:42:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:46 INFO - 'MOZ_NO_REMOTE': '1', 08:42:46 INFO - 'NO_EM_RESTART': '1', 08:42:46 INFO - 'PAGER': '/bin/cat', 08:42:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:46 INFO - 'PWD': '/builds/slave/test', 08:42:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:46 INFO - 'SHELL': '/bin/bash', 08:42:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hvuQ0HU8O2/Listeners', 08:42:46 INFO - 'TMPDIR': '/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/', 08:42:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:46 INFO - 'USER': 'cltbld', 08:42:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:46 INFO - 'XPC_FLAGS': '0x0', 08:42:46 INFO - 'XPC_SERVICE_NAME': '0', 08:42:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:42:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:47 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)) 08:42:47 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)) 08:42:47 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)) 08:42:47 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)) 08:42:47 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)) 08:42:47 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)) 08:42:47 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)) 08:42:47 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)) 08:42:47 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)) 08:42:47 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)) 08:42:47 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)) 08:42:47 INFO - Cleaning up... 08:42:47 INFO - Return code: 0 08:42:47 INFO - Running post-action listener: _resource_record_post_action 08:42:47 INFO - Running post-action listener: _start_resource_monitoring 08:42:47 INFO - Starting resource monitoring. 08:42:47 INFO - ##### 08:42:47 INFO - ##### Running install step. 08:42:47 INFO - ##### 08:42:47 INFO - Running pre-action listener: _resource_record_pre_action 08:42:47 INFO - Running main action method: install 08:42:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:42:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:42:47 INFO - Reading from file tmpfile_stdout 08:42:47 INFO - Detecting whether we're running mozinstall >=1.0... 08:42:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:42:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:42:47 INFO - Reading from file tmpfile_stdout 08:42:47 INFO - Output received: 08:42:47 INFO - Usage: mozinstall [options] installer 08:42:47 INFO - Options: 08:42:47 INFO - -h, --help show this help message and exit 08:42:47 INFO - -d DEST, --destination=DEST 08:42:47 INFO - Directory to install application into. [default: 08:42:47 INFO - "/builds/slave/test"] 08:42:47 INFO - --app=APP Application being installed. [default: firefox] 08:42:47 INFO - mkdir: /builds/slave/test/build/application 08:42:47 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'] 08:42:47 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 08:43:27 INFO - Reading from file tmpfile_stdout 08:43:27 INFO - Output received: 08:43:27 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:43:27 INFO - Running post-action listener: _resource_record_post_action 08:43:27 INFO - ##### 08:43:27 INFO - ##### Running run-tests step. 08:43:27 INFO - ##### 08:43:27 INFO - Running pre-action listener: _resource_record_pre_action 08:43:27 INFO - Running main action method: run_tests 08:43:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:43:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:43:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:43:27 INFO - 2015-11-26 08:43:27.257 screenresolution[1927:14417] starting screenresolution argv=screenresolution get 08:43:27 INFO - 2015-11-26 08:43:27.260 screenresolution[1927:14417] Display 0: 1600x1200x32@60 08:43:27 INFO - 2015-11-26 08:43:27.267 screenresolution[1928:14419] starting screenresolution argv=screenresolution list 08:43:27 INFO - Available Modes on Display 0 08:43:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:43:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:43:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:43:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:43:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:43:27 INFO - Intel HD Graphics 3000: 08:43:27 INFO - Chipset Model: Intel HD Graphics 3000 08:43:27 INFO - Type: GPU 08:43:27 INFO - Bus: Built-In 08:43:27 INFO - VRAM (Total): 512 MB 08:43:27 INFO - VRAM (Dynamic, Max): 10 08:43:27 INFO - Vendor: Intel (0x8086) 08:43:27 INFO - Device ID: 0x0116 08:43:27 INFO - Revision ID: 0x0009 08:43:27 INFO - Displays: 08:43:27 INFO - Display: 08:43:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:43:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:43:27 INFO - Display Serial Number: 1600x1200 60 08:43:27 INFO - Main Display: Yes 08:43:27 INFO - Mirror: Off 08:43:27 INFO - Online: Yes 08:43:27 INFO - Rotation: Supported 08:43:27 INFO - Return code: 0 08:43:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:43:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:43:27 INFO - Python 2.7.3 08:43:27 INFO - Return code: 0 08:43:27 INFO - grabbing minidump binary from tooltool 08:43:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:27 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 0x10547c9f0>, '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 0x1051dbcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105446990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:43:27 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 08:43:27 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 08:43:27 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:43:27 INFO - Return code: 0 08:43:27 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:43:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:43:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:43:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:43:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:43:27 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', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WOOimwXkSYuHZgkoPua15Q/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0032', '--webServer', 'localhost'] in /builds/slave/test/build 08:43:27 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 --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WOOimwXkSYuHZgkoPua15Q/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0032 --webServer localhost 08:43:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nV0LTZUh3g/Render', 08:43:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:43:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:43:27 INFO - 'HOME': '/Users/cltbld', 08:43:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:43:27 INFO - 'LOGNAME': 'cltbld', 08:43:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:43:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:43:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:27 INFO - 'MOZ_NO_REMOTE': '1', 08:43:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:43:27 INFO - 'NO_EM_RESTART': '1', 08:43:27 INFO - 'PAGER': '/bin/cat', 08:43:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:43:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:27 INFO - 'PWD': '/builds/slave/test', 08:43:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:43:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:43:27 INFO - 'SHELL': '/bin/bash', 08:43:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hvuQ0HU8O2/Listeners', 08:43:27 INFO - 'TMPDIR': '/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/', 08:43:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:43:27 INFO - 'USER': 'cltbld', 08:43:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:43:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:43:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:27 INFO - 'XPC_FLAGS': '0x0', 08:43:27 INFO - 'XPC_SERVICE_NAME': '0', 08:43:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:43:27 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', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WOOimwXkSYuHZgkoPua15Q/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0032', '--webServer', 'localhost'] with output_timeout 3600 08:43:27 INFO - mozversion INFO | application_buildid: 20151126064410 08:43:27 INFO - mozversion INFO | application_changeset: 1624a69d46d7d711c6a3abfdfb604989baf70ac9 08:43:27 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 08:43:27 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:43:27 INFO - mozversion INFO | application_name: Firefox 08:43:27 INFO - mozversion INFO | application_remotingname: firefox-dev 08:43:27 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:43:27 INFO - mozversion INFO | application_vendor: Mozilla 08:43:27 INFO - mozversion INFO | application_version: 44.0a2 08:43:27 INFO - mozversion INFO | platform_buildid: 20151126064410 08:43:27 INFO - mozversion INFO | platform_changeset: 1624a69d46d7d711c6a3abfdfb604989baf70ac9 08:43:27 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:43:27 INFO - mozversion INFO | platform_version: 44.0a2 08:43:27 INFO - 2015-11-26 08:43:27,919 DEBUG : using testdate: 1448556207 08:43:27 INFO - 2015-11-26 08:43:27,920 DEBUG : actual date: 1448556207 08:43:27 INFO - 2015-11-26 08:43:27,929 INFO : starting webserver on 'localhost:49626' 08:43:27 INFO - 2015-11-26 08:43:27,930 INFO : Starting test suite t-yosemite-r5-0032 08:43:27 INFO - 2015-11-26 08:43:27,930 INFO : Starting test dromaeo_css 08:43:27 INFO - 2015-11-26 08:43:27,930 DEBUG : operating with platform_type : mac_ 08:43:27 INFO - 2015-11-26 08:43:27,931 INFO : Initialising browser for dromaeo_css test... 08:43:27 INFO - 2015-11-26 08:43:27,962 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/tmpoRIA1G/profile http://localhost:49626/getInfo.html 08:43:30 INFO - 2015-11-26 08:43:30,404 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:43:30 INFO - 2015-11-26 08:43:30,405 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:43:30 INFO - 2015-11-26 08:43:30,405 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 08:43:30 INFO - 2015-11-26 08:43:30,405 DEBUG : BROWSER_OUTPUT: __metrics 08:43:30 INFO - 2015-11-26 08:43:30,423 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:43:31 INFO - 2015-11-26 08:43:31,171 INFO : Browser initialized. 08:43:31 INFO - 2015-11-26 08:43:31,172 INFO : Running cycle 1/1 for dromaeo_css test... 08:43:31 INFO - 2015-11-26 08:43:31,172 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/tmpoRIA1G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:43:43 INFO - 2015-11-26 08:43:43,198 DEBUG : BROWSER_OUTPUT: RSS: Main: 198750208 08:43:43 INFO - 2015-11-26 08:43:43,198 DEBUG : BROWSER_OUTPUT: 08:44:34 INFO - 2015-11-26 08:44:34,929 DEBUG : BROWSER_OUTPUT: 1448556274926 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] 08:46:45 INFO - 2015-11-26 08:46:45,572 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49626/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49626/tests/dromaeo/cssquery-ext.html) 08:46:46 INFO - 2015-11-26 08:46:46,787 DEBUG : BROWSER_OUTPUT: RSS: Main: 319152128 08:46:46 INFO - 2015-11-26 08:46:46,787 DEBUG : BROWSER_OUTPUT: 08:49:49 INFO - 2015-11-26 08:49:49,430 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49626/tests/dromaeo/cssquery-ext.html (next: http://localhost:49626/tests/dromaeo/cssquery-jquery.html) 08:49:50 INFO - 2015-11-26 08:49:50,017 DEBUG : BROWSER_OUTPUT: RSS: Main: 342884352 08:49:50 INFO - 2015-11-26 08:49:50,017 DEBUG : BROWSER_OUTPUT: 08:52:52 INFO - 2015-11-26 08:52:52,186 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49626/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49626/tests/dromaeo/cssquery-mootools.html) 08:52:52 INFO - 2015-11-26 08:52:52,763 DEBUG : BROWSER_OUTPUT: RSS: Main: 309456896 08:52:52 INFO - 2015-11-26 08:52:52,764 DEBUG : BROWSER_OUTPUT: 08:55:54 INFO - 2015-11-26 08:55:54,801 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49626/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49626/tests/dromaeo/cssquery-prototype.html) 08:55:55 INFO - 2015-11-26 08:55:55,383 DEBUG : BROWSER_OUTPUT: RSS: Main: 297738240 08:55:55 INFO - 2015-11-26 08:55:55,383 DEBUG : BROWSER_OUTPUT: 08:58:58 INFO - 2015-11-26 08:58:58,624 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49626/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49626/tests/dromaeo/cssquery-yui.html) 08:58:59 INFO - 2015-11-26 08:58:59,202 DEBUG : BROWSER_OUTPUT: RSS: Main: 299098112 08:58:59 INFO - 2015-11-26 08:58:59,202 DEBUG : BROWSER_OUTPUT: 09:02:01 INFO - 2015-11-26 09:02:01,992 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49626/tests/dromaeo/cssquery-yui.html (next: http://localhost:49626/tests/dromaeo/cssquery-dojo.html) 09:02:02 INFO - 2015-11-26 09:02:02,258 DEBUG : BROWSER_OUTPUT: RSS: Main: 359129088 09:02:02 INFO - 2015-11-26 09:02:02,258 DEBUG : BROWSER_OUTPUT: 09:02:02 INFO - 2015-11-26 09:02:02,259 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:02:02 INFO - 2015-11-26 09:02:02,260 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:02:02 INFO - 2015-11-26 09:02:02,260 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:02:02 INFO - 2015-11-26 09:02:02,260 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:02:02 INFO - 2015-11-26 09:02:02,262 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2839.971600283997;2921.4741346557616;2944.4552757739807;2964.584958105864;2992.8802847886086;4886.755662216889;4951.108800415924;4995.725235112068;5001.44984051754;5010.048090862742;4957;4977.377827771528;4996.125678006343;5005.274235235897;5113.795448182068;4394.560543945612;4519.819207231707;4533.637309015287;4556.886077848064;4634.72191668501;4428.31361139024;4432.977835110836;4439.045605194882;4441.422615060038;4478.03722199727;4472.977635111836;4493.595576398124;4521.683482156251;4532.864014079566;4537.954620453786;4361.6292615127595;4406.977965110186;4477.753723545187;4493.977530112328;4523.3667286579575;4459;4475.910481790378;4515.480719717241;4532.546745325441;4544.500104988449;4686.203345431285;4813.470518242991;4827.565519103297;4875.609951203895;4882.048000639877;5120.667156634844;5122.103631864409;5212.817551385721;5246.23929530216;5305.73471326436;5272.156454967187;5303.655262407931;5304.389995150568;5305.1776974569;5363.141897296453;4697.7651117444675;4697.859064228079;4956.702597844141;5027.4721154279005;5038.5969122470115;5313.256144139824;5343.278657381204;5380.704061276668;5441.020616289027;5457.699826509501;5125.666831655931;5189.325387699575;5200.6619569727845;5232.790688372498;5262.578993680497;4866.829660961849;4935.90128197434;5332.893342133136;5350.30446042012;5391.676499410048;5026.949730502722;5137.614678899097;5149.098907691139;5202.73986300691;5203.297554830049;5183.429822719498;5198.662086964335;5202.375714914235;5208.062548741187;5309.309789727311;3867.61323867611;3951.624595663465;4058.8985275367763;4078.8368465261055;4107.137501124737;3625.4561815727325;3628.165521929971;3707.3882809336155;3717.8326975285636;3763.7741735495956;4926.433460152057;4929.285253638274;4964.15609346412;4965.255211718271;4981.37732783402;5138.58891288696;5292.497212764782;5363.919541206885;5376.892462150813;5379.35447746273;4741.170295198395;4749.335093086971;4834.661573689808;4847.297141914473;4880.341153944172;4501.932471012938;4598.793054312564;4605.148047611203;4605.355250264965;4631.861044168681;5092.0579692756955;5142.254373115952;5261.89476210466;5277.551408130275;5279.47205279469;5191.662541934762;5192.1952097424955;5258.1849813279005;5266.394364648115;5285.180796976475;5389.0299746046085;5391.083515802401;5407.0537655909275;5415.025295446857;5471.179323101566;4843.854684359475;5068.189089745623;5322.042032434199;5343.839684809462;5346.518813306821;5009.5992320615;5083.085044691843;5101.362329708786;5154.484551544815;5178.171492561172;5117.5905927526455;5151.304573882478;5175.611829112756;5234.424213336454;5242.9475705243985;4926.113299606105;5100.795968161232;5147.768350424315;5168.560672342893;5198.194279886624;4895.828645997373;4974.427940786856;4998.225275082223;5005.224190250517;5081.644284900021;5089;5184.326037615086;5198.116320225495;5244.580433565382;5245.7114858683135;4953.380827396575;5019.84940451787;5067.569256613229;5071.315372424676;5138.049460849606 09:02:02 INFO - 2015-11-26 09:02:02,263 DEBUG : BROWSER_OUTPUT: |1;ext.html;506.0461030956647;516.2540129512853;521.658313804458;530.8725905782613;566.0603398358728;24227.515449690996;24758.009679612816;33131.50302745458;33569.664303356956;33856.830715846445;38700.612993870054;39264;39470.40794388086;39502.60497395032;39517.802410987904;7652.273034061783;8246.67013319468;8350.624221909999;8374.916250837505;8466.068732439428;7830.530168189898;9924.206063514937;10214.744631384201;10218.897811021869;10252.23108266883;9904.306698531105;9992.95003524985;10050.648227312045;10062.39625622465;10088.546015429323;7922.168172341936;8022.839543209161;9930.50347482623;9939.105480506752;10036.447995360253;9799.510024498746;9868.802623947553;9966.451845148515;9989.350692205056;10023.899761002442;36240;36393.81803090994;36778.08054798625;36794.08014799625;36863.63136368629;2682.865856707157;2854.9714502854913;2965.8368789716774;3017.230606195428;3174.6666600006897;24127.87936060326;24316.513669726508;24652.876735616388;25217;25527.489450211076;1991;2016.3043749906258;2075.1180748181964;2094.4240333908147;2151.924682636116;251189;252752;254355;255169;256814;56705.432945670844;56751.43248567462;56771.43228567744;57383;57422.425775742544;52880.73559632177;53333.466665333624;53657.463425366026;53864.461355385945;53995.73002134964;15262.542123736306;15417.691646167013;15587.532374028797;15607.297671604805;15637.921810391103;11829.822552661717;11878.109141814226;11892.762144757056;11931.821022684493;12034.578789742318;19012.714809277873;19266.422007339803;19468.22127114928;19477.12352944121;19512.609747805247;8068.354531637455;8254.133316001853;8308.335333173332;8420.873686894702;8424.620892059873;936.4989730494153;982.0866594067586;1003.4531180506641;1034.5861655337774;1049.3284298049255;26251.73748262493;26471.47057058848;26517;26667.466650666876;26711.599326010124;887.3211992825494;976.6679329028165;1010.7877345757327;1033.788073444942;1089.6077412131626;12706.30115343665;13081.738365232643;13160.802587961189;13323.600291991255;13326.733465330639;292988;299452;301314;301600;301705;51177.74411127921;51641;51803.7409812956;52043.219351709755;52191.73904130455;1299.5191779041627;1322.8743269389392;1328.3291937571657;1341.6377578053675;1341.8255626768653;25347.366315842253;25454;26363;26556.336091597863;26687;44719.776401117786;45159.54840451553;45175;45235.54764452313;45321.320180196664;236242;245835;269619;271403;391247;29304.26739331534;29503;30283.848580757836;30417;30826.38347232998;37331.6266837339;38636.420453693776;38925;39141.60858391494;39770.40344394894;32054.358912821146;32167.51748723818;33582.49626255657;33761.15597110092;33915.32169356648;32766.83616581902;32781.344373111926;33092;33106.83446582752;33526.497102543966;33585;33937.49093763546;34110.68985617026;34129.31741365208;34463.65536344604;28443;29792.55311170291;29974.25064373408;31496.527552086278;32578;22516.32451026472;22607.09571617117;22951.31146065621;22988.540229195656;23056.884715576314 09:02:02 INFO - 2015-11-26 09:02:02,266 DEBUG : BROWSER_OUTPUT: |2;jquery.html;310.4783962942256;315.20725375680166;319.7617774757806;319.9440097982853;324.1135494422754;13293.135946163517;13760.862391376084;15387.230638468074;15920.442784502544;15958.441454549078;13675.794863077062;15748.13385263813;16893.324267029304;17311.22099505522;17515.562110947234;4325.610695037446;4451.043025749464;4455.175792478386;4465.888352791174;4793.44875339337;3245.7403407727325;3305.7190138838228;4334;4472;4475.798589063484;4352.7605981670995;4407.030453300269;4414.690971631987;4417.138657961698;4424.2921132618785;4289.335153051282;4352.36890650857;4373.934390984138;4399.362092496586;4454.10917816438;3751.437284407361;3761.9811900940595;3766.2467506498538;3792.7345085844004;3801;11898.58354957581;12045.698857528545;12267.815982760265;12363.320017399039;12399.566015189424;1797.0655259265109;1820.5357633803296;1841.5212044868297;1865.7201419787004;1932.9710054349196;8315.708950186714;8509.574521273911;8780.517071561126;8972.371933964625;9106.499142547158;1401.565514690439;1408.802767612535;1425.2090090000045;1432.4771458417706;1441.7116576684705;53823.19265211025;55242.72378638121;56020.79871455158;56169.43830561683;56391.43608563944;6072.544559158081;6101.206843110367;6122.5408094392205;6147.815565533041;6195.411435913581;6986.021956926034;6994.545354551938;7023.473239507058;7089.858202835914;7091.25541818112;5169.844904652867;5190.065788158167;5239.1093514102695;5279.41926388097;5280;5555.2778138841695;5571.192177134293;5604.85987850307;5687.459691329317;5689;2715.592661100851;2775.9444811103663;2782.0680072176046;2786.958195627067;2813.606095146681;965.6330594374093;968.8692026576463;970.8737864077766;1007.6422869881234;1034.374203606807;357.8675889920746;392.3428257668451;400.4193918817668;417.93522004089414;428.0347815675694;10237.641682541076;10564.785049719381;10649;10751.731206719895;10822.458877056115;402.74224496322375;413.54303494638594;414.6993429763397;433.89369604447114;446.28371463800784;5780.797672081541;5888.440598143169;5891.764329426861;5948.405159484104;5958.940410595926;508105;514092;516967;538774;538935;68282.3171768276;69309.30690693129;69335.65332173408;69468;70725;469.5797261450982;469.75572702194665;470.6305550143121;473.2073776424544;475.0664943386263;10217.74455638615;10231.641892533726;10264.281500294908;10278.126359259546;10388.688339349832;31002;32268.838655806572;32790.83604581962;33379.165520862174;33517.83241083779;42913.14173716446;43276.78361608172;43633.56366436295;44215.11569768522;44265.77867110644;5723.742431590672;5838.591298609226;5855.795047173328;5893.616914900518;5900.70496475166;10953.397563134104;10958.287711299059;10972.561097556327;11172.553097875994;11175.664730058112;9343;9470.195033422237;9551.283653725859;9645.180159686504;9674.951625241829;9133.178013978773;9254.676086336945;9286.535673216176;9319.16127548524;9498.382605130644;9472.100150485692;9484.146426821619;9518.809623807623;9718.271129665161;9809.117179453884;5754.338251101177;5808.883822323445;5817.76728930838;5828.271466066742;5837.328707198726;8944.150305720947;9137.360384773003;9530;9533.666321678707;9548.809023819624 09:02:02 INFO - 2015-11-26 09:02:02,267 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1318.4857905416895;1341.2489006156552;1441.5675297410774;1608.3888122513442;1696.2366934879308;6425.51808614354;6674.132362792836;6949.409300209482;7153.391961683264;7191.748288809893;6921.377076063153;7074.823129421767;7076.433885289177;7088.184858741246;7148.928510714892;1998.1507859159835;2015.768186658531;2016.0323044938439;2020.0606717876185;2020.3433883987689;1998.420458067166;2018.8082132197417;2028.127905000849;2028.563858770364;2032.1363420546284;1971.1721077147633;2000.5698774763423;2012.3962811156669;2012.567298030923;2012.667909794882;2028.8478364122675;2040.6224848402944;2041.030510507512;2045.457953642286;2052.8152466278034;1925.4416219296527;1946.9415917522497;1951.6487032334173;1952.8535359847926;1953.0332485419667;6229.190205273331;6991.650417479105;7024.262452442522;7044;7047.612381319025;3952.426898099788;4275.508316543606;4339.544347843463;4383.561643835591;4410.4707435107675;2593.1572239022394;2595.3252154439792;2637.3802156493207;2655.575107982733;2666.9066582669707;729.267086577991;743.22333161846;743.5204293230889;748.3751067858291;754.3135746470685;8680.262177714902;8696.086910874394;8776.210141087333;8811.471311721318;8818.250448711868;3738.27103714773;3781.4327850822046;3800.3539398302355;3802.752821066622;3891.1828516011956;7684.769456916301;7730.188330225358;7737.767866964;7773.533587984626;7819.413543984224;4188.958110418856;4197.223513649985;4205.915881682349;4208.558101399371;4237.0466645005245;3836.8081595920094;3839.212961342918;3844.115853353688;3882.9805850970565;3915.804209789499;3251.4797632378704;3253.3168034712503;3330.467125259947;3332.616749073839;3336.5495658086334;1027.530631197395;1043.7547176413536;1051.090806452413;1051.5636011055478;1056.5404049238605;1162;1193.6777070191;1215.3801561203672;1246.7257203415234;1247.5758242197696;6760.763373281911;6788.558743681645;6798.66006699663;6799.082123913208;7019.824504387431;1032.6179313653995;1035.6582327831798;1046.529061922138;1067.64767626683;1089.1178145702006;4830.565249127595;5382.515573598395;5451.781928722886;5453.700046497402;5464.644798088191;7784.338331241795;8249.257566819015;8403.663853445916;8428.199321064489;8458;8168.856360109589;8220.8355832883;8288.58557072156;8325.625346859406;8348.290395316344;6484.805455836333;6698.564593301518;6700.296468870796;6708.060871477997;6737.9326206737305;6619.635920024445;6627.37039981201;6656.667166641745;6685.164354455693;6707.966460167863;7446.627668616656;7587.468877178544;7592.240775922363;7607.391408687181;7607.4674772765375;7403.962980185064;7564.810879728051;7594.278543538355;7594.5063570867715;7646.197149299466;5999.970000149971;6206.875862482635;6265.655388953652;6314.968425157845;6315.652639104894;6785.287544807921;6880.827979300358;6889.931100688929;6892.689828957809;6906.516543842084;6124.54065945047;6404.359564043559;6407.263164736115;6409.262934762562;6443.516736244894;6230.190075290183;6235.781747638811;6285.49716022708;6371.713272902638;6388.712507937247;6447.387498187664;6458.031295305554;6490.643014634241;6506.60960342381;6521.608703477807;5642.322921249476;5654.40628733977;5673.971630141823;5720.971395142998;5729.341125770423;5718.370979192368;5758.193852860519;5765.250517432707;5781.364049954585;5788.681622510802 09:02:02 INFO - 2015-11-26 09:02:02,271 DEBUG : BROWSER_OUTPUT: |4;prototype.html;291.62817407805045;294.9513330300501;298.81174859838296;302.34693062983945;305.3922693839261;5419.07875661137;5489.258950041743;5503.642263252886;5528.336599608043;5635.520980716634;5440.211169380447;5500.5874559408;5503.257060296859;5512.118061110213;5554.777808887639;4024.6377825995655;4059.04612416082;4118.279301122307;4152.335626299778;4160.667146628262;4090.427340172378;4105.733127346728;4176.916461670765;4189.266878296301;4200.05498762779;4115.156392939441;4124.463819703449;4126.071633882382;4139.7309174903685;4164.521080075785;4006.1787333596544;4042.8787136385954;4063.1467391847746;4119.2997190477845;4162.771047592381;3556.6621170988715;3576.5529308836394;3582.5163602913794;3582.7492075554724;3582.8208589570677;5282.867928301785;5288.973555132238;5315.202719592054;5318.388385335697;5379.865503362408;4588.977055114737;4710.576048155648;4726.007538416937;4737.24204127338;4758.095961767253;5515.062439385314;5710.77156913723;5716.714164291769;5737.454941780524;5844.386339434341;3794.5067141271734;3883.650471457582;3887.378019516864;3927.5876033016407;3948.4077388391684;5938.8218353449465;5964.522838172936;5980.970095149496;5998.430149135826;6053.788117415869;3851.768893866377;3854.2869569129803;3872.1287710264965;3877.806109694504;3884.9704828220542;3773.5660399053913;3905.258000979805;3937.1928754605237;3940.1528671335227;3989.7805620691142;4696.8590942271785;4699.483056863743;4723.716577005391;4726.976365118152;4763.833265835679;5740.311162660508;5774.307083150049;5797.710114494258;5832.387599302097;5848.035074212792;1435.1532595768547;1441.9062760920506;1442.4662874736205;1458.431211827388;1466.8753155981647;916.5005072235648;921.203159267229;929.6327950459531;940.4780346907532;948.9335746497679;5419.187121931663;5447.727613619303;5463.699496527729;5488.7530061147345;5488.862778430571;6035.66803825785;6041.5468839837185;6057.939420605738;6070.089486576961;6100.450959413674;5452.863678408072;5459.672419654833;5465.59008074396;5473.589480788957;5485.369182544058;3215.8552865121123;3215.887443939451;3278.508223766454;3325.8669653214083;3353.8826141084946;5938.435848594377;5991.101334799815;5997.0404735242155;6001.339852616209;6099.725512351954;6129.325774164839;6129.785457508966;6158.507319414436;6171.043488259327;6216.378362163748;5809.76760929575;5993.520518358521;6000.21997140369;6010;6059.424354686298;5994.490468310068;5997.730102145327;6057.515398768176;6094.451499365078;6151.2618485781995;5959.195508606283;5961.8807623846415;5980.9401905980385;6023;6035.818925432244;6084.452399284086;6104.572679912363;6111.022236442148;6131.386861314011;6163.722632481638;3764.0213544478083;3796.0699628591174;3797.145642230476;3800.5629352623696;3836.501254836853;6036.456718895321;6053.697315134137;6068.241469816273;6084.361142080018;6119.204503414706;5913.231279933581;5917.230760001173;5930.525557955267;5939.495142912728;5962.25471816023;5768.653880767168;5898.292204935436;5907.85230369227;5930.733117009831;5953.047512397996;5751.482366587027;5753.827385178452;5796.42035796417;5809.2738407699035;5814.360420353673;5921.467067963904;5922.052471604523;5923.881522369615;5963.135345374983;5964.433378829004;5625.071863142699;5777.884442311214;5789.913151302818;5790.652560846363;5839.591228613956 09:02:02 INFO - 2015-11-26 09:02:02,271 DEBUG : BROWSER_OUTPUT: |5;yui.html;641.3202005873773;648.2965981909631;668.2348710726221;702.0452185028362;716.7286245353159;11611;11976.461059252333;12000.459979300931;12059.33673647949;12062.0953428493;12232.694182645439;12321.630351089481;12353.320567368813;12369.206465062583;12422.130450868442;677.5223467455432;703.4021082080242;827.9213474719907;833.5457175839182;846.6571038729325;836.7698882807216;837.7235512280932;849.1550906847664;849.8555245608261;850.5152063323908;832.7501749475164;879.0462348352046;889.4174315823146;890.1676932068536;891.6299735609714;694.586720901063;711.8611870685193;859.9871001934976;880.903100658927;883.2624758326805;652.9673516324165;655.1679367203673;655.187567416405;662.020210089066;663.0683889135772;10719.088877445427;10874.891251087545;10997.12023038155;10999.560017599286;11004.834927476095;10326.948365258126;10966.725831854268;10983.231173817836;11198.104151667847;11259.268147570463;8278.503289802631;8524.360672949553;8583.957080214559;8679.739607811776;8713.215810577078;2346.7301260354934;2868.899588514392;2952.2471769698805;3007.6992300769966;3043.802152860057;43846;44423.111537769066;44555.33167002498;44640.3303950441;46269.305960410624;8360.856846277276;8376.371772117116;8414.410991230556;8463.280621147149;8494.957525212334;18064.36774712905;18083;18089.7286540702;18108.366207182684;18126.818731812513;6303.054541818764;6425.132607098076;6461.095446637474;6584.736610535525;6637.137172167684;3362.7309815214726;3442.242706604543;3455.032590874559;3465.3069386122875;3478.043538027063;2505.8496490210646;2539.2255362114365;2540.7586279303437;2541.580639194512;2546.1343143330987;372.6124830176586;376.5951602027831;380.36099353086524;385.1795675211837;388.56868875548116;492.99597137635396;500.51950127876916;502.09288221199574;503.8513638476658;512.0808149371886;6465.515086368541;6501.154849869581;6594.571352862049;6646.169228846395;6741.797746067626;382.7512117123836;428.04332317270877;485.08561361832494;505.4793562630496;528.1654985123496;3094.535819627074;3273.2307907641684;3345.6654334566347;3353.7652364334263;3386.390449719025;56780.71609641925;56831.43168568344;56872.146917796264;57284.14073788896;57398;48050.759746201045;48555.02889942252;48776;48857;48875.266870996966;43194.352084718754;43371.34942975858;43599.34600980988;44650.33024504635;44957.775211123735;6583.177102862142;6593.604383736991;6651.634160121046;6714.697838597177;6813.1142951415995;31146.065618031495;31723.84138079295;32719.18202044968;32721.509177362834;32781.180470487474;41523.58476415318;41740.1651966965;41836.790816046945;42100;43389.349159761994;7087.929120708727;7148;7168.928310716826;7181.964090179516;7344.596047217455;9974.351667141613;10200.642977495752;10230.181585473294;10342.32774869631;10442.112420444348;9213.262938964732;9284.767880803034;9313.068693130634;9467.715968520955;9758;9352.205062569758;9796.65711700087;9880.950595246977;9976.700698979042;10506.632267870587;9133.360664753403;9433.056694330511;9632.614695412105;9720.951395242979;10210.336328138646;7929.207079292255;7971.800704982422;8159.8776018358585;8221.465604735673;8302.377321700777;7777.496739124981;7788.143304236416;8308.626111825104;8398.866153069257;8466.534340611326 09:02:02 INFO - 2015-11-26 09:02:02,271 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:02:02 INFO - 2015-11-26 09:02:02,272 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:02:02 INFO - 2015-11-26 09:02:02,272 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,908 09:02:02 INFO - 2015-11-26 09:02:02,272 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:02:02 INFO - 2015-11-26 09:02:02,273 DEBUG : BROWSER_OUTPUT: __startTimestamp1448557322258__endTimestamp 09:02:02 INFO - 2015-11-26 09:02:02,274 DEBUG : BROWSER_OUTPUT: 09:02:02 INFO - 2015-11-26 09:02:02,274 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:02:02 INFO - 2015-11-26 09:02:02,274 DEBUG : BROWSER_OUTPUT: Number of tests: 6 09:02:02 INFO - 2015-11-26 09:02:02,274 DEBUG : BROWSER_OUTPUT: 09:02:02 INFO - 2015-11-26 09:02:02,274 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4870.88 Median:5019.85 stddev:527.63 (10.5%) stddev-sans-first:504.62 09:02:02 INFO - 2015-11-26 09:02:02,274 DEBUG : BROWSER_OUTPUT: Values: 2840.0 2921.5 2944.5 2964.6 2992.9 4886.8 4951.1 4995.7 5001.4 5010.0 4957.0 4977.4 4996.1 5005.3 5113.8 4394.6 4519.8 4533.6 4556.9 4634.7 4428.3 4433.0 4439.0 4441.4 4478.0 4473.0 4493.6 4521.7 4532.9 4538.0 4361.6 4407.0 4477.8 4494.0 4523.4 4459.0 4475.9 4515.5 4532.5 4544.5 4686.2 4813.5 4827.6 4875.6 4882.0 5120.7 5122.1 5212.8 5246.2 5305.7 5272.2 5303.7 5304.4 5305.2 5363.1 4697.8 4697.9 4956.7 5027.5 5038.6 5313.3 5343.3 5380.7 5441.0 5457.7 5125.7 5189.3 5200.7 5232.8 5262.6 4866.8 4935.9 5332.9 5350.3 5391.7 5026.9 5137.6 5149.1 5202.7 5203.3 5183.4 5198.7 5202.4 5208.1 5309.3 3867.6 3951.6 4058.9 4078.8 4107.1 3625.5 3628.2 3707.4 3717.8 3763.8 4926.4 4929.3 4964.2 4965.3 4981.4 5138.6 5292.5 5363.9 5376.9 5379.4 4741.2 4749.3 4834.7 4847.3 4880.3 4501.9 4598.8 4605.1 4605.4 4631.9 5092.1 5142.3 5261.9 5277.6 5279.5 5191.7 5192.2 5258.2 5266.4 5285.2 5389.0 5391.1 5407.1 5415.0 5471.2 4843.9 5068.2 5322.0 5343.8 5346.5 5009.6 5083.1 5101.4 5154.5 5178.2 5117.6 5151.3 5175.6 5234.4 5242.9 4926.1 5100.8 5147.8 5168.6 5198.2 4895.8 4974.4 4998.2 5005.2 5081.6 5089.0 5184.3 5198.1 5244.6 5245.7 4953.4 5019.8 5067.6 5071.3 5138.0 09:02:02 INFO - 2015-11-26 09:02:02,275 DEBUG : BROWSER_OUTPUT: 09:02:02 INFO - 2015-11-26 09:02:02,275 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:43703.92 Median:30621.69 stddev:73590.54 (240.3%) stddev-sans-first:73725.50 09:02:02 INFO - 2015-11-26 09:02:02,276 DEBUG : BROWSER_OUTPUT: Values: 506.0 516.3 521.7 530.9 566.1 24227.5 24758.0 33131.5 33569.7 33856.8 38700.6 39264.0 39470.4 39502.6 39517.8 7652.3 8246.7 8350.6 8374.9 8466.1 7830.5 9924.2 10214.7 10218.9 10252.2 9904.3 9993.0 10050.6 10062.4 10088.5 7922.2 8022.8 9930.5 9939.1 10036.4 9799.5 9868.8 9966.5 9989.4 10023.9 36240.0 36393.8 36778.1 36794.1 36863.6 2682.9 2855.0 2965.8 3017.2 3174.7 24127.9 24316.5 24652.9 25217.0 25527.5 1991.0 2016.3 2075.1 2094.4 2151.9 251189.0 252752.0 254355.0 255169.0 256814.0 56705.4 56751.4 56771.4 57383.0 57422.4 52880.7 53333.5 53657.5 53864.5 53995.7 15262.5 15417.7 15587.5 15607.3 15637.9 11829.8 11878.1 11892.8 11931.8 12034.6 19012.7 19266.4 19468.2 19477.1 19512.6 8068.4 8254.1 8308.3 8420.9 8424.6 936.5 982.1 1003.5 1034.6 1049.3 26251.7 26471.5 26517.0 26667.5 26711.6 887.3 976.7 1010.8 1033.8 1089.6 12706.3 13081.7 13160.8 13323.6 13326.7 292988.0 299452.0 301314.0 301600.0 301705.0 51177.7 51641.0 51803.7 52043.2 52191.7 1299.5 1322.9 1328.3 1341.6 1341.8 25347.4 25454.0 26363.0 26556.3 26687.0 44719.8 45159.5 45175.0 45235.5 45321.3 236242.0 245835.0 269619.0 271403.0 391247.0 29304.3 29503.0 30283.8 30417.0 30826.4 37331.6 38636.4 38925.0 39141.6 39770.4 32054.4 32167.5 33582.5 33761.2 33915.3 32766.8 32781.3 33092.0 33106.8 33526.5 33585.0 33937.5 34110.7 34129.3 34463.7 28443.0 29792.6 29974.3 31496.5 32578.0 22516.3 22607.1 22951.3 22988.5 23056.9 09:02:02 INFO - 2015-11-26 09:02:02,276 DEBUG : BROWSER_OUTPUT: 09:02:02 INFO - 2015-11-26 09:02:02,276 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25487.14 Median:4454.64 stddev:85766.37 (1925.3%) stddev-sans-first:85986.13 09:02:02 INFO - 2015-11-26 09:02:02,278 DEBUG : BROWSER_OUTPUT: Values: 310.5 315.2 319.8 319.9 324.1 13293.1 13760.9 15387.2 15920.4 15958.4 13675.8 15748.1 16893.3 17311.2 17515.6 4325.6 4451.0 4455.2 4465.9 4793.4 3245.7 3305.7 4334.0 4472.0 4475.8 4352.8 4407.0 4414.7 4417.1 4424.3 4289.3 4352.4 4373.9 4399.4 4454.1 3751.4 3762.0 3766.2 3792.7 3801.0 11898.6 12045.7 12267.8 12363.3 12399.6 1797.1 1820.5 1841.5 1865.7 1933.0 8315.7 8509.6 8780.5 8972.4 9106.5 1401.6 1408.8 1425.2 1432.5 1441.7 53823.2 55242.7 56020.8 56169.4 56391.4 6072.5 6101.2 6122.5 6147.8 6195.4 6986.0 6994.5 7023.5 7089.9 7091.3 5169.8 5190.1 5239.1 5279.4 5280.0 5555.3 5571.2 5604.9 5687.5 5689.0 2715.6 2775.9 2782.1 2787.0 2813.6 965.6 968.9 970.9 1007.6 1034.4 357.9 392.3 400.4 417.9 428.0 10237.6 10564.8 10649.0 10751.7 10822.5 402.7 413.5 414.7 433.9 446.3 5780.8 5888.4 5891.8 5948.4 5958.9 508105.0 514092.0 516967.0 538774.0 538935.0 68282.3 69309.3 69335.7 69468.0 70725.0 469.6 469.8 470.6 473.2 475.1 10217.7 10231.6 10264.3 10278.1 10388.7 31002.0 32268.8 32790.8 33379.2 33517.8 42913.1 43276.8 43633.6 44215.1 44265.8 5723.7 5838.6 5855.8 5893.6 5900.7 10953.4 10958.3 10972.6 11172.6 11175.7 9343.0 9470.2 9551.3 9645.2 9675.0 9133.2 9254.7 9286.5 9319.2 9498.4 9472.1 9484.1 9518.8 9718.3 9809.1 5754.3 5808.9 5817.8 5828.3 5837.3 8944.2 9137.4 9530.0 9533.7 9548.8 09:02:02 INFO - 2015-11-26 09:02:02,278 DEBUG : BROWSER_OUTPUT: 09:02:02 INFO - 2015-11-26 09:02:02,279 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4882.69 Median:6062.26 stddev:2487.16 (41.0%) stddev-sans-first:2479.71 09:02:02 INFO - 2015-11-26 09:02:02,279 DEBUG : BROWSER_OUTPUT: Values: 1318.5 1341.2 1441.6 1608.4 1696.2 6425.5 6674.1 6949.4 7153.4 7191.7 6921.4 7074.8 7076.4 7088.2 7148.9 1998.2 2015.8 2016.0 2020.1 2020.3 1998.4 2018.8 2028.1 2028.6 2032.1 1971.2 2000.6 2012.4 2012.6 2012.7 2028.8 2040.6 2041.0 2045.5 2052.8 1925.4 1946.9 1951.6 1952.9 1953.0 6229.2 6991.7 7024.3 7044.0 7047.6 3952.4 4275.5 4339.5 4383.6 4410.5 2593.2 2595.3 2637.4 2655.6 2666.9 729.3 743.2 743.5 748.4 754.3 8680.3 8696.1 8776.2 8811.5 8818.3 3738.3 3781.4 3800.4 3802.8 3891.2 7684.8 7730.2 7737.8 7773.5 7819.4 4189.0 4197.2 4205.9 4208.6 4237.0 3836.8 3839.2 3844.1 3883.0 3915.8 3251.5 3253.3 3330.5 3332.6 3336.5 1027.5 1043.8 1051.1 1051.6 1056.5 1162.0 1193.7 1215.4 1246.7 1247.6 6760.8 6788.6 6798.7 6799.1 7019.8 1032.6 1035.7 1046.5 1067.6 1089.1 4830.6 5382.5 5451.8 5453.7 5464.6 7784.3 8249.3 8403.7 8428.2 8458.0 8168.9 8220.8 8288.6 8325.6 8348.3 6484.8 6698.6 6700.3 6708.1 6737.9 6619.6 6627.4 6656.7 6685.2 6708.0 7446.6 7587.5 7592.2 7607.4 7607.5 7404.0 7564.8 7594.3 7594.5 7646.2 6000.0 6206.9 6265.7 6315.0 6315.7 6785.3 6880.8 6889.9 6892.7 6906.5 6124.5 6404.4 6407.3 6409.3 6443.5 6230.2 6235.8 6285.5 6371.7 6388.7 6447.4 6458.0 6490.6 6506.6 6521.6 5642.3 5654.4 5674.0 5721.0 5729.3 5718.4 5758.2 5765.3 5781.4 5788.7 09:02:02 INFO - 2015-11-26 09:02:02,279 DEBUG : BROWSER_OUTPUT: 09:02:02 INFO - 2015-11-26 09:02:02,279 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4816.79 Median:5507.88 stddev:1489.37 (27.0%) stddev-sans-first:1454.30 09:02:02 INFO - 2015-11-26 09:02:02,280 DEBUG : BROWSER_OUTPUT: Values: 291.6 295.0 298.8 302.3 305.4 5419.1 5489.3 5503.6 5528.3 5635.5 5440.2 5500.6 5503.3 5512.1 5554.8 4024.6 4059.0 4118.3 4152.3 4160.7 4090.4 4105.7 4176.9 4189.3 4200.1 4115.2 4124.5 4126.1 4139.7 4164.5 4006.2 4042.9 4063.1 4119.3 4162.8 3556.7 3576.6 3582.5 3582.7 3582.8 5282.9 5289.0 5315.2 5318.4 5379.9 4589.0 4710.6 4726.0 4737.2 4758.1 5515.1 5710.8 5716.7 5737.5 5844.4 3794.5 3883.7 3887.4 3927.6 3948.4 5938.8 5964.5 5981.0 5998.4 6053.8 3851.8 3854.3 3872.1 3877.8 3885.0 3773.6 3905.3 3937.2 3940.2 3989.8 4696.9 4699.5 4723.7 4727.0 4763.8 5740.3 5774.3 5797.7 5832.4 5848.0 1435.2 1441.9 1442.5 1458.4 1466.9 916.5 921.2 929.6 940.5 948.9 5419.2 5447.7 5463.7 5488.8 5488.9 6035.7 6041.5 6057.9 6070.1 6100.5 5452.9 5459.7 5465.6 5473.6 5485.4 3215.9 3215.9 3278.5 3325.9 3353.9 5938.4 5991.1 5997.0 6001.3 6099.7 6129.3 6129.8 6158.5 6171.0 6216.4 5809.8 5993.5 6000.2 6010.0 6059.4 5994.5 5997.7 6057.5 6094.5 6151.3 5959.2 5961.9 5980.9 6023.0 6035.8 6084.5 6104.6 6111.0 6131.4 6163.7 3764.0 3796.1 3797.1 3800.6 3836.5 6036.5 6053.7 6068.2 6084.4 6119.2 5913.2 5917.2 5930.5 5939.5 5962.3 5768.7 5898.3 5907.9 5930.7 5953.0 5751.5 5753.8 5796.4 5809.3 5814.4 5921.5 5922.1 5923.9 5963.1 5964.4 5625.1 5777.9 5789.9 5790.7 5839.6 09:02:02 INFO - 2015-11-26 09:02:02,280 DEBUG : BROWSER_OUTPUT: 09:02:02 INFO - 2015-11-26 09:02:02,281 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12510.54 Median:28654.44 stddev:15387.43 (53.7%) stddev-sans-first:15404.79 09:02:02 INFO - 2015-11-26 09:02:02,282 DEBUG : BROWSER_OUTPUT: Values: 641.3 648.3 668.2 702.0 716.7 11611.0 11976.5 12000.5 12059.3 12062.1 12232.7 12321.6 12353.3 12369.2 12422.1 677.5 703.4 827.9 833.5 846.7 836.8 837.7 849.2 849.9 850.5 832.8 879.0 889.4 890.2 891.6 694.6 711.9 860.0 880.9 883.3 653.0 655.2 655.2 662.0 663.1 10719.1 10874.9 10997.1 10999.6 11004.8 10326.9 10966.7 10983.2 11198.1 11259.3 8278.5 8524.4 8584.0 8679.7 8713.2 2346.7 2868.9 2952.2 3007.7 3043.8 43846.0 44423.1 44555.3 44640.3 46269.3 8360.9 8376.4 8414.4 8463.3 8495.0 18064.4 18083.0 18089.7 18108.4 18126.8 6303.1 6425.1 6461.1 6584.7 6637.1 3362.7 3442.2 3455.0 3465.3 3478.0 2505.8 2539.2 2540.8 2541.6 2546.1 372.6 376.6 380.4 385.2 388.6 493.0 500.5 502.1 503.9 512.1 6465.5 6501.2 6594.6 6646.2 6741.8 382.8 428.0 485.1 505.5 528.2 3094.5 3273.2 3345.7 3353.8 3386.4 56780.7 56831.4 56872.1 57284.1 57398.0 48050.8 48555.0 48776.0 48857.0 48875.3 43194.4 43371.3 43599.3 44650.3 44957.8 6583.2 6593.6 6651.6 6714.7 6813.1 31146.1 31723.8 32719.2 32721.5 32781.2 41523.6 41740.2 41836.8 42100.0 43389.3 7087.9 7148.0 7168.9 7182.0 7344.6 9974.4 10200.6 10230.2 10342.3 10442.1 9213.3 9284.8 9313.1 9467.7 9758.0 9352.2 9796.7 9881.0 9976.7 10506.6 9133.4 9433.1 9632.6 9721.0 10210.3 7929.2 7971.8 8159.9 8221.5 8302.4 7777.5 7788.1 8308.6 8398.9 8466.5 09:02:02 INFO - 2015-11-26 09:02:02,283 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:02:02 INFO - 2015-11-26 09:02:02,283 DEBUG : BROWSER_OUTPUT: 09:02:02 INFO - 2015-11-26 09:02:02,957 INFO : Browser exited with error code: 0 09:02:02 INFO - 2015-11-26 09:02:02,988 INFO : Completed test dromaeo_css (00:18:35) 09:02:02 INFO - 2015-11-26 09:02:02,989 INFO : Starting test kraken 09:02:02 INFO - 2015-11-26 09:02:02,989 DEBUG : operating with platform_type : mac_ 09:02:02 INFO - 2015-11-26 09:02:02,989 INFO : Initialising browser for kraken test... 09:02:03 INFO - 2015-11-26 09:02:03,003 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/tmppWxc6P/profile http://localhost:49626/getInfo.html 09:02:05 INFO - 2015-11-26 09:02:05,369 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:02:05 INFO - 2015-11-26 09:02:05,371 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:02:05 INFO - 2015-11-26 09:02:05,371 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 09:02:05 INFO - 2015-11-26 09:02:05,371 DEBUG : BROWSER_OUTPUT: __metrics 09:02:05 INFO - 2015-11-26 09:02:05,387 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:02:06 INFO - 2015-11-26 09:02:06,084 INFO : Browser initialized. 09:02:06 INFO - 2015-11-26 09:02:06,085 INFO : Running cycle 1/1 for kraken test... 09:02:06 INFO - 2015-11-26 09:02:06,085 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/tmppWxc6P/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:02:18 INFO - 2015-11-26 09:02:18,070 DEBUG : BROWSER_OUTPUT: RSS: Main: 199061504 09:02:18 INFO - 2015-11-26 09:02:18,071 DEBUG : BROWSER_OUTPUT: 09:02:20 INFO - 2015-11-26 09:02:20,834 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49626/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49626/tests/kraken/driver.html?testName=audio-beat-detection) 09:02:21 INFO - 2015-11-26 09:02:21,419 DEBUG : BROWSER_OUTPUT: RSS: Main: 267145216 09:02:21 INFO - 2015-11-26 09:02:21,419 DEBUG : BROWSER_OUTPUT: 09:02:24 INFO - 2015-11-26 09:02:24,319 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49626/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49626/tests/kraken/driver.html?testName=audio-dft) 09:02:24 INFO - 2015-11-26 09:02:24,902 DEBUG : BROWSER_OUTPUT: RSS: Main: 277630976 09:02:24 INFO - 2015-11-26 09:02:24,902 DEBUG : BROWSER_OUTPUT: 09:02:28 INFO - 2015-11-26 09:02:28,025 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49626/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49626/tests/kraken/driver.html?testName=audio-fft) 09:02:28 INFO - 2015-11-26 09:02:28,610 DEBUG : BROWSER_OUTPUT: RSS: Main: 267767808 09:02:28 INFO - 2015-11-26 09:02:28,611 DEBUG : BROWSER_OUTPUT: 09:02:30 INFO - 2015-11-26 09:02:30,787 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49626/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49626/tests/kraken/driver.html?testName=audio-oscillator) 09:02:31 INFO - 2015-11-26 09:02:31,372 DEBUG : BROWSER_OUTPUT: RSS: Main: 267214848 09:02:31 INFO - 2015-11-26 09:02:31,372 DEBUG : BROWSER_OUTPUT: 09:02:33 INFO - 2015-11-26 09:02:33,744 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49626/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49626/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:02:34 INFO - 2015-11-26 09:02:34,322 DEBUG : BROWSER_OUTPUT: RSS: Main: 267821056 09:02:34 INFO - 2015-11-26 09:02:34,323 DEBUG : BROWSER_OUTPUT: 09:02:37 INFO - 2015-11-26 09:02:37,652 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49626/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49626/tests/kraken/driver.html?testName=imaging-darkroom) 09:02:38 INFO - 2015-11-26 09:02:38,237 DEBUG : BROWSER_OUTPUT: RSS: Main: 267997184 09:02:38 INFO - 2015-11-26 09:02:38,237 DEBUG : BROWSER_OUTPUT: 09:02:41 INFO - 2015-11-26 09:02:41,685 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49626/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49626/tests/kraken/driver.html?testName=imaging-desaturate) 09:02:42 INFO - 2015-11-26 09:02:42,269 DEBUG : BROWSER_OUTPUT: RSS: Main: 269447168 09:02:42 INFO - 2015-11-26 09:02:42,269 DEBUG : BROWSER_OUTPUT: 09:02:45 INFO - 2015-11-26 09:02:45,443 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49626/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49626/tests/kraken/driver.html?testName=json-parse-financial) 09:02:46 INFO - 2015-11-26 09:02:46,025 DEBUG : BROWSER_OUTPUT: RSS: Main: 268685312 09:02:46 INFO - 2015-11-26 09:02:46,025 DEBUG : BROWSER_OUTPUT: 09:02:47 INFO - 2015-11-26 09:02:47,732 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49626/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49626/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:02:48 INFO - 2015-11-26 09:02:48,297 DEBUG : BROWSER_OUTPUT: RSS: Main: 298577920 09:02:48 INFO - 2015-11-26 09:02:48,297 DEBUG : BROWSER_OUTPUT: 09:02:50 INFO - 2015-11-26 09:02:50,268 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49626/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49626/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:02:50 INFO - 2015-11-26 09:02:50,884 DEBUG : BROWSER_OUTPUT: RSS: Main: 302047232 09:02:50 INFO - 2015-11-26 09:02:50,884 DEBUG : BROWSER_OUTPUT: 09:02:53 INFO - 2015-11-26 09:02:53,123 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49626/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49626/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:02:53 INFO - 2015-11-26 09:02:53,708 DEBUG : BROWSER_OUTPUT: RSS: Main: 307277824 09:02:53 INFO - 2015-11-26 09:02:53,708 DEBUG : BROWSER_OUTPUT: 09:02:56 INFO - 2015-11-26 09:02:56,515 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49626/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49626/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:02:57 INFO - 2015-11-26 09:02:57,107 DEBUG : BROWSER_OUTPUT: RSS: Main: 309792768 09:02:57 INFO - 2015-11-26 09:02:57,107 DEBUG : BROWSER_OUTPUT: 09:02:59 INFO - 2015-11-26 09:02:59,874 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49626/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49626/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:03:00 INFO - 2015-11-26 09:03:00,457 DEBUG : BROWSER_OUTPUT: RSS: Main: 308449280 09:03:00 INFO - 2015-11-26 09:03:00,457 DEBUG : BROWSER_OUTPUT: 09:03:02 INFO - 2015-11-26 09:03:02,287 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49626/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49626/tests/kraken/driver.html?testName=ai-astar) 09:03:02 INFO - 2015-11-26 09:03:02,549 DEBUG : BROWSER_OUTPUT: RSS: Main: 367968256 09:03:02 INFO - 2015-11-26 09:03:02,549 DEBUG : BROWSER_OUTPUT: 09:03:02 INFO - 2015-11-26 09:03:02,549 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:03:02 INFO - 2015-11-26 09:03:02,549 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:03:02 INFO - 2015-11-26 09:03:02,549 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:03:02 INFO - 2015-11-26 09:03:02,549 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:03:02 INFO - 2015-11-26 09:03:02,549 DEBUG : BROWSER_OUTPUT: |0;ai-astar;116;115;122;122;129;126;128;124;122;122 09:03:02 INFO - 2015-11-26 09:03:02,549 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;172;150;186;179;142;164;147;188;173;142 09:03:02 INFO - 2015-11-26 09:03:02,550 DEBUG : BROWSER_OUTPUT: |2;audio-dft;180;182;188;183;181;181;181;181;188;186 09:03:02 INFO - 2015-11-26 09:03:02,550 DEBUG : BROWSER_OUTPUT: |3;audio-fft;86;91;86;141;77;79;81;78;130;74 09:03:02 INFO - 2015-11-26 09:03:02,550 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;110;112;154;103;103;102;144;99;98;146 09:03:02 INFO - 2015-11-26 09:03:02,550 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;136;130;141;132;130;136;128;135;133;129 09:03:02 INFO - 2015-11-26 09:03:02,550 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;145;140;140;146;144;141;140;140;147 09:03:02 INFO - 2015-11-26 09:03:02,550 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;115;118;118;117;115;113;116;118;118;116 09:03:02 INFO - 2015-11-26 09:03:02,550 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;65;70;69;70;69;70;80;65;67 09:03:02 INFO - 2015-11-26 09:03:02,550 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;73;72;73;73;77;78;75;73;82 09:03:02 INFO - 2015-11-26 09:03:02,551 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;91;92;94;97;96;90;93;92;97;102 09:03:02 INFO - 2015-11-26 09:03:02,551 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;136;147;148;139;136;136;147;139;141;143 09:03:02 INFO - 2015-11-26 09:03:02,551 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;162;154;162;166;168;161;159;149;160;168 09:03:02 INFO - 2015-11-26 09:03:02,551 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;72;76;76;76;81;79;80;77;76;76 09:03:02 INFO - 2015-11-26 09:03:02,551 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:03:02 INFO - 2015-11-26 09:03:02,551 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:03:02 INFO - 2015-11-26 09:03:02,551 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,921 09:03:02 INFO - 2015-11-26 09:03:02,551 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:03:02 INFO - 2015-11-26 09:03:02,552 DEBUG : BROWSER_OUTPUT: __startTimestamp1448557382547__endTimestamp 09:03:02 INFO - 2015-11-26 09:03:02,552 DEBUG : BROWSER_OUTPUT: 09:03:02 INFO - 2015-11-26 09:03:02,553 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:03:02 INFO - 2015-11-26 09:03:02,553 DEBUG : BROWSER_OUTPUT: Number of tests: 14 09:03:02 INFO - 2015-11-26 09:03:02,553 DEBUG : BROWSER_OUTPUT: 09:03:02 INFO - 2015-11-26 09:03:02,553 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:122.60 Median:123.00 stddev:4.55 (3.7%) stddev-sans-first:4.15 09:03:02 INFO - 2015-11-26 09:03:02,554 DEBUG : BROWSER_OUTPUT: Values: 116.0 115.0 122.0 122.0 129.0 126.0 128.0 124.0 122.0 122.0 09:03:02 INFO - 2015-11-26 09:03:02,554 DEBUG : BROWSER_OUTPUT: 09:03:02 INFO - 2015-11-26 09:03:02,554 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:164.30 Median:172.50 stddev:17.90 (10.4%) stddev-sans-first:18.76 09:03:02 INFO - 2015-11-26 09:03:02,554 DEBUG : BROWSER_OUTPUT: Values: 172.0 150.0 186.0 179.0 142.0 164.0 147.0 188.0 173.0 142.0 09:03:02 INFO - 2015-11-26 09:03:02,554 DEBUG : BROWSER_OUTPUT: 09:03:02 INFO - 2015-11-26 09:03:02,554 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:183.10 Median:182.50 stddev:3.07 (1.7%) stddev-sans-first:3.05 09:03:02 INFO - 2015-11-26 09:03:02,554 DEBUG : BROWSER_OUTPUT: Values: 180.0 182.0 188.0 183.0 181.0 181.0 181.0 181.0 188.0 186.0 09:03:02 INFO - 2015-11-26 09:03:02,555 DEBUG : BROWSER_OUTPUT: 09:03:02 INFO - 2015-11-26 09:03:02,555 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:92.30 Median:80.00 stddev:23.46 (29.3%) stddev-sans-first:24.77 09:03:02 INFO - 2015-11-26 09:03:02,556 DEBUG : BROWSER_OUTPUT: Values: 86.0 91.0 86.0 141.0 77.0 79.0 81.0 78.0 130.0 74.0 09:03:02 INFO - 2015-11-26 09:03:02,556 DEBUG : BROWSER_OUTPUT: 09:03:02 INFO - 2015-11-26 09:03:02,556 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:117.10 Median:145.00 stddev:21.90 (15.1%) stddev-sans-first:23.07 09:03:02 INFO - 2015-11-26 09:03:02,557 DEBUG : BROWSER_OUTPUT: Values: 110.0 112.0 154.0 103.0 103.0 102.0 144.0 99.0 98.0 146.0 09:03:02 INFO - 2015-11-26 09:03:02,557 DEBUG : BROWSER_OUTPUT: 09:03:02 INFO - 2015-11-26 09:03:02,557 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:133.00 Median:134.00 stddev:4.03 (3.0%) stddev-sans-first:4.12 09:03:02 INFO - 2015-11-26 09:03:02,557 DEBUG : BROWSER_OUTPUT: Values: 136.0 130.0 141.0 132.0 130.0 136.0 128.0 135.0 133.0 129.0 09:03:02 INFO - 2015-11-26 09:03:02,557 DEBUG : BROWSER_OUTPUT: 09:03:02 INFO - 2015-11-26 09:03:02,557 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:143.00 Median:144.50 stddev:3.09 (2.1%) stddev-sans-first:2.92 09:03:02 INFO - 2015-11-26 09:03:02,557 DEBUG : BROWSER_OUTPUT: Values: 147.0 145.0 140.0 140.0 146.0 144.0 141.0 140.0 140.0 147.0 09:03:02 INFO - 2015-11-26 09:03:02,557 DEBUG : BROWSER_OUTPUT: 09:03:02 INFO - 2015-11-26 09:03:02,558 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:116.40 Median:117.50 stddev:1.71 (1.5%) stddev-sans-first:1.74 09:03:02 INFO - 2015-11-26 09:03:02,558 DEBUG : BROWSER_OUTPUT: Values: 115.0 118.0 118.0 117.0 115.0 113.0 116.0 118.0 118.0 116.0 09:03:02 INFO - 2015-11-26 09:03:02,558 DEBUG : BROWSER_OUTPUT: 09:03:02 INFO - 2015-11-26 09:03:02,558 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:68.30 Median:69.50 stddev:5.54 (8.0%) stddev-sans-first:4.45 09:03:02 INFO - 2015-11-26 09:03:02,558 DEBUG : BROWSER_OUTPUT: Values: 58.0 65.0 70.0 69.0 70.0 69.0 70.0 80.0 65.0 67.0 09:03:02 INFO - 2015-11-26 09:03:02,558 DEBUG : BROWSER_OUTPUT: 09:03:02 INFO - 2015-11-26 09:03:02,559 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:74.40 Median:74.00 stddev:3.84 (5.2%) stddev-sans-first:3.30 09:03:02 INFO - 2015-11-26 09:03:02,559 DEBUG : BROWSER_OUTPUT: Values: 68.0 73.0 72.0 73.0 73.0 77.0 78.0 75.0 73.0 82.0 09:03:02 INFO - 2015-11-26 09:03:02,559 DEBUG : BROWSER_OUTPUT: 09:03:02 INFO - 2015-11-26 09:03:02,559 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:94.40 Median:93.50 stddev:3.63 (3.9%) stddev-sans-first:3.63 09:03:02 INFO - 2015-11-26 09:03:02,559 DEBUG : BROWSER_OUTPUT: Values: 91.0 92.0 94.0 97.0 96.0 90.0 93.0 92.0 97.0 102.0 09:03:02 INFO - 2015-11-26 09:03:02,560 DEBUG : BROWSER_OUTPUT: 09:03:02 INFO - 2015-11-26 09:03:02,560 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:141.20 Median:142.00 stddev:4.80 (3.4%) stddev-sans-first:4.71 09:03:02 INFO - 2015-11-26 09:03:02,560 DEBUG : BROWSER_OUTPUT: Values: 136.0 147.0 148.0 139.0 136.0 136.0 147.0 139.0 141.0 143.0 09:03:02 INFO - 2015-11-26 09:03:02,560 DEBUG : BROWSER_OUTPUT: 09:03:02 INFO - 2015-11-26 09:03:02,560 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.90 Median:162.00 stddev:5.99 (3.7%) stddev-sans-first:6.34 09:03:02 INFO - 2015-11-26 09:03:02,560 DEBUG : BROWSER_OUTPUT: Values: 162.0 154.0 162.0 166.0 168.0 161.0 159.0 149.0 160.0 168.0 09:03:02 INFO - 2015-11-26 09:03:02,560 DEBUG : BROWSER_OUTPUT: 09:03:02 INFO - 2015-11-26 09:03:02,562 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.90 Median:76.50 stddev:2.56 (3.3%) stddev-sans-first:2.01 09:03:02 INFO - 2015-11-26 09:03:02,562 DEBUG : BROWSER_OUTPUT: Values: 72.0 76.0 76.0 76.0 81.0 79.0 80.0 77.0 76.0 76.0 09:03:02 INFO - 2015-11-26 09:03:02,562 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:03:02 INFO - 2015-11-26 09:03:02,562 DEBUG : BROWSER_OUTPUT: 09:03:03 INFO - 2015-11-26 09:03:03,231 INFO : Browser exited with error code: 0 09:03:03 INFO - 2015-11-26 09:03:03,286 INFO : Completed test kraken (00:01:00) 09:03:03 INFO - 2015-11-26 09:03:03,286 INFO : Starting test v8_7 09:03:03 INFO - 2015-11-26 09:03:03,286 DEBUG : operating with platform_type : mac_ 09:03:03 INFO - 2015-11-26 09:03:03,286 INFO : Initialising browser for v8_7 test... 09:03:03 INFO - 2015-11-26 09:03:03,301 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/tmpm4GEpc/profile http://localhost:49626/getInfo.html 09:03:05 INFO - 2015-11-26 09:03:05,630 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:03:05 INFO - 2015-11-26 09:03:05,630 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:03:05 INFO - 2015-11-26 09:03:05,630 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 09:03:05 INFO - 2015-11-26 09:03:05,630 DEBUG : BROWSER_OUTPUT: __metrics 09:03:05 INFO - 2015-11-26 09:03:05,646 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:03:06 INFO - 2015-11-26 09:03:06,385 INFO : Browser initialized. 09:03:06 INFO - 2015-11-26 09:03:06,386 INFO : Running cycle 1/1 for v8_7 test... 09:03:06 INFO - 2015-11-26 09:03:06,386 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/T/tmpm4GEpc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:03:18 INFO - 2015-11-26 09:03:18,355 DEBUG : BROWSER_OUTPUT: RSS: Main: 198856704 09:03:18 INFO - 2015-11-26 09:03:18,356 DEBUG : BROWSER_OUTPUT: 09:03:41 INFO - 2015-11-26 09:03:41,224 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49626/tests/v8_7/run.html (next: http://localhost:49626/tests/v8_7/run.html) 09:03:41 INFO - 2015-11-26 09:03:41,482 DEBUG : BROWSER_OUTPUT: RSS: Main: 514056192 09:03:41 INFO - 2015-11-26 09:03:41,482 DEBUG : BROWSER_OUTPUT: 09:03:41 INFO - 2015-11-26 09:03:41,482 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:03:41 INFO - 2015-11-26 09:03:41,482 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:03:41 INFO - 2015-11-26 09:03:41,482 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:03:41 INFO - 2015-11-26 09:03:41,482 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:03:41 INFO - 2015-11-26 09:03:41,483 DEBUG : BROWSER_OUTPUT: |0;Richards;186.88095683049897 09:03:41 INFO - 2015-11-26 09:03:41,483 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;205.67667626491155 09:03:41 INFO - 2015-11-26 09:03:41,483 DEBUG : BROWSER_OUTPUT: |2;Encrypt;363.7686431429611 09:03:41 INFO - 2015-11-26 09:03:41,483 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6562.091503267974 09:03:41 INFO - 2015-11-26 09:03:41,483 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1150.7479861910242 09:03:41 INFO - 2015-11-26 09:03:41,483 DEBUG : BROWSER_OUTPUT: |5;Earley;775.7951900698216 09:03:41 INFO - 2015-11-26 09:03:41,483 DEBUG : BROWSER_OUTPUT: |6;Boyer;14357.142857142857 09:03:41 INFO - 2015-11-26 09:03:41,483 DEBUG : BROWSER_OUTPUT: |7;RegExp;33112.903225806454 09:03:41 INFO - 2015-11-26 09:03:41,484 DEBUG : BROWSER_OUTPUT: |8;Splay;666.2225183211193 09:03:41 INFO - 2015-11-26 09:03:41,484 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6451.612903225807 09:03:41 INFO - 2015-11-26 09:03:41,484 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:03:41 INFO - 2015-11-26 09:03:41,484 DEBUG : BROWSER_OUTPUT: __startTimestamp1448557421476__endTimestamp 09:03:41 INFO - 2015-11-26 09:03:41,484 DEBUG : BROWSER_OUTPUT: 09:03:41 INFO - 2015-11-26 09:03:41,484 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:03:41 INFO - 2015-11-26 09:03:41,484 DEBUG : BROWSER_OUTPUT: Number of tests: 10 09:03:41 INFO - 2015-11-26 09:03:41,485 DEBUG : BROWSER_OUTPUT: 09:03:41 INFO - 2015-11-26 09:03:41,485 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:186.88 Median:186.88 stddev:0.00 (0.0%) 09:03:41 INFO - 2015-11-26 09:03:41,485 DEBUG : BROWSER_OUTPUT: Values: 186.9 09:03:41 INFO - 2015-11-26 09:03:41,485 DEBUG : BROWSER_OUTPUT: 09:03:41 INFO - 2015-11-26 09:03:41,485 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:205.68 Median:205.68 stddev:0.00 (0.0%) 09:03:41 INFO - 2015-11-26 09:03:41,485 DEBUG : BROWSER_OUTPUT: Values: 205.7 09:03:41 INFO - 2015-11-26 09:03:41,485 DEBUG : BROWSER_OUTPUT: 09:03:41 INFO - 2015-11-26 09:03:41,485 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:363.77 Median:363.77 stddev:0.00 (0.0%) 09:03:41 INFO - 2015-11-26 09:03:41,486 DEBUG : BROWSER_OUTPUT: Values: 363.8 09:03:41 INFO - 2015-11-26 09:03:41,486 DEBUG : BROWSER_OUTPUT: 09:03:41 INFO - 2015-11-26 09:03:41,486 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6562.09 Median:6562.09 stddev:0.00 (0.0%) 09:03:41 INFO - 2015-11-26 09:03:41,486 DEBUG : BROWSER_OUTPUT: Values: 6562.1 09:03:41 INFO - 2015-11-26 09:03:41,486 DEBUG : BROWSER_OUTPUT: 09:03:41 INFO - 2015-11-26 09:03:41,486 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1150.75 Median:1150.75 stddev:0.00 (0.0%) 09:03:41 INFO - 2015-11-26 09:03:41,486 DEBUG : BROWSER_OUTPUT: Values: 1150.7 09:03:41 INFO - 2015-11-26 09:03:41,486 DEBUG : BROWSER_OUTPUT: 09:03:41 INFO - 2015-11-26 09:03:41,487 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:775.80 Median:775.80 stddev:0.00 (0.0%) 09:03:41 INFO - 2015-11-26 09:03:41,487 DEBUG : BROWSER_OUTPUT: Values: 775.8 09:03:41 INFO - 2015-11-26 09:03:41,487 DEBUG : BROWSER_OUTPUT: 09:03:41 INFO - 2015-11-26 09:03:41,487 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:14357.14 Median:14357.14 stddev:0.00 (0.0%) 09:03:41 INFO - 2015-11-26 09:03:41,487 DEBUG : BROWSER_OUTPUT: Values: 14357.1 09:03:41 INFO - 2015-11-26 09:03:41,487 DEBUG : BROWSER_OUTPUT: 09:03:41 INFO - 2015-11-26 09:03:41,487 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:33112.90 Median:33112.90 stddev:0.00 (0.0%) 09:03:41 INFO - 2015-11-26 09:03:41,488 DEBUG : BROWSER_OUTPUT: Values: 33112.9 09:03:41 INFO - 2015-11-26 09:03:41,488 DEBUG : BROWSER_OUTPUT: 09:03:41 INFO - 2015-11-26 09:03:41,488 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:666.22 Median:666.22 stddev:0.00 (0.0%) 09:03:41 INFO - 2015-11-26 09:03:41,488 DEBUG : BROWSER_OUTPUT: Values: 666.2 09:03:41 INFO - 2015-11-26 09:03:41,488 DEBUG : BROWSER_OUTPUT: 09:03:41 INFO - 2015-11-26 09:03:41,488 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6451.61 Median:6451.61 stddev:0.00 (0.0%) 09:03:41 INFO - 2015-11-26 09:03:41,489 DEBUG : BROWSER_OUTPUT: Values: 6451.6 09:03:41 INFO - 2015-11-26 09:03:41,489 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:03:41 INFO - 2015-11-26 09:03:41,489 DEBUG : BROWSER_OUTPUT: 09:03:42 INFO - 2015-11-26 09:03:42,145 INFO : Browser exited with error code: 0 09:03:42 INFO - 2015-11-26 09:03:42,168 INFO : Completed test v8_7 (00:00:38) 09:03:42 INFO - 2015-11-26 09:03:42,187 INFO : Completed test suite (00:20:14) 09:03:42 INFO - 2015-11-26 09:03:42,187 DEBUG : Working with test: dromaeo_css 09:03:42 INFO - 2015-11-26 09:03:42,187 DEBUG : Generating results file: dromaeo_css 09:03:42 INFO - 2015-11-26 09:03:42,188 DEBUG : Working with test: kraken 09:03:42 INFO - 2015-11-26 09:03:42,188 DEBUG : Generating results file: kraken 09:03:42 INFO - 2015-11-26 09:03:42,188 INFO : javascript benchmark 09:03:42 INFO - 2015-11-26 09:03:42,188 DEBUG : Working with test: v8_7 09:03:42 INFO - 2015-11-26 09:03:42,188 DEBUG : Generating results file: v8_7 09:03:42 INFO - 2015-11-26 09:03:42,189 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:03:42 INFO - 2015-11-26 09:03:42,246 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,55]] 09:03:42 INFO - 2015-11-26 09:03:42,246 DEBUG : process_Request line: dromaeo_css 6063.33 graph.html#tests=[[72,52,55]] 09:03:42 INFO - 2015-11-26 09:03:42,246 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:03:42 INFO - 2015-11-26 09:03:42,278 DEBUG : process_Request line: kraken 1687.90 graph.html#tests=[[232,52,55]] 09:03:42 INFO - 2015-11-26 09:03:42,279 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:03:42 INFO - 2015-11-26 09:03:42,312 DEBUG : process_Request line: v8_7 18096.09 graph.html#tests=[[230,52,55]] 09:03:42 INFO - 2015-11-26 09:03:42,313 INFO : javascript benchmark 09:03:42 INFO - 2015-11-26 09:03:42,315 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [310.4783962942256, 315.20725375680166, 319.7617774757806, 319.9440097982853, 324.1135494422754, 13293.135946163517, 13760.862391376084, 15387.230638468074, 15920.442784502544, 15958.441454549078, 13675.794863077062, 15748.13385263813, 16893.324267029304, 17311.22099505522, 17515.562110947234, 4325.610695037446, 4451.043025749464, 4455.175792478386, 4465.888352791174, 4793.44875339337, 3245.7403407727325, 3305.7190138838228, 4334.0, 4472.0, 4475.798589063484, 4352.7605981670995, 4407.030453300269, 4414.690971631987, 4417.138657961698, 4424.2921132618785, 4289.335153051282, 4352.36890650857, 4373.934390984138, 4399.362092496586, 4454.10917816438, 3751.437284407361, 3761.9811900940595, 3766.2467506498538, 3792.7345085844004, 3801.0, 11898.58354957581, 12045.698857528545, 12267.815982760265, 12363.320017399039, 12399.566015189424, 1797.0655259265109, 1820.5357633803296, 1841.5212044868297, 1865.7201419787004, 1932.9710054349196, 8315.708950186714, 8509.574521273911, 8780.517071561126, 8972.371933964625, 9106.499142547158, 1401.565514690439, 1408.802767612535, 1425.2090090000045, 1432.4771458417706, 1441.7116576684705, 53823.19265211025, 55242.72378638121, 56020.79871455158, 56169.43830561683, 56391.43608563944, 6072.544559158081, 6101.206843110367, 6122.5408094392205, 6147.815565533041, 6195.411435913581, 6986.021956926034, 6994.545354551938, 7023.473239507058, 7089.858202835914, 7091.25541818112, 5169.844904652867, 5190.065788158167, 5239.1093514102695, 5279.41926388097, 5280.0, 5555.2778138841695, 5571.192177134293, 5604.85987850307, 5687.459691329317, 5689.0, 2715.592661100851, 2775.9444811103663, 2782.0680072176046, 2786.958195627067, 2813.606095146681, 965.6330594374093, 968.8692026576463, 970.8737864077766, 1007.6422869881234, 1034.374203606807, 357.8675889920746, 392.3428257668451, 400.4193918817668, 417.93522004089414, 428.0347815675694, 10237.641682541076, 10564.785049719381, 10649.0, 10751.731206719895, 10822.458877056115, 402.74224496322375, 413.54303494638594, 414.6993429763397, 433.89369604447114, 446.28371463800784, 5780.797672081541, 5888.440598143169, 5891.764329426861, 5948.405159484104, 5958.940410595926, 508105.0, 514092.0, 516967.0, 538774.0, 538935.0, 68282.3171768276, 69309.30690693129, 69335.65332173408, 69468.0, 70725.0, 469.5797261450982, 469.75572702194665, 470.6305550143121, 473.2073776424544, 475.0664943386263, 10217.74455638615, 10231.641892533726, 10264.281500294908, 10278.126359259546, 10388.688339349832, 31002.0, 32268.838655806572, 32790.83604581962, 33379.165520862174, 33517.83241083779, 42913.14173716446, 43276.78361608172, 43633.56366436295, 44215.11569768522, 44265.77867110644, 5723.742431590672, 5838.591298609226, 5855.795047173328, 5893.616914900518, 5900.70496475166, 10953.397563134104, 10958.287711299059, 10972.561097556327, 11172.553097875994, 11175.664730058112, 9343.0, 9470.195033422237, 9551.283653725859, 9645.180159686504, 9674.951625241829, 9133.178013978773, 9254.676086336945, 9286.535673216176, 9319.16127548524, 9498.382605130644, 9472.100150485692, 9484.146426821619, 9518.809623807623, 9718.271129665161, 9809.117179453884, 5754.338251101177, 5808.883822323445, 5817.76728930838, 5828.271466066742, 5837.328707198726, 8944.150305720947, 9137.360384773003, 9530.0, 9533.666321678707, 9548.809023819624], "dojo.html": [2839.971600283997, 2921.4741346557616, 2944.4552757739807, 2964.584958105864, 2992.8802847886086, 4886.755662216889, 4951.108800415924, 4995.725235112068, 5001.44984051754, 5010.048090862742, 4957.0, 4977.377827771528, 4996.125678006343, 5005.274235235897, 5113.795448182068, 4394.560543945612, 4519.819207231707, 4533.637309015287, 4556.886077848064, 4634.72191668501, 4428.31361139024, 4432.977835110836, 4439.045605194882, 4441.422615060038, 4478.03722199727, 4472.977635111836, 4493.595576398124, 4521.683482156251, 4532.864014079566, 4537.954620453786, 4361.6292615127595, 4406.977965110186, 4477.753723545187, 4493.977530112328, 4523.3667286579575, 4459.0, 4475.910481790378, 4515.480719717241, 4532.546745325441, 4544.500104988449, 4686.203345431285, 4813.470518242991, 4827.565519103297, 4875.609951203895, 4882.048000639877, 5120.667156634844, 5122.103631864409, 5212.817551385721, 5246.23929530216, 5305.73471326436, 5272.156454967187, 5303.655262407931, 5304.389995150568, 5305.1776974569, 5363.141897296453, 4697.7651117444675, 4697.859064228079, 4956.702597844141, 5027.4721154279005, 5038.5969122470115, 5313.256144139824, 5343.278657381204, 5380.704061276668, 5441.020616289027, 5457.699826509501, 5125.666831655931, 5189.325387699575, 5200.6619569727845, 5232.790688372498, 5262.578993680497, 4866.829660961849, 4935.90128197434, 5332.893342133136, 5350.30446042012, 5391.676499410048, 5026.949730502722, 5137.614678899097, 5149.098907691139, 5202.73986300691, 5203.297554830049, 5183.429822719498, 5198.662086964335, 5202.375714914235, 5208.062548741187, 5309.309789727311, 3867.61323867611, 3951.624595663465, 4058.8985275367763, 4078.8368465261055, 4107.137501124737, 3625.4561815727325, 3628.165521929971, 3707.3882809336155, 3717.8326975285636, 3763.7741735495956, 4926.433460152057, 4929.285253638274, 4964.15609346412, 4965.255211718271, 4981.37732783402, 5138.58891288696, 5292.497212764782, 5363.919541206885, 5376.892462150813, 5379.35447746273, 4741.170295198395, 4749.335093086971, 4834.661573689808, 4847.297141914473, 4880.341153944172, 4501.932471012938, 4598.793054312564, 4605.148047611203, 4605.355250264965, 4631.861044168681, 5092.0579692756955, 5142.254373115952, 5261.89476210466, 5277.551408130275, 5279.47205279469, 5191.662541934762, 5192.1952097424955, 5258.1849813279005, 5266.394364648115, 5285.180796976475, 5389.0299746046085, 5391.083515802401, 5407.0537655909275, 5415.025295446857, 5471.179323101566, 4843.854684359475, 5068.189089745623, 5322.042032434199, 5343.839684809462, 5346.518813306821, 5009.5992320615, 5083.085044691843, 5101.362329708786, 5154.484551544815, 5178.171492561172, 5117.5905927526455, 5151.304573882478, 5175.611829112756, 5234.424213336454, 5242.9475705243985, 4926.113299606105, 5100.795968161232, 5147.768350424315, 5168.560672342893, 5198.194279886624, 4895.828645997373, 4974.427940786856, 4998.225275082223, 5005.224190250517, 5081.644284900021, 5089.0, 5184.326037615086, 5198.116320225495, 5244.580433565382, 5245.7114858683135, 4953.380827396575, 5019.84940451787, 5067.569256613229, 5071.315372424676, 5138.049460849606], "mootools.html": [1318.4857905416895, 1341.2489006156552, 1441.5675297410774, 1608.3888122513442, 1696.2366934879308, 6425.51808614354, 6674.132362792836, 6949.409300209482, 7153.391961683264, 7191.748288809893, 6921.377076063153, 7074.823129421767, 7076.433885289177, 7088.184858741246, 7148.928510714892, 1998.1507859159835, 2015.768186658531, 2016.0323044938439, 2020.0606717876185, 2020.3433883987689, 1998.420458067166, 2018.8082132197417, 2028.127905000849, 2028.563858770364, 2032.1363420546284, 1971.1721077147633, 2000.5698774763423, 2012.3962811156669, 2012.567298030923, 2012.667909794882, 2028.8478364122675, 2040.6224848402944, 2041.030510507512, 2045.457953642286, 2052.8152466278034, 1925.4416219296527, 1946.9415917522497, 1951.6487032334173, 1952.8535359847926, 1953.0332485419667, 6229.190205273331, 6991.650417479105, 7024.262452442522, 7044.0, 7047.612381319025, 3952.426898099788, 4275.508316543606, 4339.544347843463, 4383.561643835591, 4410.4707435107675, 2593.1572239022394, 2595.3252154439792, 2637.3802156493207, 2655.575107982733, 2666.9066582669707, 729.267086577991, 743.22333161846, 743.5204293230889, 748.3751067858291, 754.3135746470685, 8680.262177714902, 8696.086910874394, 8776.210141087333, 8811.471311721318, 8818.250448711868, 3738.27103714773, 3781.4327850822046, 3800.3539398302355, 3802.752821066622, 3891.1828516011956, 7684.769456916301, 7730.188330225358, 7737.767866964, 7773.533587984626, 7819.413543984224, 4188.958110418856, 4197.223513649985, 4205.915881682349, 4208.558101399371, 4237.0466645005245, 3836.8081595920094, 3839.212961342918, 3844.115853353688, 3882.9805850970565, 3915.804209789499, 3251.4797632378704, 3253.3168034712503, 3330.467125259947, 3332.616749073839, 3336.5495658086334, 1027.530631197395, 1043.7547176413536, 1051.090806452413, 1051.5636011055478, 1056.5404049238605, 1162.0, 1193.6777070191, 1215.3801561203672, 1246.7257203415234, 1247.5758242197696, 6760.763373281911, 6788.558743681645, 6798.66006699663, 6799.082123913208, 7019.824504387431, 1032.6179313653995, 1035.6582327831798, 1046.529061922138, 1067.64767626683, 1089.1178145702006, 4830.565249127595, 5382.515573598395, 5451.781928722886, 5453.700046497402, 5464.644798088191, 7784.338331241795, 8249.257566819015, 8403.663853445916, 8428.199321064489, 8458.0, 8168.856360109589, 8220.8355832883, 8288.58557072156, 8325.625346859406, 8348.290395316344, 6484.805455836333, 6698.564593301518, 6700.296468870796, 6708.060871477997, 6737.9326206737305, 6619.635920024445, 6627.37039981201, 6656.667166641745, 6685.164354455693, 6707.966460167863, 7446.627668616656, 7587.468877178544, 7592.240775922363, 7607.391408687181, 7607.4674772765375, 7403.962980185064, 7564.810879728051, 7594.278543538355, 7594.5063570867715, 7646.197149299466, 5999.970000149971, 6206.875862482635, 6265.655388953652, 6314.968425157845, 6315.652639104894, 6785.287544807921, 6880.827979300358, 6889.931100688929, 6892.689828957809, 6906.516543842084, 6124.54065945047, 6404.359564043559, 6407.263164736115, 6409.262934762562, 6443.516736244894, 6230.190075290183, 6235.781747638811, 6285.49716022708, 6371.713272902638, 6388.712507937247, 6447.387498187664, 6458.031295305554, 6490.643014634241, 6506.60960342381, 6521.608703477807, 5642.322921249476, 5654.40628733977, 5673.971630141823, 5720.971395142998, 5729.341125770423, 5718.370979192368, 5758.193852860519, 5765.250517432707, 5781.364049954585, 5788.681622510802], "ext.html": [506.0461030956647, 516.2540129512853, 521.658313804458, 530.8725905782613, 566.0603398358728, 24227.515449690996, 24758.009679612816, 33131.50302745458, 33569.664303356956, 33856.830715846445, 38700.612993870054, 39264.0, 39470.40794388086, 39502.60497395032, 39517.802410987904, 7652.273034061783, 8246.67013319468, 8350.624221909999, 8374.916250837505, 8466.068732439428, 7830.530168189898, 9924.206063514937, 10214.744631384201, 10218.897811021869, 10252.23108266883, 9904.306698531105, 9992.95003524985, 10050.648227312045, 10062.39625622465, 10088.546015429323, 7922.168172341936, 8022.839543209161, 9930.50347482623, 9939.105480506752, 10036.447995360253, 9799.510024498746, 9868.802623947553, 9966.451845148515, 9989.350692205056, 10023.899761002442, 36240.0, 36393.81803090994, 36778.08054798625, 36794.08014799625, 36863.63136368629, 2682.865856707157, 2854.9714502854913, 2965.8368789716774, 3017.230606195428, 3174.6666600006897, 24127.87936060326, 24316.513669726508, 24652.876735616388, 25217.0, 25527.489450211076, 1991.0, 2016.3043749906258, 2075.1180748181964, 2094.4240333908147, 2151.924682636116, 251189.0, 252752.0, 254355.0, 255169.0, 256814.0, 56705.432945670844, 56751.43248567462, 56771.43228567744, 57383.0, 57422.425775742544, 52880.73559632177, 53333.466665333624, 53657.463425366026, 53864.461355385945, 53995.73002134964, 15262.542123736306, 15417.691646167013, 15587.532374028797, 15607.297671604805, 15637.921810391103, 11829.822552661717, 11878.109141814226, 11892.762144757056, 11931.821022684493, 12034.578789742318, 19012.714809277873, 19266.422007339803, 19468.22127114928, 19477.12352944121, 19512.609747805247, 8068.354531637455, 8254.133316001853, 8308.335333173332, 8420.873686894702, 8424.620892059873, 936.4989730494153, 982.0866594067586, 1003.4531180506641, 1034.5861655337774, 1049.3284298049255, 26251.73748262493, 26471.47057058848, 26517.0, 26667.466650666876, 26711.599326010124, 887.3211992825494, 976.6679329028165, 1010.7877345757327, 1033.788073444942, 1089.6077412131626, 12706.30115343665, 13081.738365232643, 13160.802587961189, 13323.600291991255, 13326.733465330639, 292988.0, 299452.0, 301314.0, 301600.0, 301705.0, 51177.74411127921, 51641.0, 51803.7409812956, 52043.219351709755, 52191.73904130455, 1299.5191779041627, 1322.8743269389392, 1328.3291937571657, 1341.6377578053675, 1341.8255626768653, 25347.366315842253, 25454.0, 26363.0, 26556.336091597863, 26687.0, 44719.776401117786, 45159.54840451553, 45175.0, 45235.54764452313, 45321.320180196664, 236242.0, 245835.0, 269619.0, 271403.0, 391247.0, 29304.26739331534, 29503.0, 30283.848580757836, 30417.0, 30826.38347232998, 37331.6266837339, 38636.420453693776, 38925.0, 39141.60858391494, 39770.40344394894, 32054.358912821146, 32167.51748723818, 33582.49626255657, 33761.15597110092, 33915.32169356648, 32766.83616581902, 32781.344373111926, 33092.0, 33106.83446582752, 33526.497102543966, 33585.0, 33937.49093763546, 34110.68985617026, 34129.31741365208, 34463.65536344604, 28443.0, 29792.55311170291, 29974.25064373408, 31496.527552086278, 32578.0, 22516.32451026472, 22607.09571617117, 22951.31146065621, 22988.540229195656, 23056.884715576314], "prototype.html": [291.62817407805045, 294.9513330300501, 298.81174859838296, 302.34693062983945, 305.3922693839261, 5419.07875661137, 5489.258950041743, 5503.642263252886, 5528.336599608043, 5635.520980716634, 5440.211169380447, 5500.5874559408, 5503.257060296859, 5512.118061110213, 5554.777808887639, 4024.6377825995655, 4059.04612416082, 4118.279301122307, 4152.335626299778, 4160.667146628262, 4090.427340172378, 4105.733127346728, 4176.916461670765, 4189.266878296301, 4200.05498762779, 4115.156392939441, 4124.463819703449, 4126.071633882382, 4139.7309174903685, 4164.521080075785, 4006.1787333596544, 4042.8787136385954, 4063.1467391847746, 4119.2997190477845, 4162.771047592381, 3556.6621170988715, 3576.5529308836394, 3582.5163602913794, 3582.7492075554724, 3582.8208589570677, 5282.867928301785, 5288.973555132238, 5315.202719592054, 5318.388385335697, 5379.865503362408, 4588.977055114737, 4710.576048155648, 4726.007538416937, 4737.24204127338, 4758.095961767253, 5515.062439385314, 5710.77156913723, 5716.714164291769, 5737.454941780524, 5844.386339434341, 3794.5067141271734, 3883.650471457582, 3887.378019516864, 3927.5876033016407, 3948.4077388391684, 5938.8218353449465, 5964.522838172936, 5980.970095149496, 5998.430149135826, 6053.788117415869, 3851.768893866377, 3854.2869569129803, 3872.1287710264965, 3877.806109694504, 3884.9704828220542, 3773.5660399053913, 3905.258000979805, 3937.1928754605237, 3940.1528671335227, 3989.7805620691142, 4696.8590942271785, 4699.483056863743, 4723.716577005391, 4726.976365118152, 4763.833265835679, 5740.311162660508, 5774.307083150049, 5797.710114494258, 5832.387599302097, 5848.035074212792, 1435.1532595768547, 1441.9062760920506, 1442.4662874736205, 1458.431211827388, 1466.8753155981647, 916.5005072235648, 921.203159267229, 929.6327950459531, 940.4780346907532, 948.9335746497679, 5419.187121931663, 5447.727613619303, 5463.699496527729, 5488.7530061147345, 5488.862778430571, 6035.66803825785, 6041.5468839837185, 6057.939420605738, 6070.089486576961, 6100.450959413674, 5452.863678408072, 5459.672419654833, 5465.59008074396, 5473.589480788957, 5485.369182544058, 3215.8552865121123, 3215.887443939451, 3278.508223766454, 3325.8669653214083, 3353.8826141084946, 5938.435848594377, 5991.101334799815, 5997.0404735242155, 6001.339852616209, 6099.725512351954, 6129.325774164839, 6129.785457508966, 6158.507319414436, 6171.043488259327, 6216.378362163748, 5809.76760929575, 5993.520518358521, 6000.21997140369, 6010.0, 6059.424354686298, 5994.490468310068, 5997.730102145327, 6057.515398768176, 6094.451499365078, 6151.2618485781995, 5959.195508606283, 5961.8807623846415, 5980.9401905980385, 6023.0, 6035.818925432244, 6084.452399284086, 6104.572679912363, 6111.022236442148, 6131.386861314011, 6163.722632481638, 3764.0213544478083, 3796.0699628591174, 3797.145642230476, 3800.5629352623696, 3836.501254836853, 6036.456718895321, 6053.697315134137, 6068.241469816273, 6084.361142080018, 6119.204503414706, 5913.231279933581, 5917.230760001173, 5930.525557955267, 5939.495142912728, 5962.25471816023, 5768.653880767168, 5898.292204935436, 5907.85230369227, 5930.733117009831, 5953.047512397996, 5751.482366587027, 5753.827385178452, 5796.42035796417, 5809.2738407699035, 5814.360420353673, 5921.467067963904, 5922.052471604523, 5923.881522369615, 5963.135345374983, 5964.433378829004, 5625.071863142699, 5777.884442311214, 5789.913151302818, 5790.652560846363, 5839.591228613956], "yui.html": [641.3202005873773, 648.2965981909631, 668.2348710726221, 702.0452185028362, 716.7286245353159, 11611.0, 11976.461059252333, 12000.459979300931, 12059.33673647949, 12062.0953428493, 12232.694182645439, 12321.630351089481, 12353.320567368813, 12369.206465062583, 12422.130450868442, 677.5223467455432, 703.4021082080242, 827.9213474719907, 833.5457175839182, 846.6571038729325, 836.7698882807216, 837.7235512280932, 849.1550906847664, 849.8555245608261, 850.5152063323908, 832.7501749475164, 879.0462348352046, 889.4174315823146, 890.1676932068536, 891.6299735609714, 694.586720901063, 711.8611870685193, 859.9871001934976, 880.903100658927, 883.2624758326805, 652.9673516324165, 655.1679367203673, 655.187567416405, 662.020210089066, 663.0683889135772, 10719.088877445427, 10874.891251087545, 10997.12023038155, 10999.560017599286, 11004.834927476095, 10326.948365258126, 10966.725831854268, 10983.231173817836, 11198.104151667847, 11259.268147570463, 8278.503289802631, 8524.360672949553, 8583.957080214559, 8679.739607811776, 8713.215810577078, 2346.7301260354934, 2868.899588514392, 2952.2471769698805, 3007.6992300769966, 3043.802152860057, 43846.0, 44423.111537769066, 44555.33167002498, 44640.3303950441, 46269.305960410624, 8360.856846277276, 8376.371772117116, 8414.410991230556, 8463.280621147149, 8494.957525212334, 18064.36774712905, 18083.0, 18089.7286540702, 18108.366207182684, 18126.818731812513, 6303.054541818764, 6425.132607098076, 6461.095446637474, 6584.736610535525, 6637.137172167684, 3362.7309815214726, 3442.242706604543, 3455.032590874559, 3465.3069386122875, 3478.043538027063, 2505.8496490210646, 2539.2255362114365, 2540.7586279303437, 2541.580639194512, 2546.1343143330987, 372.6124830176586, 376.5951602027831, 380.36099353086524, 385.1795675211837, 388.56868875548116, 492.99597137635396, 500.51950127876916, 502.09288221199574, 503.8513638476658, 512.0808149371886, 6465.515086368541, 6501.154849869581, 6594.571352862049, 6646.169228846395, 6741.797746067626, 382.7512117123836, 428.04332317270877, 485.08561361832494, 505.4793562630496, 528.1654985123496, 3094.535819627074, 3273.2307907641684, 3345.6654334566347, 3353.7652364334263, 3386.390449719025, 56780.71609641925, 56831.43168568344, 56872.146917796264, 57284.14073788896, 57398.0, 48050.759746201045, 48555.02889942252, 48776.0, 48857.0, 48875.266870996966, 43194.352084718754, 43371.34942975858, 43599.34600980988, 44650.33024504635, 44957.775211123735, 6583.177102862142, 6593.604383736991, 6651.634160121046, 6714.697838597177, 6813.1142951415995, 31146.065618031495, 31723.84138079295, 32719.18202044968, 32721.509177362834, 32781.180470487474, 41523.58476415318, 41740.1651966965, 41836.790816046945, 42100.0, 43389.349159761994, 7087.929120708727, 7148.0, 7168.928310716826, 7181.964090179516, 7344.596047217455, 9974.351667141613, 10200.642977495752, 10230.181585473294, 10342.32774869631, 10442.112420444348, 9213.262938964732, 9284.767880803034, 9313.068693130634, 9467.715968520955, 9758.0, 9352.205062569758, 9796.65711700087, 9880.950595246977, 9976.700698979042, 10506.632267870587, 9133.360664753403, 9433.056694330511, 9632.614695412105, 9720.951395242979, 10210.336328138646, 7929.207079292255, 7971.800704982422, 8159.8776018358585, 8221.465604735673, 8302.377321700777, 7777.496739124981, 7788.143304236416, 8308.626111825104, 8398.866153069257, 8466.534340611326]}, "summary": {"suite": 6063.334615640769, "subtests": {"jquery.html": {"filtered": 6242.400830706738, "value": 6242.400830706738}, "dojo.html": {"filtered": 4837.829563915933, "value": 4837.829563915933}, "mootools.html": {"filtered": 4020.956045384373, "value": 4020.956045384373}, "ext.html": {"filtered": 17350.8101911402, "value": 17350.8101911402}, "prototype.html": {"filtered": 4328.130274080454, "value": 4328.130274080454}, "yui.html": {"filtered": 5448.4746060479665, "value": 5448.4746060479665}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0032"}, "testrun": {"date": 1448556207, "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": "20151126064410", "branch": "Mozilla-Aurora", "revision": "1624a69d46d7d711c6a3abfdfb604989baf70ac9"}}, {"talos_counters": {}, "results": {"audio-dft": [180.0, 182.0, 188.0, 183.0, 181.0, 181.0, 181.0, 181.0, 188.0, 186.0], "ai-astar": [116.0, 115.0, 122.0, 122.0, 129.0, 126.0, 128.0, 124.0, 122.0, 122.0], "imaging-gaussian-blur": [136.0, 130.0, 141.0, 132.0, 130.0, 136.0, 128.0, 135.0, 133.0, 129.0], "audio-beat-detection": [172.0, 150.0, 186.0, 179.0, 142.0, 164.0, 147.0, 188.0, 173.0, 142.0], "json-stringify-tinderbox": [68.0, 73.0, 72.0, 73.0, 73.0, 77.0, 78.0, 75.0, 73.0, 82.0], "stanford-crypto-pbkdf2": [162.0, 154.0, 162.0, 166.0, 168.0, 161.0, 159.0, 149.0, 160.0, 168.0], "json-parse-financial": [58.0, 65.0, 70.0, 69.0, 70.0, 69.0, 70.0, 80.0, 65.0, 67.0], "stanford-crypto-sha256-iterative": [72.0, 76.0, 76.0, 76.0, 81.0, 79.0, 80.0, 77.0, 76.0, 76.0], "audio-fft": [86.0, 91.0, 86.0, 141.0, 77.0, 79.0, 81.0, 78.0, 130.0, 74.0], "imaging-darkroom": [147.0, 145.0, 140.0, 140.0, 146.0, 144.0, 141.0, 140.0, 140.0, 147.0], "stanford-crypto-ccm": [136.0, 147.0, 148.0, 139.0, 136.0, 136.0, 147.0, 139.0, 141.0, 143.0], "audio-oscillator": [110.0, 112.0, 154.0, 103.0, 103.0, 102.0, 144.0, 99.0, 98.0, 146.0], "stanford-crypto-aes": [91.0, 92.0, 94.0, 97.0, 96.0, 90.0, 93.0, 92.0, 97.0, 102.0], "imaging-desaturate": [115.0, 118.0, 118.0, 117.0, 115.0, 113.0, 116.0, 118.0, 118.0, 116.0]}, "summary": {"suite": 1687.9000000000003, "subtests": {"audio-fft": {"filtered": 92.3, "value": 92.3}, "stanford-crypto-pbkdf2": {"filtered": 160.9, "value": 160.9}, "audio-beat-detection": {"filtered": 164.3, "value": 164.3}, "stanford-crypto-ccm": {"filtered": 141.2, "value": 141.2}, "imaging-darkroom": {"filtered": 143.0, "value": 143.0}, "json-parse-financial": {"filtered": 68.3, "value": 68.3}, "audio-oscillator": {"filtered": 117.1, "value": 117.1}, "ai-astar": {"filtered": 122.6, "value": 122.6}, "audio-dft": {"filtered": 183.1, "value": 183.1}, "stanford-crypto-sha256-iterative": {"filtered": 76.9, "value": 76.9}, "json-stringify-tinderbox": {"filtered": 74.4, "value": 74.4}, "imaging-gaussian-blur": {"filtered": 133.0, "value": 133.0}, "stanford-crypto-aes": {"filtered": 94.4, "value": 94.4}, "imaging-desaturate": {"filtered": 116.4, "value": 116.4}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0032"}, "testrun": {"date": 1448556207, "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": "20151126064410", "branch": "Mozilla-Aurora", "revision": "1624a69d46d7d711c6a3abfdfb604989baf70ac9"}}, {"talos_counters": {}, "results": {"DeltaBlue": [205.67667626491155], "Encrypt": [363.7686431429611], "NavierStokes": [6451.612903225807], "Decrypt": [6562.091503267974], "Splay": [666.2225183211193], "Richards": [186.88095683049897], "RegExp": [33112.903225806454], "Earley": [775.7951900698216], "Boyer": [14357.142857142857], "RayTrace": [1150.7479861910242]}, "summary": {"suite": 18096.092844657116, "subtests": {"DeltaBlue": {"filtered": 321.46571599999993, "value": 321.46571599999993}, "Encrypt": {"filtered": 731.7315690000003, "value": 731.7315690000003}, "NavierStokes": {"filtered": 230.02, "value": 230.02}, "Decrypt": {"filtered": 40.5634392430279, "value": 40.5634392430279}, "Splay": {"filtered": 122.31799100000005, "value": 122.31799100000005}, "RegExp": {"filtered": 27.511480759863588, "value": 27.511480759863588}, "Richards": {"filtered": 188.9010020000001, "value": 188.9010020000001}, "Earley": {"filtered": 859.0708069999997, "value": 859.0708069999997}, "Boyer": {"filtered": 46.42030845771142, "value": 46.42030845771142}, "RayTrace": {"filtered": 643.0504409999999, "value": 643.0504409999999}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0032"}, "testrun": {"date": 1448556207, "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": "20151126064410", "branch": "Mozilla-Aurora", "revision": "1624a69d46d7d711c6a3abfdfb604989baf70ac9"}}] 09:03:42 INFO - RETURN: dromaeo_css: 6063.33 09:03:42 INFO - RETURN: kraken: 1687.90 09:03:42 INFO - RETURN: v8_7: 18096.09 09:03:42 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,55]]", "result": "18096.09"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,55]]", "result": "1687.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,55]]", "result": "6063.33"}}} 09:03:42 INFO - Return code: 0 09:03:42 INFO - # TBPL SUCCESS # 09:03:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:03:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:03:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:03:42 INFO - 2015-11-26 09:03:42.449 screenresolution[1953:16669] starting screenresolution argv=screenresolution get 09:03:42 INFO - 2015-11-26 09:03:42.452 screenresolution[1953:16669] Display 0: 1600x1200x32@60 09:03:42 INFO - 2015-11-26 09:03:42.459 screenresolution[1954:16672] starting screenresolution argv=screenresolution list 09:03:42 INFO - Available Modes on Display 0 09:03:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:03:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:03:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:03:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:03:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:03:42 INFO - Intel HD Graphics 3000: 09:03:42 INFO - Chipset Model: Intel HD Graphics 3000 09:03:42 INFO - Type: GPU 09:03:42 INFO - Bus: Built-In 09:03:42 INFO - VRAM (Total): 512 MB 09:03:42 INFO - VRAM (Dynamic, Max): 10 09:03:42 INFO - Vendor: Intel (0x8086) 09:03:42 INFO - Device ID: 0x0116 09:03:42 INFO - Revision ID: 0x0009 09:03:42 INFO - Displays: 09:03:42 INFO - Display: 09:03:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:03:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:03:42 INFO - Display Serial Number: 1600x1200 60 09:03:42 INFO - Main Display: Yes 09:03:42 INFO - Mirror: Off 09:03:42 INFO - Online: Yes 09:03:42 INFO - Rotation: Supported 09:03:42 INFO - Return code: 0 09:03:42 INFO - Running post-action listener: _resource_record_post_action 09:03:42 INFO - Running post-run listener: _resource_record_post_run 09:03:43 INFO - Total resource usage - Wall time: 1255s; CPU: 30.0%; Read bytes: 614400; Write bytes: 682677760; Read time: 297; Write time: 51723 09:03:43 INFO - install - Wall time: 40s; CPU: 30.0%; Read bytes: 332448256; Write bytes: 333219840; Read time: 34400; Write time: 4759 09:03:43 INFO - run-tests - Wall time: 1216s; CPU: 30.0%; Read bytes: 606208; Write bytes: 339197440; Read time: 282; Write time: 46576 09:03:43 INFO - Running post-run listener: _upload_blobber_files 09:03:43 INFO - Blob upload gear active. 09:03:43 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 09:03:43 INFO - Copying logs to upload dir... 09:03:43 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1314.598093 ========= master_lag: 3.17 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2015-11-26 09:03:47.044941) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-26 09:03:47.046176) ========= 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.nV0LTZUh3g/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.hvuQ0HU8O2/Listeners TMPDIR=/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/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/WOOimwXkSYuHZgkoPua15Q/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009656 build_url: 'https://queue.taskcluster.net/v1/task/WOOimwXkSYuHZgkoPua15Q/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg' ========= master_lag: 0.44 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-26 09:03:47.491380) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 09:03:47.491756) ========= 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.nV0LTZUh3g/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.hvuQ0HU8O2/Listeners TMPDIR=/var/folders/m3/f3vg2l0n57q227wm_gfkhq1400000w/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.005312 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 09:03:47.541558) ========= ========= Started reboot skipped (results: 3, elapsed: 15 secs) (at 2015-11-26 09:03:47.541895) ========= ========= Finished reboot skipped (results: 3, elapsed: 15 secs) (at 2015-11-26 09:04:03.218243) ========= ========= Total master_lag: 3.78 =========