builder: mozilla-aurora_yosemite_test-dromaeojs slave: t-yosemite-r5-0097 starttime: 1449139601.51 results: success (0) buildid: 20151203004003 builduid: 2b3bc083607149069d5bb35daee29a53 revision: 7aad7dee85151ba464c2a5d5aa9e522bad9287e3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-03 02:46:41.508841) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-03 02:46:41.509411) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 02:46:41.509734) ========= 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.XbnhTwpCSs/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.heTemyE2si/Listeners TMPDIR=/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/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.005573 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 02:46:41.528216) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 02:46:41.528514) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 02:46:41.539253) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 02:46:41.539687) ========= 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.XbnhTwpCSs/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.heTemyE2si/Listeners TMPDIR=/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/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.005365 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 02:46:41.589059) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-03 02:46:41.589352) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-03 02:46:41.589719) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 02:46:41.589998) ========= 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.XbnhTwpCSs/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.heTemyE2si/Listeners TMPDIR=/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False --2015-12-03 02:46:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 12.2M=0.001s 2015-12-03 02:46:41 (12.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.353899 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 02:46:41.955728) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 02:46:41.956209) ========= 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.XbnhTwpCSs/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.heTemyE2si/Listeners TMPDIR=/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/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.019358 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 02:46:42.007706) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 02:46:42.008467) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7aad7dee85151ba464c2a5d5aa9e522bad9287e3 --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 7aad7dee85151ba464c2a5d5aa9e522bad9287e3 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.XbnhTwpCSs/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.heTemyE2si/Listeners TMPDIR=/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 2015-12-03 02:46:42,075 truncating revision to first 12 chars 2015-12-03 02:46:42,075 Setting DEBUG logging. 2015-12-03 02:46:42,075 attempt 1/10 2015-12-03 02:46:42,075 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/7aad7dee8515?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-03 02:46:42,325 unpacking tar archive at: mozilla-aurora-7aad7dee8515/testing/mozharness/ program finished with exit code 0 elapsedTime=0.514505 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 02:46:42.536204) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 02:46:42.536541) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 02:46:42.545359) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-03 02:46:42.545809) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-03 02:46:42.546250) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2015-12-03 02:46:42.546539) ========= /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.XbnhTwpCSs/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.heTemyE2si/Listeners TMPDIR=/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/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 02:46:42 INFO - MultiFileLogger online at 20151203 02:46:42 in /builds/slave/test 02:46:42 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 02:46:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:46:42 INFO - {'append_to_log': False, 02:46:42 INFO - 'base_work_dir': '/builds/slave/test', 02:46:42 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:46:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:46:42 INFO - 'branch': 'Mozilla-Aurora', 02:46:42 INFO - 'buildbot_json_path': 'buildprops.json', 02:46:42 INFO - 'config_files': ('talos/mac_config.py',), 02:46:42 INFO - 'default_actions': ('clobber', 02:46:42 INFO - 'read-buildbot-config', 02:46:42 INFO - 'download-and-extract', 02:46:42 INFO - 'populate-webroot', 02:46:42 INFO - 'create-virtualenv', 02:46:42 INFO - 'install', 02:46:42 INFO - 'run-tests'), 02:46:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:46:42 INFO - 'download_minidump_stackwalk': True, 02:46:42 INFO - 'download_symbols': 'ondemand', 02:46:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:46:42 INFO - 'tooltool.py': '/tools/tooltool.py', 02:46:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:46:42 INFO - '/tools/misc-python/virtualenv.py')}, 02:46:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:46:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:46:42 INFO - 'installer_path': 'installer.exe', 02:46:42 INFO - 'log_level': 'info', 02:46:42 INFO - 'log_name': 'talos', 02:46:42 INFO - 'log_to_console': True, 02:46:42 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:46:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:46:42 INFO - 'opt_config_files': (), 02:46:42 INFO - 'pip_index': False, 02:46:42 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:46:42 INFO - 'cmd': ('bash', 02:46:42 INFO - '-c', 02:46:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:46:42 INFO - 'enabled': True, 02:46:42 INFO - 'halt_on_failure': False, 02:46:42 INFO - 'name': 'check_screen_resolution'},), 02:46:42 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:46:42 INFO - 'cmd': ('bash', 02:46:42 INFO - '-c', 02:46:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:46:42 INFO - 'enabled': True, 02:46:42 INFO - 'halt_on_failure': False, 02:46:42 INFO - 'name': 'check_screen_resolution'},), 02:46:42 INFO - 'run_cmd_checks_enabled': True, 02:46:42 INFO - 'sps_profile': False, 02:46:42 INFO - 'sps_profile_interval': 0, 02:46:42 INFO - 'suite': 'dromaeojs', 02:46:42 INFO - 'system_bits': '64', 02:46:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:46:42 INFO - 'title': 't-yosemite-r5-0097', 02:46:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:46:42 INFO - 'use_talos_json': True, 02:46:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:46:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:46:42 INFO - 'work_dir': 'build'} 02:46:42 INFO - ##### 02:46:42 INFO - ##### Running clobber step. 02:46:42 INFO - ##### 02:46:42 INFO - Running pre-action listener: _resource_record_pre_action 02:46:42 INFO - Running main action method: clobber 02:46:42 INFO - rmtree: /builds/slave/test/build 02:46:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:46:44 INFO - Running post-action listener: _resource_record_post_action 02:46:44 INFO - ##### 02:46:44 INFO - ##### Running read-buildbot-config step. 02:46:44 INFO - ##### 02:46:44 INFO - Running pre-action listener: _resource_record_pre_action 02:46:44 INFO - Running main action method: read_buildbot_config 02:46:44 INFO - Using buildbot properties: 02:46:44 INFO - { 02:46:44 INFO - "properties": { 02:46:44 INFO - "buildnumber": 448, 02:46:44 INFO - "product": "firefox", 02:46:44 INFO - "script_repo_revision": "production", 02:46:44 INFO - "builddir": "mozilla-aurora_yosemite_test-dromaeojs", 02:46:44 INFO - "repository": "", 02:46:44 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-aurora talos dromaeojs", 02:46:44 INFO - "buildid": "20151203004003", 02:46:44 INFO - "slavename": "t-yosemite-r5-0097", 02:46:44 INFO - "stage_platform": "macosx64", 02:46:44 INFO - "basedir": "/builds/slave/test", 02:46:44 INFO - "nightly_build": "True", 02:46:44 INFO - "project": "", 02:46:44 INFO - "platform": "yosemite", 02:46:44 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 02:46:44 INFO - "slavebuilddir": "test", 02:46:44 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:46:44 INFO - "branch": "mozilla-aurora", 02:46:44 INFO - "repo_path": "releases/mozilla-aurora", 02:46:44 INFO - "pgo_build": "False", 02:46:44 INFO - "builduid": "2b3bc083607149069d5bb35daee29a53", 02:46:44 INFO - "revision": "7aad7dee85151ba464c2a5d5aa9e522bad9287e3" 02:46:44 INFO - }, 02:46:44 INFO - "sourcestamp": { 02:46:44 INFO - "repository": "", 02:46:44 INFO - "hasPatch": false, 02:46:44 INFO - "project": "", 02:46:44 INFO - "branch": "mozilla-aurora-macosx64-talos", 02:46:44 INFO - "changes": [ 02:46:44 INFO - { 02:46:44 INFO - "category": null, 02:46:44 INFO - "files": [ 02:46:44 INFO - { 02:46:44 INFO - "url": null, 02:46:44 INFO - "name": "https://queue.taskcluster.net/v1/task/8T2u2LUeS3y8uUvfLin7OQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg" 02:46:44 INFO - } 02:46:44 INFO - ], 02:46:44 INFO - "repository": "", 02:46:44 INFO - "rev": "7aad7dee85151ba464c2a5d5aa9e522bad9287e3", 02:46:44 INFO - "who": "sendchange", 02:46:44 INFO - "when": 1449139556, 02:46:44 INFO - "number": 6738429, 02:46:44 INFO - "comments": "", 02:46:44 INFO - "project": "", 02:46:44 INFO - "at": "Thu 03 Dec 2015 02:45:56", 02:46:44 INFO - "branch": "mozilla-aurora-macosx64-talos", 02:46:44 INFO - "revlink": "", 02:46:44 INFO - "properties": [ 02:46:44 INFO - [ 02:46:44 INFO - "buildid", 02:46:44 INFO - "20151203004003", 02:46:44 INFO - "Change" 02:46:44 INFO - ], 02:46:44 INFO - [ 02:46:44 INFO - "builduid", 02:46:44 INFO - "2b3bc083607149069d5bb35daee29a53", 02:46:44 INFO - "Change" 02:46:44 INFO - ], 02:46:44 INFO - [ 02:46:44 INFO - "nightly_build", 02:46:44 INFO - "True", 02:46:44 INFO - "Change" 02:46:44 INFO - ], 02:46:44 INFO - [ 02:46:44 INFO - "pgo_build", 02:46:44 INFO - "False", 02:46:44 INFO - "Change" 02:46:44 INFO - ] 02:46:44 INFO - ], 02:46:44 INFO - "revision": "7aad7dee85151ba464c2a5d5aa9e522bad9287e3" 02:46:44 INFO - } 02:46:44 INFO - ], 02:46:44 INFO - "revision": "7aad7dee85151ba464c2a5d5aa9e522bad9287e3" 02:46:44 INFO - } 02:46:44 INFO - } 02:46:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/8T2u2LUeS3y8uUvfLin7OQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg. 02:46:44 INFO - Running post-action listener: _resource_record_post_action 02:46:44 INFO - ##### 02:46:44 INFO - ##### Running download-and-extract step. 02:46:44 INFO - ##### 02:46:44 INFO - Running pre-action listener: _resource_record_pre_action 02:46:44 INFO - Running main action method: download_and_extract 02:46:44 INFO - mkdir: /builds/slave/test/build/tests 02:46:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:46:44 INFO - https://queue.taskcluster.net/v1/task/8T2u2LUeS3y8uUvfLin7OQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:46:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8T2u2LUeS3y8uUvfLin7OQ/artifacts/public/build/test_packages.json 02:46:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8T2u2LUeS3y8uUvfLin7OQ/artifacts/public/build/test_packages.json 02:46:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8T2u2LUeS3y8uUvfLin7OQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 02:46:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8T2u2LUeS3y8uUvfLin7OQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 02:47:01 INFO - Downloaded 1149 bytes. 02:47:01 INFO - Reading from file /builds/slave/test/build/test_packages.json 02:47:01 INFO - Using the following test package requirements: 02:47:01 INFO - {u'common': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 02:47:01 INFO - u'cppunittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:47:01 INFO - u'firefox-44.0a2.en-US.mac.cppunittest.tests.zip'], 02:47:01 INFO - u'jittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:47:01 INFO - u'jsshell-mac.zip'], 02:47:01 INFO - u'mochitest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:47:01 INFO - u'firefox-44.0a2.en-US.mac.mochitest.tests.zip'], 02:47:01 INFO - u'mozbase': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 02:47:01 INFO - u'reftest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:47:01 INFO - u'firefox-44.0a2.en-US.mac.reftest.tests.zip'], 02:47:01 INFO - u'talos': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:47:01 INFO - u'firefox-44.0a2.en-US.mac.talos.tests.zip'], 02:47:01 INFO - u'web-platform': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:47:01 INFO - u'firefox-44.0a2.en-US.mac.web-platform.tests.zip'], 02:47:01 INFO - u'webapprt': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 02:47:01 INFO - u'xpcshell': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:47:01 INFO - u'firefox-44.0a2.en-US.mac.xpcshell.tests.zip']} 02:47:01 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:47:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:47:01 INFO - https://queue.taskcluster.net/v1/task/8T2u2LUeS3y8uUvfLin7OQ/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:47:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8T2u2LUeS3y8uUvfLin7OQ/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:47:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8T2u2LUeS3y8uUvfLin7OQ/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:47:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8T2u2LUeS3y8uUvfLin7OQ/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 02:47:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8T2u2LUeS3y8uUvfLin7OQ/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 02:47:03 INFO - Downloaded 17490240 bytes. 02:47:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 02:47:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:47:03 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 02:47:08 INFO - Return code: 0 02:47:08 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 02:47:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:47:08 INFO - https://queue.taskcluster.net/v1/task/8T2u2LUeS3y8uUvfLin7OQ/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:47:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8T2u2LUeS3y8uUvfLin7OQ/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:47:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8T2u2LUeS3y8uUvfLin7OQ/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:47:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8T2u2LUeS3y8uUvfLin7OQ/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 02:47:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8T2u2LUeS3y8uUvfLin7OQ/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 02:47:09 INFO - Downloaded 17490240 bytes. 02:47:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 02:47:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:47:09 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 02:47:14 INFO - Return code: 0 02:47:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:47:14 INFO - https://queue.taskcluster.net/v1/task/8T2u2LUeS3y8uUvfLin7OQ/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:47:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8T2u2LUeS3y8uUvfLin7OQ/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 02:47:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8T2u2LUeS3y8uUvfLin7OQ/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 02:47:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8T2u2LUeS3y8uUvfLin7OQ/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 02:47:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8T2u2LUeS3y8uUvfLin7OQ/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 02:47:16 INFO - Downloaded 11131307 bytes. 02:47:16 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 02:47:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 02:47:16 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] with output_timeout 1760 02:47:16 INFO - Return code: 0 02:47: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')]} 02:47:16 INFO - https://queue.taskcluster.net/v1/task/8T2u2LUeS3y8uUvfLin7OQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 02:47:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8T2u2LUeS3y8uUvfLin7OQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 02:47:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8T2u2LUeS3y8uUvfLin7OQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 02:47:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8T2u2LUeS3y8uUvfLin7OQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg 02:47:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8T2u2LUeS3y8uUvfLin7OQ/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 02:47:20 INFO - Downloaded 108764997 bytes. 02:47:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/8T2u2LUeS3y8uUvfLin7OQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 02:47:20 INFO - mkdir: /builds/slave/test/properties 02:47:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:47:20 INFO - Writing to file /builds/slave/test/properties/build_url 02:47:20 INFO - Contents: 02:47:20 INFO - build_url:https://queue.taskcluster.net/v1/task/8T2u2LUeS3y8uUvfLin7OQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 02:47:20 INFO - Running post-action listener: _resource_record_post_action 02:47:20 INFO - Running post-action listener: set_extra_try_arguments 02:47:20 INFO - ##### 02:47:20 INFO - ##### Running populate-webroot step. 02:47:20 INFO - ##### 02:47:20 INFO - Running pre-action listener: _resource_record_pre_action 02:47:20 INFO - Running main action method: populate_webroot 02:47:20 INFO - Guessing talos json url... 02:47:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:47:20 INFO - https://queue.taskcluster.net/v1/task/8T2u2LUeS3y8uUvfLin7OQ/artifacts/public/build/firefox-44.0a2.en-US.mac.txt matches https://queue.taskcluster.net 02:47:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8T2u2LUeS3y8uUvfLin7OQ/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 02:47:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8T2u2LUeS3y8uUvfLin7OQ/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 02:47:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8T2u2LUeS3y8uUvfLin7OQ/artifacts/public/build/firefox-44.0a2.en-US.mac.txt to /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 02:47:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8T2u2LUeS3y8uUvfLin7OQ/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 02:47:21 INFO - Downloaded 107 bytes. 02:47:21 INFO - Reading from file /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 02:47:21 INFO - Contents: 02:47:21 INFO - 20151203004003 02:47:21 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/7aad7dee85151ba464c2a5d5aa9e522bad9287e3 02:47: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')]} 02:47:21 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/7aad7dee85/testing/talos/talos.json 02:47:21 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/7aad7dee85/testing/talos/talos.json to /builds/slave/test/build/talos.json 02:47:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/releases/mozilla-aurora/raw-file/7aad7dee85/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 02:47:21 INFO - Downloaded 4264 bytes. 02:47:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:47:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:47:21 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 02:47:21 INFO - '../fennec_ids.txt'], 02:47:21 INFO - 'tests': ['tcheck2']}, 02:47:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:47:21 INFO - '--tppagecycles', 02:47:21 INFO - '7'], 02:47:21 INFO - 'tests': ['tsvgm']}}, 02:47:21 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:47:21 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:47:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:47:21 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:47:21 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:47:21 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:47:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:47:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:47:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:47:21 INFO - 'talos_options': ['--e10s'], 02:47:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:47:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:47:21 INFO - 'tests': ['damp', 'tps']}, 02:47:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:47:21 INFO - 'talos_options': ['--e10s'], 02:47:21 INFO - 'tests': ['damp', 'tps']}, 02:47:21 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:47:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:47:21 INFO - 'other': {'tests': ['a11yr', 02:47:21 INFO - 'ts_paint', 02:47:21 INFO - 'tpaint', 02:47:21 INFO - 'sessionrestore', 02:47:21 INFO - 'sessionrestore_no_auto_restore']}, 02:47:21 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:47:21 INFO - 'tests': ['a11yr', 02:47:21 INFO - 'ts_paint', 02:47:21 INFO - 'tpaint', 02:47:21 INFO - 'sessionrestore', 02:47:21 INFO - 'sessionrestore_no_auto_restore']}, 02:47:21 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:47:21 INFO - 'tests': ['a11yr', 02:47:21 INFO - 'ts_paint', 02:47:21 INFO - 'tpaint', 02:47:21 INFO - 'sessionrestore', 02:47:21 INFO - 'sessionrestore_no_auto_restore']}, 02:47:21 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:47:21 INFO - 'tests': ['a11yr', 02:47:21 INFO - 'ts_paint', 02:47:21 INFO - 'tpaint', 02:47:21 INFO - 'sessionrestore', 02:47:21 INFO - 'sessionrestore_no_auto_restore']}, 02:47:21 INFO - 'other_l64': {'tests': ['a11yr', 02:47:21 INFO - 'ts_paint', 02:47:21 INFO - 'tpaint', 02:47:21 INFO - 'sessionrestore', 02:47:21 INFO - 'sessionrestore_no_auto_restore']}, 02:47:21 INFO - 'other_nol64': {'tests': ['a11yr', 02:47:21 INFO - 'ts_paint', 02:47:21 INFO - 'tpaint', 02:47:21 INFO - 'sessionrestore', 02:47:21 INFO - 'sessionrestore_no_auto_restore']}, 02:47:21 INFO - 'svgr': {'tests': ['tsvgx', 02:47:21 INFO - 'tsvgr_opacity', 02:47:21 INFO - 'tart', 02:47:21 INFO - 'tscrollx', 02:47:21 INFO - 'cart']}, 02:47:21 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:47:21 INFO - 'tests': ['tsvgx', 02:47:21 INFO - 'tsvgr_opacity', 02:47:21 INFO - 'tart', 02:47:21 INFO - 'tscrollx', 02:47:21 INFO - 'cart']}, 02:47:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:47:21 INFO - 'tests': ['tp5o']}, 02:47:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:47:21 INFO - 'talos_options': ['--e10s'], 02:47:21 INFO - 'tests': ['tp5o']}, 02:47:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:47:21 INFO - 'talos_options': ['--xperf_path', 02:47:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:47:21 INFO - 'tests': ['tp5n']}, 02:47:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:47:21 INFO - 'talos_options': ['--e10s', 02:47:21 INFO - '--xperf_path', 02:47:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 02:47:21 INFO - 'C:/slave/talos-data/talos/xperf.config'], 02:47:21 INFO - 'tests': ['tp5n']}}, 02:47:21 INFO - 'talos.zip': {'path': '', 02:47:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:47:21 INFO - Running post-action listener: _resource_record_post_action 02:47:21 INFO - ##### 02:47:21 INFO - ##### Running create-virtualenv step. 02:47:21 INFO - ##### 02:47:21 INFO - Running pre-action listener: _resource_record_pre_action 02:47:21 INFO - Running main action method: create_virtualenv 02:47:21 INFO - Creating virtualenv /builds/slave/test/build/venv 02:47:21 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:47:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:47:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:47:21 INFO - Using real prefix '/tools/python27' 02:47:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:47:22 INFO - Installing distribute.............................................................................................................................................................................................done. 02:47:26 INFO - Installing pip.................done. 02:47:26 INFO - Return code: 0 02:47:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:47: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')]} 02:47:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:47:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47: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')]} 02:47:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:47:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102c0fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c7c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea0af479c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102bc49f0>, '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 0x102923cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b8e990>, '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.XbnhTwpCSs/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.heTemyE2si/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/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 02:47: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', 'pip>=1.5'] in /builds/slave/test/build 02:47: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 pip>=1.5 02:47:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XbnhTwpCSs/Render', 02:47:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:47:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:47:26 INFO - 'HOME': '/Users/cltbld', 02:47:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:47:26 INFO - 'LOGNAME': 'cltbld', 02:47:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:26 INFO - 'MOZ_NO_REMOTE': '1', 02:47:26 INFO - 'NO_EM_RESTART': '1', 02:47:26 INFO - 'PAGER': '/bin/cat', 02:47:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:47:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:47:26 INFO - 'PWD': '/builds/slave/test', 02:47:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:47:26 INFO - 'SHELL': '/bin/bash', 02:47:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.heTemyE2si/Listeners', 02:47:26 INFO - 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/', 02:47:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:47:26 INFO - 'USER': 'cltbld', 02:47:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:47:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:47:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:26 INFO - 'XPC_FLAGS': '0x0', 02:47:26 INFO - 'XPC_SERVICE_NAME': '0', 02:47:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:47:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:47:26 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:47:26 INFO - Cleaning up... 02:47:26 INFO - Return code: 0 02:47:26 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:47: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')]} 02:47:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:47:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47: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')]} 02:47:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:47:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102c0fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c7c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea0af479c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102bc49f0>, '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 0x102923cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b8e990>, '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.XbnhTwpCSs/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.heTemyE2si/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/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 02:47:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:47:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:47:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XbnhTwpCSs/Render', 02:47:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:47:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:47:26 INFO - 'HOME': '/Users/cltbld', 02:47:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:47:26 INFO - 'LOGNAME': 'cltbld', 02:47:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:26 INFO - 'MOZ_NO_REMOTE': '1', 02:47:26 INFO - 'NO_EM_RESTART': '1', 02:47:26 INFO - 'PAGER': '/bin/cat', 02:47:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:47:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:47:26 INFO - 'PWD': '/builds/slave/test', 02:47:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:47:26 INFO - 'SHELL': '/bin/bash', 02:47:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.heTemyE2si/Listeners', 02:47:26 INFO - 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/', 02:47:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:47:26 INFO - 'USER': 'cltbld', 02:47:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:47:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:47:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:26 INFO - 'XPC_FLAGS': '0x0', 02:47:26 INFO - 'XPC_SERVICE_NAME': '0', 02:47:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:47:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:47:26 INFO - Downloading/unpacking psutil>=0.7.1 02:47: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 02:47: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 02:47: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 02:47: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 02:47: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 02:47: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 02:47:29 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 02:47:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 02:47:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:47:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:47:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:47:29 INFO - Installing collected packages: psutil 02:47:29 INFO - Running setup.py install for psutil 02:47:29 INFO - building 'psutil._psutil_osx' extension 02:47:29 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 02:47:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 02:47:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 02:47:30 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 02:47:30 INFO - building 'psutil._psutil_posix' extension 02:47:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 02:47:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:47:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:47:30 INFO - ^ 02:47:30 INFO - 1 warning generated. 02:47:30 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 02:47:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:47:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:47:30 INFO - Successfully installed psutil 02:47:30 INFO - Cleaning up... 02:47:30 INFO - Return code: 0 02:47:30 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:47:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:47:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:47:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:47:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:47:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:30 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 0x102c0fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c7c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea0af479c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102bc49f0>, '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 0x102923cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b8e990>, '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.XbnhTwpCSs/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.heTemyE2si/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/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 02:47:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 02:47:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 02:47:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XbnhTwpCSs/Render', 02:47:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:47:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:47:30 INFO - 'HOME': '/Users/cltbld', 02:47:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:47:30 INFO - 'LOGNAME': 'cltbld', 02:47:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:30 INFO - 'MOZ_NO_REMOTE': '1', 02:47:30 INFO - 'NO_EM_RESTART': '1', 02:47:30 INFO - 'PAGER': '/bin/cat', 02:47:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:47:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:47:30 INFO - 'PWD': '/builds/slave/test', 02:47:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:47:30 INFO - 'SHELL': '/bin/bash', 02:47:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.heTemyE2si/Listeners', 02:47:30 INFO - 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/', 02:47:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:47:30 INFO - 'USER': 'cltbld', 02:47:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:47:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:47:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:30 INFO - 'XPC_FLAGS': '0x0', 02:47:30 INFO - 'XPC_SERVICE_NAME': '0', 02:47:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:47:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:47:30 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:47: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 02:47: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 02:47: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 02:47: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 02:47: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 02:47: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 02:47:33 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:47:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 02:47:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:47:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:47:33 INFO - Installing collected packages: mozsystemmonitor 02:47:33 INFO - Running setup.py install for mozsystemmonitor 02:47:33 INFO - Successfully installed mozsystemmonitor 02:47:33 INFO - Cleaning up... 02:47:33 INFO - Return code: 0 02:47:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:47:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:47:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:47:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:47:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:47:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:33 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 0x102c0fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c7c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea0af479c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102bc49f0>, '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 0x102923cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b8e990>, '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.XbnhTwpCSs/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.heTemyE2si/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/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 02:47:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:47:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:47:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XbnhTwpCSs/Render', 02:47:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:47:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:47:33 INFO - 'HOME': '/Users/cltbld', 02:47:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:47:33 INFO - 'LOGNAME': 'cltbld', 02:47:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:33 INFO - 'MOZ_NO_REMOTE': '1', 02:47:33 INFO - 'NO_EM_RESTART': '1', 02:47:33 INFO - 'PAGER': '/bin/cat', 02:47:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:47:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:47:33 INFO - 'PWD': '/builds/slave/test', 02:47:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:47:33 INFO - 'SHELL': '/bin/bash', 02:47:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.heTemyE2si/Listeners', 02:47:33 INFO - 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/', 02:47:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:47:33 INFO - 'USER': 'cltbld', 02:47:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:47:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:47:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:33 INFO - 'XPC_FLAGS': '0x0', 02:47:33 INFO - 'XPC_SERVICE_NAME': '0', 02:47:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:47:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:47:33 INFO - Downloading/unpacking blobuploader==1.2.4 02:47: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 02:47: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 02:47: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 02:47: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 02:47: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 02:47: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 02:47:36 INFO - Downloading blobuploader-1.2.4.tar.gz 02:47:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 02:47:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:47:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:47:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:47:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:47:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:47:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:47:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:47:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:47:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 02:47:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:47:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:47:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:47:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:47:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:47:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:47:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:47:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:47:37 INFO - Downloading docopt-0.6.1.tar.gz 02:47:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 02:47:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:47:37 INFO - Installing collected packages: blobuploader, requests, docopt 02:47:37 INFO - Running setup.py install for blobuploader 02:47:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:47:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:47:37 INFO - Running setup.py install for requests 02:47:38 INFO - Running setup.py install for docopt 02:47:38 INFO - Successfully installed blobuploader requests docopt 02:47:38 INFO - Cleaning up... 02:47:38 INFO - Return code: 0 02:47:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:47:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:47:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:47:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:47:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:47:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:38 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 0x102c0fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c7c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea0af479c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102bc49f0>, '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 0x102923cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b8e990>, '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.XbnhTwpCSs/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.heTemyE2si/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/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 02:47:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:47:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:47:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XbnhTwpCSs/Render', 02:47:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:47:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:47:38 INFO - 'HOME': '/Users/cltbld', 02:47:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:47:38 INFO - 'LOGNAME': 'cltbld', 02:47:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:38 INFO - 'MOZ_NO_REMOTE': '1', 02:47:38 INFO - 'NO_EM_RESTART': '1', 02:47:38 INFO - 'PAGER': '/bin/cat', 02:47:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:47:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:47:38 INFO - 'PWD': '/builds/slave/test', 02:47:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:47:38 INFO - 'SHELL': '/bin/bash', 02:47:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.heTemyE2si/Listeners', 02:47:38 INFO - 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/', 02:47:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:47:38 INFO - 'USER': 'cltbld', 02:47:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:47:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:47:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:38 INFO - 'XPC_FLAGS': '0x0', 02:47:38 INFO - 'XPC_SERVICE_NAME': '0', 02:47:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:47:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:47:39 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-DMYfM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:47:39 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-lbKt8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:47:39 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-xYTa7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:47:39 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-L4b4Rz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:47:39 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-CkKbgu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:47:39 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-lAkBTx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:47:39 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-nzb8gk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:47:39 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-mYTguU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:47:39 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-WYkQnL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:47:40 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-j2aRaK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:47:40 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-TQN_bU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:47:40 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-F7Jjgw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:47:40 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-R9lg1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:47:40 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-tDbdGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:47:40 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-XQNzwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:47:40 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-Eo99rn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:47:40 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-rVF1X2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:47:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:47:41 INFO - Running setup.py install for manifestparser 02:47:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:47:41 INFO - Running setup.py install for mozcrash 02:47:41 INFO - Running setup.py install for mozdebug 02:47:41 INFO - Running setup.py install for mozdevice 02:47:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:47:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:47:41 INFO - Running setup.py install for mozfile 02:47:41 INFO - Running setup.py install for mozhttpd 02:47:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:47:42 INFO - Running setup.py install for mozinfo 02:47:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:47:42 INFO - Running setup.py install for mozInstall 02:47:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:47:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:47:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:47:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:47:42 INFO - Running setup.py install for mozleak 02:47:42 INFO - Running setup.py install for mozlog 02:47:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:47:42 INFO - Running setup.py install for moznetwork 02:47:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:47:42 INFO - Running setup.py install for mozprocess 02:47:43 INFO - Running setup.py install for mozprofile 02:47:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:47:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:47:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:47:43 INFO - Running setup.py install for mozrunner 02:47:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:47:43 INFO - Running setup.py install for mozscreenshot 02:47:43 INFO - Running setup.py install for moztest 02:47:43 INFO - Running setup.py install for mozversion 02:47:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:47:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:47:44 INFO - Cleaning up... 02:47:44 INFO - Return code: 0 02:47:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:47:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:47:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:47:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:47:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:47:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x102c0fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c7c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea0af479c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102bc49f0>, '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 0x102923cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b8e990>, '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.XbnhTwpCSs/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.heTemyE2si/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/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 02:47:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:47:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:47:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XbnhTwpCSs/Render', 02:47:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:47:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:47:44 INFO - 'HOME': '/Users/cltbld', 02:47:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:47:44 INFO - 'LOGNAME': 'cltbld', 02:47:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:44 INFO - 'MOZ_NO_REMOTE': '1', 02:47:44 INFO - 'NO_EM_RESTART': '1', 02:47:44 INFO - 'PAGER': '/bin/cat', 02:47:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:47:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:47:44 INFO - 'PWD': '/builds/slave/test', 02:47:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:47:44 INFO - 'SHELL': '/bin/bash', 02:47:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.heTemyE2si/Listeners', 02:47:44 INFO - 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/', 02:47:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:47:44 INFO - 'USER': 'cltbld', 02:47:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:47:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:47:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:44 INFO - 'XPC_FLAGS': '0x0', 02:47:44 INFO - 'XPC_SERVICE_NAME': '0', 02:47:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:47:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:47:44 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-DhFuAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:47:44 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:47:44 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-4JNClE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:47:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:47:44 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-iDSiW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:47:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:47:44 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-scoibE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:47:44 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)) 02:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:47:44 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-t20mFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:47:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:47:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:47:45 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-pmj200-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:47:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:47:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:47:45 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-W_uZz0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:47:45 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)) 02:47:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:47:45 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-F1w5RE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:47:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:47:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:47:45 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-QzToTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:47:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:47:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:47:45 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-42kRGO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:47:45 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)) 02:47:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:47:45 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-9rmeJ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:47:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:47:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:47:45 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-I6EFHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:47:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:47:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:47:45 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-URd2BJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:47:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:47:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:47:46 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-HEf7Uw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:47:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:47:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:47:46 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-ilELjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:47:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:47:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:47:46 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-itsoNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:47:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:47:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:47:46 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-StWkwa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:47:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:47:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:47:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:47:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:47:46 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)) 02:47:46 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)) 02:47:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:47:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:47:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:47:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:47:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:47:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:47:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:47:48 INFO - Downloading blessings-1.5.1.tar.gz 02:47:48 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 02:47:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:47:49 INFO - Installing collected packages: blessings 02:47:49 INFO - Running setup.py install for blessings 02:47:49 INFO - Successfully installed blessings 02:47:49 INFO - Cleaning up... 02:47:49 INFO - Return code: 0 02:47:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:47:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:47:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:47:49 INFO - Reading from file tmpfile_stdout 02:47:49 INFO - Current package versions: 02:47:49 INFO - blessings == 1.5.1 02:47:49 INFO - blobuploader == 1.2.4 02:47:49 INFO - docopt == 0.6.1 02:47:49 INFO - manifestparser == 1.1 02:47:49 INFO - mozInstall == 1.12 02:47:49 INFO - mozcrash == 0.16 02:47:49 INFO - mozdebug == 0.1 02:47:49 INFO - mozdevice == 0.46 02:47:49 INFO - mozfile == 1.2 02:47:49 INFO - mozhttpd == 0.7 02:47:49 INFO - mozinfo == 0.8 02:47:49 INFO - mozleak == 0.1 02:47:49 INFO - mozlog == 3.0 02:47:49 INFO - moznetwork == 0.27 02:47:49 INFO - mozprocess == 0.22 02:47:49 INFO - mozprofile == 0.27 02:47:49 INFO - mozrunner == 6.11 02:47:49 INFO - mozscreenshot == 0.1 02:47:49 INFO - mozsystemmonitor == 0.0 02:47:49 INFO - moztest == 0.7 02:47:49 INFO - mozversion == 1.4 02:47:49 INFO - psutil == 3.1.1 02:47:49 INFO - requests == 1.2.3 02:47:49 INFO - wsgiref == 0.1.2 02:47:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:47:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:47:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:47:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:47:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:47:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:47:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x102c0fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c7c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea0af479c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102bc49f0>, '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 0x102923cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b8e990>, '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.XbnhTwpCSs/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.heTemyE2si/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/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 02:47:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:47:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:47:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XbnhTwpCSs/Render', 02:47:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:47:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:47:49 INFO - 'HOME': '/Users/cltbld', 02:47:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:47:49 INFO - 'LOGNAME': 'cltbld', 02:47:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:49 INFO - 'MOZ_NO_REMOTE': '1', 02:47:49 INFO - 'NO_EM_RESTART': '1', 02:47:49 INFO - 'PAGER': '/bin/cat', 02:47:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:47:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:47:49 INFO - 'PWD': '/builds/slave/test', 02:47:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:47:49 INFO - 'SHELL': '/bin/bash', 02:47:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.heTemyE2si/Listeners', 02:47:49 INFO - 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/', 02:47:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:47:49 INFO - 'USER': 'cltbld', 02:47:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:47:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:47:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:49 INFO - 'XPC_FLAGS': '0x0', 02:47:49 INFO - 'XPC_SERVICE_NAME': '0', 02:47:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:47:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:47:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:47:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:47:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:47:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:47:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:47:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:47:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:47:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:47:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:47:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:47:50 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:47:50 INFO - Cleaning up... 02:47:50 INFO - Return code: 0 02:47:50 INFO - Running post-action listener: _resource_record_post_action 02:47:50 INFO - Running post-action listener: _start_resource_monitoring 02:47:50 INFO - Starting resource monitoring. 02:47:50 INFO - ##### 02:47:50 INFO - ##### Running install step. 02:47:50 INFO - ##### 02:47:50 INFO - Running pre-action listener: _resource_record_pre_action 02:47:50 INFO - Running main action method: install 02:47:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:47:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:47:50 INFO - Reading from file tmpfile_stdout 02:47:50 INFO - Detecting whether we're running mozinstall >=1.0... 02:47:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:47:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:47:50 INFO - Reading from file tmpfile_stdout 02:47:50 INFO - Output received: 02:47:50 INFO - Usage: mozinstall [options] installer 02:47:50 INFO - Options: 02:47:50 INFO - -h, --help show this help message and exit 02:47:50 INFO - -d DEST, --destination=DEST 02:47:50 INFO - Directory to install application into. [default: 02:47:50 INFO - "/builds/slave/test"] 02:47:50 INFO - --app=APP Application being installed. [default: firefox] 02:47:50 INFO - mkdir: /builds/slave/test/build/application 02:47:50 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'] 02:47:50 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 02:48:28 INFO - Reading from file tmpfile_stdout 02:48:28 INFO - Output received: 02:48:28 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:48:28 INFO - Running post-action listener: _resource_record_post_action 02:48:28 INFO - ##### 02:48:28 INFO - ##### Running run-tests step. 02:48:28 INFO - ##### 02:48:28 INFO - Running pre-action listener: _resource_record_pre_action 02:48:28 INFO - Running main action method: run_tests 02:48:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:48:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:48:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:48:28 INFO - 2015-12-03 02:48:28.872 screenresolution[2032:21968] starting screenresolution argv=screenresolution get 02:48:28 INFO - 2015-12-03 02:48:28.876 screenresolution[2032:21968] Display 0: 1600x1200x32@60 02:48:28 INFO - 2015-12-03 02:48:28.883 screenresolution[2033:21970] starting screenresolution argv=screenresolution list 02:48:28 INFO - Available Modes on Display 0 02:48:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:48:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:48:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:48:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:48:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:48:29 INFO - Intel HD Graphics 3000: 02:48:29 INFO - Chipset Model: Intel HD Graphics 3000 02:48:29 INFO - Type: GPU 02:48:29 INFO - Bus: Built-In 02:48:29 INFO - VRAM (Total): 512 MB 02:48:29 INFO - VRAM (Dynamic, Max): 10 02:48:29 INFO - Vendor: Intel (0x8086) 02:48:29 INFO - Device ID: 0x0116 02:48:29 INFO - Revision ID: 0x0009 02:48:29 INFO - Displays: 02:48:29 INFO - Display: 02:48:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:48:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:48:29 INFO - Display Serial Number: 1600x1200 60 02:48:29 INFO - Main Display: Yes 02:48:29 INFO - Mirror: Off 02:48:29 INFO - Online: Yes 02:48:29 INFO - Rotation: Supported 02:48:29 INFO - Return code: 0 02:48:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:48:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:48:29 INFO - Python 2.7.3 02:48:29 INFO - Return code: 0 02:48:29 INFO - grabbing minidump binary from tooltool 02:48: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')]} 02:48:29 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 0x102bc49f0>, '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 0x102923cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b8e990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:48:29 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:48:29 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 02:48:29 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:48:29 INFO - Return code: 0 02:48:29 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:48:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:48:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:48:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:48:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:48:29 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/8T2u2LUeS3y8uUvfLin7OQ/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0097', '--webServer', 'localhost'] in /builds/slave/test/build 02:48:29 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/8T2u2LUeS3y8uUvfLin7OQ/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0097 --webServer localhost 02:48:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XbnhTwpCSs/Render', 02:48:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:29 INFO - 'HOME': '/Users/cltbld', 02:48:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:29 INFO - 'LOGNAME': 'cltbld', 02:48:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:48:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:48:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:29 INFO - 'MOZ_NO_REMOTE': '1', 02:48:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:48:29 INFO - 'NO_EM_RESTART': '1', 02:48:29 INFO - 'PAGER': '/bin/cat', 02:48:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:29 INFO - 'PWD': '/builds/slave/test', 02:48:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:48:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:29 INFO - 'SHELL': '/bin/bash', 02:48:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.heTemyE2si/Listeners', 02:48:29 INFO - 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/', 02:48:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:29 INFO - 'USER': 'cltbld', 02:48:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:29 INFO - 'XPC_FLAGS': '0x0', 02:48:29 INFO - 'XPC_SERVICE_NAME': '0', 02:48:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:48:29 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/8T2u2LUeS3y8uUvfLin7OQ/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0097', '--webServer', 'localhost'] with output_timeout 3600 02:48:29 INFO - mozversion INFO | application_buildid: 20151203004003 02:48:29 INFO - mozversion INFO | application_changeset: 7aad7dee85151ba464c2a5d5aa9e522bad9287e3 02:48:29 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 02:48:29 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:48:29 INFO - mozversion INFO | application_name: Firefox 02:48:29 INFO - mozversion INFO | application_remotingname: firefox-dev 02:48:29 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:48:29 INFO - mozversion INFO | application_vendor: Mozilla 02:48:29 INFO - mozversion INFO | application_version: 44.0a2 02:48:29 INFO - mozversion INFO | platform_buildid: 20151203004003 02:48:29 INFO - mozversion INFO | platform_changeset: 7aad7dee85151ba464c2a5d5aa9e522bad9287e3 02:48:29 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:48:29 INFO - mozversion INFO | platform_version: 44.0a2 02:48:29 INFO - 2015-12-03 02:48:29,511 DEBUG : using testdate: 1449139709 02:48:29 INFO - 2015-12-03 02:48:29,511 DEBUG : actual date: 1449139709 02:48:29 INFO - 2015-12-03 02:48:29,524 INFO : starting webserver on 'localhost:49861' 02:48:29 INFO - 2015-12-03 02:48:29,525 INFO : Starting test suite t-yosemite-r5-0097 02:48:29 INFO - 2015-12-03 02:48:29,526 INFO : Starting test dromaeo_css 02:48:29 INFO - 2015-12-03 02:48:29,526 DEBUG : operating with platform_type : mac_ 02:48:29 INFO - 2015-12-03 02:48:29,526 INFO : Initialising browser for dromaeo_css test... 02:48:29 INFO - 2015-12-03 02:48:29,552 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/tmpk5QQsD/profile http://localhost:49861/getInfo.html 02:48:32 INFO - 2015-12-03 02:48:32,000 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:48:32 INFO - 2015-12-03 02:48:32,000 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:48:32 INFO - 2015-12-03 02:48:32,000 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 02:48:32 INFO - 2015-12-03 02:48:32,000 DEBUG : BROWSER_OUTPUT: __metrics 02:48:32 INFO - 2015-12-03 02:48:32,016 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:48:32 INFO - 2015-12-03 02:48:32,661 INFO : Browser initialized. 02:48:32 INFO - 2015-12-03 02:48:32,661 INFO : Running cycle 1/1 for dromaeo_css test... 02:48:32 INFO - 2015-12-03 02:48:32,662 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/tmpk5QQsD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:48:44 INFO - 2015-12-03 02:48:44,566 DEBUG : BROWSER_OUTPUT: RSS: Main: 197591040 02:48:44 INFO - 2015-12-03 02:48:44,566 DEBUG : BROWSER_OUTPUT: 02:49:35 INFO - 2015-12-03 02:49:35,833 DEBUG : BROWSER_OUTPUT: 1449139775823 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 02:51:46 INFO - 2015-12-03 02:51:46,086 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49861/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49861/tests/dromaeo/cssquery-ext.html) 02:51:47 INFO - 2015-12-03 02:51:47,266 DEBUG : BROWSER_OUTPUT: RSS: Main: 318971904 02:51:47 INFO - 2015-12-03 02:51:47,266 DEBUG : BROWSER_OUTPUT: 02:54:49 INFO - 2015-12-03 02:54:49,954 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49861/tests/dromaeo/cssquery-ext.html (next: http://localhost:49861/tests/dromaeo/cssquery-jquery.html) 02:54:50 INFO - 2015-12-03 02:54:50,535 DEBUG : BROWSER_OUTPUT: RSS: Main: 345190400 02:54:50 INFO - 2015-12-03 02:54:50,535 DEBUG : BROWSER_OUTPUT: 02:57:52 INFO - 2015-12-03 02:57:52,604 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49861/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49861/tests/dromaeo/cssquery-mootools.html) 02:57:53 INFO - 2015-12-03 02:57:53,187 DEBUG : BROWSER_OUTPUT: RSS: Main: 315338752 02:57:53 INFO - 2015-12-03 02:57:53,187 DEBUG : BROWSER_OUTPUT: 03:00:55 INFO - 2015-12-03 03:00:55,142 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49861/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49861/tests/dromaeo/cssquery-prototype.html) 03:00:55 INFO - 2015-12-03 03:00:55,726 DEBUG : BROWSER_OUTPUT: RSS: Main: 303075328 03:00:55 INFO - 2015-12-03 03:00:55,726 DEBUG : BROWSER_OUTPUT: 03:03:58 INFO - 2015-12-03 03:03:58,700 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49861/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49861/tests/dromaeo/cssquery-yui.html) 03:03:59 INFO - 2015-12-03 03:03:59,305 DEBUG : BROWSER_OUTPUT: RSS: Main: 301555712 03:03:59 INFO - 2015-12-03 03:03:59,305 DEBUG : BROWSER_OUTPUT: 03:07:01 INFO - 2015-12-03 03:07:01,986 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49861/tests/dromaeo/cssquery-yui.html (next: http://localhost:49861/tests/dromaeo/cssquery-dojo.html) 03:07:02 INFO - 2015-12-03 03:07:02,246 DEBUG : BROWSER_OUTPUT: RSS: Main: 345755648 03:07:02 INFO - 2015-12-03 03:07:02,246 DEBUG : BROWSER_OUTPUT: 03:07:02 INFO - 2015-12-03 03:07:02,246 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:07:02 INFO - 2015-12-03 03:07:02,246 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:07:02 INFO - 2015-12-03 03:07:02,246 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:07:02 INFO - 2015-12-03 03:07:02,247 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:07:02 INFO - 2015-12-03 03:07:02,250 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2942.117364790565;2943.4996050671384;2947.778916581257;3074.7232749052587;3158.857851396687;4964.2553616957475;5047.4447810740885;5055.191169412895;5066.189409694445;5090.389153301604;4993.126202914494;4997.975010124945;5024.196128619422;5060.139776238039;5063.0380227756705;4506.324051392285;4587.724736515803;4647.465541462741;4653.650976176792;4670.929936050945;4661.184292748772;4663.673542851985;4706.411698537683;4711.057788442326;4729.0541891621815;4532.592066713995;4546.477155127153;4549.090181963604;4549.31760235964;4590.196715574778;4500.864974050767;4541.6593755468475;4564.497905230422;4638.999999999966;4648.790804413809;4519.502854685982;4522.819087236507;4535.160995215896;4590.693087061792;4625.190591646448;4766.332713420124;4797.712137271775;4865.805367785284;4867.440244371907;4930.654854160211;5188.533032027136;5251.317328747276;5257;5271.262023316739;5357.544608708265;5333.759980800874;5339.065663508909;5376.892462150735;5436.891262174774;5451.591130665216;4897.240927656219;4994.900101997976;5015.548600625962;5047.621428392885;5088.491150884882;5320.840374788762;5393.298871146804;5435.891282174413;5458.2904222451625;5529.281193444826;5186.974065129651;5187.636865419385;5203.739813009334;5212.478752124757;5231.424543300234;5200.531952124327;5306.655067420683;5352.892942141136;5392.110301800238;5400.135978243462;4972.129877271463;5075.543201111917;5117.795288188505;5163.4062082860955;5303.840884773463;5280.6303558750515;5345.412004679482;5393.352797664305;5408.150563867628;5425.430329815392;3932.6264004919485;4054.533728621246;4158.438610787565;4166.125113726091;4210.347396153601;3661.1579336752698;3747.4191500317493;3764.4353346997623;3773.2076263984322;3789.905252368658;4984.975075124601;5007.248912663057;5056.140456122468;5100.948990510047;5104.387473503203;5139.049275883899;5225.111731005738;5508.366537848118;5562.221289019541;5577.107662774018;4796.424429068534;4832.347633069561;4908.067467181224;4927.310176575283;4968.279599458058;4645.512221216791;4754.07295577366;4758.619310455225;4792.0895029944195;4808.326834243208;5392.676439413648;5528.474794894479;5536.307961504812;5536.861578460571;5604.663720176803;5249.89500209986;5278.89442211146;5337.839864804062;5373.059714550016;5420.891582168413;5401.783928642967;5484.533814625802;5488.835334939959;5499.862503437446;5512.531434827924;5147.819826306061;5328;5387.542058925035;5388.488093631099;5401.297831281908;5200.375954885438;5286.709230992333;5300.681959082467;5309.256704061511;5321.787128514816;5338.439463856239;5395.325584301962;5407.864803379947;5412.648177868426;5421.457854214547;5062.190049592047;5178.61160412963;5342.011727830364;5411.269478620336;5412.269343638558;5125.308083408841;5152.948470515247;5154.561862241751;5266.89466210666;5276;5187.688738675692;5190.117679994334;5200.60995425337;5202.089634314056;5239.580833533232;4828.61371090319;5082.263071854634;5098.643094983316;5107.182850744011;5151.072806894645 03:07:02 INFO - 2015-12-03 03:07:02,251 DEBUG : BROWSER_OUTPUT: |1;ext.html;541.450427815767;542.3410556174246;549.0693274899045;549.8268045565648;561.0882316236116;31166;31732.365352692963;36442.27115457689;36907.630923690755;36955.630443695554;40646.593534064654;41101;41188;41317.17365652685;41585.16829663405;8037.799055023613;8518.701845435411;8599.398042137052;8738.606762695663;8770.12298770121;8012.318952889012;10497.895021049806;10560.31357961734;10683.946580267087;10697.83953240702;10369.325993810378;10376.533056012497;10453.529591168415;10470.057694807465;10569.788604227911;8226.753197404087;8412.411131220817;10356.37861728295;10481.895181048207;10561.683149505527;10217.182625390025;10358.171346292278;10380.169586433067;10389.9480502597;10390;37994.24011519754;38117.61882381168;38395.23209535793;38482.23035539302;38515.807420963;2749.7351218439344;2822.125141206212;2843.6587609486787;2865.8280503169876;3401.1327111586634;26497.73502264991;26550.203493895213;26579.46841063187;26931.326716832235;27080.729192708215;2282.6690129931235;2283.303592404316;2291.598970180212;2298.28753086542;2301.7813307735737;257798;259182.70408648025;260254;260745;261477;56605.15092273619;57743.133852992236;60223;64778;66901.33098668951;60614.696926515084;60659;60818;60884.086738698956;60911.69544152251;16310.75533866993;16318;16350.591235219215;16500.83499165017;16531.173441327886;12502.249865008129;12558.30929298879;12628.747425051448;12707.809382859265;12816;19746.50633734168;19928.800711992986;19972.600547988957;19981.800181998286;20003.299884504264;8034.437589368805;8229.423940324119;8338.749837504885;8374.288185504178;8460;941.2328951904176;945.2013048973606;945.5083356654501;1023.8668973033458;1036.103770238738;27514.521247928813;27578;27844;27878.442431151263;28027;917.5180191174376;977.8533220016913;1023.1865666794915;1048.187654567701;1122.2088427658482;11636.418179091012;12916.289604071679;14776.40894364235;14977.850221497863;15101.47144849925;311507;318604;319774;321069;322474;45305.546944530135;52925;53269.46730532645;53442.198367024524;53479;1240.3550153919912;1346.6296768388772;1353.4180302470033;1364.270115488209;1461.985380146185;25941.09206177775;26972.730272697023;27165.320866978484;27896.86051569729;27944.44111117807;44455;44749.32876006928;44813.551864480934;45201.32198017098;50103;203721;205194;207327;207475;208377;28967.420651587272;29095.12714618565;29932;29995.100146995625;30286.394272114874;37198.25603487969;41103.38344924888;41366.1726765469;41672.79163604163;41685.37471937984;32466.675333246367;34231.48652770161;34408.82795586006;34592.135196620286;34858.47712284369;33487.33025339528;33861;34485;34495.13762155866;34596;34274.485882711284;34953.126171845906;35066.474002890485;35191.29617407689;35708;29719.55420668735;29842.850785745934;29873.253168670955;30033.54949675713;30034.3993120132;22754.544909102056;23278.3016509505;23477.647835282827;23514.412139696644;23563.764362356156 03:07:02 INFO - 2015-12-03 03:07:02,253 DEBUG : BROWSER_OUTPUT: |2;jquery.html;333.8330834582709;334.6452760074321;335.1888429999401;337.2193372343027;342.6487849953797;14238.572842814732;14614.561563153096;15940.601484962866;16426.178691065445;17522.123893805307;11123.666290011291;13862.584122476317;14660.633484162901;17233.482995510123;17419.564510887234;4042.9393559096566;4165.396017577465;4186.225548273564;4188.6439652629415;4203.327467605184;3247.350529894031;4138.52406973199;4138.875833724978;4150.439690641755;4190.413342132104;4094.324436467994;4494.078713863666;4501.122281155176;4510.030343476152;4557.680962332638;4211.620954114113;4421.115776844628;4497.7526236057;4502.032063106448;4544.4092268005115;3819.8090095495113;3822.4266360046217;3829.3107240696663;3833.6358045985585;3836.5804652278557;12801.743965120739;13020.153690010118;13034.21794692312;13058;13099.934500327532;1696.957576060596;1715.6997525432998;1718.4415065103767;1823.8085001074828;1882.4634979030911;9110.453372797587;9334.766630834283;9363.204127649158;9494.905050949472;9528.142467177988;1480.740870347685;1506.4652048522726;1543.7066957278082;1557.8987365821185;1593.3785823528833;54602.72698636521;57107;57255.141172882024;57456;58084.419155808326;6061.909071363933;6107.389261073857;6118.479929205978;6126.417990291005;6156;6965.47758918073;6967.059446974695;7027.227005029443;7045.788626341218;7048.718051277994;5227.921581176285;5249.475052494797;5271.420143784258;5326.840194794162;5327.334083239595;5727.226824378656;5728.398518155617;5745.195672605839;5765.250517432707;5807.245058142415;2762.958555621667;2829.2078218098554;2829.717028297154;2839.0347281924246;2866.4553734790325;941.9293552983554;961.3510880156007;996.6163027234422;1016.6035246253966;1032.055669062799;372.79123690733275;385.11423725431393;385.39108209029666;399.3689969847634;400.17763496015965;10401.375917444977;10777.407242601575;11091.22361434708;11193;11243.26918750295;410.55249777741807;421.172396241381;422.96827737919165;423.3691799219141;425.3555862867758;5831.1544826000845;5929.970350148222;5977.402259773988;6062.302835173923;6072.36240194782;362633;559534;568258;570242;578859;67712.32287677159;70161.29838701547;70530;70787;71454.2854571458;393.7184912787371;404.7996241860298;408.96319331259735;409.68249606555156;416.50435981182295;9701.12689857888;9741.659041933783;9785.021497850443;9833.4099954003;9844.655437059668;30550.694493055675;33618;33778.8311058453;33995.49006764851;34171.48742768811;39565.40651890282;41786;42946.78526607347;44260.33609495796;44632.33051504295;5326.8934621308135;5332.413434522277;5415.945840541544;5437.537809286255;5488.91766623493;10308.12380947628;10311.123554497952;10581.788364232827;10645.041946224877;10756.085732712807;9125.269978401844;9140.451572905647;9220.538973051187;9404.106609872051;9421.717348479557;8532.445391049561;8894.555272236492;8965.731028069169;9057.90942090597;9153.130452606993;7699.576523291273;9277.350585458953;9832.213422926006;9966.850497242402;9975.251856110675;5672.2058911751565;5743.1385292206505;5753.712314384347;5753.827385178452;5824.592278540462;9410.811783764424;9475.952620236854;9504.334696571173;9637.132658060807;9637.614495420105 03:07:02 INFO - 2015-12-03 03:07:02,257 DEBUG : BROWSER_OUTPUT: |3;mootools.html;744.6760659113282;1567.388718399824;1643.827398123197;1646.2262736513842;1670.7159782836916;6156.81529554113;6460.7092680829355;6645.867082658356;6665.700043498042;6736.8989465158065;6619.768308109217;6752.054712340277;6756.797296081113;6759.425448836842;6807.761728339509;2021.858469907107;2025.1190732031614;2044.846636502261;2050.128695304497;2051.179528188729;2007.5483016321357;2031.471817327498;2034.6032523657893;2062.0308455026116;2063.5563353878915;2017.4956260934766;2026.371824734337;2054.6507093794016;2057.1360028787944;2058.0430100003496;2033.2070492507933;2038.2254743197564;2038.2560365466645;2041.5100375909824;2045.9079341429672;2017.7276067730816;2035.745531808524;2048.805363490466;2050.559129787103;2056.033664177834;6064.848378790522;6217.844553886144;6704.296048914891;6761.560498567577;6840.623765692885;4070.1045769930865;4209.684273679456;4212.684048696329;4221.176870510251;4254.212970600449;2624.829386089898;2640.841549507036;2649.8277611955355;2670.6528151340203;2688.932776680579;812.1675282835082;818.8239528501341;1453.3096779029877;1458.300015992319;1512.9092254464658;8636.784080397978;8686.609102590399;8689.869651955225;8714.564271786385;8793.428427152214;3621.9094522637147;3622.9637703622625;3640.3265395901844;3673.9816300918324;3718.3492888744363;7071.257517960643;7072.434205263567;7073;7132.322429369202;7184.137903451619;4140.855070072533;4151.647109995623;4175.081482073939;4182.205380977665;4193.874183774492;3866.2654095721723;3869.245497128033;3870.109874728772;3871.341871881787;3920.9019774505296;3045.25391279138;3066.0648502206595;3093.1030001299373;3095.4737694591972;3108.1918701137865;904.7511934218143;924.6809850601531;927.1423932862076;928.79102202004;936.7002559181133;1171.2855158353398;1219.9268043917393;1226.6136167107334;1244.9688757781128;1250.3435696259355;6573.3426657333885;6594.571352862049;6596.472282217411;6599.8020059398295;6600.339966003361;397.16396984347534;408.5363112866917;414.9294619914622;418.03642603798534;418.053109706515;4931;5144.511271429208;5174.508421699932;5175.45657705943;5263;6968.163820341591;7660.770176894702;7844.137144914055;7848.058233012075;7923;7746.806329841686;7794.493357931717;7828.647710853025;7835.216478352119;7848.686052557834;6222.564420490613;6299.212598425197;6408.359164083555;6447.0329450582785;6563.474922006228;6409.615423074631;6412.935870641234;6435;6440.066190402459;6466.547341686225;7156.463265255023;7255.056842610426;7268.0914885639295;7302.598357090411;7317.304856038668;7187.137543494814;7302.087239095114;7315.817104572428;7342.045534080536;7430.814229644086;5797.188393624811;5834;5836.153757705194;5908.05471124618;5916.408359164049;6560.27836937946;6626.6686665667485;6629.801105966829;6629.966850165718;6632.801015969529;6206;6235.189425374672;6295.496360291258;6326.145970293951;6327.651979141191;6077.574569780073;6132.693365331805;6191.628502289877;6202.2867370253;6204.13142160089;6159.384061593805;6236.688165591793;6280.591761535486;6295.150154729053;6330.272018717722;5597.944020559905;5707.514861236841;5737.110747834093;5781.8554536136935;5787.334456537384;5757.712114394348;5778.913316300175;5780.190773291659;5822;5855.473007429352 03:07:02 INFO - 2015-12-03 03:07:02,257 DEBUG : BROWSER_OUTPUT: |4;prototype.html;281.32762697153805;290.11514879617164;291.88762326504303;294.3891425292518;298.31834258718834;5480.890382192354;5757.798477053304;5773.653580785156;5777.42225777422;5895.941040589592;5572.4148964358765;5589.580781441398;5592.189132575774;5684;5710.486056254937;4293.7209081409765;4298.398224248608;4314.37441570972;4316.5036020857615;4338.240807858612;4210.989362552996;4291.8497852575165;4300.526942036374;4312.28847240205;4373.190959672471;4212.789360531977;4227.640650544708;4264.445622069126;4288.892777680568;4363.38912552243;4240.512341080785;4257.042165512766;4268.423762792015;4286.892827679318;4306.892327691801;3679.411294192943;3704.814759262053;3709.0541911812584;3711.480392745018;3711.9072023199365;5535.889282214373;5538.196961440609;5548.91676624851;5587.189857470685;5620.297462817148;4755.762211889426;4946.183879659852;4947.975260123712;4950.777215025332;4953.826616068421;5949.25634295713;5964.403559644001;6008.609440386361;6027.336992930774;6031.668258245794;4043.2722110020186;4074.0833312504747;4076.347784354519;4086.3257562502154;4134.73124246923;6119.418655227746;6268.059791031336;6281.089242059876;6282.2147231596055;6304.716287767015;4080.5103387593085;4091.243120022805;4092.7135100542678;4130.814113364906;4153.210889930964;4165.729227600196;4168.958310416857;4174.686898482626;4187.43469631602;4223.303154979394;4842.225243960949;4881.4630390657;4890.657653964188;4902.632302577321;4914.778834952435;5784.739686714108;6014.939850601438;6042.577019608585;6042.818715438544;6048.364921683248;1453.14264583896;1464.4874293997016;1473.638958455164;1478.1205182916149;1478.3569147420906;924.6578765856676;927.8097989912052;929.61885626894;937.5921474158763;940.722486866376;5591.10542313228;5601.6358936668985;5603.551715862721;5604.971975140098;5609.467100625434;6216.689165541705;6228.128062071313;6235.719392627343;6242.687865606701;6282.089097080898;5481.150421684645;5530.557555395559;5614.045612245928;5616.073347897551;5616.438356164351;3445.1214940190594;3473.0449126490416;3488.145404375944;3489.9302013959577;3523.6828685418436;6306.400891915261;6307.369263073656;6308.400701933309;6318.115463835067;6373.044043393528;6201.844953876189;6422.775202867877;6440.259370172396;6465.709043093072;6513.088167656532;6301.40136687014;6348.365163483615;6420.550561460746;6424.935750642528;6437.903431448625;6317.494600432046;6338.397852204033;6346.936530634819;6388.680565971776;6389.041643753474;6009.098635204754;6175.413335733098;6199.876002479835;6214.751409943732;6244.65654389013;6302;6315.936840631535;6325.810225693236;6366.713497892699;6367.26776420699;3934.2131573684806;3971.980140099281;3978.8209530570616;3981.48240728715;4022.3966405039478;6188.916939535653;6214.8135555931585;6229.470495007975;6266.310705822447;6269.090981807703;6000.939990600213;6016.849578760566;6034.849128771816;6072.301685306246;6141.600795948428;6016.819495415145;6048.243969503812;6049.30433000193;6077.6353418795015;6126.23422072241;5914.970425147847;5916.55625828056;5917.91123133162;5944.673042982505;5994.31065427464;5891.086881533369;6110.969445152924;6125.989211780006;6146.6004709693725;6176.845578860564;5990.7903223386975;5993.130996005642;6000.51995840323;6024.9397506026135;6059.939400605937 03:07:02 INFO - 2015-12-03 03:07:02,259 DEBUG : BROWSER_OUTPUT: |5;yui.html;677.9491538134641;716.6524235745662;719.6186021408652;721.3399739238596;734.2437289591722;13121.343932803358;13581.864181358196;13594.320283985811;13703.931480342584;13713.177209367432;12493.500259989612;12639;12641.178323408973;12780.61658150257;12834.101612887102;689.3795583974438;702.620584884162;860.0324634785866;868.7350358140781;878.1613559051091;856.1737922904396;861.4960248254779;869.9739007829776;870.7474832298626;872.9039805621377;907.0883761819363;914.4650379527951;915.1214833759599;915.9587818548148;917.0645941140033;712.4478529139906;721.5382155420535;880.8062226310202;881.9647214111428;896.1486587741606;649.0621052578978;654.2149420695184;654.9705263263164;659.1266571792394;661.9669016549153;12632.49470021198;12765.680857978532;12856.228626282453;12979;12982.675433114153;10753.677389678322;11188.496517656726;11298.54805807775;11562.826557601642;11608.709782255512;9041.63833446668;9054.86417703735;9129.543522823833;9254.12085851843;9259.351845370828;3112.4864397374404;3149.9055028349185;3198.9680103198903;3249.1714612773826;3254.6094468663673;46135.53864461312;46719;46913;47048.2942755859;47156.292655609854;8345.319444375244;8697.130286971378;8699.869501957475;8863.955680221687;8929.1468971091;18820.905895470434;18844.05779711009;18912.338068167548;18916.10838916125;19036.80963190378;6834.555753875982;6902.689378977958;7018.368346848808;7042.647867606702;7142.321479459443;3835.8082095895093;3857.4213867920034;3912.784796836201;3979.2837289288204;3986.3023970804993;2703.9053633122744;2772.3207814085677;2774.694783573805;2780.6107144999714;2824.5904343870025;406.6641084038918;407.92657321681787;412.8555005747964;414.4674093789466;414.5564246256537;486.727432637724;511.9513646203605;535.1010302691516;558.2296430925297;574.2678085441096;7503.437242206856;7533.171351151369;7709.190534993745;7778.766637000899;7873.803154921058;439.65926407034164;440.02095337872976;488.19447910947224;522.4305506997391;583.9270091238595;3362.83185840707;3715.108373990277;3717.7211709121925;3777.9433308500393;3798.0884587699306;58541.121883171785;58973.705131474926;59240.40759592349;59473.702631486565;59768;48237.27644085341;48328.27507587389;48395.75802121037;48407.515924841005;48746.75626621844;44817.87955301078;46205;46831;46868;47122.76438617785;7231.2768723129375;7318.817029574303;7465.888011679721;7467.327940485382;7555.962220188864;33999.32001360008;34057.65942340545;34758;34764.82617586896;34779;42678.35982460328;43078.13843723045;43673.12653746971;43699.34450983301;45863.54136458593;6409.653972665792;6426.614403135827;6474.870502590016;6582.275949645439;6791.219009813737;9681.322307438411;9857.063578959987;10099.79800403973;10164.33931794431;10182.389056656624;9198.95400522993;9219.400738951947;9545.47499887485;9715.22278217755;9842.557084931052;9370.344075914893;9415.529223538933;9448;9468.621255149717;9620.230381569318;8658.91341086581;8773.605187766438;9158.816823663356;9277.721668349961;9328.0205578416;8002.439829212132;8466.238038576557;8676.78308042304;8799.47203167812;9025.954870225869;8298;8834.337424693302;8924.107589241024;9006.369554131148;9184.081591840762 03:07:02 INFO - 2015-12-03 03:07:02,259 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:07:02 INFO - 2015-12-03 03:07:02,259 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:07:02 INFO - 2015-12-03 03:07:02,260 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,924 03:07:02 INFO - 2015-12-03 03:07:02,260 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:07:02 INFO - 2015-12-03 03:07:02,260 DEBUG : BROWSER_OUTPUT: __startTimestamp1449140822245__endTimestamp 03:07:02 INFO - 2015-12-03 03:07:02,260 DEBUG : BROWSER_OUTPUT: 03:07:02 INFO - 2015-12-03 03:07:02,262 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:07:02 INFO - 2015-12-03 03:07:02,262 DEBUG : BROWSER_OUTPUT: Number of tests: 6 03:07:02 INFO - 2015-12-03 03:07:02,262 DEBUG : BROWSER_OUTPUT: 03:07:02 INFO - 2015-12-03 03:07:02,262 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4971.73 Median:5117.80 stddev:534.41 (10.4%) stddev-sans-first:511.79 03:07:02 INFO - 2015-12-03 03:07:02,262 DEBUG : BROWSER_OUTPUT: Values: 2942.1 2943.5 2947.8 3074.7 3158.9 4964.3 5047.4 5055.2 5066.2 5090.4 4993.1 4998.0 5024.2 5060.1 5063.0 4506.3 4587.7 4647.5 4653.7 4670.9 4661.2 4663.7 4706.4 4711.1 4729.1 4532.6 4546.5 4549.1 4549.3 4590.2 4500.9 4541.7 4564.5 4639.0 4648.8 4519.5 4522.8 4535.2 4590.7 4625.2 4766.3 4797.7 4865.8 4867.4 4930.7 5188.5 5251.3 5257.0 5271.3 5357.5 5333.8 5339.1 5376.9 5436.9 5451.6 4897.2 4994.9 5015.5 5047.6 5088.5 5320.8 5393.3 5435.9 5458.3 5529.3 5187.0 5187.6 5203.7 5212.5 5231.4 5200.5 5306.7 5352.9 5392.1 5400.1 4972.1 5075.5 5117.8 5163.4 5303.8 5280.6 5345.4 5393.4 5408.2 5425.4 3932.6 4054.5 4158.4 4166.1 4210.3 3661.2 3747.4 3764.4 3773.2 3789.9 4985.0 5007.2 5056.1 5100.9 5104.4 5139.0 5225.1 5508.4 5562.2 5577.1 4796.4 4832.3 4908.1 4927.3 4968.3 4645.5 4754.1 4758.6 4792.1 4808.3 5392.7 5528.5 5536.3 5536.9 5604.7 5249.9 5278.9 5337.8 5373.1 5420.9 5401.8 5484.5 5488.8 5499.9 5512.5 5147.8 5328.0 5387.5 5388.5 5401.3 5200.4 5286.7 5300.7 5309.3 5321.8 5338.4 5395.3 5407.9 5412.6 5421.5 5062.2 5178.6 5342.0 5411.3 5412.3 5125.3 5152.9 5154.6 5266.9 5276.0 5187.7 5190.1 5200.6 5202.1 5239.6 4828.6 5082.3 5098.6 5107.2 5151.1 03:07:02 INFO - 2015-12-03 03:07:02,263 DEBUG : BROWSER_OUTPUT: 03:07:02 INFO - 2015-12-03 03:07:02,263 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:43235.24 Median:29902.63 stddev:69395.91 (232.1%) stddev-sans-first:69516.54 03:07:02 INFO - 2015-12-03 03:07:02,264 DEBUG : BROWSER_OUTPUT: Values: 541.5 542.3 549.1 549.8 561.1 31166.0 31732.4 36442.3 36907.6 36955.6 40646.6 41101.0 41188.0 41317.2 41585.2 8037.8 8518.7 8599.4 8738.6 8770.1 8012.3 10497.9 10560.3 10683.9 10697.8 10369.3 10376.5 10453.5 10470.1 10569.8 8226.8 8412.4 10356.4 10481.9 10561.7 10217.2 10358.2 10380.2 10389.9 10390.0 37994.2 38117.6 38395.2 38482.2 38515.8 2749.7 2822.1 2843.7 2865.8 3401.1 26497.7 26550.2 26579.5 26931.3 27080.7 2282.7 2283.3 2291.6 2298.3 2301.8 257798.0 259182.7 260254.0 260745.0 261477.0 56605.2 57743.1 60223.0 64778.0 66901.3 60614.7 60659.0 60818.0 60884.1 60911.7 16310.8 16318.0 16350.6 16500.8 16531.2 12502.2 12558.3 12628.7 12707.8 12816.0 19746.5 19928.8 19972.6 19981.8 20003.3 8034.4 8229.4 8338.7 8374.3 8460.0 941.2 945.2 945.5 1023.9 1036.1 27514.5 27578.0 27844.0 27878.4 28027.0 917.5 977.9 1023.2 1048.2 1122.2 11636.4 12916.3 14776.4 14977.9 15101.5 311507.0 318604.0 319774.0 321069.0 322474.0 45305.5 52925.0 53269.5 53442.2 53479.0 1240.4 1346.6 1353.4 1364.3 1462.0 25941.1 26972.7 27165.3 27896.9 27944.4 44455.0 44749.3 44813.6 45201.3 50103.0 203721.0 205194.0 207327.0 207475.0 208377.0 28967.4 29095.1 29932.0 29995.1 30286.4 37198.3 41103.4 41366.2 41672.8 41685.4 32466.7 34231.5 34408.8 34592.1 34858.5 33487.3 33861.0 34485.0 34495.1 34596.0 34274.5 34953.1 35066.5 35191.3 35708.0 29719.6 29842.9 29873.3 30033.5 30034.4 22754.5 23278.3 23477.6 23514.4 23563.8 03:07:02 INFO - 2015-12-03 03:07:02,265 DEBUG : BROWSER_OUTPUT: 03:07:02 INFO - 2015-12-03 03:07:02,265 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25635.15 Median:24563.20 stddev:87601.40 (356.6%) stddev-sans-first:87826.54 03:07:02 INFO - 2015-12-03 03:07:02,266 DEBUG : BROWSER_OUTPUT: Values: 333.8 334.6 335.2 337.2 342.6 14238.6 14614.6 15940.6 16426.2 17522.1 11123.7 13862.6 14660.6 17233.5 17419.6 4042.9 4165.4 4186.2 4188.6 4203.3 3247.4 4138.5 4138.9 4150.4 4190.4 4094.3 4494.1 4501.1 4510.0 4557.7 4211.6 4421.1 4497.8 4502.0 4544.4 3819.8 3822.4 3829.3 3833.6 3836.6 12801.7 13020.2 13034.2 13058.0 13099.9 1697.0 1715.7 1718.4 1823.8 1882.5 9110.5 9334.8 9363.2 9494.9 9528.1 1480.7 1506.5 1543.7 1557.9 1593.4 54602.7 57107.0 57255.1 57456.0 58084.4 6061.9 6107.4 6118.5 6126.4 6156.0 6965.5 6967.1 7027.2 7045.8 7048.7 5227.9 5249.5 5271.4 5326.8 5327.3 5727.2 5728.4 5745.2 5765.3 5807.2 2763.0 2829.2 2829.7 2839.0 2866.5 941.9 961.4 996.6 1016.6 1032.1 372.8 385.1 385.4 399.4 400.2 10401.4 10777.4 11091.2 11193.0 11243.3 410.6 421.2 423.0 423.4 425.4 5831.2 5930.0 5977.4 6062.3 6072.4 362633.0 559534.0 568258.0 570242.0 578859.0 67712.3 70161.3 70530.0 70787.0 71454.3 393.7 404.8 409.0 409.7 416.5 9701.1 9741.7 9785.0 9833.4 9844.7 30550.7 33618.0 33778.8 33995.5 34171.5 39565.4 41786.0 42946.8 44260.3 44632.3 5326.9 5332.4 5415.9 5437.5 5488.9 10308.1 10311.1 10581.8 10645.0 10756.1 9125.3 9140.5 9220.5 9404.1 9421.7 8532.4 8894.6 8965.7 9057.9 9153.1 7699.6 9277.4 9832.2 9966.9 9975.3 5672.2 5743.1 5753.7 5753.8 5824.6 9410.8 9476.0 9504.3 9637.1 9637.6 03:07:02 INFO - 2015-12-03 03:07:02,266 DEBUG : BROWSER_OUTPUT: 03:07:02 INFO - 2015-12-03 03:07:02,266 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4720.66 Median:5912.23 stddev:2368.55 (40.1%) stddev-sans-first:2356.32 03:07:02 INFO - 2015-12-03 03:07:02,267 DEBUG : BROWSER_OUTPUT: Values: 744.7 1567.4 1643.8 1646.2 1670.7 6156.8 6460.7 6645.9 6665.7 6736.9 6619.8 6752.1 6756.8 6759.4 6807.8 2021.9 2025.1 2044.8 2050.1 2051.2 2007.5 2031.5 2034.6 2062.0 2063.6 2017.5 2026.4 2054.7 2057.1 2058.0 2033.2 2038.2 2038.3 2041.5 2045.9 2017.7 2035.7 2048.8 2050.6 2056.0 6064.8 6217.8 6704.3 6761.6 6840.6 4070.1 4209.7 4212.7 4221.2 4254.2 2624.8 2640.8 2649.8 2670.7 2688.9 812.2 818.8 1453.3 1458.3 1512.9 8636.8 8686.6 8689.9 8714.6 8793.4 3621.9 3623.0 3640.3 3674.0 3718.3 7071.3 7072.4 7073.0 7132.3 7184.1 4140.9 4151.6 4175.1 4182.2 4193.9 3866.3 3869.2 3870.1 3871.3 3920.9 3045.3 3066.1 3093.1 3095.5 3108.2 904.8 924.7 927.1 928.8 936.7 1171.3 1219.9 1226.6 1245.0 1250.3 6573.3 6594.6 6596.5 6599.8 6600.3 397.2 408.5 414.9 418.0 418.1 4931.0 5144.5 5174.5 5175.5 5263.0 6968.2 7660.8 7844.1 7848.1 7923.0 7746.8 7794.5 7828.6 7835.2 7848.7 6222.6 6299.2 6408.4 6447.0 6563.5 6409.6 6412.9 6435.0 6440.1 6466.5 7156.5 7255.1 7268.1 7302.6 7317.3 7187.1 7302.1 7315.8 7342.0 7430.8 5797.2 5834.0 5836.2 5908.1 5916.4 6560.3 6626.7 6629.8 6630.0 6632.8 6206.0 6235.2 6295.5 6326.1 6327.7 6077.6 6132.7 6191.6 6202.3 6204.1 6159.4 6236.7 6280.6 6295.2 6330.3 5597.9 5707.5 5737.1 5781.9 5787.3 5757.7 5778.9 5780.2 5822.0 5855.5 03:07:02 INFO - 2015-12-03 03:07:02,268 DEBUG : BROWSER_OUTPUT: 03:07:02 INFO - 2015-12-03 03:07:02,268 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5003.84 Median:5734.14 stddev:1542.52 (26.9%) stddev-sans-first:1505.57 03:07:02 INFO - 2015-12-03 03:07:02,269 DEBUG : BROWSER_OUTPUT: Values: 281.3 290.1 291.9 294.4 298.3 5480.9 5757.8 5773.7 5777.4 5895.9 5572.4 5589.6 5592.2 5684.0 5710.5 4293.7 4298.4 4314.4 4316.5 4338.2 4211.0 4291.8 4300.5 4312.3 4373.2 4212.8 4227.6 4264.4 4288.9 4363.4 4240.5 4257.0 4268.4 4286.9 4306.9 3679.4 3704.8 3709.1 3711.5 3711.9 5535.9 5538.2 5548.9 5587.2 5620.3 4755.8 4946.2 4948.0 4950.8 4953.8 5949.3 5964.4 6008.6 6027.3 6031.7 4043.3 4074.1 4076.3 4086.3 4134.7 6119.4 6268.1 6281.1 6282.2 6304.7 4080.5 4091.2 4092.7 4130.8 4153.2 4165.7 4169.0 4174.7 4187.4 4223.3 4842.2 4881.5 4890.7 4902.6 4914.8 5784.7 6014.9 6042.6 6042.8 6048.4 1453.1 1464.5 1473.6 1478.1 1478.4 924.7 927.8 929.6 937.6 940.7 5591.1 5601.6 5603.6 5605.0 5609.5 6216.7 6228.1 6235.7 6242.7 6282.1 5481.2 5530.6 5614.0 5616.1 5616.4 3445.1 3473.0 3488.1 3489.9 3523.7 6306.4 6307.4 6308.4 6318.1 6373.0 6201.8 6422.8 6440.3 6465.7 6513.1 6301.4 6348.4 6420.6 6424.9 6437.9 6317.5 6338.4 6346.9 6388.7 6389.0 6009.1 6175.4 6199.9 6214.8 6244.7 6302.0 6315.9 6325.8 6366.7 6367.3 3934.2 3972.0 3978.8 3981.5 4022.4 6188.9 6214.8 6229.5 6266.3 6269.1 6000.9 6016.8 6034.8 6072.3 6141.6 6016.8 6048.2 6049.3 6077.6 6126.2 5915.0 5916.6 5917.9 5944.7 5994.3 5891.1 6111.0 6126.0 6146.6 6176.8 5990.8 5993.1 6000.5 6024.9 6059.9 03:07:02 INFO - 2015-12-03 03:07:02,269 DEBUG : BROWSER_OUTPUT: 03:07:02 INFO - 2015-12-03 03:07:02,269 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13055.15 Median:59357.06 stddev:15931.81 (26.8%) stddev-sans-first:15949.39 03:07:02 INFO - 2015-12-03 03:07:02,270 DEBUG : BROWSER_OUTPUT: Values: 677.9 716.7 719.6 721.3 734.2 13121.3 13581.9 13594.3 13703.9 13713.2 12493.5 12639.0 12641.2 12780.6 12834.1 689.4 702.6 860.0 868.7 878.2 856.2 861.5 870.0 870.7 872.9 907.1 914.5 915.1 916.0 917.1 712.4 721.5 880.8 882.0 896.1 649.1 654.2 655.0 659.1 662.0 12632.5 12765.7 12856.2 12979.0 12982.7 10753.7 11188.5 11298.5 11562.8 11608.7 9041.6 9054.9 9129.5 9254.1 9259.4 3112.5 3149.9 3199.0 3249.2 3254.6 46135.5 46719.0 46913.0 47048.3 47156.3 8345.3 8697.1 8699.9 8864.0 8929.1 18820.9 18844.1 18912.3 18916.1 19036.8 6834.6 6902.7 7018.4 7042.6 7142.3 3835.8 3857.4 3912.8 3979.3 3986.3 2703.9 2772.3 2774.7 2780.6 2824.6 406.7 407.9 412.9 414.5 414.6 486.7 512.0 535.1 558.2 574.3 7503.4 7533.2 7709.2 7778.8 7873.8 439.7 440.0 488.2 522.4 583.9 3362.8 3715.1 3717.7 3777.9 3798.1 58541.1 58973.7 59240.4 59473.7 59768.0 48237.3 48328.3 48395.8 48407.5 48746.8 44817.9 46205.0 46831.0 46868.0 47122.8 7231.3 7318.8 7465.9 7467.3 7556.0 33999.3 34057.7 34758.0 34764.8 34779.0 42678.4 43078.1 43673.1 43699.3 45863.5 6409.7 6426.6 6474.9 6582.3 6791.2 9681.3 9857.1 10099.8 10164.3 10182.4 9199.0 9219.4 9545.5 9715.2 9842.6 9370.3 9415.5 9448.0 9468.6 9620.2 8658.9 8773.6 9158.8 9277.7 9328.0 8002.4 8466.2 8676.8 8799.5 9026.0 8298.0 8834.3 8924.1 9006.4 9184.1 03:07:02 INFO - 2015-12-03 03:07:02,271 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:07:02 INFO - 2015-12-03 03:07:02,271 DEBUG : BROWSER_OUTPUT: 03:07:02 INFO - 2015-12-03 03:07:02,938 INFO : Browser exited with error code: 0 03:07:02 INFO - 2015-12-03 03:07:02,967 INFO : Completed test dromaeo_css (00:18:33) 03:07:02 INFO - 2015-12-03 03:07:02,967 INFO : Starting test kraken 03:07:02 INFO - 2015-12-03 03:07:02,967 DEBUG : operating with platform_type : mac_ 03:07:02 INFO - 2015-12-03 03:07:02,968 INFO : Initialising browser for kraken test... 03:07:02 INFO - 2015-12-03 03:07:02,981 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/tmpaUT0ry/profile http://localhost:49861/getInfo.html 03:07:05 INFO - 2015-12-03 03:07:05,234 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:07:05 INFO - 2015-12-03 03:07:05,235 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:07:05 INFO - 2015-12-03 03:07:05,235 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 03:07:05 INFO - 2015-12-03 03:07:05,235 DEBUG : BROWSER_OUTPUT: __metrics 03:07:05 INFO - 2015-12-03 03:07:05,251 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:07:05 INFO - 2015-12-03 03:07:05,930 INFO : Browser initialized. 03:07:05 INFO - 2015-12-03 03:07:05,931 INFO : Running cycle 1/1 for kraken test... 03:07:05 INFO - 2015-12-03 03:07:05,931 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/tmpaUT0ry/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:07:17 INFO - 2015-12-03 03:07:17,832 DEBUG : BROWSER_OUTPUT: RSS: Main: 198160384 03:07:17 INFO - 2015-12-03 03:07:17,832 DEBUG : BROWSER_OUTPUT: 03:07:20 INFO - 2015-12-03 03:07:20,382 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49861/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49861/tests/kraken/driver.html?testName=audio-beat-detection) 03:07:20 INFO - 2015-12-03 03:07:20,965 DEBUG : BROWSER_OUTPUT: RSS: Main: 267210752 03:07:20 INFO - 2015-12-03 03:07:20,965 DEBUG : BROWSER_OUTPUT: 03:07:23 INFO - 2015-12-03 03:07:23,711 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49861/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49861/tests/kraken/driver.html?testName=audio-dft) 03:07:24 INFO - 2015-12-03 03:07:24,290 DEBUG : BROWSER_OUTPUT: RSS: Main: 279601152 03:07:24 INFO - 2015-12-03 03:07:24,290 DEBUG : BROWSER_OUTPUT: 03:07:27 INFO - 2015-12-03 03:07:27,280 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49861/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49861/tests/kraken/driver.html?testName=audio-fft) 03:07:27 INFO - 2015-12-03 03:07:27,860 DEBUG : BROWSER_OUTPUT: RSS: Main: 267264000 03:07:27 INFO - 2015-12-03 03:07:27,860 DEBUG : BROWSER_OUTPUT: 03:07:29 INFO - 2015-12-03 03:07:29,963 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49861/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49861/tests/kraken/driver.html?testName=audio-oscillator) 03:07:30 INFO - 2015-12-03 03:07:30,551 DEBUG : BROWSER_OUTPUT: RSS: Main: 266756096 03:07:30 INFO - 2015-12-03 03:07:30,551 DEBUG : BROWSER_OUTPUT: 03:07:32 INFO - 2015-12-03 03:07:32,848 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49861/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49861/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:07:33 INFO - 2015-12-03 03:07:33,430 DEBUG : BROWSER_OUTPUT: RSS: Main: 267091968 03:07:33 INFO - 2015-12-03 03:07:33,430 DEBUG : BROWSER_OUTPUT: 03:07:36 INFO - 2015-12-03 03:07:36,649 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49861/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49861/tests/kraken/driver.html?testName=imaging-darkroom) 03:07:37 INFO - 2015-12-03 03:07:37,231 DEBUG : BROWSER_OUTPUT: RSS: Main: 268439552 03:07:37 INFO - 2015-12-03 03:07:37,231 DEBUG : BROWSER_OUTPUT: 03:07:40 INFO - 2015-12-03 03:07:40,539 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49861/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49861/tests/kraken/driver.html?testName=imaging-desaturate) 03:07:41 INFO - 2015-12-03 03:07:41,125 DEBUG : BROWSER_OUTPUT: RSS: Main: 268283904 03:07:41 INFO - 2015-12-03 03:07:41,125 DEBUG : BROWSER_OUTPUT: 03:07:44 INFO - 2015-12-03 03:07:44,199 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49861/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49861/tests/kraken/driver.html?testName=json-parse-financial) 03:07:44 INFO - 2015-12-03 03:07:44,783 DEBUG : BROWSER_OUTPUT: RSS: Main: 268754944 03:07:44 INFO - 2015-12-03 03:07:44,783 DEBUG : BROWSER_OUTPUT: 03:07:46 INFO - 2015-12-03 03:07:46,414 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49861/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49861/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:07:46 INFO - 2015-12-03 03:07:46,985 DEBUG : BROWSER_OUTPUT: RSS: Main: 302878720 03:07:46 INFO - 2015-12-03 03:07:46,985 DEBUG : BROWSER_OUTPUT: 03:07:48 INFO - 2015-12-03 03:07:48,881 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49861/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49861/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:07:49 INFO - 2015-12-03 03:07:49,503 DEBUG : BROWSER_OUTPUT: RSS: Main: 304132096 03:07:49 INFO - 2015-12-03 03:07:49,503 DEBUG : BROWSER_OUTPUT: 03:07:51 INFO - 2015-12-03 03:07:51,654 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49861/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49861/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:07:52 INFO - 2015-12-03 03:07:52,229 DEBUG : BROWSER_OUTPUT: RSS: Main: 310079488 03:07:52 INFO - 2015-12-03 03:07:52,229 DEBUG : BROWSER_OUTPUT: 03:07:54 INFO - 2015-12-03 03:07:54,930 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49861/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49861/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:07:55 INFO - 2015-12-03 03:07:55,524 DEBUG : BROWSER_OUTPUT: RSS: Main: 312250368 03:07:55 INFO - 2015-12-03 03:07:55,525 DEBUG : BROWSER_OUTPUT: 03:07:58 INFO - 2015-12-03 03:07:58,216 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49861/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49861/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:07:58 INFO - 2015-12-03 03:07:58,797 DEBUG : BROWSER_OUTPUT: RSS: Main: 310046720 03:07:58 INFO - 2015-12-03 03:07:58,797 DEBUG : BROWSER_OUTPUT: 03:08:00 INFO - 2015-12-03 03:08:00,575 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49861/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49861/tests/kraken/driver.html?testName=ai-astar) 03:08:00 INFO - 2015-12-03 03:08:00,832 DEBUG : BROWSER_OUTPUT: RSS: Main: 371015680 03:08:00 INFO - 2015-12-03 03:08:00,832 DEBUG : BROWSER_OUTPUT: 03:08:00 INFO - 2015-12-03 03:08:00,832 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:08:00 INFO - 2015-12-03 03:08:00,832 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:08:00 INFO - 2015-12-03 03:08:00,833 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:08:00 INFO - 2015-12-03 03:08:00,833 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:08:00 INFO - 2015-12-03 03:08:00,833 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;108;101;106;110;114;108;109;101;106 03:08:00 INFO - 2015-12-03 03:08:00,833 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;159;136;164;158;131;150;135;177;167;141 03:08:00 INFO - 2015-12-03 03:08:00,833 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;169;173;174;175;181;177;174;174;174 03:08:00 INFO - 2015-12-03 03:08:00,833 DEBUG : BROWSER_OUTPUT: |3;audio-fft;77;83;78;130;73;77;80;76;127;70 03:08:00 INFO - 2015-12-03 03:08:00,833 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;100;102;147;95;96;102;147;97;94;146 03:08:00 INFO - 2015-12-03 03:08:00,834 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;122;129;125;135;130;124;124;124;136;125 03:08:00 INFO - 2015-12-03 03:08:00,834 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;130;135;136;140;135;134;136;135;134;140 03:08:00 INFO - 2015-12-03 03:08:00,834 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;101;109;111;113;112;109;109;129;115;111 03:08:00 INFO - 2015-12-03 03:08:00,834 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;61;62;64;66;66;67;76;61;63 03:08:00 INFO - 2015-12-03 03:08:00,834 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;67;70;75;72;75;74;73;73;73 03:08:00 INFO - 2015-12-03 03:08:00,834 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;86;86;87;90;90;91;92;93;91;94 03:08:00 INFO - 2015-12-03 03:08:00,834 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;127;132;135;130;136;145;145;142;135;133 03:08:00 INFO - 2015-12-03 03:08:00,835 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;144;166;163;157;158;158;163;163;155 03:08:00 INFO - 2015-12-03 03:08:00,835 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;69;70;77;76;77;76;75;73;73 03:08:00 INFO - 2015-12-03 03:08:00,835 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:08:00 INFO - 2015-12-03 03:08:00,835 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:08:00 INFO - 2015-12-03 03:08:00,835 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,901 03:08:00 INFO - 2015-12-03 03:08:00,835 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:08:00 INFO - 2015-12-03 03:08:00,835 DEBUG : BROWSER_OUTPUT: __startTimestamp1449140880829__endTimestamp 03:08:00 INFO - 2015-12-03 03:08:00,836 DEBUG : BROWSER_OUTPUT: 03:08:00 INFO - 2015-12-03 03:08:00,836 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:08:00 INFO - 2015-12-03 03:08:00,836 DEBUG : BROWSER_OUTPUT: Number of tests: 14 03:08:00 INFO - 2015-12-03 03:08:00,836 DEBUG : BROWSER_OUTPUT: 03:08:00 INFO - 2015-12-03 03:08:00,836 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.20 Median:108.50 stddev:3.97 (3.7%) stddev-sans-first:4.15 03:08:00 INFO - 2015-12-03 03:08:00,836 DEBUG : BROWSER_OUTPUT: Values: 109.0 108.0 101.0 106.0 110.0 114.0 108.0 109.0 101.0 106.0 03:08:00 INFO - 2015-12-03 03:08:00,836 DEBUG : BROWSER_OUTPUT: 03:08:00 INFO - 2015-12-03 03:08:00,838 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:151.80 Median:158.50 stddev:15.60 (9.8%) stddev-sans-first:16.32 03:08:00 INFO - 2015-12-03 03:08:00,838 DEBUG : BROWSER_OUTPUT: Values: 159.0 136.0 164.0 158.0 131.0 150.0 135.0 177.0 167.0 141.0 03:08:00 INFO - 2015-12-03 03:08:00,838 DEBUG : BROWSER_OUTPUT: 03:08:00 INFO - 2015-12-03 03:08:00,838 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:173.40 Median:174.00 stddev:4.74 (2.7%) stddev-sans-first:3.21 03:08:00 INFO - 2015-12-03 03:08:00,839 DEBUG : BROWSER_OUTPUT: Values: 163.0 169.0 173.0 174.0 175.0 181.0 177.0 174.0 174.0 174.0 03:08:00 INFO - 2015-12-03 03:08:00,839 DEBUG : BROWSER_OUTPUT: 03:08:00 INFO - 2015-12-03 03:08:00,839 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:87.10 Median:77.00 stddev:22.11 (28.7%) stddev-sans-first:23.15 03:08:00 INFO - 2015-12-03 03:08:00,839 DEBUG : BROWSER_OUTPUT: Values: 77.0 83.0 78.0 130.0 73.0 77.0 80.0 76.0 127.0 70.0 03:08:00 INFO - 2015-12-03 03:08:00,839 DEBUG : BROWSER_OUTPUT: 03:08:00 INFO - 2015-12-03 03:08:00,839 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:112.60 Median:120.50 stddev:23.67 (19.6%) stddev-sans-first:24.66 03:08:00 INFO - 2015-12-03 03:08:00,840 DEBUG : BROWSER_OUTPUT: Values: 100.0 102.0 147.0 95.0 96.0 102.0 147.0 97.0 94.0 146.0 03:08:00 INFO - 2015-12-03 03:08:00,840 DEBUG : BROWSER_OUTPUT: 03:08:00 INFO - 2015-12-03 03:08:00,840 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:127.40 Median:127.00 stddev:4.90 (3.9%) stddev-sans-first:4.80 03:08:00 INFO - 2015-12-03 03:08:00,840 DEBUG : BROWSER_OUTPUT: Values: 122.0 129.0 125.0 135.0 130.0 124.0 124.0 124.0 136.0 125.0 03:08:00 INFO - 2015-12-03 03:08:00,840 DEBUG : BROWSER_OUTPUT: 03:08:00 INFO - 2015-12-03 03:08:00,840 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:135.50 Median:135.50 stddev:2.92 (2.2%) stddev-sans-first:2.32 03:08:00 INFO - 2015-12-03 03:08:00,841 DEBUG : BROWSER_OUTPUT: Values: 130.0 135.0 136.0 140.0 135.0 134.0 136.0 135.0 134.0 140.0 03:08:00 INFO - 2015-12-03 03:08:00,841 DEBUG : BROWSER_OUTPUT: 03:08:00 INFO - 2015-12-03 03:08:00,841 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:111.90 Median:111.50 stddev:7.06 (6.3%) stddev-sans-first:6.29 03:08:00 INFO - 2015-12-03 03:08:00,841 DEBUG : BROWSER_OUTPUT: Values: 101.0 109.0 111.0 113.0 112.0 109.0 109.0 129.0 115.0 111.0 03:08:00 INFO - 2015-12-03 03:08:00,841 DEBUG : BROWSER_OUTPUT: 03:08:00 INFO - 2015-12-03 03:08:00,841 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:64.50 Median:65.00 stddev:4.79 (7.4%) stddev-sans-first:4.65 03:08:00 INFO - 2015-12-03 03:08:00,842 DEBUG : BROWSER_OUTPUT: Values: 59.0 61.0 62.0 64.0 66.0 66.0 67.0 76.0 61.0 63.0 03:08:00 INFO - 2015-12-03 03:08:00,842 DEBUG : BROWSER_OUTPUT: 03:08:00 INFO - 2015-12-03 03:08:00,843 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:72.10 Median:73.00 stddev:2.64 (3.6%) stddev-sans-first:2.55 03:08:00 INFO - 2015-12-03 03:08:00,843 DEBUG : BROWSER_OUTPUT: Values: 69.0 67.0 70.0 75.0 72.0 75.0 74.0 73.0 73.0 73.0 03:08:00 INFO - 2015-12-03 03:08:00,843 DEBUG : BROWSER_OUTPUT: 03:08:00 INFO - 2015-12-03 03:08:00,843 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:90.00 Median:91.00 stddev:2.83 (3.1%) stddev-sans-first:2.60 03:08:00 INFO - 2015-12-03 03:08:00,843 DEBUG : BROWSER_OUTPUT: Values: 86.0 86.0 87.0 90.0 90.0 91.0 92.0 93.0 91.0 94.0 03:08:00 INFO - 2015-12-03 03:08:00,844 DEBUG : BROWSER_OUTPUT: 03:08:00 INFO - 2015-12-03 03:08:00,844 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:136.00 Median:135.50 stddev:6.16 (4.5%) stddev-sans-first:5.61 03:08:00 INFO - 2015-12-03 03:08:00,844 DEBUG : BROWSER_OUTPUT: Values: 127.0 132.0 135.0 130.0 136.0 145.0 145.0 142.0 135.0 133.0 03:08:00 INFO - 2015-12-03 03:08:00,844 DEBUG : BROWSER_OUTPUT: 03:08:00 INFO - 2015-12-03 03:08:00,844 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.40 Median:160.50 stddev:9.19 (5.7%) stddev-sans-first:6.54 03:08:00 INFO - 2015-12-03 03:08:00,844 DEBUG : BROWSER_OUTPUT: Values: 137.0 144.0 166.0 163.0 157.0 158.0 158.0 163.0 163.0 155.0 03:08:00 INFO - 2015-12-03 03:08:00,844 DEBUG : BROWSER_OUTPUT: 03:08:00 INFO - 2015-12-03 03:08:00,844 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.50 Median:75.50 stddev:3.21 (4.2%) stddev-sans-first:2.96 03:08:00 INFO - 2015-12-03 03:08:00,844 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 70.0 77.0 76.0 77.0 76.0 75.0 73.0 73.0 03:08:00 INFO - 2015-12-03 03:08:00,845 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:08:00 INFO - 2015-12-03 03:08:00,845 DEBUG : BROWSER_OUTPUT: 03:08:01 INFO - 2015-12-03 03:08:01,461 INFO : Browser exited with error code: 0 03:08:01 INFO - 2015-12-03 03:08:01,513 INFO : Completed test kraken (00:00:58) 03:08:01 INFO - 2015-12-03 03:08:01,513 INFO : Starting test v8_7 03:08:01 INFO - 2015-12-03 03:08:01,513 DEBUG : operating with platform_type : mac_ 03:08:01 INFO - 2015-12-03 03:08:01,513 INFO : Initialising browser for v8_7 test... 03:08:01 INFO - 2015-12-03 03:08:01,527 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/tmp2Fu3DI/profile http://localhost:49861/getInfo.html 03:08:03 INFO - 2015-12-03 03:08:03,763 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:08:03 INFO - 2015-12-03 03:08:03,764 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:08:03 INFO - 2015-12-03 03:08:03,764 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 03:08:03 INFO - 2015-12-03 03:08:03,764 DEBUG : BROWSER_OUTPUT: __metrics 03:08:03 INFO - 2015-12-03 03:08:03,768 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:08:04 INFO - 2015-12-03 03:08:04,404 INFO : Browser initialized. 03:08:04 INFO - 2015-12-03 03:08:04,405 INFO : Running cycle 1/1 for v8_7 test... 03:08:04 INFO - 2015-12-03 03:08:04,405 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/tmp2Fu3DI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:08:16 INFO - 2015-12-03 03:08:16,300 DEBUG : BROWSER_OUTPUT: RSS: Main: 197758976 03:08:16 INFO - 2015-12-03 03:08:16,301 DEBUG : BROWSER_OUTPUT: 03:08:37 INFO - 2015-12-03 03:08:37,710 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49861/tests/v8_7/run.html (next: http://localhost:49861/tests/v8_7/run.html) 03:08:37 INFO - 2015-12-03 03:08:37,959 DEBUG : BROWSER_OUTPUT: RSS: Main: 557191168 03:08:37 INFO - 2015-12-03 03:08:37,959 DEBUG : BROWSER_OUTPUT: 03:08:37 INFO - 2015-12-03 03:08:37,959 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:08:37 INFO - 2015-12-03 03:08:37,959 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:08:37 INFO - 2015-12-03 03:08:37,960 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:08:37 INFO - 2015-12-03 03:08:37,960 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:08:37 INFO - 2015-12-03 03:08:37,960 DEBUG : BROWSER_OUTPUT: |0;Richards;171.52658662092625 03:08:37 INFO - 2015-12-03 03:08:37,960 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;184.8770567572564 03:08:37 INFO - 2015-12-03 03:08:37,960 DEBUG : BROWSER_OUTPUT: |2;Encrypt;345.9010722933241 03:08:37 INFO - 2015-12-03 03:08:37,960 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6229.813664596273 03:08:37 INFO - 2015-12-03 03:08:37,960 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1091.703056768559 03:08:37 INFO - 2015-12-03 03:08:37,960 DEBUG : BROWSER_OUTPUT: |5;Earley;740.1924500370096 03:08:37 INFO - 2015-12-03 03:08:37,960 DEBUG : BROWSER_OUTPUT: |6;Boyer;13426.666666666666 03:08:37 INFO - 2015-12-03 03:08:37,960 DEBUG : BROWSER_OUTPUT: |7;RegExp;31250 03:08:37 INFO - 2015-12-03 03:08:37,960 DEBUG : BROWSER_OUTPUT: |8;Splay;723.589001447178 03:08:37 INFO - 2015-12-03 03:08:37,960 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6185.185185185185 03:08:37 INFO - 2015-12-03 03:08:37,961 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:08:37 INFO - 2015-12-03 03:08:37,961 DEBUG : BROWSER_OUTPUT: __startTimestamp1449140917957__endTimestamp 03:08:37 INFO - 2015-12-03 03:08:37,961 DEBUG : BROWSER_OUTPUT: 03:08:37 INFO - 2015-12-03 03:08:37,961 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:08:37 INFO - 2015-12-03 03:08:37,961 DEBUG : BROWSER_OUTPUT: Number of tests: 10 03:08:37 INFO - 2015-12-03 03:08:37,961 DEBUG : BROWSER_OUTPUT: 03:08:37 INFO - 2015-12-03 03:08:37,961 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:171.53 Median:171.53 stddev:0.00 (0.0%) 03:08:37 INFO - 2015-12-03 03:08:37,961 DEBUG : BROWSER_OUTPUT: Values: 171.5 03:08:37 INFO - 2015-12-03 03:08:37,961 DEBUG : BROWSER_OUTPUT: 03:08:37 INFO - 2015-12-03 03:08:37,961 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:184.88 Median:184.88 stddev:0.00 (0.0%) 03:08:37 INFO - 2015-12-03 03:08:37,961 DEBUG : BROWSER_OUTPUT: Values: 184.9 03:08:37 INFO - 2015-12-03 03:08:37,961 DEBUG : BROWSER_OUTPUT: 03:08:37 INFO - 2015-12-03 03:08:37,961 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:345.90 Median:345.90 stddev:0.00 (0.0%) 03:08:37 INFO - 2015-12-03 03:08:37,961 DEBUG : BROWSER_OUTPUT: Values: 345.9 03:08:37 INFO - 2015-12-03 03:08:37,962 DEBUG : BROWSER_OUTPUT: 03:08:37 INFO - 2015-12-03 03:08:37,962 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6229.81 Median:6229.81 stddev:0.00 (0.0%) 03:08:37 INFO - 2015-12-03 03:08:37,962 DEBUG : BROWSER_OUTPUT: Values: 6229.8 03:08:37 INFO - 2015-12-03 03:08:37,962 DEBUG : BROWSER_OUTPUT: 03:08:37 INFO - 2015-12-03 03:08:37,962 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1091.70 Median:1091.70 stddev:0.00 (0.0%) 03:08:37 INFO - 2015-12-03 03:08:37,962 DEBUG : BROWSER_OUTPUT: Values: 1091.7 03:08:37 INFO - 2015-12-03 03:08:37,962 DEBUG : BROWSER_OUTPUT: 03:08:37 INFO - 2015-12-03 03:08:37,962 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:740.19 Median:740.19 stddev:0.00 (0.0%) 03:08:37 INFO - 2015-12-03 03:08:37,962 DEBUG : BROWSER_OUTPUT: Values: 740.2 03:08:37 INFO - 2015-12-03 03:08:37,962 DEBUG : BROWSER_OUTPUT: 03:08:37 INFO - 2015-12-03 03:08:37,962 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:13426.67 Median:13426.67 stddev:0.00 (0.0%) 03:08:37 INFO - 2015-12-03 03:08:37,962 DEBUG : BROWSER_OUTPUT: Values: 13426.7 03:08:37 INFO - 2015-12-03 03:08:37,963 DEBUG : BROWSER_OUTPUT: 03:08:37 INFO - 2015-12-03 03:08:37,963 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:31250.00 Median:31250.00 stddev:0.00 (0.0%) 03:08:37 INFO - 2015-12-03 03:08:37,963 DEBUG : BROWSER_OUTPUT: Values: 31250.0 03:08:37 INFO - 2015-12-03 03:08:37,963 DEBUG : BROWSER_OUTPUT: 03:08:37 INFO - 2015-12-03 03:08:37,963 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:723.59 Median:723.59 stddev:0.00 (0.0%) 03:08:37 INFO - 2015-12-03 03:08:37,963 DEBUG : BROWSER_OUTPUT: Values: 723.6 03:08:37 INFO - 2015-12-03 03:08:37,963 DEBUG : BROWSER_OUTPUT: 03:08:37 INFO - 2015-12-03 03:08:37,963 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6185.19 Median:6185.19 stddev:0.00 (0.0%) 03:08:37 INFO - 2015-12-03 03:08:37,963 DEBUG : BROWSER_OUTPUT: Values: 6185.2 03:08:37 INFO - 2015-12-03 03:08:37,963 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:08:37 INFO - 2015-12-03 03:08:37,963 DEBUG : BROWSER_OUTPUT: 03:08:38 INFO - 2015-12-03 03:08:38,572 INFO : Browser exited with error code: 0 03:08:38 INFO - 2015-12-03 03:08:38,592 INFO : Completed test v8_7 (00:00:37) 03:08:38 INFO - 2015-12-03 03:08:38,618 INFO : Completed test suite (00:20:09) 03:08:38 INFO - 2015-12-03 03:08:38,618 DEBUG : Working with test: dromaeo_css 03:08:38 INFO - 2015-12-03 03:08:38,618 DEBUG : Generating results file: dromaeo_css 03:08:38 INFO - 2015-12-03 03:08:38,619 DEBUG : Working with test: kraken 03:08:38 INFO - 2015-12-03 03:08:38,619 DEBUG : Generating results file: kraken 03:08:38 INFO - 2015-12-03 03:08:38,619 INFO : javascript benchmark 03:08:38 INFO - 2015-12-03 03:08:38,620 DEBUG : Working with test: v8_7 03:08:38 INFO - 2015-12-03 03:08:38,620 DEBUG : Generating results file: v8_7 03:08:38 INFO - 2015-12-03 03:08:38,620 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:08:38 INFO - 2015-12-03 03:08:38,686 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,55]] 03:08:38 INFO - 2015-12-03 03:08:38,687 DEBUG : process_Request line: dromaeo_css 6158.39 graph.html#tests=[[72,52,55]] 03:08:38 INFO - 2015-12-03 03:08:38,687 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:08:38 INFO - 2015-12-03 03:08:38,721 DEBUG : process_Request line: kraken 1599.40 graph.html#tests=[[232,52,55]] 03:08:38 INFO - 2015-12-03 03:08:38,721 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:08:38 INFO - 2015-12-03 03:08:38,762 DEBUG : process_Request line: v8_7 18979.01 graph.html#tests=[[230,52,55]] 03:08:38 INFO - 2015-12-03 03:08:38,763 INFO : javascript benchmark 03:08:38 INFO - 2015-12-03 03:08:38,764 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [333.8330834582709, 334.6452760074321, 335.1888429999401, 337.2193372343027, 342.6487849953797, 14238.572842814732, 14614.561563153096, 15940.601484962866, 16426.178691065445, 17522.123893805307, 11123.666290011291, 13862.584122476317, 14660.633484162901, 17233.482995510123, 17419.564510887234, 4042.9393559096566, 4165.396017577465, 4186.225548273564, 4188.6439652629415, 4203.327467605184, 3247.350529894031, 4138.52406973199, 4138.875833724978, 4150.439690641755, 4190.413342132104, 4094.324436467994, 4494.078713863666, 4501.122281155176, 4510.030343476152, 4557.680962332638, 4211.620954114113, 4421.115776844628, 4497.7526236057, 4502.032063106448, 4544.4092268005115, 3819.8090095495113, 3822.4266360046217, 3829.3107240696663, 3833.6358045985585, 3836.5804652278557, 12801.743965120739, 13020.153690010118, 13034.21794692312, 13058.0, 13099.934500327532, 1696.957576060596, 1715.6997525432998, 1718.4415065103767, 1823.8085001074828, 1882.4634979030911, 9110.453372797587, 9334.766630834283, 9363.204127649158, 9494.905050949472, 9528.142467177988, 1480.740870347685, 1506.4652048522726, 1543.7066957278082, 1557.8987365821185, 1593.3785823528833, 54602.72698636521, 57107.0, 57255.141172882024, 57456.0, 58084.419155808326, 6061.909071363933, 6107.389261073857, 6118.479929205978, 6126.417990291005, 6156.0, 6965.47758918073, 6967.059446974695, 7027.227005029443, 7045.788626341218, 7048.718051277994, 5227.921581176285, 5249.475052494797, 5271.420143784258, 5326.840194794162, 5327.334083239595, 5727.226824378656, 5728.398518155617, 5745.195672605839, 5765.250517432707, 5807.245058142415, 2762.958555621667, 2829.2078218098554, 2829.717028297154, 2839.0347281924246, 2866.4553734790325, 941.9293552983554, 961.3510880156007, 996.6163027234422, 1016.6035246253966, 1032.055669062799, 372.79123690733275, 385.11423725431393, 385.39108209029666, 399.3689969847634, 400.17763496015965, 10401.375917444977, 10777.407242601575, 11091.22361434708, 11193.0, 11243.26918750295, 410.55249777741807, 421.172396241381, 422.96827737919165, 423.3691799219141, 425.3555862867758, 5831.1544826000845, 5929.970350148222, 5977.402259773988, 6062.302835173923, 6072.36240194782, 362633.0, 559534.0, 568258.0, 570242.0, 578859.0, 67712.32287677159, 70161.29838701547, 70530.0, 70787.0, 71454.2854571458, 393.7184912787371, 404.7996241860298, 408.96319331259735, 409.68249606555156, 416.50435981182295, 9701.12689857888, 9741.659041933783, 9785.021497850443, 9833.4099954003, 9844.655437059668, 30550.694493055675, 33618.0, 33778.8311058453, 33995.49006764851, 34171.48742768811, 39565.40651890282, 41786.0, 42946.78526607347, 44260.33609495796, 44632.33051504295, 5326.8934621308135, 5332.413434522277, 5415.945840541544, 5437.537809286255, 5488.91766623493, 10308.12380947628, 10311.123554497952, 10581.788364232827, 10645.041946224877, 10756.085732712807, 9125.269978401844, 9140.451572905647, 9220.538973051187, 9404.106609872051, 9421.717348479557, 8532.445391049561, 8894.555272236492, 8965.731028069169, 9057.90942090597, 9153.130452606993, 7699.576523291273, 9277.350585458953, 9832.213422926006, 9966.850497242402, 9975.251856110675, 5672.2058911751565, 5743.1385292206505, 5753.712314384347, 5753.827385178452, 5824.592278540462, 9410.811783764424, 9475.952620236854, 9504.334696571173, 9637.132658060807, 9637.614495420105], "dojo.html": [2942.117364790565, 2943.4996050671384, 2947.778916581257, 3074.7232749052587, 3158.857851396687, 4964.2553616957475, 5047.4447810740885, 5055.191169412895, 5066.189409694445, 5090.389153301604, 4993.126202914494, 4997.975010124945, 5024.196128619422, 5060.139776238039, 5063.0380227756705, 4506.324051392285, 4587.724736515803, 4647.465541462741, 4653.650976176792, 4670.929936050945, 4661.184292748772, 4663.673542851985, 4706.411698537683, 4711.057788442326, 4729.0541891621815, 4532.592066713995, 4546.477155127153, 4549.090181963604, 4549.31760235964, 4590.196715574778, 4500.864974050767, 4541.6593755468475, 4564.497905230422, 4638.999999999966, 4648.790804413809, 4519.502854685982, 4522.819087236507, 4535.160995215896, 4590.693087061792, 4625.190591646448, 4766.332713420124, 4797.712137271775, 4865.805367785284, 4867.440244371907, 4930.654854160211, 5188.533032027136, 5251.317328747276, 5257.0, 5271.262023316739, 5357.544608708265, 5333.759980800874, 5339.065663508909, 5376.892462150735, 5436.891262174774, 5451.591130665216, 4897.240927656219, 4994.900101997976, 5015.548600625962, 5047.621428392885, 5088.491150884882, 5320.840374788762, 5393.298871146804, 5435.891282174413, 5458.2904222451625, 5529.281193444826, 5186.974065129651, 5187.636865419385, 5203.739813009334, 5212.478752124757, 5231.424543300234, 5200.531952124327, 5306.655067420683, 5352.892942141136, 5392.110301800238, 5400.135978243462, 4972.129877271463, 5075.543201111917, 5117.795288188505, 5163.4062082860955, 5303.840884773463, 5280.6303558750515, 5345.412004679482, 5393.352797664305, 5408.150563867628, 5425.430329815392, 3932.6264004919485, 4054.533728621246, 4158.438610787565, 4166.125113726091, 4210.347396153601, 3661.1579336752698, 3747.4191500317493, 3764.4353346997623, 3773.2076263984322, 3789.905252368658, 4984.975075124601, 5007.248912663057, 5056.140456122468, 5100.948990510047, 5104.387473503203, 5139.049275883899, 5225.111731005738, 5508.366537848118, 5562.221289019541, 5577.107662774018, 4796.424429068534, 4832.347633069561, 4908.067467181224, 4927.310176575283, 4968.279599458058, 4645.512221216791, 4754.07295577366, 4758.619310455225, 4792.0895029944195, 4808.326834243208, 5392.676439413648, 5528.474794894479, 5536.307961504812, 5536.861578460571, 5604.663720176803, 5249.89500209986, 5278.89442211146, 5337.839864804062, 5373.059714550016, 5420.891582168413, 5401.783928642967, 5484.533814625802, 5488.835334939959, 5499.862503437446, 5512.531434827924, 5147.819826306061, 5328.0, 5387.542058925035, 5388.488093631099, 5401.297831281908, 5200.375954885438, 5286.709230992333, 5300.681959082467, 5309.256704061511, 5321.787128514816, 5338.439463856239, 5395.325584301962, 5407.864803379947, 5412.648177868426, 5421.457854214547, 5062.190049592047, 5178.61160412963, 5342.011727830364, 5411.269478620336, 5412.269343638558, 5125.308083408841, 5152.948470515247, 5154.561862241751, 5266.89466210666, 5276.0, 5187.688738675692, 5190.117679994334, 5200.60995425337, 5202.089634314056, 5239.580833533232, 4828.61371090319, 5082.263071854634, 5098.643094983316, 5107.182850744011, 5151.072806894645], "mootools.html": [744.6760659113282, 1567.388718399824, 1643.827398123197, 1646.2262736513842, 1670.7159782836916, 6156.81529554113, 6460.7092680829355, 6645.867082658356, 6665.700043498042, 6736.8989465158065, 6619.768308109217, 6752.054712340277, 6756.797296081113, 6759.425448836842, 6807.761728339509, 2021.858469907107, 2025.1190732031614, 2044.846636502261, 2050.128695304497, 2051.179528188729, 2007.5483016321357, 2031.471817327498, 2034.6032523657893, 2062.0308455026116, 2063.5563353878915, 2017.4956260934766, 2026.371824734337, 2054.6507093794016, 2057.1360028787944, 2058.0430100003496, 2033.2070492507933, 2038.2254743197564, 2038.2560365466645, 2041.5100375909824, 2045.9079341429672, 2017.7276067730816, 2035.745531808524, 2048.805363490466, 2050.559129787103, 2056.033664177834, 6064.848378790522, 6217.844553886144, 6704.296048914891, 6761.560498567577, 6840.623765692885, 4070.1045769930865, 4209.684273679456, 4212.684048696329, 4221.176870510251, 4254.212970600449, 2624.829386089898, 2640.841549507036, 2649.8277611955355, 2670.6528151340203, 2688.932776680579, 812.1675282835082, 818.8239528501341, 1453.3096779029877, 1458.300015992319, 1512.9092254464658, 8636.784080397978, 8686.609102590399, 8689.869651955225, 8714.564271786385, 8793.428427152214, 3621.9094522637147, 3622.9637703622625, 3640.3265395901844, 3673.9816300918324, 3718.3492888744363, 7071.257517960643, 7072.434205263567, 7073.0, 7132.322429369202, 7184.137903451619, 4140.855070072533, 4151.647109995623, 4175.081482073939, 4182.205380977665, 4193.874183774492, 3866.2654095721723, 3869.245497128033, 3870.109874728772, 3871.341871881787, 3920.9019774505296, 3045.25391279138, 3066.0648502206595, 3093.1030001299373, 3095.4737694591972, 3108.1918701137865, 904.7511934218143, 924.6809850601531, 927.1423932862076, 928.79102202004, 936.7002559181133, 1171.2855158353398, 1219.9268043917393, 1226.6136167107334, 1244.9688757781128, 1250.3435696259355, 6573.3426657333885, 6594.571352862049, 6596.472282217411, 6599.8020059398295, 6600.339966003361, 397.16396984347534, 408.5363112866917, 414.9294619914622, 418.03642603798534, 418.053109706515, 4931.0, 5144.511271429208, 5174.508421699932, 5175.45657705943, 5263.0, 6968.163820341591, 7660.770176894702, 7844.137144914055, 7848.058233012075, 7923.0, 7746.806329841686, 7794.493357931717, 7828.647710853025, 7835.216478352119, 7848.686052557834, 6222.564420490613, 6299.212598425197, 6408.359164083555, 6447.0329450582785, 6563.474922006228, 6409.615423074631, 6412.935870641234, 6435.0, 6440.066190402459, 6466.547341686225, 7156.463265255023, 7255.056842610426, 7268.0914885639295, 7302.598357090411, 7317.304856038668, 7187.137543494814, 7302.087239095114, 7315.817104572428, 7342.045534080536, 7430.814229644086, 5797.188393624811, 5834.0, 5836.153757705194, 5908.05471124618, 5916.408359164049, 6560.27836937946, 6626.6686665667485, 6629.801105966829, 6629.966850165718, 6632.801015969529, 6206.0, 6235.189425374672, 6295.496360291258, 6326.145970293951, 6327.651979141191, 6077.574569780073, 6132.693365331805, 6191.628502289877, 6202.2867370253, 6204.13142160089, 6159.384061593805, 6236.688165591793, 6280.591761535486, 6295.150154729053, 6330.272018717722, 5597.944020559905, 5707.514861236841, 5737.110747834093, 5781.8554536136935, 5787.334456537384, 5757.712114394348, 5778.913316300175, 5780.190773291659, 5822.0, 5855.473007429352], "ext.html": [541.450427815767, 542.3410556174246, 549.0693274899045, 549.8268045565648, 561.0882316236116, 31166.0, 31732.365352692963, 36442.27115457689, 36907.630923690755, 36955.630443695554, 40646.593534064654, 41101.0, 41188.0, 41317.17365652685, 41585.16829663405, 8037.799055023613, 8518.701845435411, 8599.398042137052, 8738.606762695663, 8770.12298770121, 8012.318952889012, 10497.895021049806, 10560.31357961734, 10683.946580267087, 10697.83953240702, 10369.325993810378, 10376.533056012497, 10453.529591168415, 10470.057694807465, 10569.788604227911, 8226.753197404087, 8412.411131220817, 10356.37861728295, 10481.895181048207, 10561.683149505527, 10217.182625390025, 10358.171346292278, 10380.169586433067, 10389.9480502597, 10390.0, 37994.24011519754, 38117.61882381168, 38395.23209535793, 38482.23035539302, 38515.807420963, 2749.7351218439344, 2822.125141206212, 2843.6587609486787, 2865.8280503169876, 3401.1327111586634, 26497.73502264991, 26550.203493895213, 26579.46841063187, 26931.326716832235, 27080.729192708215, 2282.6690129931235, 2283.303592404316, 2291.598970180212, 2298.28753086542, 2301.7813307735737, 257798.0, 259182.70408648025, 260254.0, 260745.0, 261477.0, 56605.15092273619, 57743.133852992236, 60223.0, 64778.0, 66901.33098668951, 60614.696926515084, 60659.0, 60818.0, 60884.086738698956, 60911.69544152251, 16310.75533866993, 16318.0, 16350.591235219215, 16500.83499165017, 16531.173441327886, 12502.249865008129, 12558.30929298879, 12628.747425051448, 12707.809382859265, 12816.0, 19746.50633734168, 19928.800711992986, 19972.600547988957, 19981.800181998286, 20003.299884504264, 8034.437589368805, 8229.423940324119, 8338.749837504885, 8374.288185504178, 8460.0, 941.2328951904176, 945.2013048973606, 945.5083356654501, 1023.8668973033458, 1036.103770238738, 27514.521247928813, 27578.0, 27844.0, 27878.442431151263, 28027.0, 917.5180191174376, 977.8533220016913, 1023.1865666794915, 1048.187654567701, 1122.2088427658482, 11636.418179091012, 12916.289604071679, 14776.40894364235, 14977.850221497863, 15101.47144849925, 311507.0, 318604.0, 319774.0, 321069.0, 322474.0, 45305.546944530135, 52925.0, 53269.46730532645, 53442.198367024524, 53479.0, 1240.3550153919912, 1346.6296768388772, 1353.4180302470033, 1364.270115488209, 1461.985380146185, 25941.09206177775, 26972.730272697023, 27165.320866978484, 27896.86051569729, 27944.44111117807, 44455.0, 44749.32876006928, 44813.551864480934, 45201.32198017098, 50103.0, 203721.0, 205194.0, 207327.0, 207475.0, 208377.0, 28967.420651587272, 29095.12714618565, 29932.0, 29995.100146995625, 30286.394272114874, 37198.25603487969, 41103.38344924888, 41366.1726765469, 41672.79163604163, 41685.37471937984, 32466.675333246367, 34231.48652770161, 34408.82795586006, 34592.135196620286, 34858.47712284369, 33487.33025339528, 33861.0, 34485.0, 34495.13762155866, 34596.0, 34274.485882711284, 34953.126171845906, 35066.474002890485, 35191.29617407689, 35708.0, 29719.55420668735, 29842.850785745934, 29873.253168670955, 30033.54949675713, 30034.3993120132, 22754.544909102056, 23278.3016509505, 23477.647835282827, 23514.412139696644, 23563.764362356156], "prototype.html": [281.32762697153805, 290.11514879617164, 291.88762326504303, 294.3891425292518, 298.31834258718834, 5480.890382192354, 5757.798477053304, 5773.653580785156, 5777.42225777422, 5895.941040589592, 5572.4148964358765, 5589.580781441398, 5592.189132575774, 5684.0, 5710.486056254937, 4293.7209081409765, 4298.398224248608, 4314.37441570972, 4316.5036020857615, 4338.240807858612, 4210.989362552996, 4291.8497852575165, 4300.526942036374, 4312.28847240205, 4373.190959672471, 4212.789360531977, 4227.640650544708, 4264.445622069126, 4288.892777680568, 4363.38912552243, 4240.512341080785, 4257.042165512766, 4268.423762792015, 4286.892827679318, 4306.892327691801, 3679.411294192943, 3704.814759262053, 3709.0541911812584, 3711.480392745018, 3711.9072023199365, 5535.889282214373, 5538.196961440609, 5548.91676624851, 5587.189857470685, 5620.297462817148, 4755.762211889426, 4946.183879659852, 4947.975260123712, 4950.777215025332, 4953.826616068421, 5949.25634295713, 5964.403559644001, 6008.609440386361, 6027.336992930774, 6031.668258245794, 4043.2722110020186, 4074.0833312504747, 4076.347784354519, 4086.3257562502154, 4134.73124246923, 6119.418655227746, 6268.059791031336, 6281.089242059876, 6282.2147231596055, 6304.716287767015, 4080.5103387593085, 4091.243120022805, 4092.7135100542678, 4130.814113364906, 4153.210889930964, 4165.729227600196, 4168.958310416857, 4174.686898482626, 4187.43469631602, 4223.303154979394, 4842.225243960949, 4881.4630390657, 4890.657653964188, 4902.632302577321, 4914.778834952435, 5784.739686714108, 6014.939850601438, 6042.577019608585, 6042.818715438544, 6048.364921683248, 1453.14264583896, 1464.4874293997016, 1473.638958455164, 1478.1205182916149, 1478.3569147420906, 924.6578765856676, 927.8097989912052, 929.61885626894, 937.5921474158763, 940.722486866376, 5591.10542313228, 5601.6358936668985, 5603.551715862721, 5604.971975140098, 5609.467100625434, 6216.689165541705, 6228.128062071313, 6235.719392627343, 6242.687865606701, 6282.089097080898, 5481.150421684645, 5530.557555395559, 5614.045612245928, 5616.073347897551, 5616.438356164351, 3445.1214940190594, 3473.0449126490416, 3488.145404375944, 3489.9302013959577, 3523.6828685418436, 6306.400891915261, 6307.369263073656, 6308.400701933309, 6318.115463835067, 6373.044043393528, 6201.844953876189, 6422.775202867877, 6440.259370172396, 6465.709043093072, 6513.088167656532, 6301.40136687014, 6348.365163483615, 6420.550561460746, 6424.935750642528, 6437.903431448625, 6317.494600432046, 6338.397852204033, 6346.936530634819, 6388.680565971776, 6389.041643753474, 6009.098635204754, 6175.413335733098, 6199.876002479835, 6214.751409943732, 6244.65654389013, 6302.0, 6315.936840631535, 6325.810225693236, 6366.713497892699, 6367.26776420699, 3934.2131573684806, 3971.980140099281, 3978.8209530570616, 3981.48240728715, 4022.3966405039478, 6188.916939535653, 6214.8135555931585, 6229.470495007975, 6266.310705822447, 6269.090981807703, 6000.939990600213, 6016.849578760566, 6034.849128771816, 6072.301685306246, 6141.600795948428, 6016.819495415145, 6048.243969503812, 6049.30433000193, 6077.6353418795015, 6126.23422072241, 5914.970425147847, 5916.55625828056, 5917.91123133162, 5944.673042982505, 5994.31065427464, 5891.086881533369, 6110.969445152924, 6125.989211780006, 6146.6004709693725, 6176.845578860564, 5990.7903223386975, 5993.130996005642, 6000.51995840323, 6024.9397506026135, 6059.939400605937], "yui.html": [677.9491538134641, 716.6524235745662, 719.6186021408652, 721.3399739238596, 734.2437289591722, 13121.343932803358, 13581.864181358196, 13594.320283985811, 13703.931480342584, 13713.177209367432, 12493.500259989612, 12639.0, 12641.178323408973, 12780.61658150257, 12834.101612887102, 689.3795583974438, 702.620584884162, 860.0324634785866, 868.7350358140781, 878.1613559051091, 856.1737922904396, 861.4960248254779, 869.9739007829776, 870.7474832298626, 872.9039805621377, 907.0883761819363, 914.4650379527951, 915.1214833759599, 915.9587818548148, 917.0645941140033, 712.4478529139906, 721.5382155420535, 880.8062226310202, 881.9647214111428, 896.1486587741606, 649.0621052578978, 654.2149420695184, 654.9705263263164, 659.1266571792394, 661.9669016549153, 12632.49470021198, 12765.680857978532, 12856.228626282453, 12979.0, 12982.675433114153, 10753.677389678322, 11188.496517656726, 11298.54805807775, 11562.826557601642, 11608.709782255512, 9041.63833446668, 9054.86417703735, 9129.543522823833, 9254.12085851843, 9259.351845370828, 3112.4864397374404, 3149.9055028349185, 3198.9680103198903, 3249.1714612773826, 3254.6094468663673, 46135.53864461312, 46719.0, 46913.0, 47048.2942755859, 47156.292655609854, 8345.319444375244, 8697.130286971378, 8699.869501957475, 8863.955680221687, 8929.1468971091, 18820.905895470434, 18844.05779711009, 18912.338068167548, 18916.10838916125, 19036.80963190378, 6834.555753875982, 6902.689378977958, 7018.368346848808, 7042.647867606702, 7142.321479459443, 3835.8082095895093, 3857.4213867920034, 3912.784796836201, 3979.2837289288204, 3986.3023970804993, 2703.9053633122744, 2772.3207814085677, 2774.694783573805, 2780.6107144999714, 2824.5904343870025, 406.6641084038918, 407.92657321681787, 412.8555005747964, 414.4674093789466, 414.5564246256537, 486.727432637724, 511.9513646203605, 535.1010302691516, 558.2296430925297, 574.2678085441096, 7503.437242206856, 7533.171351151369, 7709.190534993745, 7778.766637000899, 7873.803154921058, 439.65926407034164, 440.02095337872976, 488.19447910947224, 522.4305506997391, 583.9270091238595, 3362.83185840707, 3715.108373990277, 3717.7211709121925, 3777.9433308500393, 3798.0884587699306, 58541.121883171785, 58973.705131474926, 59240.40759592349, 59473.702631486565, 59768.0, 48237.27644085341, 48328.27507587389, 48395.75802121037, 48407.515924841005, 48746.75626621844, 44817.87955301078, 46205.0, 46831.0, 46868.0, 47122.76438617785, 7231.2768723129375, 7318.817029574303, 7465.888011679721, 7467.327940485382, 7555.962220188864, 33999.32001360008, 34057.65942340545, 34758.0, 34764.82617586896, 34779.0, 42678.35982460328, 43078.13843723045, 43673.12653746971, 43699.34450983301, 45863.54136458593, 6409.653972665792, 6426.614403135827, 6474.870502590016, 6582.275949645439, 6791.219009813737, 9681.322307438411, 9857.063578959987, 10099.79800403973, 10164.33931794431, 10182.389056656624, 9198.95400522993, 9219.400738951947, 9545.47499887485, 9715.22278217755, 9842.557084931052, 9370.344075914893, 9415.529223538933, 9448.0, 9468.621255149717, 9620.230381569318, 8658.91341086581, 8773.605187766438, 9158.816823663356, 9277.721668349961, 9328.0205578416, 8002.439829212132, 8466.238038576557, 8676.78308042304, 8799.47203167812, 9025.954870225869, 8298.0, 8834.337424693302, 8924.107589241024, 9006.369554131148, 9184.081591840762]}, "summary": {"suite": 6158.38720868145, "subtests": {"jquery.html": {"filtered": 6213.869026508041, "value": 6213.869026508041}, "dojo.html": {"filtered": 4938.430262591542, "value": 4938.430262591542}, "mootools.html": {"filtered": 3870.216055259919, "value": 3870.216055259919}, "ext.html": {"filtered": 17878.103582280248, "value": 17878.103582280248}, "prototype.html": {"filtered": 4486.507657467406, "value": 4486.507657467406}, "yui.html": {"filtered": 5725.876905880174, "value": 5725.876905880174}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0097"}, "testrun": {"date": 1449139709, "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": "20151203004003", "branch": "Mozilla-Aurora", "revision": "7aad7dee85151ba464c2a5d5aa9e522bad9287e3"}}, {"talos_counters": {}, "results": {"audio-dft": [163.0, 169.0, 173.0, 174.0, 175.0, 181.0, 177.0, 174.0, 174.0, 174.0], "ai-astar": [109.0, 108.0, 101.0, 106.0, 110.0, 114.0, 108.0, 109.0, 101.0, 106.0], "imaging-gaussian-blur": [122.0, 129.0, 125.0, 135.0, 130.0, 124.0, 124.0, 124.0, 136.0, 125.0], "audio-beat-detection": [159.0, 136.0, 164.0, 158.0, 131.0, 150.0, 135.0, 177.0, 167.0, 141.0], "json-stringify-tinderbox": [69.0, 67.0, 70.0, 75.0, 72.0, 75.0, 74.0, 73.0, 73.0, 73.0], "stanford-crypto-pbkdf2": [137.0, 144.0, 166.0, 163.0, 157.0, 158.0, 158.0, 163.0, 163.0, 155.0], "json-parse-financial": [59.0, 61.0, 62.0, 64.0, 66.0, 66.0, 67.0, 76.0, 61.0, 63.0], "stanford-crypto-sha256-iterative": [69.0, 69.0, 70.0, 77.0, 76.0, 77.0, 76.0, 75.0, 73.0, 73.0], "audio-fft": [77.0, 83.0, 78.0, 130.0, 73.0, 77.0, 80.0, 76.0, 127.0, 70.0], "imaging-darkroom": [130.0, 135.0, 136.0, 140.0, 135.0, 134.0, 136.0, 135.0, 134.0, 140.0], "stanford-crypto-ccm": [127.0, 132.0, 135.0, 130.0, 136.0, 145.0, 145.0, 142.0, 135.0, 133.0], "audio-oscillator": [100.0, 102.0, 147.0, 95.0, 96.0, 102.0, 147.0, 97.0, 94.0, 146.0], "stanford-crypto-aes": [86.0, 86.0, 87.0, 90.0, 90.0, 91.0, 92.0, 93.0, 91.0, 94.0], "imaging-desaturate": [101.0, 109.0, 111.0, 113.0, 112.0, 109.0, 109.0, 129.0, 115.0, 111.0]}, "summary": {"suite": 1599.4, "subtests": {"audio-fft": {"filtered": 87.1, "value": 87.1}, "stanford-crypto-pbkdf2": {"filtered": 156.4, "value": 156.4}, "audio-beat-detection": {"filtered": 151.8, "value": 151.8}, "stanford-crypto-ccm": {"filtered": 136.0, "value": 136.0}, "imaging-darkroom": {"filtered": 135.5, "value": 135.5}, "json-parse-financial": {"filtered": 64.5, "value": 64.5}, "audio-oscillator": {"filtered": 112.6, "value": 112.6}, "ai-astar": {"filtered": 107.2, "value": 107.2}, "audio-dft": {"filtered": 173.4, "value": 173.4}, "stanford-crypto-sha256-iterative": {"filtered": 73.5, "value": 73.5}, "json-stringify-tinderbox": {"filtered": 72.1, "value": 72.1}, "imaging-gaussian-blur": {"filtered": 127.4, "value": 127.4}, "stanford-crypto-aes": {"filtered": 90.0, "value": 90.0}, "imaging-desaturate": {"filtered": 111.9, "value": 111.9}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0097"}, "testrun": {"date": 1449139709, "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": "20151203004003", "branch": "Mozilla-Aurora", "revision": "7aad7dee85151ba464c2a5d5aa9e522bad9287e3"}}, {"talos_counters": {}, "results": {"DeltaBlue": [184.8770567572564], "Encrypt": [345.9010722933241], "NavierStokes": [6185.185185185185], "Decrypt": [6229.813664596273], "Splay": [723.589001447178], "Richards": [171.52658662092625], "RegExp": [31250.0], "Earley": [740.1924500370096], "Boyer": [13426.666666666666], "RayTrace": [1091.703056768559]}, "summary": {"suite": 18979.01308591522, "subtests": {"DeltaBlue": {"filtered": 357.63226199999986, "value": 357.63226199999986}, "Encrypt": {"filtered": 769.5292710000003, "value": 769.5292710000003}, "NavierStokes": {"filtered": 239.92814371257467, "value": 239.92814371257467}, "Decrypt": {"filtered": 42.72696011964105, "value": 42.72696011964105}, "Splay": {"filtered": 112.62056199999999, "value": 112.62056199999999}, "RegExp": {"filtered": 29.151519999999987, "value": 29.151519999999987}, "Richards": {"filtered": 205.81065999999998, "value": 205.81065999999998}, "Earley": {"filtered": 900.3915129999997, "value": 900.3915129999997}, "Boyer": {"filtered": 49.6372641509434, "value": 49.6372641509434}, "RayTrace": {"filtered": 677.8299240000001, "value": 677.8299240000001}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0097"}, "testrun": {"date": 1449139709, "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": "20151203004003", "branch": "Mozilla-Aurora", "revision": "7aad7dee85151ba464c2a5d5aa9e522bad9287e3"}}] 03:08:38 INFO - RETURN: dromaeo_css: 6158.39 03:08:38 INFO - RETURN: kraken: 1599.40 03:08:38 INFO - RETURN: v8_7: 18979.01 03:08:38 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,55]]", "result": "18979.01"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,55]]", "result": "1599.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,55]]", "result": "6158.39"}}} 03:08:38 INFO - Return code: 0 03:08:38 INFO - # TBPL SUCCESS # 03:08:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:08:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:08:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:08:38 INFO - 2015-12-03 03:08:38.860 screenresolution[2060:24158] starting screenresolution argv=screenresolution get 03:08:38 INFO - 2015-12-03 03:08:38.866 screenresolution[2060:24158] Display 0: 1600x1200x32@60 03:08:38 INFO - 2015-12-03 03:08:38.872 screenresolution[2061:24162] starting screenresolution argv=screenresolution list 03:08:38 INFO - Available Modes on Display 0 03:08:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:08:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:08:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:08:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:08:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:08:39 INFO - Intel HD Graphics 3000: 03:08:39 INFO - Chipset Model: Intel HD Graphics 3000 03:08:39 INFO - Type: GPU 03:08:39 INFO - Bus: Built-In 03:08:39 INFO - VRAM (Total): 512 MB 03:08:39 INFO - VRAM (Dynamic, Max): 10 03:08:39 INFO - Vendor: Intel (0x8086) 03:08:39 INFO - Device ID: 0x0116 03:08:39 INFO - Revision ID: 0x0009 03:08:39 INFO - Displays: 03:08:39 INFO - Display: 03:08:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:08:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:08:39 INFO - Display Serial Number: 1600x1200 60 03:08:39 INFO - Main Display: Yes 03:08:39 INFO - Mirror: Off 03:08:39 INFO - Online: Yes 03:08:39 INFO - Rotation: Supported 03:08:39 INFO - Return code: 0 03:08:39 INFO - Running post-action listener: _resource_record_post_action 03:08:39 INFO - Running post-run listener: _resource_record_post_run 03:08:40 INFO - Total resource usage - Wall time: 1249s; CPU: 30.0%; Read bytes: 192512; Write bytes: 684258304; Read time: 117; Write time: 69775 03:08:40 INFO - install - Wall time: 39s; CPU: 30.0%; Read bytes: 334340608; Write bytes: 334858240; Read time: 33478; Write time: 6984 03:08:40 INFO - run-tests - Wall time: 1210s; CPU: 30.0%; Read bytes: 192512; Write bytes: 339135488; Read time: 117; Write time: 62042 03:08:40 INFO - Running post-run listener: _upload_blobber_files 03:08:40 INFO - Blob upload gear active. 03:08:40 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 03:08:40 INFO - Copying logs to upload dir... 03:08:40 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1317.715728 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2015-12-03 03:08:40.291124) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-03 03:08:40.295030) ========= 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.XbnhTwpCSs/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.heTemyE2si/Listeners TMPDIR=/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/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/8T2u2LUeS3y8uUvfLin7OQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009808 build_url: 'https://queue.taskcluster.net/v1/task/8T2u2LUeS3y8uUvfLin7OQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-03 03:08:40.318336) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 03:08:40.318930) ========= 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.XbnhTwpCSs/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.heTemyE2si/Listeners TMPDIR=/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/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.005231 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 03:08:40.371415) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 03:08:40.371955) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 03:08:40.372709) ========= ========= Total master_lag: 0.20 =========