builder: mozilla-central_yosemite_test-dromaeojs slave: t-yosemite-r5-0047 starttime: 1445647678.97 results: success (0) buildid: 20151023153832 builduid: aabcbbac09c04978ab166b620d55a4d9 revision: 9b328712d6cd729984ab946294bad62e426e5713 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-10-23 17:47:58.973357) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-10-23 17:47:58.973846) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-23 17:47:58.974138) ========= 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.1KUwu8NaCv/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.K8x8Wlr7Oo/Listeners TMPDIR=/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/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.005775 basedir: '/builds/slave/test' ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-23 17:47:59.070480) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-23 17:47:59.070865) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-23 17:47:59.096923) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-23 17:47:59.097319) ========= 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.1KUwu8NaCv/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.K8x8Wlr7Oo/Listeners TMPDIR=/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/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.017108 ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-23 17:47:59.146775) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-23 17:47:59.147093) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-23 17:47:59.147527) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-23 17:47:59.147859) ========= 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.1KUwu8NaCv/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.K8x8Wlr7Oo/Listeners TMPDIR=/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/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-10-23 17:47:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 9.33M=0.001s 2015-10-23 17:47:59 (9.33 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.212200 ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-23 17:47:59.375487) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-23 17:47:59.375869) ========= 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.1KUwu8NaCv/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.K8x8Wlr7Oo/Listeners TMPDIR=/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/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.039751 ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-23 17:47:59.429936) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-23 17:47:59.430286) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9b328712d6cd729984ab946294bad62e426e5713 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 9b328712d6cd729984ab946294bad62e426e5713 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1KUwu8NaCv/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.K8x8Wlr7Oo/Listeners TMPDIR=/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/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-10-23 17:47:59,603 truncating revision to first 12 chars 2015-10-23 17:47:59,603 Setting DEBUG logging. 2015-10-23 17:47:59,603 attempt 1/10 2015-10-23 17:47:59,603 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9b328712d6cd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-10-23 17:47:59,925 unpacking tar archive at: mozilla-central-9b328712d6cd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.585030 ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-23 17:48:00.116036) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-23 17:48:00.116340) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-23 17:48:00.129779) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-23 17:48:00.130502) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-23 17:48:00.131347) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 40 secs) (at 2015-10-23 17:48:00.131747) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1KUwu8NaCv/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.K8x8Wlr7Oo/Listeners TMPDIR=/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/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 17:48:00 INFO - MultiFileLogger online at 20151023 17:48:00 in /builds/slave/test 17:48:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 17:48:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:48:00 INFO - {'append_to_log': False, 17:48:00 INFO - 'base_work_dir': '/builds/slave/test', 17:48:00 INFO - 'blob_upload_branch': 'Firefox', 17:48:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:48:00 INFO - 'branch': 'Firefox', 17:48:00 INFO - 'buildbot_json_path': 'buildprops.json', 17:48:00 INFO - 'config_files': ('talos/mac_config.py',), 17:48:00 INFO - 'default_actions': ('clobber', 17:48:00 INFO - 'read-buildbot-config', 17:48:00 INFO - 'download-and-extract', 17:48:00 INFO - 'populate-webroot', 17:48:00 INFO - 'create-virtualenv', 17:48:00 INFO - 'install', 17:48:00 INFO - 'run-tests'), 17:48:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:48:00 INFO - 'download_minidump_stackwalk': True, 17:48:00 INFO - 'download_symbols': 'ondemand', 17:48:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:48:00 INFO - 'tooltool.py': '/tools/tooltool.py', 17:48:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:48:00 INFO - '/tools/misc-python/virtualenv.py')}, 17:48:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:48:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:48:00 INFO - 'installer_path': 'installer.exe', 17:48:00 INFO - 'log_level': 'info', 17:48:00 INFO - 'log_name': 'talos', 17:48:00 INFO - 'log_to_console': True, 17:48:00 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:48:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:48:00 INFO - 'opt_config_files': (), 17:48:00 INFO - 'pip_index': False, 17:48:00 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:48:00 INFO - 'cmd': ('bash', 17:48:00 INFO - '-c', 17:48:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:48:00 INFO - 'enabled': True, 17:48:00 INFO - 'halt_on_failure': False, 17:48:00 INFO - 'name': 'check_screen_resolution'},), 17:48:00 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:48:00 INFO - 'cmd': ('bash', 17:48:00 INFO - '-c', 17:48:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:48:00 INFO - 'enabled': True, 17:48:00 INFO - 'halt_on_failure': False, 17:48:00 INFO - 'name': 'check_screen_resolution'},), 17:48:00 INFO - 'run_cmd_checks_enabled': True, 17:48:00 INFO - 'sps_profile': False, 17:48:00 INFO - 'sps_profile_interval': 0, 17:48:00 INFO - 'suite': 'dromaeojs', 17:48:00 INFO - 'system_bits': '64', 17:48:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:48:00 INFO - 'title': 't-yosemite-r5-0047', 17:48:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:48:00 INFO - 'use_talos_json': True, 17:48:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:48:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:48:00 INFO - 'work_dir': 'build'} 17:48:00 INFO - ##### 17:48:00 INFO - ##### Running clobber step. 17:48:00 INFO - ##### 17:48:00 INFO - Running pre-action listener: _resource_record_pre_action 17:48:00 INFO - Running main action method: clobber 17:48:00 INFO - rmtree: /builds/slave/test/build 17:48:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:48:03 INFO - Running post-action listener: _resource_record_post_action 17:48:03 INFO - ##### 17:48:03 INFO - ##### Running read-buildbot-config step. 17:48:03 INFO - ##### 17:48:03 INFO - Running pre-action listener: _resource_record_pre_action 17:48:03 INFO - Running main action method: read_buildbot_config 17:48:03 INFO - Using buildbot properties: 17:48:03 INFO - { 17:48:03 INFO - "properties": { 17:48:03 INFO - "buildnumber": 537, 17:48:03 INFO - "product": "firefox", 17:48:03 INFO - "script_repo_revision": "production", 17:48:03 INFO - "builddir": "mozilla-central_yosemite_test-dromaeojs", 17:48:03 INFO - "repository": "", 17:48:03 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-central talos dromaeojs", 17:48:03 INFO - "buildid": "20151023153832", 17:48:03 INFO - "slavename": "t-yosemite-r5-0047", 17:48:03 INFO - "pgo_build": "False", 17:48:03 INFO - "basedir": "/builds/slave/test", 17:48:03 INFO - "project": "", 17:48:03 INFO - "platform": "yosemite", 17:48:03 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 17:48:03 INFO - "slavebuilddir": "test", 17:48:03 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 17:48:03 INFO - "branch": "mozilla-central", 17:48:03 INFO - "repo_path": "mozilla-central", 17:48:03 INFO - "stage_platform": "macosx64", 17:48:03 INFO - "builduid": "aabcbbac09c04978ab166b620d55a4d9", 17:48:03 INFO - "revision": "9b328712d6cd729984ab946294bad62e426e5713" 17:48:03 INFO - }, 17:48:03 INFO - "sourcestamp": { 17:48:03 INFO - "repository": "", 17:48:03 INFO - "hasPatch": false, 17:48:03 INFO - "project": "", 17:48:03 INFO - "branch": "mozilla-central-macosx64-talos", 17:48:03 INFO - "changes": [ 17:48:03 INFO - { 17:48:03 INFO - "category": null, 17:48:03 INFO - "files": [ 17:48:03 INFO - { 17:48:03 INFO - "url": null, 17:48:03 INFO - "name": "https://queue.taskcluster.net/v1/task/Pt0-O-58R9-Uhmxy_coewQ/artifacts/public/build/firefox-44.0a1.en-US.mac.dmg" 17:48:03 INFO - } 17:48:03 INFO - ], 17:48:03 INFO - "repository": "", 17:48:03 INFO - "rev": "9b328712d6cd729984ab946294bad62e426e5713", 17:48:03 INFO - "who": "kwierso@gmail.com", 17:48:03 INFO - "when": 1445647550, 17:48:03 INFO - "number": 6569058, 17:48:03 INFO - "comments": "Merge inbound to central, a=merge", 17:48:03 INFO - "project": "", 17:48:03 INFO - "at": "Fri 23 Oct 2015 17:45:50", 17:48:03 INFO - "branch": "mozilla-central-macosx64-talos", 17:48:03 INFO - "revlink": "", 17:48:03 INFO - "properties": [ 17:48:03 INFO - [ 17:48:03 INFO - "buildid", 17:48:03 INFO - "20151023153832", 17:48:03 INFO - "Change" 17:48:03 INFO - ], 17:48:03 INFO - [ 17:48:03 INFO - "builduid", 17:48:03 INFO - "aabcbbac09c04978ab166b620d55a4d9", 17:48:03 INFO - "Change" 17:48:03 INFO - ], 17:48:03 INFO - [ 17:48:03 INFO - "pgo_build", 17:48:03 INFO - "False", 17:48:03 INFO - "Change" 17:48:03 INFO - ] 17:48:03 INFO - ], 17:48:03 INFO - "revision": "9b328712d6cd729984ab946294bad62e426e5713" 17:48:03 INFO - } 17:48:03 INFO - ], 17:48:03 INFO - "revision": "9b328712d6cd729984ab946294bad62e426e5713" 17:48:03 INFO - } 17:48:03 INFO - } 17:48:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/Pt0-O-58R9-Uhmxy_coewQ/artifacts/public/build/firefox-44.0a1.en-US.mac.dmg. 17:48:03 INFO - Running post-action listener: _resource_record_post_action 17:48:03 INFO - ##### 17:48:03 INFO - ##### Running download-and-extract step. 17:48:03 INFO - ##### 17:48:03 INFO - Running pre-action listener: _resource_record_pre_action 17:48:03 INFO - Running main action method: download_and_extract 17:48:03 INFO - mkdir: /builds/slave/test/build/tests 17:48:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:48:03 INFO - https://queue.taskcluster.net/v1/task/Pt0-O-58R9-Uhmxy_coewQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:48:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pt0-O-58R9-Uhmxy_coewQ/artifacts/public/build/test_packages.json 17:48:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pt0-O-58R9-Uhmxy_coewQ/artifacts/public/build/test_packages.json 17:48:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pt0-O-58R9-Uhmxy_coewQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 17:48:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pt0-O-58R9-Uhmxy_coewQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 17:48:04 INFO - Downloaded 1149 bytes. 17:48:04 INFO - Reading from file /builds/slave/test/build/test_packages.json 17:48:04 INFO - Using the following test package requirements: 17:48:04 INFO - {u'common': [u'firefox-44.0a1.en-US.mac.common.tests.zip'], 17:48:04 INFO - u'cppunittest': [u'firefox-44.0a1.en-US.mac.common.tests.zip', 17:48:04 INFO - u'firefox-44.0a1.en-US.mac.cppunittest.tests.zip'], 17:48:04 INFO - u'jittest': [u'firefox-44.0a1.en-US.mac.common.tests.zip', 17:48:04 INFO - u'jsshell-mac.zip'], 17:48:04 INFO - u'mochitest': [u'firefox-44.0a1.en-US.mac.common.tests.zip', 17:48:04 INFO - u'firefox-44.0a1.en-US.mac.mochitest.tests.zip'], 17:48:04 INFO - u'mozbase': [u'firefox-44.0a1.en-US.mac.common.tests.zip'], 17:48:04 INFO - u'reftest': [u'firefox-44.0a1.en-US.mac.common.tests.zip', 17:48:04 INFO - u'firefox-44.0a1.en-US.mac.reftest.tests.zip'], 17:48:04 INFO - u'talos': [u'firefox-44.0a1.en-US.mac.common.tests.zip', 17:48:04 INFO - u'firefox-44.0a1.en-US.mac.talos.tests.zip'], 17:48:04 INFO - u'web-platform': [u'firefox-44.0a1.en-US.mac.common.tests.zip', 17:48:04 INFO - u'firefox-44.0a1.en-US.mac.web-platform.tests.zip'], 17:48:04 INFO - u'webapprt': [u'firefox-44.0a1.en-US.mac.common.tests.zip'], 17:48:04 INFO - u'xpcshell': [u'firefox-44.0a1.en-US.mac.common.tests.zip', 17:48:04 INFO - u'firefox-44.0a1.en-US.mac.xpcshell.tests.zip']} 17:48:04 INFO - Downloading packages: [u'firefox-44.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:48:04 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')]} 17:48:04 INFO - https://queue.taskcluster.net/v1/task/Pt0-O-58R9-Uhmxy_coewQ/artifacts/public/build/firefox-44.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:48:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pt0-O-58R9-Uhmxy_coewQ/artifacts/public/build/firefox-44.0a1.en-US.mac.common.tests.zip 17:48:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pt0-O-58R9-Uhmxy_coewQ/artifacts/public/build/firefox-44.0a1.en-US.mac.common.tests.zip 17:48:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pt0-O-58R9-Uhmxy_coewQ/artifacts/public/build/firefox-44.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-44.0a1.en-US.mac.common.tests.zip 17:48:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pt0-O-58R9-Uhmxy_coewQ/artifacts/public/build/firefox-44.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:48:06 INFO - Downloaded 17449880 bytes. 17:48:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 17:48:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a1.en-US.mac.common.tests.zip 17:48:06 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 17:48:10 INFO - Return code: 0 17:48:10 INFO - Downloading packages: [u'firefox-44.0a1.en-US.mac.common.tests.zip', u'firefox-44.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 17:48:10 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')]} 17:48:10 INFO - https://queue.taskcluster.net/v1/task/Pt0-O-58R9-Uhmxy_coewQ/artifacts/public/build/firefox-44.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:48:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pt0-O-58R9-Uhmxy_coewQ/artifacts/public/build/firefox-44.0a1.en-US.mac.common.tests.zip 17:48:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pt0-O-58R9-Uhmxy_coewQ/artifacts/public/build/firefox-44.0a1.en-US.mac.common.tests.zip 17:48:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pt0-O-58R9-Uhmxy_coewQ/artifacts/public/build/firefox-44.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-44.0a1.en-US.mac.common.tests.zip 17:48:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pt0-O-58R9-Uhmxy_coewQ/artifacts/public/build/firefox-44.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:48:11 INFO - Downloaded 17449880 bytes. 17:48:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 17:48:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a1.en-US.mac.common.tests.zip 17:48:11 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 17:48:17 INFO - Return code: 0 17:48:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:48:17 INFO - https://queue.taskcluster.net/v1/task/Pt0-O-58R9-Uhmxy_coewQ/artifacts/public/build/firefox-44.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 17:48:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pt0-O-58R9-Uhmxy_coewQ/artifacts/public/build/firefox-44.0a1.en-US.mac.talos.tests.zip 17:48:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pt0-O-58R9-Uhmxy_coewQ/artifacts/public/build/firefox-44.0a1.en-US.mac.talos.tests.zip 17:48:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pt0-O-58R9-Uhmxy_coewQ/artifacts/public/build/firefox-44.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-44.0a1.en-US.mac.talos.tests.zip 17:48:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pt0-O-58R9-Uhmxy_coewQ/artifacts/public/build/firefox-44.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a1.en-US.mac.talos.tests.zip'}, attempt #1 17:48:18 INFO - Downloaded 11131307 bytes. 17:48:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a1.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 17:48:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a1.en-US.mac.talos.tests.zip 17:48:18 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 17:48:18 INFO - Return code: 0 17:48:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:48:18 INFO - https://queue.taskcluster.net/v1/task/Pt0-O-58R9-Uhmxy_coewQ/artifacts/public/build/firefox-44.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 17:48:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pt0-O-58R9-Uhmxy_coewQ/artifacts/public/build/firefox-44.0a1.en-US.mac.dmg 17:48:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pt0-O-58R9-Uhmxy_coewQ/artifacts/public/build/firefox-44.0a1.en-US.mac.dmg 17:48:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pt0-O-58R9-Uhmxy_coewQ/artifacts/public/build/firefox-44.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-44.0a1.en-US.mac.dmg 17:48:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pt0-O-58R9-Uhmxy_coewQ/artifacts/public/build/firefox-44.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-44.0a1.en-US.mac.dmg'}, attempt #1 17:48:21 INFO - Downloaded 108322869 bytes. 17:48:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Pt0-O-58R9-Uhmxy_coewQ/artifacts/public/build/firefox-44.0a1.en-US.mac.dmg 17:48:21 INFO - mkdir: /builds/slave/test/properties 17:48:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:48:21 INFO - Writing to file /builds/slave/test/properties/build_url 17:48:21 INFO - Contents: 17:48:21 INFO - build_url:https://queue.taskcluster.net/v1/task/Pt0-O-58R9-Uhmxy_coewQ/artifacts/public/build/firefox-44.0a1.en-US.mac.dmg 17:48:21 INFO - Running post-action listener: _resource_record_post_action 17:48:21 INFO - Running post-action listener: set_extra_try_arguments 17:48:21 INFO - ##### 17:48:21 INFO - ##### Running populate-webroot step. 17:48:21 INFO - ##### 17:48:21 INFO - Running pre-action listener: _resource_record_pre_action 17:48:21 INFO - Running main action method: populate_webroot 17:48:21 INFO - Guessing talos json url... 17:48: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')]} 17:48:21 INFO - https://queue.taskcluster.net/v1/task/Pt0-O-58R9-Uhmxy_coewQ/artifacts/public/build/firefox-44.0a1.en-US.mac.txt matches https://queue.taskcluster.net 17:48:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pt0-O-58R9-Uhmxy_coewQ/artifacts/public/build/firefox-44.0a1.en-US.mac.txt 17:48:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pt0-O-58R9-Uhmxy_coewQ/artifacts/public/build/firefox-44.0a1.en-US.mac.txt 17:48:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pt0-O-58R9-Uhmxy_coewQ/artifacts/public/build/firefox-44.0a1.en-US.mac.txt to /builds/slave/test/build/firefox-44.0a1.en-US.mac.txt 17:48:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pt0-O-58R9-Uhmxy_coewQ/artifacts/public/build/firefox-44.0a1.en-US.mac.txt', 'file_name': '/builds/slave/test/build/firefox-44.0a1.en-US.mac.txt'}, attempt #1 17:48:22 INFO - Downloaded 99 bytes. 17:48:22 INFO - Reading from file /builds/slave/test/build/firefox-44.0a1.en-US.mac.txt 17:48:22 INFO - Contents: 17:48:22 INFO - 20151023153832 17:48:22 INFO - https://hg.mozilla.org/mozilla-central/rev/9b328712d6cd729984ab946294bad62e426e5713 17:48:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:48:22 INFO - trying https://hg.mozilla.org/mozilla-central/raw-file/9b328712d6/testing/talos/talos.json 17:48:22 INFO - Downloading https://hg.mozilla.org/mozilla-central/raw-file/9b328712d6/testing/talos/talos.json to /builds/slave/test/build/talos.json 17:48:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/mozilla-central/raw-file/9b328712d6/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 17:48:22 INFO - Downloaded 4264 bytes. 17:48:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:48:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:48:22 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 17:48:22 INFO - '../fennec_ids.txt'], 17:48:22 INFO - 'tests': ['tcheck2']}, 17:48:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:48:22 INFO - '--tppagecycles', 17:48:22 INFO - '7'], 17:48:22 INFO - 'tests': ['tsvgm']}}, 17:48:22 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:48:22 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:48:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:48:22 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:48:22 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:48:22 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:48:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:48:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:48:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:48:22 INFO - 'talos_options': ['--e10s'], 17:48:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:48:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:48:22 INFO - 'tests': ['damp', 'tps']}, 17:48:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:48:22 INFO - 'talos_options': ['--e10s'], 17:48:22 INFO - 'tests': ['damp', 'tps']}, 17:48:22 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:48:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:48:22 INFO - 'other': {'tests': ['a11yr', 17:48:22 INFO - 'ts_paint', 17:48:22 INFO - 'tpaint', 17:48:22 INFO - 'sessionrestore', 17:48:22 INFO - 'sessionrestore_no_auto_restore']}, 17:48:22 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:48:22 INFO - 'tests': ['a11yr', 17:48:22 INFO - 'ts_paint', 17:48:22 INFO - 'tpaint', 17:48:22 INFO - 'sessionrestore', 17:48:22 INFO - 'sessionrestore_no_auto_restore']}, 17:48:22 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:48:22 INFO - 'tests': ['a11yr', 17:48:22 INFO - 'ts_paint', 17:48:22 INFO - 'tpaint', 17:48:22 INFO - 'sessionrestore', 17:48:22 INFO - 'sessionrestore_no_auto_restore']}, 17:48:22 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:48:22 INFO - 'tests': ['a11yr', 17:48:22 INFO - 'ts_paint', 17:48:22 INFO - 'tpaint', 17:48:22 INFO - 'sessionrestore', 17:48:22 INFO - 'sessionrestore_no_auto_restore']}, 17:48:22 INFO - 'other_l64': {'tests': ['a11yr', 17:48:22 INFO - 'ts_paint', 17:48:22 INFO - 'tpaint', 17:48:22 INFO - 'sessionrestore', 17:48:22 INFO - 'sessionrestore_no_auto_restore']}, 17:48:22 INFO - 'other_nol64': {'tests': ['a11yr', 17:48:22 INFO - 'ts_paint', 17:48:22 INFO - 'tpaint', 17:48:22 INFO - 'sessionrestore', 17:48:22 INFO - 'sessionrestore_no_auto_restore']}, 17:48:22 INFO - 'svgr': {'tests': ['tsvgx', 17:48:22 INFO - 'tsvgr_opacity', 17:48:22 INFO - 'tart', 17:48:22 INFO - 'tscrollx', 17:48:22 INFO - 'cart']}, 17:48:22 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:48:22 INFO - 'tests': ['tsvgx', 17:48:22 INFO - 'tsvgr_opacity', 17:48:22 INFO - 'tart', 17:48:22 INFO - 'tscrollx', 17:48:22 INFO - 'cart']}, 17:48:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:48:22 INFO - 'tests': ['tp5o']}, 17:48:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:48:22 INFO - 'talos_options': ['--e10s'], 17:48:22 INFO - 'tests': ['tp5o']}, 17:48:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:48:22 INFO - 'talos_options': ['--xperf_path', 17:48:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:48:22 INFO - 'tests': ['tp5n']}, 17:48:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:48:22 INFO - 'talos_options': ['--e10s', 17:48:22 INFO - '--xperf_path', 17:48:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 17:48:22 INFO - 'C:/slave/talos-data/talos/xperf.config'], 17:48:22 INFO - 'tests': ['tp5n']}}, 17:48:22 INFO - 'talos.zip': {'path': '', 17:48:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:48:22 INFO - Running post-action listener: _resource_record_post_action 17:48:22 INFO - ##### 17:48:22 INFO - ##### Running create-virtualenv step. 17:48:22 INFO - ##### 17:48:22 INFO - Running pre-action listener: _resource_record_pre_action 17:48:22 INFO - Running main action method: create_virtualenv 17:48:22 INFO - Creating virtualenv /builds/slave/test/build/venv 17:48:22 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 17:48:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:48:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:48:23 INFO - Using real prefix '/tools/python27' 17:48:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:48:23 INFO - Installing distribute.............................................................................................................................................................................................done. 17:48:27 INFO - Installing pip.................done. 17:48:27 INFO - Return code: 0 17:48:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:48:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:48:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:48:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:48:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:48:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:48:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1086a7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108714228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd67a5056e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10865c9f0>, '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 0x1083bbcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108626990>, '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.1KUwu8NaCv/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.K8x8Wlr7Oo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/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 17:48:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:48:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:48:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1KUwu8NaCv/Render', 17:48:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:48:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:48:27 INFO - 'HOME': '/Users/cltbld', 17:48:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:48:27 INFO - 'LOGNAME': 'cltbld', 17:48:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:48:27 INFO - 'MOZ_NO_REMOTE': '1', 17:48:27 INFO - 'NO_EM_RESTART': '1', 17:48:27 INFO - 'PAGER': '/bin/cat', 17:48:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:48:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:48:27 INFO - 'PWD': '/builds/slave/test', 17:48:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:48:27 INFO - 'SHELL': '/bin/bash', 17:48:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K8x8Wlr7Oo/Listeners', 17:48:27 INFO - 'TMPDIR': '/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/', 17:48:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:48:27 INFO - 'USER': 'cltbld', 17:48:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:48:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:48:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:48:27 INFO - 'XPC_FLAGS': '0x0', 17:48:27 INFO - 'XPC_SERVICE_NAME': '0', 17:48:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 17:48:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:48:27 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 17:48:27 INFO - Cleaning up... 17:48:27 INFO - Return code: 0 17:48:27 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:48:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:48:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:48:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:48:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:48:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:48:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1086a7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108714228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd67a5056e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10865c9f0>, '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 0x1083bbcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108626990>, '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.1KUwu8NaCv/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.K8x8Wlr7Oo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/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 17:48:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 17:48:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 17:48:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1KUwu8NaCv/Render', 17:48:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:48:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:48:27 INFO - 'HOME': '/Users/cltbld', 17:48:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:48:27 INFO - 'LOGNAME': 'cltbld', 17:48:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:48:27 INFO - 'MOZ_NO_REMOTE': '1', 17:48:27 INFO - 'NO_EM_RESTART': '1', 17:48:27 INFO - 'PAGER': '/bin/cat', 17:48:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:48:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:48:27 INFO - 'PWD': '/builds/slave/test', 17:48:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:48:27 INFO - 'SHELL': '/bin/bash', 17:48:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K8x8Wlr7Oo/Listeners', 17:48:27 INFO - 'TMPDIR': '/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/', 17:48:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:48:27 INFO - 'USER': 'cltbld', 17:48:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:48:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:48:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:48:27 INFO - 'XPC_FLAGS': '0x0', 17:48:27 INFO - 'XPC_SERVICE_NAME': '0', 17:48:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 17:48:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:48:28 INFO - Downloading/unpacking psutil>=0.7.1 17:48:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:48:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:48:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:48:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:48:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:48:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:48:30 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 17:48:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 17:48:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:48:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:48:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:48:30 INFO - Installing collected packages: psutil 17:48:30 INFO - Running setup.py install for psutil 17:48:30 INFO - building 'psutil._psutil_osx' extension 17:48: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_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 17:48:32 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 17:48:32 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 17:48:32 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 17:48:33 INFO - building 'psutil._psutil_posix' extension 17:48:33 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 17:48:33 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:48:33 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:48:33 INFO - ^ 17:48:33 INFO - 1 warning generated. 17:48:33 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 17:48:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:48:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:48:33 INFO - Successfully installed psutil 17:48:33 INFO - Cleaning up... 17:48:33 INFO - Return code: 0 17:48:33 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:48: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')]} 17:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:48:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:48: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')]} 17:48:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:48:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:48: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', '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 0x1086a7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108714228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd67a5056e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10865c9f0>, '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 0x1083bbcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108626990>, '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.1KUwu8NaCv/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.K8x8Wlr7Oo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/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 17:48: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 17:48: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 mozsystemmonitor==0.0.0 17:48:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1KUwu8NaCv/Render', 17:48:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:48:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:48:33 INFO - 'HOME': '/Users/cltbld', 17:48:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:48:33 INFO - 'LOGNAME': 'cltbld', 17:48:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:48:33 INFO - 'MOZ_NO_REMOTE': '1', 17:48:33 INFO - 'NO_EM_RESTART': '1', 17:48:33 INFO - 'PAGER': '/bin/cat', 17:48:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:48:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:48:33 INFO - 'PWD': '/builds/slave/test', 17:48:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:48:33 INFO - 'SHELL': '/bin/bash', 17:48:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K8x8Wlr7Oo/Listeners', 17:48:33 INFO - 'TMPDIR': '/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/', 17:48:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:48:33 INFO - 'USER': 'cltbld', 17:48:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:48:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:48:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:48:33 INFO - 'XPC_FLAGS': '0x0', 17:48:33 INFO - 'XPC_SERVICE_NAME': '0', 17:48:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 17:48:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:48:33 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:48: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 17:48: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 17:48: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 17:48: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 17:48: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 17:48: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 17:48:36 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:48:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 17:48:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:48:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:48:36 INFO - Installing collected packages: mozsystemmonitor 17:48:36 INFO - Running setup.py install for mozsystemmonitor 17:48:36 INFO - Successfully installed mozsystemmonitor 17:48:36 INFO - Cleaning up... 17:48:36 INFO - Return code: 0 17:48:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:48:36 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')]} 17:48:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:48:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:48:36 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')]} 17:48:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:48:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:48:36 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 0x1086a7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108714228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd67a5056e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10865c9f0>, '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 0x1083bbcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108626990>, '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.1KUwu8NaCv/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.K8x8Wlr7Oo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/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 17:48:36 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 17:48:36 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 17:48:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1KUwu8NaCv/Render', 17:48:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:48:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:48:36 INFO - 'HOME': '/Users/cltbld', 17:48:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:48:36 INFO - 'LOGNAME': 'cltbld', 17:48:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:48:36 INFO - 'MOZ_NO_REMOTE': '1', 17:48:36 INFO - 'NO_EM_RESTART': '1', 17:48:36 INFO - 'PAGER': '/bin/cat', 17:48:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:48:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:48:36 INFO - 'PWD': '/builds/slave/test', 17:48:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:48:36 INFO - 'SHELL': '/bin/bash', 17:48:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K8x8Wlr7Oo/Listeners', 17:48:36 INFO - 'TMPDIR': '/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/', 17:48:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:48:36 INFO - 'USER': 'cltbld', 17:48:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:48:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:48:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:48:36 INFO - 'XPC_FLAGS': '0x0', 17:48:36 INFO - 'XPC_SERVICE_NAME': '0', 17:48:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 17:48:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:48:36 INFO - Downloading/unpacking blobuploader==1.2.4 17:48: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 17:48: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 17:48: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 17:48: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 17:48: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 17:48: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 17:48:38 INFO - Downloading blobuploader-1.2.4.tar.gz 17:48:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 17:48:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:48:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:48:39 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 17:48:39 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 17:48:39 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 17:48:39 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 17:48:39 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 17:48:39 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 17:48:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 17:48:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:48:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:48:39 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 17:48:39 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 17:48:39 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 17:48:39 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 17:48:39 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 17:48:39 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 17:48:40 INFO - Downloading docopt-0.6.1.tar.gz 17:48:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 17:48:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:48:40 INFO - Installing collected packages: blobuploader, requests, docopt 17:48:40 INFO - Running setup.py install for blobuploader 17:48:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:48:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:48:40 INFO - Running setup.py install for requests 17:48:40 INFO - Running setup.py install for docopt 17:48:41 INFO - Successfully installed blobuploader requests docopt 17:48:41 INFO - Cleaning up... 17:48:41 INFO - Return code: 0 17:48:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:48:41 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')]} 17:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:48:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:48:41 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')]} 17:48:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:48:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:48:41 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 0x1086a7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108714228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd67a5056e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10865c9f0>, '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 0x1083bbcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108626990>, '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.1KUwu8NaCv/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.K8x8Wlr7Oo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/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 17:48:41 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 17:48:41 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 17:48:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1KUwu8NaCv/Render', 17:48:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:48:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:48:41 INFO - 'HOME': '/Users/cltbld', 17:48:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:48:41 INFO - 'LOGNAME': 'cltbld', 17:48:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:48:41 INFO - 'MOZ_NO_REMOTE': '1', 17:48:41 INFO - 'NO_EM_RESTART': '1', 17:48:41 INFO - 'PAGER': '/bin/cat', 17:48:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:48:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:48:41 INFO - 'PWD': '/builds/slave/test', 17:48:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:48:41 INFO - 'SHELL': '/bin/bash', 17:48:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K8x8Wlr7Oo/Listeners', 17:48:41 INFO - 'TMPDIR': '/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/', 17:48:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:48:41 INFO - 'USER': 'cltbld', 17:48:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:48:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:48:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:48:41 INFO - 'XPC_FLAGS': '0x0', 17:48:41 INFO - 'XPC_SERVICE_NAME': '0', 17:48:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 17:48:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:48:41 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-U0uRr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:48:41 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-HJe2Mz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:48:41 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-hW3kuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:48:41 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-3vWZST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:48:41 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-OtnyZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:48:42 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-9nDhEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:48:42 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-R7q5iO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:48:42 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-K5MMt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:48:42 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-slWhf6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:48:42 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-eCfAdd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:48:42 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-Lz1_MP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:48:42 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-1yZIkY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:48:42 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-98nRNY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:48:42 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-UAkeGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:48:43 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-F0pMrl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:48:43 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-Qdr8va-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:48:43 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-fH6T2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:48:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:48:43 INFO - Running setup.py install for manifestparser 17:48:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:48:43 INFO - Running setup.py install for mozcrash 17:48:43 INFO - Running setup.py install for mozdebug 17:48:43 INFO - Running setup.py install for mozdevice 17:48:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:48:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:48:44 INFO - Running setup.py install for mozfile 17:48:44 INFO - Running setup.py install for mozhttpd 17:48:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:48:44 INFO - Running setup.py install for mozinfo 17:48:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:48:44 INFO - Running setup.py install for mozInstall 17:48:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:48:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:48:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:48:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:48:44 INFO - Running setup.py install for mozleak 17:48:44 INFO - Running setup.py install for mozlog 17:48:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:48:45 INFO - Running setup.py install for moznetwork 17:48:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:48:45 INFO - Running setup.py install for mozprocess 17:48:45 INFO - Running setup.py install for mozprofile 17:48:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:48:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:48:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:48:45 INFO - Running setup.py install for mozrunner 17:48:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:48:45 INFO - Running setup.py install for mozscreenshot 17:48:45 INFO - Running setup.py install for moztest 17:48:46 INFO - Running setup.py install for mozversion 17:48:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:48:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:48:46 INFO - Cleaning up... 17:48:46 INFO - Return code: 0 17:48:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:48:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:48:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:48:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:48:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:48:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:48:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:48:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x1086a7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108714228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd67a5056e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10865c9f0>, '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 0x1083bbcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108626990>, '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.1KUwu8NaCv/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.K8x8Wlr7Oo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/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 17:48:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 17:48:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/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 17:48:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1KUwu8NaCv/Render', 17:48:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:48:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:48:46 INFO - 'HOME': '/Users/cltbld', 17:48:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:48:46 INFO - 'LOGNAME': 'cltbld', 17:48:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:48:46 INFO - 'MOZ_NO_REMOTE': '1', 17:48:46 INFO - 'NO_EM_RESTART': '1', 17:48:46 INFO - 'PAGER': '/bin/cat', 17:48:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:48:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:48:46 INFO - 'PWD': '/builds/slave/test', 17:48:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:48:46 INFO - 'SHELL': '/bin/bash', 17:48:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K8x8Wlr7Oo/Listeners', 17:48:46 INFO - 'TMPDIR': '/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/', 17:48:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:48:46 INFO - 'USER': 'cltbld', 17:48:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:48:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:48:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:48:46 INFO - 'XPC_FLAGS': '0x0', 17:48:46 INFO - 'XPC_SERVICE_NAME': '0', 17:48:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 17:48:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:48:46 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-XlX08r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:48:46 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:48:46 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-vpEY7K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:48:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:48:46 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-TJjs0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:48:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:48:46 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-jNsNax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:48:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:48:46 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-rUm4so-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:48:47 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)) 17:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:48:47 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-X9Fx5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:48:47 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)) 17:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:48:47 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-SytFbq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:48:47 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)) 17:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:48:47 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-WqQVnF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:48:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:48:47 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-CWlCoY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:48:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:48:47 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-sS9JCx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:48:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:48:47 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-yUHc7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:48:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:48:47 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-Tj4dKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:48:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:48:47 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-_1QDn8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:48:48 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)) 17:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:48:48 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-G8TWVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:48:48 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)) 17:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:48:48 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-PXWADf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:48:48 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)) 17:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:48:48 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-SOHOoS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:48:48 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-8W3e1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.46->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.46->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:48:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:48:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:48:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:48:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:48:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:48:50 INFO - Downloading blessings-1.5.1.tar.gz 17:48:50 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 17:48:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:48:50 INFO - Installing collected packages: blessings 17:48:50 INFO - Running setup.py install for blessings 17:48:51 INFO - Successfully installed blessings 17:48:51 INFO - Cleaning up... 17:48:51 INFO - Return code: 0 17:48:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:48:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:48:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:48:51 INFO - Reading from file tmpfile_stdout 17:48:51 INFO - Current package versions: 17:48:51 INFO - blessings == 1.5.1 17:48:51 INFO - blobuploader == 1.2.4 17:48:51 INFO - docopt == 0.6.1 17:48:51 INFO - manifestparser == 1.1 17:48:51 INFO - mozInstall == 1.12 17:48:51 INFO - mozcrash == 0.16 17:48:51 INFO - mozdebug == 0.1 17:48:51 INFO - mozdevice == 0.46 17:48:51 INFO - mozfile == 1.2 17:48:51 INFO - mozhttpd == 0.7 17:48:51 INFO - mozinfo == 0.8 17:48:51 INFO - mozleak == 0.1 17:48:51 INFO - mozlog == 3.0 17:48:51 INFO - moznetwork == 0.27 17:48:51 INFO - mozprocess == 0.22 17:48:51 INFO - mozprofile == 0.27 17:48:51 INFO - mozrunner == 6.11 17:48:51 INFO - mozscreenshot == 0.1 17:48:51 INFO - mozsystemmonitor == 0.0 17:48:51 INFO - moztest == 0.7 17:48:51 INFO - mozversion == 1.4 17:48:51 INFO - psutil == 3.1.1 17:48:51 INFO - requests == 1.2.3 17:48:51 INFO - wsgiref == 0.1.2 17:48:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:48:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:48:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:48:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:48:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:48:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:48:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1086a7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108714228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd67a5056e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10865c9f0>, '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 0x1083bbcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108626990>, '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.1KUwu8NaCv/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.K8x8Wlr7Oo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/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 17:48:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:48:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:48:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1KUwu8NaCv/Render', 17:48:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:48:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:48:51 INFO - 'HOME': '/Users/cltbld', 17:48:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:48:51 INFO - 'LOGNAME': 'cltbld', 17:48:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:48:51 INFO - 'MOZ_NO_REMOTE': '1', 17:48:51 INFO - 'NO_EM_RESTART': '1', 17:48:51 INFO - 'PAGER': '/bin/cat', 17:48:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:48:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:48:51 INFO - 'PWD': '/builds/slave/test', 17:48:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:48:51 INFO - 'SHELL': '/bin/bash', 17:48:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K8x8Wlr7Oo/Listeners', 17:48:51 INFO - 'TMPDIR': '/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/', 17:48:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:48:51 INFO - 'USER': 'cltbld', 17:48:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:48:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:48:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:48:51 INFO - 'XPC_FLAGS': '0x0', 17:48:51 INFO - 'XPC_SERVICE_NAME': '0', 17:48:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 17:48:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:48:51 INFO - Cleaning up... 17:48:51 INFO - Return code: 0 17:48:51 INFO - Running post-action listener: _resource_record_post_action 17:48:51 INFO - Running post-action listener: _start_resource_monitoring 17:48:51 INFO - Starting resource monitoring. 17:48:51 INFO - ##### 17:48:51 INFO - ##### Running install step. 17:48:51 INFO - ##### 17:48:51 INFO - Running pre-action listener: _resource_record_pre_action 17:48:51 INFO - Running main action method: install 17:48:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:48:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:48:52 INFO - Reading from file tmpfile_stdout 17:48:52 INFO - Detecting whether we're running mozinstall >=1.0... 17:48:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:48:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:48:52 INFO - Reading from file tmpfile_stdout 17:48:52 INFO - Output received: 17:48:52 INFO - Usage: mozinstall [options] installer 17:48:52 INFO - Options: 17:48:52 INFO - -h, --help show this help message and exit 17:48:52 INFO - -d DEST, --destination=DEST 17:48:52 INFO - Directory to install application into. [default: 17:48:52 INFO - "/builds/slave/test"] 17:48:52 INFO - --app=APP Application being installed. [default: firefox] 17:48:52 INFO - mkdir: /builds/slave/test/build/application 17:48:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-44.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:48:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-44.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 17:49:27 INFO - Reading from file tmpfile_stdout 17:49:27 INFO - Output received: 17:49:27 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:49:27 INFO - Running post-action listener: _resource_record_post_action 17:49:27 INFO - ##### 17:49:27 INFO - ##### Running run-tests step. 17:49:27 INFO - ##### 17:49:27 INFO - Running pre-action listener: _resource_record_pre_action 17:49:27 INFO - Running main action method: run_tests 17:49:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:49:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:49:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:49:27 INFO - 2015-10-23 17:49:27.928 screenresolution[1632:7521] starting screenresolution argv=screenresolution get 17:49:27 INFO - 2015-10-23 17:49:27.931 screenresolution[1632:7521] Display 0: 1600x1200x32@60 17:49:27 INFO - 2015-10-23 17:49:27.937 screenresolution[1633:7523] starting screenresolution argv=screenresolution list 17:49:27 INFO - Available Modes on Display 0 17:49:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:49:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:49:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:49:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:49:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:49:28 INFO - Intel HD Graphics 3000: 17:49:28 INFO - Chipset Model: Intel HD Graphics 3000 17:49:28 INFO - Type: GPU 17:49:28 INFO - Bus: Built-In 17:49:28 INFO - VRAM (Total): 512 MB 17:49:28 INFO - VRAM (Dynamic, Max): 10 17:49:28 INFO - Vendor: Intel (0x8086) 17:49:28 INFO - Device ID: 0x0116 17:49:28 INFO - Revision ID: 0x0009 17:49:28 INFO - Displays: 17:49:28 INFO - Display: 17:49:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:49:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:49:28 INFO - Display Serial Number: 1600x1200 60 17:49:28 INFO - Main Display: Yes 17:49:28 INFO - Mirror: Off 17:49:28 INFO - Online: Yes 17:49:28 INFO - Rotation: Supported 17:49:28 INFO - Return code: 0 17:49:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:49:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:49:28 INFO - Python 2.7.3 17:49:28 INFO - Return code: 0 17:49:28 INFO - grabbing minidump binary from tooltool 17:49:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:49:28 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 0x10865c9f0>, '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 0x1083bbcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108626990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:49:28 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 17:49:28 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 17:49:28 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:49:28 INFO - Return code: 0 17:49:28 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:49:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:49:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:49:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:49:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:49:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Pt0-O-58R9-Uhmxy_coewQ/artifacts/public/build/firefox-44.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0047', '--webServer', 'localhost'] in /builds/slave/test/build 17:49:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Pt0-O-58R9-Uhmxy_coewQ/artifacts/public/build/firefox-44.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0047 --webServer localhost 17:49:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1KUwu8NaCv/Render', 17:49:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:49:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:49:28 INFO - 'HOME': '/Users/cltbld', 17:49:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:49:28 INFO - 'LOGNAME': 'cltbld', 17:49:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:49:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:49:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:28 INFO - 'MOZ_NO_REMOTE': '1', 17:49:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:49:28 INFO - 'NO_EM_RESTART': '1', 17:49:28 INFO - 'PAGER': '/bin/cat', 17:49:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:49:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:49:28 INFO - 'PWD': '/builds/slave/test', 17:49:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:49:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:49:28 INFO - 'SHELL': '/bin/bash', 17:49:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K8x8Wlr7Oo/Listeners', 17:49:28 INFO - 'TMPDIR': '/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/', 17:49:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:49:28 INFO - 'USER': 'cltbld', 17:49:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:49:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:49:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:28 INFO - 'XPC_FLAGS': '0x0', 17:49:28 INFO - 'XPC_SERVICE_NAME': '0', 17:49:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 17:49:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Pt0-O-58R9-Uhmxy_coewQ/artifacts/public/build/firefox-44.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0047', '--webServer', 'localhost'] with output_timeout 3600 17:49:28 INFO - mozversion INFO | application_buildid: 20151023153832 17:49:28 INFO - mozversion INFO | application_changeset: 9b328712d6cd729984ab946294bad62e426e5713 17:49:28 INFO - mozversion INFO | application_display_name: Nightly 17:49:28 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:49:28 INFO - mozversion INFO | application_name: Firefox 17:49:28 INFO - mozversion INFO | application_remotingname: firefox 17:49:28 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 17:49:28 INFO - mozversion INFO | application_vendor: Mozilla 17:49:28 INFO - mozversion INFO | application_version: 44.0a1 17:49:28 INFO - mozversion INFO | platform_buildid: 20151023153832 17:49:28 INFO - mozversion INFO | platform_changeset: 9b328712d6cd729984ab946294bad62e426e5713 17:49:28 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 17:49:28 INFO - mozversion INFO | platform_version: 44.0a1 17:49:28 INFO - 2015-10-23 17:49:28,645 DEBUG : using testdate: 1445647768 17:49:28 INFO - 2015-10-23 17:49:28,645 DEBUG : actual date: 1445647768 17:49:28 INFO - 2015-10-23 17:49:28,659 INFO : starting webserver on 'localhost:49273' 17:49:28 INFO - 2015-10-23 17:49:28,661 INFO : Starting test suite t-yosemite-r5-0047 17:49:28 INFO - 2015-10-23 17:49:28,661 INFO : Starting test dromaeo_css 17:49:28 INFO - 2015-10-23 17:49:28,661 DEBUG : operating with platform_type : mac_ 17:49:28 INFO - 2015-10-23 17:49:28,662 INFO : Initialising browser for dromaeo_css test... 17:49:28 INFO - 2015-10-23 17:49:28,690 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/tmpgf_sSe/profile http://localhost:49273/getInfo.html 17:49:31 INFO - 2015-10-23 17:49:31,540 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:49:31 INFO - 2015-10-23 17:49:31,540 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:49:31 INFO - 2015-10-23 17:49:31,541 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 17:49:31 INFO - 2015-10-23 17:49:31,541 DEBUG : BROWSER_OUTPUT: __metrics 17:49:31 INFO - 2015-10-23 17:49:31,556 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:49:32 INFO - 2015-10-23 17:49:32,386 INFO : Browser initialized. 17:49:32 INFO - 2015-10-23 17:49:32,386 INFO : Running cycle 1/1 for dromaeo_css test... 17:49:32 INFO - 2015-10-23 17:49:32,386 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/tmpgf_sSe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:49:44 INFO - 2015-10-23 17:49:44,283 DEBUG : BROWSER_OUTPUT: RSS: Main: 225857536 17:49:44 INFO - 2015-10-23 17:49:44,283 DEBUG : BROWSER_OUTPUT: 17:50:36 INFO - 2015-10-23 17:50:36,273 DEBUG : BROWSER_OUTPUT: 1445647836272 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] 17:52:47 INFO - 2015-10-23 17:52:47,056 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 17:52:48 INFO - 2015-10-23 17:52:48,248 DEBUG : BROWSER_OUTPUT: RSS: Main: 337035264 17:52:48 INFO - 2015-10-23 17:52:48,248 DEBUG : BROWSER_OUTPUT: 17:55:50 INFO - 2015-10-23 17:55:50,935 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 17:55:51 INFO - 2015-10-23 17:55:51,498 DEBUG : BROWSER_OUTPUT: RSS: Main: 354578432 17:55:51 INFO - 2015-10-23 17:55:51,499 DEBUG : BROWSER_OUTPUT: 17:58:53 INFO - 2015-10-23 17:58:53,546 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 17:58:54 INFO - 2015-10-23 17:58:54,111 DEBUG : BROWSER_OUTPUT: RSS: Main: 320430080 17:58:54 INFO - 2015-10-23 17:58:54,111 DEBUG : BROWSER_OUTPUT: 18:01:56 INFO - 2015-10-23 18:01:56,324 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 18:01:56 INFO - 2015-10-23 18:01:56,913 DEBUG : BROWSER_OUTPUT: RSS: Main: 346951680 18:01:56 INFO - 2015-10-23 18:01:56,914 DEBUG : BROWSER_OUTPUT: 18:05:00 INFO - 2015-10-23 18:05:00,017 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 18:05:00 INFO - 2015-10-23 18:05:00,595 DEBUG : BROWSER_OUTPUT: RSS: Main: 312569856 18:05:00 INFO - 2015-10-23 18:05:00,595 DEBUG : BROWSER_OUTPUT: 18:08:03 INFO - 2015-10-23 18:08:03,137 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 18:08:03 INFO - 2015-10-23 18:08:03,394 DEBUG : BROWSER_OUTPUT: RSS: Main: 359243776 18:08:03 INFO - 2015-10-23 18:08:03,394 DEBUG : BROWSER_OUTPUT: 18:08:03 INFO - 2015-10-23 18:08:03,394 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:08:03 INFO - 2015-10-23 18:08:03,394 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:08:03 INFO - 2015-10-23 18:08:03,395 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:08:03 INFO - 2015-10-23 18:08:03,395 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:08:03 INFO - 2015-10-23 18:08:03,395 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3174.380995705837;3244.7890887092335;3265.9183520412003;3279.0490757680273;3321.38554367442;5436.293281873351;5514.035043867322;5568.86077848054;5576;5599.944000559998;5550.69471179085;5567.638103523268;5590.720463976795;5621.690807005602;5672.319321681393;5082.2376643503585;5132.4610915853855;5152.896942061157;5159.174532074869;5169.147090730025;5121.462246464123;5155.123628983063;5155.407128180251;5160.6903585784785;5205.557527610139;4972.453030166679;5091.974540127313;5102.719350435725;5120.334356533664;5197.116490196695;5057.974710126463;5072.010957863218;5149.45930677281;5160.793568257265;5163;5072.746362681851;5090.847274581768;5111.616628752821;5128.487151284879;5144.0740666679985;5524.33707955044;5532.917006244909;5538.833834984916;5551.333839939233;5569.944300556983;5655.688937108457;5683;5747;5791.507721843648;5839.299284085937;5871.8532036699;5875.764969401219;5890.587658863881;5914.822555323347;5953.1070339449;5450.945490545044;5457;5463.235147079412;5464.617476776667;5485.177223416519;5777.653340799566;5887.411258874164;5893.11603259506;5901.616394934315;5999.130126131687;5721.5136713379;5732.283464566929;5734.569907256972;5746.42535746422;5819.563532734977;5870.0607902735355;5881.470667639933;5883.146943693226;5883.911741323884;5890.823275301748;5460.099083651233;5684.232628595169;5686.857828554236;5707.315122185364;5787.536997040227;5551.361593416808;5567.387587365387;5581.944180558143;5606.719664016783;5748.856278593069;4327.1345730853955;4340.088581397942;4361.760103194291;4370.322599997005;4397.648188144941;3871.3612253977776;3916.4908561886773;3949.861754838567;4031.274370613318;4079.204555111725;5421.186821976657;5431.728413579305;5447.046766815792;5456.836294911159;5457.727113644302;5900.085486749561;5904.261967254093;5907.291125064934;5912.536035293412;5975.492083172892;5244.868878278074;5305.973470132624;5370.436104209002;5371.355437347544;5411.810586629449;5164.380274367025;5176.4047134580005;5188.22176673502;5192.7403629818355;5195.246689230041;5966.284045914518;5973.910391344133;5989.520838332923;5997.810291629273;5999.850003749942;5654.943450565606;5750.137479378127;5751.252337196305;5855.268091488564;5979.701014949323;5926.348101708895;5963.612365196248;5976.342602313829;5976.850578735392;5994.730237139252;5753.712314384347;5771.538276937751;5780.393058728773;5791.7683292667825;5795.246617939641;5740.13897915316;5835.533157347317;5884.029135192645;5884.764609415746;5986.580939334205;5730.684812335361;5733.369329373849;5743.885122297447;5750.108733146369;5751.33859606134;5620.606557541097;5712;5727.971360143172;5731.627444216113;5756.65460072397;5428.131498960148;5540.252065971043;5558.249636299048;5565.693886836263;5680.772769089355;5701.914471283017;5736.885262294647;5742.339630942328;5745.91381129275;5771.307443106854;5630.380658127685;5640.520555752807;5650.717464126695;5653.208550802973;5654.378018417889 18:08:03 INFO - 2015-10-23 18:08:03,395 DEBUG : BROWSER_OUTPUT: |1;ext.html;566.7619599768097;569.2883895131087;569.3395661033201;575.3412342867417;600.615606012152;31417.68582314179;32203.838980805092;37576.99999999996;37724.81137594315;38047.619523804824;41507;42227.15545689085;42250.78874605631;42256.36615450763;42272.78863605685;8320.875186872201;9144;9313.115254050888;9341.579628916716;9367.250619950388;8420.831583368328;11166.330020198773;11308.886911130907;11314.773704525904;11316;11059.336439813596;11210.551577936872;11231.719207019809;11247.156463265288;11258.718532036724;8553.957230213871;8763.51800650964;10756.892431075667;11042.779144417107;11136.443177841076;10930.125589952864;11043.061339786127;11082.168837337233;11093.057090147347;11100.833487497694;39068.80465597682;39489.802550987064;39495.21009579821;39509.802450987845;39567;3035.802672826281;3065.1877252527875;3118.5945827042337;3209.983950080258;3416.7266618670697;26977.865110674516;28565.57151642727;28589.714102858914;29454.11637650874;30279.394412111633;2062.2026859125735;2082.3856962196187;2092.8953552322323;2106.662933930579;2139.764625891151;269472;272708;273231.6338418315;273240;273994;52080;52933.47066529362;55010;55733;55911;69461;70236.29763702297;70688.23279418056;70704.64647676729;70774.29225707677;17144.657106857794;17348.13259337028;17359.913200433915;17366;17367.392141274995;13161.341932903508;13221.338933053308;13225.537106201236;13234.07361484706;13235.669108272177;19506.12222449993;19866.205351785768;19909.502262443264;19921.60156796885;19933.401997940084;9066.954665226764;9285.30360222986;9309.53452327381;9322.440653560672;9327;942.2462030375672;944.5088553952044;978.4667356290838;1033.4574348467115;1096.0464395975553;28436;28463.857680711877;28540.429191416057;28607.28481787972;28668;1111.8999290063932;1121.5513794482108;1150.9654710358702;1199.3643369014437;1268.8033354829831;16296.674066518603;16710.916445417693;16715.832841671672;16771.496855094367;17021.574460638334;404259;414487;415320;415452;415608;57223.42776572181;57711.71144144252;57719.71140144272;57747.71126144342;57763.71118144466;1394.1356359057247;1397.9790303145257;1414.9151050936564;1419.4464158978008;1420.8934329925296;29008;29192.27019324534;29197.270068247613;29663.85168074146;29742.405151897274;46206.30690539577;46227;46733;46863;47255.29117063178;293331;293689;298080.72071712033;298995;300254;31118.22204444907;31542.36915261636;31551.52672709865;31554.211144721565;31621;40043;40419.79790101031;40682;40806.393821164056;41069.58930410658;33620.1594960128;34908.47637285392;35057;35189.82405087958;39308.80345598254;36256;36750;38577;39051;39942.600573993885;36273;36544.24924759764;36553.81723091367;36588.81705591455;39318.803405983934;31847.681523185398;32370.514442283857;32374.83812580922;34477;35805.283894321445;24443.877780610983;24607;24614.87692561526;24795;25100.49799004046 18:08:03 INFO - 2015-10-23 18:08:03,395 DEBUG : BROWSER_OUTPUT: |2;jquery.html;352.95411596492454;355.84342889128766;358.96410358964107;360.35496461334213;365.24576749013283;14307.713845723105;14449.422023119088;17758.556036099104;18271.72592411113;18883.527911802194;11696.941515292432;12047.397630118503;14885.181315027668;18114.184861681224;18165.545861353472;4313.396124542574;4425.092855964535;4431.313146462304;4433.268510695748;4438.7780610969485;3451.4650229214385;3518.771279866813;4329.567043295677;4406.118776244748;4705.082508910764;4734.502877197896;4768.451628062765;4769.165396055676;4770.117528257266;4779;4489.775511224426;4760.690555113906;4762.738049407281;4764.023375208074;4874.512548745132;4105.91788164235;4108.424820525099;4108.424820525129;4111.691623128278;4123.773192474413;13239.602811915658;13412.195268283935;13475.730485390237;13494.93252533731;13520.864791352058;1828.5245836082581;1912;1988.67186914159;1994.0328940463864;1995.6308083004546;9513.571889265;9544.42733435996;9616.95191524038;9654.372465789702;9774.462404567746;1497.0493736477306;1519.5821149184062;1558.516859773474;1559.7114533811282;1563.8748900087965;56113.158302625496;57452.13821792677;57636.42363576352;57726.71136644332;57741;6466.805995820133;6515.381038801306;6532.738690452328;6556.541042127005;6556.672166391661;7547.132079810892;7550.5469671819865;7559.584222867685;7562.886556701654;7563.621818909032;5577.860553486114;5579.832605021856;5582.91625625616;5608;5610.354809196994;6027.367126451747;6042.395760423922;6066.636001839904;6069.939300606938;6074.75700971965;2927.312081660808;2948.395578906319;2955.1015536413956;2968.495355789521;2980.910572682823;1048.3290693955873;1056.7780766039064;1065.8454524093963;1069.4866464097277;1109.389835590422;404.4863023959555;433.6465780388973;439.58678841888525;449.62680974790845;449.84255510571694;11230.94384528072;11647.59233426826;11706.941465292619;11822.231554949072;12014.098942579341;415.21938755140144;466.10275220200975;469.2328043648659;481.3309499795287;496.44894167474075;6118.694065296718;6228.719707613168;6302.590331628429;6314.494840412756;6325.9051114233325;480600;489761;503489;504941;508034;65418;66862;67281;67916.6604166976;68045.3195468039;501.3782909192575;506.1572481817806;507.85526125054184;508.379776672459;509.85469141294556;10624.415657138623;10829.404382759023;10999.34003959765;11112.111031117653;11114.944425277821;33322.500162498065;34176.65823341735;34264.486032710025;34538.481922770676;34749.82625086858;43607;44200.7789961061;44323;44864.32703509515;45036.77481612571;6039.184710064085;6255.530835187288;6258.561900666909;6320.873582528416;6346.809595712136;11472.598459054227;11752.353620550952;11816.76366472683;11826.349550774446;11846.111541634584;9767.218622510325;10124.038216369434;10272.075513203847;10307.742306442398;10319.845202321821;9574.234061274941;9695.563699633674;9819.165370943265;9880.061394167542;9988.300818942604;7970.521768693897;10112.59549618007;10324.07083362471;10424.113950314308;10428.113610343205;6184.443400094013;6217.906731398942;6308.747650093945;6312.652804095819;6312.810615681537;9544.713658590254;10293.845592316271;10299.279050466395;10306.690799276033;10374.740631484274 18:08:03 INFO - 2015-10-23 18:08:03,396 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1378.7449321875447;1468.9999999999998;1691.9830801691983;1773.5388798912286;1946.7761207461147;8341.958290208548;9039.141281578248;9142.817143657123;9143.81712365753;9155.67955121571;8803.515806630632;9022.86465703015;9040.457572545653;9045.683401080963;9057.09429057094;2060.320094368862;2109.957800843982;2358.103920510208;2390.282915125464;2399.36416849535;2439.2070330635856;2462.7906627936645;2464.2607217834666;2466.0628960994795;2475.4430253192977;2374.536965291769;2394.832361734679;2396.7363590005084;2397.2688330059327;2402.627592723131;2115.7778433264516;2169.7287839020046;2340.9531809363716;2382.952340953171;2390.9043638254448;2353.6116540770754;2355.0815182079004;2355.9528809423887;2361.97638023621;2414.8430352027062;9378.67174648884;9455.149036586672;9463.621455141785;9463.952680236624;9464.574094165779;5425.565954723613;5539.169124631298;5541.889162216733;5547.5007249347345;5548.140038294071;3031.439183750991;3037.346970401374;3071.8003329783714;3076.5846610707717;3087.691230876917;831.1356189562907;854.4531499840107;864.2222000199807;890.2343984173606;907.0974380491388;13103.86896131036;13134.540291089766;13145;13150.408231629599;13174.736505269937;4790.473047964721;4854.2233242681;4933.605311575066;4977.129002424561;4986.950130498722;11126.888731112747;11141.442927853575;11152.163587730953;11179.273347232403;11188;5529.115341545414;5535.252740880011;5538.418466061005;5556.222128901957;5562.97218513913;4923.532264434873;4963.156263435225;4969.204927211629;4979.950200498021;4982.053409852117;4104.938425923614;4109.876703698894;4124.876253712393;4129.215449064668;4173.833046678099;1145.7479354541988;1151.6199654114123;1153.2676750263474;1164.0745607242263;1166.4575972172981;1348.528015194674;1363.2365875109772;1369.3084992079137;1387;1394.8674875886775;8640.567971601395;8803.163699448542;8815.647374104963;8818;8823.779405514913;483.59136529633105;493.67664179962185;499.8000799680157;499.86753510319795;501.67641870993003;6671.266160722316;6692.364225398579;6774.424173945171;6781.321867813278;6785.898211526831;10849.891501084889;11058.668239952814;11070.169737269736;11088.22382433238;11099.500522476508;10973.122150227962;10982.670519884416;11007.009369156815;11054.226204165792;11283.830742538868;8467.49195048299;8544.444611100384;8554.828903421896;8568.186022327869;8576.656933722707;8288.917110829056;8344.958275208584;8370.455920365157;8388.874166887623;8395;9454.243660507005;9533.968000797544;9584.712458626253;9628.566714498005;9649.807003859743;9760.072793084646;9907.950460247652;9978.850317245393;10012.39925604466;10020.69937901864;8081.9191808083515;8084.717034903751;8157.877631835646;8179.468334558473;8184.8363032737825;8326.916730832614;8380.12008739098;8384.371172161991;8385.161483851565;8389.496630202208;7024.7190112396975;7962;8237.135100814568;8263.214994575506;8386.832263354821;7055.929440705528;8097.676092956216;8210.58947052633;8228.136045715113;8280.627371768405;8391.07698153215;8418.873716894374;8422.915770842214;8451.619677114668;8472.872906906277;7332.046833911558;7353.301436363537;7401.481896267425;7404.148522919718;7429.851402972018;7651.196624354585;7692.92307076922;7693.115291741521;7695.422843286664;7718.691252349843 18:08:03 INFO - 2015-10-23 18:08:03,400 DEBUG : BROWSER_OUTPUT: |4;prototype.html;328.99506507402384;339.09461737161774;340.50966608084354;344.9724022078232;345.79079656807636;6050.092486127083;6181.1964444622245;6225.252969643643;6226.68866556672;6255.593386429879;5991.281046274453;6056.12186232997;6095.573309868311;6103.389661033894;6103.572749907497;4759.214729569617;4770.713757174563;4773.76131193439;4778.354922085508;4779.450363208241;4584;4673.672842900998;4689.202835517953;4755.3104799804005;4798.296604705331;4713.646476514258;4732.834350797722;4742.976285118587;4749.667523273372;4750.857474275777;4717.669763116583;4719.10337035962;4729.337892695025;4730.195866702668;4746.786394612251;4144.647704945083;4144.730592511507;4150.667946564267;4154.169166166779;4164.375343698439;5795.1886735857015;5900.085486749561;5935;6050.69746512677;6057.485113765335;5287.762050707727;5290.074237008546;5310.628256022042;5315.096433606296;5317.973410132963;6308.022256550242;6312.179416675849;6331.68341582919;6345.175127233476;6346.682665866688;4374.562543745632;4459.799309031101;4468.776561171929;4478.014836735945;4479.641628669699;6565.638889861056;6588.60468371904;6596.637184954778;6599.604023758542;6610.471162307004;4547.204239258117;4550.158220729176;4554.407926969473;4556.863294101182;4561.589456948891;4644.0944015916575;4650.209464391061;4651.302304654261;4658.440987081504;4659.161350956792;5140.151874940668;5296.390915044819;5297.947020529822;5298.417174110845;5300.257963885059;6287.528435367366;6301.495880329563;6305.4009869062365;6328.7468501260355;6335.429811316912;1618.4820857325542;1619.3198856480305;1621.3190460006826;1621.9107949062916;1635.681042196784;1065.8347956066823;1095.8301463273206;1117.0560876059717;1125.4879030041475;1126.0822429719751;5989.79035733756;5994.670293133832;6013.579049466583;6013.729382177812;6032.517398608101;6328.430441260309;6403.903941440882;6452.580582262138;6563.967180164069;6586.868262634816;5984;5986.042233242661;6001.969990150022;6010.549208809357;6016.067509536029;3592.4431713084514;3613.94579081314;3631.618680038558;3636.4363523653874;3642.0894776305922;6501.804945851632;6584.242812076577;6599.835004124935;6619.073329733841;6650.667466626746;6662.467002639874;6701.028350889093;6705.128333316735;6714.362135597111;6718.227403848522;6553.901691474632;6568.113304703804;6581.3747693969;6592.274849766522;6607.834804129935;6363.649999250086;6504.707288171949;6520.902186467301;6527.67361631926;6535.673216339069;6426.614403135827;6451.1290975717675;6451.903221451776;6458.22501299847;6471.7734879279;6632.2372927114;6645.833854153685;6650.46796256308;6660.367265109807;6671.766488172891;4305.375720520445;4387.517373089022;4411.139827733561;4445.177642136216;4450.243458612108;6613.867722645617;6619.933800662125;6620.106285651375;6650.135482387453;6655.733770649314;6403.07155462446;6418.326075761977;6426.775062872777;6430.582012169194;6430.742770289136;6288.371162883675;6432.195975503062;6432.807015789534;6443.967780161257;6463.15978922737;6280.685965701605;6294.653794041372;6302.905456418249;6310.905336420049;6314.905276420949;6422.775202868064;6432.903506447314;6438.484921206198;6446.774362897276;6458.031295305742;6093.75624974996;6217.036359364306;6239.344868788893;6278.968605156945;6304.148939893055 18:08:03 INFO - 2015-10-23 18:08:03,400 DEBUG : BROWSER_OUTPUT: |5;yui.html;749.0374868294243;775.1937984496121;778.3734094054288;783.1659282863748;783.7922950418139;12673.619791406249;13137.934310328435;13142.868571314308;13147.7370452591;13159.14465559738;12235.571754988578;12360.93819530901;12362.258264504137;12370.690732731664;12387.814182787242;709.0321710864658;726.0307489501522;888.0985799413584;905.302916754099;906.0395980260945;894.6063731957918;904.8009437923646;916.5142474488532;916.5417291354323;917.1104029091771;953.5851904421598;960.851068084448;960.8750862387915;962.210986990668;962.6245764151952;733.0360575842776;744.8957145999565;916.3402350307767;945.6264775413741;951.9286053546011;706.58311596158;706.6643344411364;706.752636577199;707.3139055116528;707.4305184326615;12411.565595204214;12715.109942304043;12718.173318734252;12734.490620375174;12740.044496662787;10243.48782560869;10318.845217321747;10542.525586348633;10711.143108551298;11085.69259355453;8251.95874020626;8316;8659.004214515347;8669.720203126531;8822.735317940473;2770.6536682914634;2832.546792513188;2861.413410250894;2897.840618765967;2939.514980028293;38081.42877856834;38594.80702596469;38629.42055869164;38713.419298710825;38891.61108388908;6331.493480521547;6383.425491705769;6440.549161558646;6472.676366181672;6624.0395142705;11273.774524509465;11280.041196498225;11281.21031527785;11289.15331350152;11290.362897379833;5786.450287222707;5824.708764561755;5884.6469211847425;6015.458608725148;6148.292946311231;3664.560941289187;3686.318031164243;3751.7373783835415;3783.2055268393397;3898.161895192547;2582.9354266143496;2596.2211336598943;2600.557905156128;2604.270804174834;2607.3220962549494;395.2628348130773;398.6352487473929;407.43366720258865;407.904142526506;407.97756123413495;558.6508432229856;576.6568891509545;577.5956830218863;607.134832863177;620.8297359477327;6717.462602991749;7096.7516136934955;7190.496665233383;7280.854382912418;7378.926210737931;452.79171581072416;463.9582437580634;488.504168269207;516.2772119033308;559.0747313196666;3405.897823065312;3438.3123375325035;3487.790732556004;3500.334936362083;3537.646235376493;45500.54499454963;45603.315950260774;45702;45765.771171144595;46027.539724603;39417.211655766725;39728.40407393892;40331.798341008696;40552.391714124315;40707.38938915919;33645.32709345848;34009;34016.48975265373;34117.147071323416;34227.14432139217;6790.25307216196;6862.451003919774;6970.756023539152;7037.7184912602925;7058.858822823412;23333;23943.16198933029;23958.161464348665;24024.87987560051;24045.27864164078;33339.33321333608;33963.66036339605;34868.47697284492;35072.29855402827;35142.29715405728;6689.531732778659;6756.831079223059;6832.555883867532;6875.346842049998;6960.443164546723;9494.335396522178;9511.096445837635;9553.140217380469;9762.219022478042;10340.53467593945;8935;9128.28742443369;9189.448633081769;9230.630774768933;9791.314607977372;8951.083714456257;9011.954940225258;9056.547172641473;9215.032421595635;9311.255099591881;9072.50101244438;9186.586603602987;9208.217301529445;9260.120288572574;9389.906100938902;8035.477693949874;8185.30424913889;8331.875021874555;8370.330373570221;8412.537310447984;7800.882986755317;7977.760667179994;8207.861161740318;8223.301019413417;8314 18:08:03 INFO - 2015-10-23 18:08:03,400 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:08:03 INFO - 2015-10-23 18:08:03,400 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:08:03 INFO - 2015-10-23 18:08:03,400 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,959 18:08:03 INFO - 2015-10-23 18:08:03,401 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:08:03 INFO - 2015-10-23 18:08:03,401 DEBUG : BROWSER_OUTPUT: __startTimestamp1445648883388__endTimestamp 18:08:03 INFO - 2015-10-23 18:08:03,401 DEBUG : BROWSER_OUTPUT: 18:08:03 INFO - 2015-10-23 18:08:03,401 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:08:03 INFO - 2015-10-23 18:08:03,401 DEBUG : BROWSER_OUTPUT: Number of tests: 6 18:08:03 INFO - 2015-10-23 18:08:03,401 DEBUG : BROWSER_OUTPUT: 18:08:03 INFO - 2015-10-23 18:08:03,401 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5438.78 Median:5620.61 stddev:584.93 (10.4%) stddev-sans-first:559.10 18:08:03 INFO - 2015-10-23 18:08:03,402 DEBUG : BROWSER_OUTPUT: Values: 3174.4 3244.8 3265.9 3279.0 3321.4 5436.3 5514.0 5568.9 5576.0 5599.9 5550.7 5567.6 5590.7 5621.7 5672.3 5082.2 5132.5 5152.9 5159.2 5169.1 5121.5 5155.1 5155.4 5160.7 5205.6 4972.5 5092.0 5102.7 5120.3 5197.1 5058.0 5072.0 5149.5 5160.8 5163.0 5072.7 5090.8 5111.6 5128.5 5144.1 5524.3 5532.9 5538.8 5551.3 5569.9 5655.7 5683.0 5747.0 5791.5 5839.3 5871.9 5875.8 5890.6 5914.8 5953.1 5450.9 5457.0 5463.2 5464.6 5485.2 5777.7 5887.4 5893.1 5901.6 5999.1 5721.5 5732.3 5734.6 5746.4 5819.6 5870.1 5881.5 5883.1 5883.9 5890.8 5460.1 5684.2 5686.9 5707.3 5787.5 5551.4 5567.4 5581.9 5606.7 5748.9 4327.1 4340.1 4361.8 4370.3 4397.6 3871.4 3916.5 3949.9 4031.3 4079.2 5421.2 5431.7 5447.0 5456.8 5457.7 5900.1 5904.3 5907.3 5912.5 5975.5 5244.9 5306.0 5370.4 5371.4 5411.8 5164.4 5176.4 5188.2 5192.7 5195.2 5966.3 5973.9 5989.5 5997.8 5999.9 5654.9 5750.1 5751.3 5855.3 5979.7 5926.3 5963.6 5976.3 5976.9 5994.7 5753.7 5771.5 5780.4 5791.8 5795.2 5740.1 5835.5 5884.0 5884.8 5986.6 5730.7 5733.4 5743.9 5750.1 5751.3 5620.6 5712.0 5728.0 5731.6 5756.7 5428.1 5540.3 5558.2 5565.7 5680.8 5701.9 5736.9 5742.3 5745.9 5771.3 5630.4 5640.5 5650.7 5653.2 5654.4 18:08:03 INFO - 2015-10-23 18:08:03,403 DEBUG : BROWSER_OUTPUT: 18:08:03 INFO - 2015-10-23 18:08:03,403 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:49828.61 Median:31552.87 stddev:87550.20 (277.5%) stddev-sans-first:87717.68 18:08:03 INFO - 2015-10-23 18:08:03,404 DEBUG : BROWSER_OUTPUT: Values: 566.8 569.3 569.3 575.3 600.6 31417.7 32203.8 37577.0 37724.8 38047.6 41507.0 42227.2 42250.8 42256.4 42272.8 8320.9 9144.0 9313.1 9341.6 9367.3 8420.8 11166.3 11308.9 11314.8 11316.0 11059.3 11210.6 11231.7 11247.2 11258.7 8554.0 8763.5 10756.9 11042.8 11136.4 10930.1 11043.1 11082.2 11093.1 11100.8 39068.8 39489.8 39495.2 39509.8 39567.0 3035.8 3065.2 3118.6 3210.0 3416.7 26977.9 28565.6 28589.7 29454.1 30279.4 2062.2 2082.4 2092.9 2106.7 2139.8 269472.0 272708.0 273231.6 273240.0 273994.0 52080.0 52933.5 55010.0 55733.0 55911.0 69461.0 70236.3 70688.2 70704.6 70774.3 17144.7 17348.1 17359.9 17366.0 17367.4 13161.3 13221.3 13225.5 13234.1 13235.7 19506.1 19866.2 19909.5 19921.6 19933.4 9067.0 9285.3 9309.5 9322.4 9327.0 942.2 944.5 978.5 1033.5 1096.0 28436.0 28463.9 28540.4 28607.3 28668.0 1111.9 1121.6 1151.0 1199.4 1268.8 16296.7 16710.9 16715.8 16771.5 17021.6 404259.0 414487.0 415320.0 415452.0 415608.0 57223.4 57711.7 57719.7 57747.7 57763.7 1394.1 1398.0 1414.9 1419.4 1420.9 29008.0 29192.3 29197.3 29663.9 29742.4 46206.3 46227.0 46733.0 46863.0 47255.3 293331.0 293689.0 298080.7 298995.0 300254.0 31118.2 31542.4 31551.5 31554.2 31621.0 40043.0 40419.8 40682.0 40806.4 41069.6 33620.2 34908.5 35057.0 35189.8 39308.8 36256.0 36750.0 38577.0 39051.0 39942.6 36273.0 36544.2 36553.8 36588.8 39318.8 31847.7 32370.5 32374.8 34477.0 35805.3 24443.9 24607.0 24614.9 24795.0 25100.5 18:08:03 INFO - 2015-10-23 18:08:03,404 DEBUG : BROWSER_OUTPUT: 18:08:03 INFO - 2015-10-23 18:08:03,405 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25149.64 Median:24378.13 stddev:81472.06 (334.2%) stddev-sans-first:81679.33 18:08:03 INFO - 2015-10-23 18:08:03,406 DEBUG : BROWSER_OUTPUT: Values: 353.0 355.8 359.0 360.4 365.2 14307.7 14449.4 17758.6 18271.7 18883.5 11696.9 12047.4 14885.2 18114.2 18165.5 4313.4 4425.1 4431.3 4433.3 4438.8 3451.5 3518.8 4329.6 4406.1 4705.1 4734.5 4768.5 4769.2 4770.1 4779.0 4489.8 4760.7 4762.7 4764.0 4874.5 4105.9 4108.4 4108.4 4111.7 4123.8 13239.6 13412.2 13475.7 13494.9 13520.9 1828.5 1912.0 1988.7 1994.0 1995.6 9513.6 9544.4 9617.0 9654.4 9774.5 1497.0 1519.6 1558.5 1559.7 1563.9 56113.2 57452.1 57636.4 57726.7 57741.0 6466.8 6515.4 6532.7 6556.5 6556.7 7547.1 7550.5 7559.6 7562.9 7563.6 5577.9 5579.8 5582.9 5608.0 5610.4 6027.4 6042.4 6066.6 6069.9 6074.8 2927.3 2948.4 2955.1 2968.5 2980.9 1048.3 1056.8 1065.8 1069.5 1109.4 404.5 433.6 439.6 449.6 449.8 11230.9 11647.6 11706.9 11822.2 12014.1 415.2 466.1 469.2 481.3 496.4 6118.7 6228.7 6302.6 6314.5 6325.9 480600.0 489761.0 503489.0 504941.0 508034.0 65418.0 66862.0 67281.0 67916.7 68045.3 501.4 506.2 507.9 508.4 509.9 10624.4 10829.4 10999.3 11112.1 11114.9 33322.5 34176.7 34264.5 34538.5 34749.8 43607.0 44200.8 44323.0 44864.3 45036.8 6039.2 6255.5 6258.6 6320.9 6346.8 11472.6 11752.4 11816.8 11826.3 11846.1 9767.2 10124.0 10272.1 10307.7 10319.8 9574.2 9695.6 9819.2 9880.1 9988.3 7970.5 10112.6 10324.1 10424.1 10428.1 6184.4 6217.9 6308.7 6312.7 6312.8 9544.7 10293.8 10299.3 10306.7 10374.7 18:08:03 INFO - 2015-10-23 18:08:03,406 DEBUG : BROWSER_OUTPUT: 18:08:03 INFO - 2015-10-23 18:08:03,406 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:6309.15 Median:5538.79 stddev:3483.49 (62.9%) stddev-sans-first:3473.55 18:08:03 INFO - 2015-10-23 18:08:03,407 DEBUG : BROWSER_OUTPUT: Values: 1378.7 1469.0 1692.0 1773.5 1946.8 8342.0 9039.1 9142.8 9143.8 9155.7 8803.5 9022.9 9040.5 9045.7 9057.1 2060.3 2110.0 2358.1 2390.3 2399.4 2439.2 2462.8 2464.3 2466.1 2475.4 2374.5 2394.8 2396.7 2397.3 2402.6 2115.8 2169.7 2341.0 2383.0 2390.9 2353.6 2355.1 2356.0 2362.0 2414.8 9378.7 9455.1 9463.6 9464.0 9464.6 5425.6 5539.2 5541.9 5547.5 5548.1 3031.4 3037.3 3071.8 3076.6 3087.7 831.1 854.5 864.2 890.2 907.1 13103.9 13134.5 13145.0 13150.4 13174.7 4790.5 4854.2 4933.6 4977.1 4987.0 11126.9 11141.4 11152.2 11179.3 11188.0 5529.1 5535.3 5538.4 5556.2 5563.0 4923.5 4963.2 4969.2 4980.0 4982.1 4104.9 4109.9 4124.9 4129.2 4173.8 1145.7 1151.6 1153.3 1164.1 1166.5 1348.5 1363.2 1369.3 1387.0 1394.9 8640.6 8803.2 8815.6 8818.0 8823.8 483.6 493.7 499.8 499.9 501.7 6671.3 6692.4 6774.4 6781.3 6785.9 10849.9 11058.7 11070.2 11088.2 11099.5 10973.1 10982.7 11007.0 11054.2 11283.8 8467.5 8544.4 8554.8 8568.2 8576.7 8288.9 8345.0 8370.5 8388.9 8395.0 9454.2 9534.0 9584.7 9628.6 9649.8 9760.1 9908.0 9978.9 10012.4 10020.7 8081.9 8084.7 8157.9 8179.5 8184.8 8326.9 8380.1 8384.4 8385.2 8389.5 7024.7 7962.0 8237.1 8263.2 8386.8 7055.9 8097.7 8210.6 8228.1 8280.6 8391.1 8418.9 8422.9 8451.6 8472.9 7332.0 7353.3 7401.5 7404.1 7429.9 7651.2 7692.9 7693.1 7695.4 7718.7 18:08:03 INFO - 2015-10-23 18:08:03,408 DEBUG : BROWSER_OUTPUT: 18:08:03 INFO - 2015-10-23 18:08:03,408 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5339.63 Median:6053.41 stddev:1575.00 (26.0%) stddev-sans-first:1533.85 18:08:03 INFO - 2015-10-23 18:08:03,409 DEBUG : BROWSER_OUTPUT: Values: 329.0 339.1 340.5 345.0 345.8 6050.1 6181.2 6225.3 6226.7 6255.6 5991.3 6056.1 6095.6 6103.4 6103.6 4759.2 4770.7 4773.8 4778.4 4779.5 4584.0 4673.7 4689.2 4755.3 4798.3 4713.6 4732.8 4743.0 4749.7 4750.9 4717.7 4719.1 4729.3 4730.2 4746.8 4144.6 4144.7 4150.7 4154.2 4164.4 5795.2 5900.1 5935.0 6050.7 6057.5 5287.8 5290.1 5310.6 5315.1 5318.0 6308.0 6312.2 6331.7 6345.2 6346.7 4374.6 4459.8 4468.8 4478.0 4479.6 6565.6 6588.6 6596.6 6599.6 6610.5 4547.2 4550.2 4554.4 4556.9 4561.6 4644.1 4650.2 4651.3 4658.4 4659.2 5140.2 5296.4 5297.9 5298.4 5300.3 6287.5 6301.5 6305.4 6328.7 6335.4 1618.5 1619.3 1621.3 1621.9 1635.7 1065.8 1095.8 1117.1 1125.5 1126.1 5989.8 5994.7 6013.6 6013.7 6032.5 6328.4 6403.9 6452.6 6564.0 6586.9 5984.0 5986.0 6002.0 6010.5 6016.1 3592.4 3613.9 3631.6 3636.4 3642.1 6501.8 6584.2 6599.8 6619.1 6650.7 6662.5 6701.0 6705.1 6714.4 6718.2 6553.9 6568.1 6581.4 6592.3 6607.8 6363.6 6504.7 6520.9 6527.7 6535.7 6426.6 6451.1 6451.9 6458.2 6471.8 6632.2 6645.8 6650.5 6660.4 6671.8 4305.4 4387.5 4411.1 4445.2 4450.2 6613.9 6619.9 6620.1 6650.1 6655.7 6403.1 6418.3 6426.8 6430.6 6430.7 6288.4 6432.2 6432.8 6444.0 6463.2 6280.7 6294.7 6302.9 6310.9 6314.9 6422.8 6432.9 6438.5 6446.8 6458.0 6093.8 6217.0 6239.3 6279.0 6304.1 18:08:03 INFO - 2015-10-23 18:08:03,409 DEBUG : BROWSER_OUTPUT: 18:08:03 INFO - 2015-10-23 18:08:03,409 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:10873.46 Median:5854.68 stddev:12277.64 (209.7%) stddev-sans-first:12288.54 18:08:03 INFO - 2015-10-23 18:08:03,411 DEBUG : BROWSER_OUTPUT: Values: 749.0 775.2 778.4 783.2 783.8 12673.6 13137.9 13142.9 13147.7 13159.1 12235.6 12360.9 12362.3 12370.7 12387.8 709.0 726.0 888.1 905.3 906.0 894.6 904.8 916.5 916.5 917.1 953.6 960.9 960.9 962.2 962.6 733.0 744.9 916.3 945.6 951.9 706.6 706.7 706.8 707.3 707.4 12411.6 12715.1 12718.2 12734.5 12740.0 10243.5 10318.8 10542.5 10711.1 11085.7 8252.0 8316.0 8659.0 8669.7 8822.7 2770.7 2832.5 2861.4 2897.8 2939.5 38081.4 38594.8 38629.4 38713.4 38891.6 6331.5 6383.4 6440.5 6472.7 6624.0 11273.8 11280.0 11281.2 11289.2 11290.4 5786.5 5824.7 5884.6 6015.5 6148.3 3664.6 3686.3 3751.7 3783.2 3898.2 2582.9 2596.2 2600.6 2604.3 2607.3 395.3 398.6 407.4 407.9 408.0 558.7 576.7 577.6 607.1 620.8 6717.5 7096.8 7190.5 7280.9 7378.9 452.8 464.0 488.5 516.3 559.1 3405.9 3438.3 3487.8 3500.3 3537.6 45500.5 45603.3 45702.0 45765.8 46027.5 39417.2 39728.4 40331.8 40552.4 40707.4 33645.3 34009.0 34016.5 34117.1 34227.1 6790.3 6862.5 6970.8 7037.7 7058.9 23333.0 23943.2 23958.2 24024.9 24045.3 33339.3 33963.7 34868.5 35072.3 35142.3 6689.5 6756.8 6832.6 6875.3 6960.4 9494.3 9511.1 9553.1 9762.2 10340.5 8935.0 9128.3 9189.4 9230.6 9791.3 8951.1 9012.0 9056.5 9215.0 9311.3 9072.5 9186.6 9208.2 9260.1 9389.9 8035.5 8185.3 8331.9 8370.3 8412.5 7800.9 7977.8 8207.9 8223.3 8314.0 18:08:03 INFO - 2015-10-23 18:08:03,411 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:08:03 INFO - 2015-10-23 18:08:03,411 DEBUG : BROWSER_OUTPUT: 18:08:04 INFO - 2015-10-23 18:08:04,076 INFO : Browser exited with error code: 0 18:08:04 INFO - 2015-10-23 18:08:04,103 INFO : Completed test dromaeo_css (00:18:35) 18:08:04 INFO - 2015-10-23 18:08:04,103 INFO : Starting test kraken 18:08:04 INFO - 2015-10-23 18:08:04,103 DEBUG : operating with platform_type : mac_ 18:08:04 INFO - 2015-10-23 18:08:04,104 INFO : Initialising browser for kraken test... 18:08:04 INFO - 2015-10-23 18:08:04,117 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/tmpKI2XaG/profile http://localhost:49273/getInfo.html 18:08:06 INFO - 2015-10-23 18:08:06,313 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:08:06 INFO - 2015-10-23 18:08:06,313 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:08:06 INFO - 2015-10-23 18:08:06,313 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 18:08:06 INFO - 2015-10-23 18:08:06,314 DEBUG : BROWSER_OUTPUT: __metrics 18:08:06 INFO - 2015-10-23 18:08:06,329 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:08:06 INFO - 2015-10-23 18:08:06,592 DEBUG : BROWSER_OUTPUT: console.error: 18:08:06 INFO - 2015-10-23 18:08:06,593 DEBUG : BROWSER_OUTPUT: Message: [Exception... "Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [mozIStorageAsyncStatement.executeAsync]" nsresult: "0x80040111 (NS_ERROR_NOT_AVAILABLE)" location: "JS frame :: resource://gre/modules/Sqlite.jsm :: ConnectionData.prototype<._executeStatement :: line 758" data: no] 18:08:06 INFO - 2015-10-23 18:08:06,593 DEBUG : BROWSER_OUTPUT: Stack: 18:08:06 INFO - 2015-10-23 18:08:06,593 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<._executeStatement@resource://gre/modules/Sqlite.jsm:758:19 18:08:06 INFO - 2015-10-23 18:08:06,594 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached/<@resource://gre/modules/Sqlite.jsm:493:9 18:08:06 INFO - 2015-10-23 18:08:06,595 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached@resource://gre/modules/Sqlite.jsm:491:1 18:08:06 INFO - 2015-10-23 18:08:06,595 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeBeforeShutdown/loggedDb<.executeCached.value<@resource://gre/modules/Sqlite.jsm:368:51 18:08:06 INFO - 2015-10-23 18:08:06,595 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 18:08:06 INFO - 2015-10-23 18:08:06,595 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3 18:08:06 INFO - 2015-10-23 18:08:06,595 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 18:08:06 INFO - 2015-10-23 18:08:06,595 DEBUG : BROWSER_OUTPUT: transaction@resource://gre/modules/Bookmarks.jsm:798:13 18:08:06 INFO - 2015-10-23 18:08:06,595 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 18:08:06 INFO - 2015-10-23 18:08:06,595 DEBUG : BROWSER_OUTPUT: Handler.prototype.process@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:934:23 18:08:06 INFO - 2015-10-23 18:08:06,595 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 18:08:06 INFO - 2015-10-23 18:08:06,596 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 18:08:06 INFO - 2015-10-23 18:08:06,596 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 18:08:06 INFO - 2015-10-23 18:08:06,596 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 18:08:06 INFO - 2015-10-23 18:08:06,596 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 18:08:06 INFO - 2015-10-23 18:08:06,596 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 18:08:06 INFO - 2015-10-23 18:08:06,596 DEBUG : BROWSER_OUTPUT: 18:08:07 INFO - 2015-10-23 18:08:07,007 INFO : Browser initialized. 18:08:07 INFO - 2015-10-23 18:08:07,007 INFO : Running cycle 1/1 for kraken test... 18:08:07 INFO - 2015-10-23 18:08:07,008 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/tmpKI2XaG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:08:18 INFO - 2015-10-23 18:08:18,874 DEBUG : BROWSER_OUTPUT: RSS: Main: 222830592 18:08:18 INFO - 2015-10-23 18:08:18,874 DEBUG : BROWSER_OUTPUT: 18:08:21 INFO - 2015-10-23 18:08:21,438 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 18:08:22 INFO - 2015-10-23 18:08:22,027 DEBUG : BROWSER_OUTPUT: RSS: Main: 272445440 18:08:22 INFO - 2015-10-23 18:08:22,028 DEBUG : BROWSER_OUTPUT: 18:08:24 INFO - 2015-10-23 18:08:24,709 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 18:08:25 INFO - 2015-10-23 18:08:25,292 DEBUG : BROWSER_OUTPUT: RSS: Main: 282226688 18:08:25 INFO - 2015-10-23 18:08:25,292 DEBUG : BROWSER_OUTPUT: 18:08:28 INFO - 2015-10-23 18:08:28,244 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 18:08:28 INFO - 2015-10-23 18:08:28,811 DEBUG : BROWSER_OUTPUT: RSS: Main: 258854912 18:08:28 INFO - 2015-10-23 18:08:28,811 DEBUG : BROWSER_OUTPUT: 18:08:30 INFO - 2015-10-23 18:08:30,876 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 18:08:31 INFO - 2015-10-23 18:08:31,447 DEBUG : BROWSER_OUTPUT: RSS: Main: 255836160 18:08:31 INFO - 2015-10-23 18:08:31,448 DEBUG : BROWSER_OUTPUT: 18:08:33 INFO - 2015-10-23 18:08:33,758 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:08:34 INFO - 2015-10-23 18:08:34,327 DEBUG : BROWSER_OUTPUT: RSS: Main: 263737344 18:08:34 INFO - 2015-10-23 18:08:34,328 DEBUG : BROWSER_OUTPUT: 18:08:37 INFO - 2015-10-23 18:08:37,373 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 18:08:37 INFO - 2015-10-23 18:08:37,948 DEBUG : BROWSER_OUTPUT: RSS: Main: 264409088 18:08:37 INFO - 2015-10-23 18:08:37,949 DEBUG : BROWSER_OUTPUT: 18:08:41 INFO - 2015-10-23 18:08:41,114 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 18:08:41 INFO - 2015-10-23 18:08:41,696 DEBUG : BROWSER_OUTPUT: RSS: Main: 263839744 18:08:41 INFO - 2015-10-23 18:08:41,696 DEBUG : BROWSER_OUTPUT: 18:08:44 INFO - 2015-10-23 18:08:44,568 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 18:08:45 INFO - 2015-10-23 18:08:45,134 DEBUG : BROWSER_OUTPUT: RSS: Main: 266543104 18:08:45 INFO - 2015-10-23 18:08:45,134 DEBUG : BROWSER_OUTPUT: 18:08:46 INFO - 2015-10-23 18:08:46,738 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:08:47 INFO - 2015-10-23 18:08:47,303 DEBUG : BROWSER_OUTPUT: RSS: Main: 296009728 18:08:47 INFO - 2015-10-23 18:08:47,304 DEBUG : BROWSER_OUTPUT: 18:08:49 INFO - 2015-10-23 18:08:49,093 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:08:49 INFO - 2015-10-23 18:08:49,660 DEBUG : BROWSER_OUTPUT: RSS: Main: 297938944 18:08:49 INFO - 2015-10-23 18:08:49,660 DEBUG : BROWSER_OUTPUT: 18:08:51 INFO - 2015-10-23 18:08:51,743 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:08:52 INFO - 2015-10-23 18:08:52,314 DEBUG : BROWSER_OUTPUT: RSS: Main: 309829632 18:08:52 INFO - 2015-10-23 18:08:52,314 DEBUG : BROWSER_OUTPUT: 18:08:54 INFO - 2015-10-23 18:08:54,880 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:08:55 INFO - 2015-10-23 18:08:55,454 DEBUG : BROWSER_OUTPUT: RSS: Main: 310534144 18:08:55 INFO - 2015-10-23 18:08:55,455 DEBUG : BROWSER_OUTPUT: 18:08:58 INFO - 2015-10-23 18:08:58,051 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:08:58 INFO - 2015-10-23 18:08:58,618 DEBUG : BROWSER_OUTPUT: RSS: Main: 308056064 18:08:58 INFO - 2015-10-23 18:08:58,618 DEBUG : BROWSER_OUTPUT: 18:09:00 INFO - 2015-10-23 18:09:00,372 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 18:09:00 INFO - 2015-10-23 18:09:00,623 DEBUG : BROWSER_OUTPUT: RSS: Main: 361750528 18:09:00 INFO - 2015-10-23 18:09:00,623 DEBUG : BROWSER_OUTPUT: 18:09:00 INFO - 2015-10-23 18:09:00,624 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:09:00 INFO - 2015-10-23 18:09:00,624 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:09:00 INFO - 2015-10-23 18:09:00,624 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:09:00 INFO - 2015-10-23 18:09:00,624 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:09:00 INFO - 2015-10-23 18:09:00,625 DEBUG : BROWSER_OUTPUT: |0;ai-astar;106;101;106;107;108;105;109;106;106;107 18:09:00 INFO - 2015-10-23 18:09:00,625 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;142;137;156;166;144;140;144;138;163;144 18:09:00 INFO - 2015-10-23 18:09:00,625 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;161;160;159;158;158;159;160;159;159 18:09:00 INFO - 2015-10-23 18:09:00,625 DEBUG : BROWSER_OUTPUT: |3;audio-fft;81;81;82;83;78;82;80;81;81;81 18:09:00 INFO - 2015-10-23 18:09:00,625 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;105;105;134;103;103;105;140;104;105;141 18:09:00 INFO - 2015-10-23 18:09:00,625 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;120;115;115;120;120;114;120;121;120;120 18:09:00 INFO - 2015-10-23 18:09:00,626 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;126;125;125;125;125;125;125;125;125;125 18:09:00 INFO - 2015-10-23 18:09:00,626 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;101;100;101;100;102;101;100;101;101;101 18:09:00 INFO - 2015-10-23 18:09:00,626 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;62;61;62;60;62;62;61;69;60;61 18:09:00 INFO - 2015-10-23 18:09:00,626 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;65;64;61;64;64;62;63;71;61 18:09:00 INFO - 2015-10-23 18:09:00,628 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;86;85;85;85;84;85;85;85;85;85 18:09:00 INFO - 2015-10-23 18:09:00,628 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;134;124;129;123;129;124;128;122;130;127 18:09:00 INFO - 2015-10-23 18:09:00,628 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;151;148;150;149;141;150;149;152;148 18:09:00 INFO - 2015-10-23 18:09:00,628 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;74;75;76;74;72;72;73;73;73;74 18:09:00 INFO - 2015-10-23 18:09:00,628 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:09:00 INFO - 2015-10-23 18:09:00,628 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:09:00 INFO - 2015-10-23 18:09:00,628 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,888 18:09:00 INFO - 2015-10-23 18:09:00,628 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:09:00 INFO - 2015-10-23 18:09:00,629 DEBUG : BROWSER_OUTPUT: __startTimestamp1445648940624__endTimestamp 18:09:00 INFO - 2015-10-23 18:09:00,629 DEBUG : BROWSER_OUTPUT: 18:09:00 INFO - 2015-10-23 18:09:00,629 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:09:00 INFO - 2015-10-23 18:09:00,629 DEBUG : BROWSER_OUTPUT: Number of tests: 14 18:09:00 INFO - 2015-10-23 18:09:00,629 DEBUG : BROWSER_OUTPUT: 18:09:00 INFO - 2015-10-23 18:09:00,629 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:106.10 Median:106.50 stddev:2.13 (2.0%) stddev-sans-first:2.26 18:09:00 INFO - 2015-10-23 18:09:00,629 DEBUG : BROWSER_OUTPUT: Values: 106.0 101.0 106.0 107.0 108.0 105.0 109.0 106.0 106.0 107.0 18:09:00 INFO - 2015-10-23 18:09:00,631 DEBUG : BROWSER_OUTPUT: 18:09:00 INFO - 2015-10-23 18:09:00,631 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:147.40 Median:144.00 stddev:10.43 (7.2%) stddev-sans-first:10.87 18:09:00 INFO - 2015-10-23 18:09:00,631 DEBUG : BROWSER_OUTPUT: Values: 142.0 137.0 156.0 166.0 144.0 140.0 144.0 138.0 163.0 144.0 18:09:00 INFO - 2015-10-23 18:09:00,631 DEBUG : BROWSER_OUTPUT: 18:09:00 INFO - 2015-10-23 18:09:00,632 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:159.30 Median:159.50 stddev:0.95 (0.6%) stddev-sans-first:0.97 18:09:00 INFO - 2015-10-23 18:09:00,632 DEBUG : BROWSER_OUTPUT: Values: 160.0 161.0 160.0 159.0 158.0 158.0 159.0 160.0 159.0 159.0 18:09:00 INFO - 2015-10-23 18:09:00,632 DEBUG : BROWSER_OUTPUT: 18:09:00 INFO - 2015-10-23 18:09:00,632 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.00 Median:81.00 stddev:1.33 (1.6%) stddev-sans-first:1.41 18:09:00 INFO - 2015-10-23 18:09:00,632 DEBUG : BROWSER_OUTPUT: Values: 81.0 81.0 82.0 83.0 78.0 82.0 80.0 81.0 81.0 81.0 18:09:00 INFO - 2015-10-23 18:09:00,632 DEBUG : BROWSER_OUTPUT: 18:09:00 INFO - 2015-10-23 18:09:00,632 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:114.50 Median:105.00 stddev:16.56 (15.8%) stddev-sans-first:17.21 18:09:00 INFO - 2015-10-23 18:09:00,633 DEBUG : BROWSER_OUTPUT: Values: 105.0 105.0 134.0 103.0 103.0 105.0 140.0 104.0 105.0 141.0 18:09:00 INFO - 2015-10-23 18:09:00,633 DEBUG : BROWSER_OUTPUT: 18:09:00 INFO - 2015-10-23 18:09:00,633 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:118.50 Median:120.00 stddev:2.68 (2.2%) stddev-sans-first:2.78 18:09:00 INFO - 2015-10-23 18:09:00,633 DEBUG : BROWSER_OUTPUT: Values: 120.0 115.0 115.0 120.0 120.0 114.0 120.0 121.0 120.0 120.0 18:09:00 INFO - 2015-10-23 18:09:00,634 DEBUG : BROWSER_OUTPUT: 18:09:00 INFO - 2015-10-23 18:09:00,634 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:125.10 Median:125.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 18:09:00 INFO - 2015-10-23 18:09:00,634 DEBUG : BROWSER_OUTPUT: Values: 126.0 125.0 125.0 125.0 125.0 125.0 125.0 125.0 125.0 125.0 18:09:00 INFO - 2015-10-23 18:09:00,634 DEBUG : BROWSER_OUTPUT: 18:09:00 INFO - 2015-10-23 18:09:00,634 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:100.80 Median:101.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 18:09:00 INFO - 2015-10-23 18:09:00,634 DEBUG : BROWSER_OUTPUT: Values: 101.0 100.0 101.0 100.0 102.0 101.0 100.0 101.0 101.0 101.0 18:09:00 INFO - 2015-10-23 18:09:00,635 DEBUG : BROWSER_OUTPUT: 18:09:00 INFO - 2015-10-23 18:09:00,635 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:62.00 Median:62.00 stddev:2.58 (4.2%) stddev-sans-first:2.74 18:09:00 INFO - 2015-10-23 18:09:00,635 DEBUG : BROWSER_OUTPUT: Values: 62.0 61.0 62.0 60.0 62.0 62.0 61.0 69.0 60.0 61.0 18:09:00 INFO - 2015-10-23 18:09:00,635 DEBUG : BROWSER_OUTPUT: 18:09:00 INFO - 2015-10-23 18:09:00,635 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:63.80 Median:64.00 stddev:2.86 (4.5%) stddev-sans-first:3.02 18:09:00 INFO - 2015-10-23 18:09:00,635 DEBUG : BROWSER_OUTPUT: Values: 63.0 65.0 64.0 61.0 64.0 64.0 62.0 63.0 71.0 61.0 18:09:00 INFO - 2015-10-23 18:09:00,635 DEBUG : BROWSER_OUTPUT: 18:09:00 INFO - 2015-10-23 18:09:00,637 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:85.00 stddev:0.47 (0.6%) stddev-sans-first:0.33 18:09:00 INFO - 2015-10-23 18:09:00,637 DEBUG : BROWSER_OUTPUT: Values: 86.0 85.0 85.0 85.0 84.0 85.0 85.0 85.0 85.0 85.0 18:09:00 INFO - 2015-10-23 18:09:00,637 DEBUG : BROWSER_OUTPUT: 18:09:00 INFO - 2015-10-23 18:09:00,637 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:127.00 Median:128.50 stddev:3.74 (2.9%) stddev-sans-first:2.99 18:09:00 INFO - 2015-10-23 18:09:00,637 DEBUG : BROWSER_OUTPUT: Values: 134.0 124.0 129.0 123.0 129.0 124.0 128.0 122.0 130.0 127.0 18:09:00 INFO - 2015-10-23 18:09:00,637 DEBUG : BROWSER_OUTPUT: 18:09:00 INFO - 2015-10-23 18:09:00,638 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.80 Median:149.50 stddev:4.05 (2.7%) stddev-sans-first:3.16 18:09:00 INFO - 2015-10-23 18:09:00,638 DEBUG : BROWSER_OUTPUT: Values: 140.0 151.0 148.0 150.0 149.0 141.0 150.0 149.0 152.0 148.0 18:09:00 INFO - 2015-10-23 18:09:00,638 DEBUG : BROWSER_OUTPUT: 18:09:00 INFO - 2015-10-23 18:09:00,638 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.60 Median:74.00 stddev:1.26 (1.7%) stddev-sans-first:1.33 18:09:00 INFO - 2015-10-23 18:09:00,638 DEBUG : BROWSER_OUTPUT: Values: 74.0 75.0 76.0 74.0 72.0 72.0 73.0 73.0 73.0 74.0 18:09:00 INFO - 2015-10-23 18:09:00,638 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:09:00 INFO - 2015-10-23 18:09:00,638 DEBUG : BROWSER_OUTPUT: 18:09:01 INFO - 2015-10-23 18:09:01,276 INFO : Browser exited with error code: 0 18:09:01 INFO - 2015-10-23 18:09:01,324 INFO : Completed test kraken (00:00:57) 18:09:01 INFO - 2015-10-23 18:09:01,324 INFO : Starting test v8_7 18:09:01 INFO - 2015-10-23 18:09:01,324 DEBUG : operating with platform_type : mac_ 18:09:01 INFO - 2015-10-23 18:09:01,324 INFO : Initialising browser for v8_7 test... 18:09:01 INFO - 2015-10-23 18:09:01,337 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/tmpnisRL1/profile http://localhost:49273/getInfo.html 18:09:03 INFO - 2015-10-23 18:09:03,528 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:09:03 INFO - 2015-10-23 18:09:03,528 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:09:03 INFO - 2015-10-23 18:09:03,528 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 18:09:03 INFO - 2015-10-23 18:09:03,528 DEBUG : BROWSER_OUTPUT: __metrics 18:09:03 INFO - 2015-10-23 18:09:03,547 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:09:04 INFO - 2015-10-23 18:09:04,225 INFO : Browser initialized. 18:09:04 INFO - 2015-10-23 18:09:04,225 INFO : Running cycle 1/1 for v8_7 test... 18:09:04 INFO - 2015-10-23 18:09:04,226 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/tmpnisRL1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:09:16 INFO - 2015-10-23 18:09:16,065 DEBUG : BROWSER_OUTPUT: RSS: Main: 222470144 18:09:16 INFO - 2015-10-23 18:09:16,065 DEBUG : BROWSER_OUTPUT: 18:09:37 INFO - 2015-10-23 18:09:37,799 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/v8_7/run.html (next: http://localhost:49273/tests/v8_7/run.html) 18:09:38 INFO - 2015-10-23 18:09:38,057 DEBUG : BROWSER_OUTPUT: RSS: Main: 295428096 18:09:38 INFO - 2015-10-23 18:09:38,057 DEBUG : BROWSER_OUTPUT: 18:09:38 INFO - 2015-10-23 18:09:38,058 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:09:38 INFO - 2015-10-23 18:09:38,058 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:09:38 INFO - 2015-10-23 18:09:38,058 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:09:38 INFO - 2015-10-23 18:09:38,058 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:09:38 INFO - 2015-10-23 18:09:38,058 DEBUG : BROWSER_OUTPUT: |0;Richards;166.63889351774705 18:09:38 INFO - 2015-10-23 18:09:38,058 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;199.68051118210863 18:09:38 INFO - 2015-10-23 18:09:38,058 DEBUG : BROWSER_OUTPUT: |2;Encrypt;323.41526520051747 18:09:38 INFO - 2015-10-23 18:09:38,058 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5758.620689655172 18:09:38 INFO - 2015-10-23 18:09:38,059 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2047.034764826176 18:09:38 INFO - 2015-10-23 18:09:38,059 DEBUG : BROWSER_OUTPUT: |5;Earley;951.4747859181732 18:09:38 INFO - 2015-10-23 18:09:38,059 DEBUG : BROWSER_OUTPUT: |6;Boyer;12797.468354430379 18:09:38 INFO - 2015-10-23 18:09:38,059 DEBUG : BROWSER_OUTPUT: |7;RegExp;30235.29411764706 18:09:38 INFO - 2015-10-23 18:09:38,059 DEBUG : BROWSER_OUTPUT: |8;Splay;631.7119393556538 18:09:38 INFO - 2015-10-23 18:09:38,059 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;5786.127167630058 18:09:38 INFO - 2015-10-23 18:09:38,059 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:09:38 INFO - 2015-10-23 18:09:38,060 DEBUG : BROWSER_OUTPUT: __startTimestamp1445648978050__endTimestamp 18:09:38 INFO - 2015-10-23 18:09:38,060 DEBUG : BROWSER_OUTPUT: 18:09:38 INFO - 2015-10-23 18:09:38,060 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:09:38 INFO - 2015-10-23 18:09:38,060 DEBUG : BROWSER_OUTPUT: Number of tests: 10 18:09:38 INFO - 2015-10-23 18:09:38,060 DEBUG : BROWSER_OUTPUT: 18:09:38 INFO - 2015-10-23 18:09:38,060 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.64 Median:166.64 stddev:0.00 (0.0%) 18:09:38 INFO - 2015-10-23 18:09:38,060 DEBUG : BROWSER_OUTPUT: Values: 166.6 18:09:38 INFO - 2015-10-23 18:09:38,060 DEBUG : BROWSER_OUTPUT: 18:09:38 INFO - 2015-10-23 18:09:38,060 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:199.68 Median:199.68 stddev:0.00 (0.0%) 18:09:38 INFO - 2015-10-23 18:09:38,061 DEBUG : BROWSER_OUTPUT: Values: 199.7 18:09:38 INFO - 2015-10-23 18:09:38,061 DEBUG : BROWSER_OUTPUT: 18:09:38 INFO - 2015-10-23 18:09:38,061 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:323.42 Median:323.42 stddev:0.00 (0.0%) 18:09:38 INFO - 2015-10-23 18:09:38,061 DEBUG : BROWSER_OUTPUT: Values: 323.4 18:09:38 INFO - 2015-10-23 18:09:38,061 DEBUG : BROWSER_OUTPUT: 18:09:38 INFO - 2015-10-23 18:09:38,061 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5758.62 Median:5758.62 stddev:0.00 (0.0%) 18:09:38 INFO - 2015-10-23 18:09:38,061 DEBUG : BROWSER_OUTPUT: Values: 5758.6 18:09:38 INFO - 2015-10-23 18:09:38,062 DEBUG : BROWSER_OUTPUT: 18:09:38 INFO - 2015-10-23 18:09:38,062 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2047.03 Median:2047.03 stddev:0.00 (0.0%) 18:09:38 INFO - 2015-10-23 18:09:38,062 DEBUG : BROWSER_OUTPUT: Values: 2047.0 18:09:38 INFO - 2015-10-23 18:09:38,062 DEBUG : BROWSER_OUTPUT: 18:09:38 INFO - 2015-10-23 18:09:38,062 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:951.47 Median:951.47 stddev:0.00 (0.0%) 18:09:38 INFO - 2015-10-23 18:09:38,062 DEBUG : BROWSER_OUTPUT: Values: 951.5 18:09:38 INFO - 2015-10-23 18:09:38,062 DEBUG : BROWSER_OUTPUT: 18:09:38 INFO - 2015-10-23 18:09:38,062 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12797.47 Median:12797.47 stddev:0.00 (0.0%) 18:09:38 INFO - 2015-10-23 18:09:38,062 DEBUG : BROWSER_OUTPUT: Values: 12797.5 18:09:38 INFO - 2015-10-23 18:09:38,062 DEBUG : BROWSER_OUTPUT: 18:09:38 INFO - 2015-10-23 18:09:38,063 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:30235.29 Median:30235.29 stddev:0.00 (0.0%) 18:09:38 INFO - 2015-10-23 18:09:38,063 DEBUG : BROWSER_OUTPUT: Values: 30235.3 18:09:38 INFO - 2015-10-23 18:09:38,063 DEBUG : BROWSER_OUTPUT: 18:09:38 INFO - 2015-10-23 18:09:38,063 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:631.71 Median:631.71 stddev:0.00 (0.0%) 18:09:38 INFO - 2015-10-23 18:09:38,063 DEBUG : BROWSER_OUTPUT: Values: 631.7 18:09:38 INFO - 2015-10-23 18:09:38,063 DEBUG : BROWSER_OUTPUT: 18:09:38 INFO - 2015-10-23 18:09:38,063 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:5786.13 Median:5786.13 stddev:0.00 (0.0%) 18:09:38 INFO - 2015-10-23 18:09:38,063 DEBUG : BROWSER_OUTPUT: Values: 5786.1 18:09:38 INFO - 2015-10-23 18:09:38,064 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:09:38 INFO - 2015-10-23 18:09:38,064 DEBUG : BROWSER_OUTPUT: 18:09:38 INFO - 2015-10-23 18:09:38,656 INFO : Browser exited with error code: 0 18:09:38 INFO - 2015-10-23 18:09:38,676 INFO : Completed test v8_7 (00:00:37) 18:09:38 INFO - 2015-10-23 18:09:38,969 INFO : Completed test suite (00:20:10) 18:09:38 INFO - 2015-10-23 18:09:38,969 DEBUG : Working with test: dromaeo_css 18:09:38 INFO - 2015-10-23 18:09:38,969 DEBUG : Generating results file: dromaeo_css 18:09:38 INFO - 2015-10-23 18:09:38,970 DEBUG : Working with test: kraken 18:09:38 INFO - 2015-10-23 18:09:38,970 DEBUG : Generating results file: kraken 18:09:38 INFO - 2015-10-23 18:09:38,970 INFO : javascript benchmark 18:09:38 INFO - 2015-10-23 18:09:38,970 DEBUG : Working with test: v8_7 18:09:38 INFO - 2015-10-23 18:09:38,971 DEBUG : Generating results file: v8_7 18:09:38 INFO - 2015-10-23 18:09:38,971 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:09:39 INFO - 2015-10-23 18:09:39,033 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,55]] 18:09:39 INFO - 2015-10-23 18:09:39,033 DEBUG : process_Request line: dromaeo_css 6642.47 graph.html#tests=[[72,1,55]] 18:09:39 INFO - 2015-10-23 18:09:39,033 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:09:39 INFO - 2015-10-23 18:09:39,062 DEBUG : process_Request line: kraken 1511.90 graph.html#tests=[[232,1,55]] 18:09:39 INFO - 2015-10-23 18:09:39,062 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:09:39 INFO - 2015-10-23 18:09:39,105 DEBUG : process_Request line: v8_7 18044.82 graph.html#tests=[[230,1,55]] 18:09:39 INFO - 2015-10-23 18:09:39,106 INFO : javascript benchmark 18:09:39 INFO - 2015-10-23 18:09:39,108 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [352.95411596492454, 355.84342889128766, 358.96410358964107, 360.35496461334213, 365.24576749013283, 14307.713845723105, 14449.422023119088, 17758.556036099104, 18271.72592411113, 18883.527911802194, 11696.941515292432, 12047.397630118503, 14885.181315027668, 18114.184861681224, 18165.545861353472, 4313.396124542574, 4425.092855964535, 4431.313146462304, 4433.268510695748, 4438.7780610969485, 3451.4650229214385, 3518.771279866813, 4329.567043295677, 4406.118776244748, 4705.082508910764, 4734.502877197896, 4768.451628062765, 4769.165396055676, 4770.117528257266, 4779.0, 4489.775511224426, 4760.690555113906, 4762.738049407281, 4764.023375208074, 4874.512548745132, 4105.91788164235, 4108.424820525099, 4108.424820525129, 4111.691623128278, 4123.773192474413, 13239.602811915658, 13412.195268283935, 13475.730485390237, 13494.93252533731, 13520.864791352058, 1828.5245836082581, 1912.0, 1988.67186914159, 1994.0328940463864, 1995.6308083004546, 9513.571889265, 9544.42733435996, 9616.95191524038, 9654.372465789702, 9774.462404567746, 1497.0493736477306, 1519.5821149184062, 1558.516859773474, 1559.7114533811282, 1563.8748900087965, 56113.158302625496, 57452.13821792677, 57636.42363576352, 57726.71136644332, 57741.0, 6466.805995820133, 6515.381038801306, 6532.738690452328, 6556.541042127005, 6556.672166391661, 7547.132079810892, 7550.5469671819865, 7559.584222867685, 7562.886556701654, 7563.621818909032, 5577.860553486114, 5579.832605021856, 5582.91625625616, 5608.0, 5610.354809196994, 6027.367126451747, 6042.395760423922, 6066.636001839904, 6069.939300606938, 6074.75700971965, 2927.312081660808, 2948.395578906319, 2955.1015536413956, 2968.495355789521, 2980.910572682823, 1048.3290693955873, 1056.7780766039064, 1065.8454524093963, 1069.4866464097277, 1109.389835590422, 404.4863023959555, 433.6465780388973, 439.58678841888525, 449.62680974790845, 449.84255510571694, 11230.94384528072, 11647.59233426826, 11706.941465292619, 11822.231554949072, 12014.098942579341, 415.21938755140144, 466.10275220200975, 469.2328043648659, 481.3309499795287, 496.44894167474075, 6118.694065296718, 6228.719707613168, 6302.590331628429, 6314.494840412756, 6325.9051114233325, 480600.0, 489761.0, 503489.0, 504941.0, 508034.0, 65418.0, 66862.0, 67281.0, 67916.6604166976, 68045.3195468039, 501.3782909192575, 506.1572481817806, 507.85526125054184, 508.379776672459, 509.85469141294556, 10624.415657138623, 10829.404382759023, 10999.34003959765, 11112.111031117653, 11114.944425277821, 33322.500162498065, 34176.65823341735, 34264.486032710025, 34538.481922770676, 34749.82625086858, 43607.0, 44200.7789961061, 44323.0, 44864.32703509515, 45036.77481612571, 6039.184710064085, 6255.530835187288, 6258.561900666909, 6320.873582528416, 6346.809595712136, 11472.598459054227, 11752.353620550952, 11816.76366472683, 11826.349550774446, 11846.111541634584, 9767.218622510325, 10124.038216369434, 10272.075513203847, 10307.742306442398, 10319.845202321821, 9574.234061274941, 9695.563699633674, 9819.165370943265, 9880.061394167542, 9988.300818942604, 7970.521768693897, 10112.59549618007, 10324.07083362471, 10424.113950314308, 10428.113610343205, 6184.443400094013, 6217.906731398942, 6308.747650093945, 6312.652804095819, 6312.810615681537, 9544.713658590254, 10293.845592316271, 10299.279050466395, 10306.690799276033, 10374.740631484274], "dojo.html": [3174.380995705837, 3244.7890887092335, 3265.9183520412003, 3279.0490757680273, 3321.38554367442, 5436.293281873351, 5514.035043867322, 5568.86077848054, 5576.0, 5599.944000559998, 5550.69471179085, 5567.638103523268, 5590.720463976795, 5621.690807005602, 5672.319321681393, 5082.2376643503585, 5132.4610915853855, 5152.896942061157, 5159.174532074869, 5169.147090730025, 5121.462246464123, 5155.123628983063, 5155.407128180251, 5160.6903585784785, 5205.557527610139, 4972.453030166679, 5091.974540127313, 5102.719350435725, 5120.334356533664, 5197.116490196695, 5057.974710126463, 5072.010957863218, 5149.45930677281, 5160.793568257265, 5163.0, 5072.746362681851, 5090.847274581768, 5111.616628752821, 5128.487151284879, 5144.0740666679985, 5524.33707955044, 5532.917006244909, 5538.833834984916, 5551.333839939233, 5569.944300556983, 5655.688937108457, 5683.0, 5747.0, 5791.507721843648, 5839.299284085937, 5871.8532036699, 5875.764969401219, 5890.587658863881, 5914.822555323347, 5953.1070339449, 5450.945490545044, 5457.0, 5463.235147079412, 5464.617476776667, 5485.177223416519, 5777.653340799566, 5887.411258874164, 5893.11603259506, 5901.616394934315, 5999.130126131687, 5721.5136713379, 5732.283464566929, 5734.569907256972, 5746.42535746422, 5819.563532734977, 5870.0607902735355, 5881.470667639933, 5883.146943693226, 5883.911741323884, 5890.823275301748, 5460.099083651233, 5684.232628595169, 5686.857828554236, 5707.315122185364, 5787.536997040227, 5551.361593416808, 5567.387587365387, 5581.944180558143, 5606.719664016783, 5748.856278593069, 4327.1345730853955, 4340.088581397942, 4361.760103194291, 4370.322599997005, 4397.648188144941, 3871.3612253977776, 3916.4908561886773, 3949.861754838567, 4031.274370613318, 4079.204555111725, 5421.186821976657, 5431.728413579305, 5447.046766815792, 5456.836294911159, 5457.727113644302, 5900.085486749561, 5904.261967254093, 5907.291125064934, 5912.536035293412, 5975.492083172892, 5244.868878278074, 5305.973470132624, 5370.436104209002, 5371.355437347544, 5411.810586629449, 5164.380274367025, 5176.4047134580005, 5188.22176673502, 5192.7403629818355, 5195.246689230041, 5966.284045914518, 5973.910391344133, 5989.520838332923, 5997.810291629273, 5999.850003749942, 5654.943450565606, 5750.137479378127, 5751.252337196305, 5855.268091488564, 5979.701014949323, 5926.348101708895, 5963.612365196248, 5976.342602313829, 5976.850578735392, 5994.730237139252, 5753.712314384347, 5771.538276937751, 5780.393058728773, 5791.7683292667825, 5795.246617939641, 5740.13897915316, 5835.533157347317, 5884.029135192645, 5884.764609415746, 5986.580939334205, 5730.684812335361, 5733.369329373849, 5743.885122297447, 5750.108733146369, 5751.33859606134, 5620.606557541097, 5712.0, 5727.971360143172, 5731.627444216113, 5756.65460072397, 5428.131498960148, 5540.252065971043, 5558.249636299048, 5565.693886836263, 5680.772769089355, 5701.914471283017, 5736.885262294647, 5742.339630942328, 5745.91381129275, 5771.307443106854, 5630.380658127685, 5640.520555752807, 5650.717464126695, 5653.208550802973, 5654.378018417889], "mootools.html": [1378.7449321875447, 1468.9999999999998, 1691.9830801691983, 1773.5388798912286, 1946.7761207461147, 8341.958290208548, 9039.141281578248, 9142.817143657123, 9143.81712365753, 9155.67955121571, 8803.515806630632, 9022.86465703015, 9040.457572545653, 9045.683401080963, 9057.09429057094, 2060.320094368862, 2109.957800843982, 2358.103920510208, 2390.282915125464, 2399.36416849535, 2439.2070330635856, 2462.7906627936645, 2464.2607217834666, 2466.0628960994795, 2475.4430253192977, 2374.536965291769, 2394.832361734679, 2396.7363590005084, 2397.2688330059327, 2402.627592723131, 2115.7778433264516, 2169.7287839020046, 2340.9531809363716, 2382.952340953171, 2390.9043638254448, 2353.6116540770754, 2355.0815182079004, 2355.9528809423887, 2361.97638023621, 2414.8430352027062, 9378.67174648884, 9455.149036586672, 9463.621455141785, 9463.952680236624, 9464.574094165779, 5425.565954723613, 5539.169124631298, 5541.889162216733, 5547.5007249347345, 5548.140038294071, 3031.439183750991, 3037.346970401374, 3071.8003329783714, 3076.5846610707717, 3087.691230876917, 831.1356189562907, 854.4531499840107, 864.2222000199807, 890.2343984173606, 907.0974380491388, 13103.86896131036, 13134.540291089766, 13145.0, 13150.408231629599, 13174.736505269937, 4790.473047964721, 4854.2233242681, 4933.605311575066, 4977.129002424561, 4986.950130498722, 11126.888731112747, 11141.442927853575, 11152.163587730953, 11179.273347232403, 11188.0, 5529.115341545414, 5535.252740880011, 5538.418466061005, 5556.222128901957, 5562.97218513913, 4923.532264434873, 4963.156263435225, 4969.204927211629, 4979.950200498021, 4982.053409852117, 4104.938425923614, 4109.876703698894, 4124.876253712393, 4129.215449064668, 4173.833046678099, 1145.7479354541988, 1151.6199654114123, 1153.2676750263474, 1164.0745607242263, 1166.4575972172981, 1348.528015194674, 1363.2365875109772, 1369.3084992079137, 1387.0, 1394.8674875886775, 8640.567971601395, 8803.163699448542, 8815.647374104963, 8818.0, 8823.779405514913, 483.59136529633105, 493.67664179962185, 499.8000799680157, 499.86753510319795, 501.67641870993003, 6671.266160722316, 6692.364225398579, 6774.424173945171, 6781.321867813278, 6785.898211526831, 10849.891501084889, 11058.668239952814, 11070.169737269736, 11088.22382433238, 11099.500522476508, 10973.122150227962, 10982.670519884416, 11007.009369156815, 11054.226204165792, 11283.830742538868, 8467.49195048299, 8544.444611100384, 8554.828903421896, 8568.186022327869, 8576.656933722707, 8288.917110829056, 8344.958275208584, 8370.455920365157, 8388.874166887623, 8395.0, 9454.243660507005, 9533.968000797544, 9584.712458626253, 9628.566714498005, 9649.807003859743, 9760.072793084646, 9907.950460247652, 9978.850317245393, 10012.39925604466, 10020.69937901864, 8081.9191808083515, 8084.717034903751, 8157.877631835646, 8179.468334558473, 8184.8363032737825, 8326.916730832614, 8380.12008739098, 8384.371172161991, 8385.161483851565, 8389.496630202208, 7024.7190112396975, 7962.0, 8237.135100814568, 8263.214994575506, 8386.832263354821, 7055.929440705528, 8097.676092956216, 8210.58947052633, 8228.136045715113, 8280.627371768405, 8391.07698153215, 8418.873716894374, 8422.915770842214, 8451.619677114668, 8472.872906906277, 7332.046833911558, 7353.301436363537, 7401.481896267425, 7404.148522919718, 7429.851402972018, 7651.196624354585, 7692.92307076922, 7693.115291741521, 7695.422843286664, 7718.691252349843], "ext.html": [566.7619599768097, 569.2883895131087, 569.3395661033201, 575.3412342867417, 600.615606012152, 31417.68582314179, 32203.838980805092, 37576.99999999996, 37724.81137594315, 38047.619523804824, 41507.0, 42227.15545689085, 42250.78874605631, 42256.36615450763, 42272.78863605685, 8320.875186872201, 9144.0, 9313.115254050888, 9341.579628916716, 9367.250619950388, 8420.831583368328, 11166.330020198773, 11308.886911130907, 11314.773704525904, 11316.0, 11059.336439813596, 11210.551577936872, 11231.719207019809, 11247.156463265288, 11258.718532036724, 8553.957230213871, 8763.51800650964, 10756.892431075667, 11042.779144417107, 11136.443177841076, 10930.125589952864, 11043.061339786127, 11082.168837337233, 11093.057090147347, 11100.833487497694, 39068.80465597682, 39489.802550987064, 39495.21009579821, 39509.802450987845, 39567.0, 3035.802672826281, 3065.1877252527875, 3118.5945827042337, 3209.983950080258, 3416.7266618670697, 26977.865110674516, 28565.57151642727, 28589.714102858914, 29454.11637650874, 30279.394412111633, 2062.2026859125735, 2082.3856962196187, 2092.8953552322323, 2106.662933930579, 2139.764625891151, 269472.0, 272708.0, 273231.6338418315, 273240.0, 273994.0, 52080.0, 52933.47066529362, 55010.0, 55733.0, 55911.0, 69461.0, 70236.29763702297, 70688.23279418056, 70704.64647676729, 70774.29225707677, 17144.657106857794, 17348.13259337028, 17359.913200433915, 17366.0, 17367.392141274995, 13161.341932903508, 13221.338933053308, 13225.537106201236, 13234.07361484706, 13235.669108272177, 19506.12222449993, 19866.205351785768, 19909.502262443264, 19921.60156796885, 19933.401997940084, 9066.954665226764, 9285.30360222986, 9309.53452327381, 9322.440653560672, 9327.0, 942.2462030375672, 944.5088553952044, 978.4667356290838, 1033.4574348467115, 1096.0464395975553, 28436.0, 28463.857680711877, 28540.429191416057, 28607.28481787972, 28668.0, 1111.8999290063932, 1121.5513794482108, 1150.9654710358702, 1199.3643369014437, 1268.8033354829831, 16296.674066518603, 16710.916445417693, 16715.832841671672, 16771.496855094367, 17021.574460638334, 404259.0, 414487.0, 415320.0, 415452.0, 415608.0, 57223.42776572181, 57711.71144144252, 57719.71140144272, 57747.71126144342, 57763.71118144466, 1394.1356359057247, 1397.9790303145257, 1414.9151050936564, 1419.4464158978008, 1420.8934329925296, 29008.0, 29192.27019324534, 29197.270068247613, 29663.85168074146, 29742.405151897274, 46206.30690539577, 46227.0, 46733.0, 46863.0, 47255.29117063178, 293331.0, 293689.0, 298080.72071712033, 298995.0, 300254.0, 31118.22204444907, 31542.36915261636, 31551.52672709865, 31554.211144721565, 31621.0, 40043.0, 40419.79790101031, 40682.0, 40806.393821164056, 41069.58930410658, 33620.1594960128, 34908.47637285392, 35057.0, 35189.82405087958, 39308.80345598254, 36256.0, 36750.0, 38577.0, 39051.0, 39942.600573993885, 36273.0, 36544.24924759764, 36553.81723091367, 36588.81705591455, 39318.803405983934, 31847.681523185398, 32370.514442283857, 32374.83812580922, 34477.0, 35805.283894321445, 24443.877780610983, 24607.0, 24614.87692561526, 24795.0, 25100.49799004046], "prototype.html": [328.99506507402384, 339.09461737161774, 340.50966608084354, 344.9724022078232, 345.79079656807636, 6050.092486127083, 6181.1964444622245, 6225.252969643643, 6226.68866556672, 6255.593386429879, 5991.281046274453, 6056.12186232997, 6095.573309868311, 6103.389661033894, 6103.572749907497, 4759.214729569617, 4770.713757174563, 4773.76131193439, 4778.354922085508, 4779.450363208241, 4584.0, 4673.672842900998, 4689.202835517953, 4755.3104799804005, 4798.296604705331, 4713.646476514258, 4732.834350797722, 4742.976285118587, 4749.667523273372, 4750.857474275777, 4717.669763116583, 4719.10337035962, 4729.337892695025, 4730.195866702668, 4746.786394612251, 4144.647704945083, 4144.730592511507, 4150.667946564267, 4154.169166166779, 4164.375343698439, 5795.1886735857015, 5900.085486749561, 5935.0, 6050.69746512677, 6057.485113765335, 5287.762050707727, 5290.074237008546, 5310.628256022042, 5315.096433606296, 5317.973410132963, 6308.022256550242, 6312.179416675849, 6331.68341582919, 6345.175127233476, 6346.682665866688, 4374.562543745632, 4459.799309031101, 4468.776561171929, 4478.014836735945, 4479.641628669699, 6565.638889861056, 6588.60468371904, 6596.637184954778, 6599.604023758542, 6610.471162307004, 4547.204239258117, 4550.158220729176, 4554.407926969473, 4556.863294101182, 4561.589456948891, 4644.0944015916575, 4650.209464391061, 4651.302304654261, 4658.440987081504, 4659.161350956792, 5140.151874940668, 5296.390915044819, 5297.947020529822, 5298.417174110845, 5300.257963885059, 6287.528435367366, 6301.495880329563, 6305.4009869062365, 6328.7468501260355, 6335.429811316912, 1618.4820857325542, 1619.3198856480305, 1621.3190460006826, 1621.9107949062916, 1635.681042196784, 1065.8347956066823, 1095.8301463273206, 1117.0560876059717, 1125.4879030041475, 1126.0822429719751, 5989.79035733756, 5994.670293133832, 6013.579049466583, 6013.729382177812, 6032.517398608101, 6328.430441260309, 6403.903941440882, 6452.580582262138, 6563.967180164069, 6586.868262634816, 5984.0, 5986.042233242661, 6001.969990150022, 6010.549208809357, 6016.067509536029, 3592.4431713084514, 3613.94579081314, 3631.618680038558, 3636.4363523653874, 3642.0894776305922, 6501.804945851632, 6584.242812076577, 6599.835004124935, 6619.073329733841, 6650.667466626746, 6662.467002639874, 6701.028350889093, 6705.128333316735, 6714.362135597111, 6718.227403848522, 6553.901691474632, 6568.113304703804, 6581.3747693969, 6592.274849766522, 6607.834804129935, 6363.649999250086, 6504.707288171949, 6520.902186467301, 6527.67361631926, 6535.673216339069, 6426.614403135827, 6451.1290975717675, 6451.903221451776, 6458.22501299847, 6471.7734879279, 6632.2372927114, 6645.833854153685, 6650.46796256308, 6660.367265109807, 6671.766488172891, 4305.375720520445, 4387.517373089022, 4411.139827733561, 4445.177642136216, 4450.243458612108, 6613.867722645617, 6619.933800662125, 6620.106285651375, 6650.135482387453, 6655.733770649314, 6403.07155462446, 6418.326075761977, 6426.775062872777, 6430.582012169194, 6430.742770289136, 6288.371162883675, 6432.195975503062, 6432.807015789534, 6443.967780161257, 6463.15978922737, 6280.685965701605, 6294.653794041372, 6302.905456418249, 6310.905336420049, 6314.905276420949, 6422.775202868064, 6432.903506447314, 6438.484921206198, 6446.774362897276, 6458.031295305742, 6093.75624974996, 6217.036359364306, 6239.344868788893, 6278.968605156945, 6304.148939893055], "yui.html": [749.0374868294243, 775.1937984496121, 778.3734094054288, 783.1659282863748, 783.7922950418139, 12673.619791406249, 13137.934310328435, 13142.868571314308, 13147.7370452591, 13159.14465559738, 12235.571754988578, 12360.93819530901, 12362.258264504137, 12370.690732731664, 12387.814182787242, 709.0321710864658, 726.0307489501522, 888.0985799413584, 905.302916754099, 906.0395980260945, 894.6063731957918, 904.8009437923646, 916.5142474488532, 916.5417291354323, 917.1104029091771, 953.5851904421598, 960.851068084448, 960.8750862387915, 962.210986990668, 962.6245764151952, 733.0360575842776, 744.8957145999565, 916.3402350307767, 945.6264775413741, 951.9286053546011, 706.58311596158, 706.6643344411364, 706.752636577199, 707.3139055116528, 707.4305184326615, 12411.565595204214, 12715.109942304043, 12718.173318734252, 12734.490620375174, 12740.044496662787, 10243.48782560869, 10318.845217321747, 10542.525586348633, 10711.143108551298, 11085.69259355453, 8251.95874020626, 8316.0, 8659.004214515347, 8669.720203126531, 8822.735317940473, 2770.6536682914634, 2832.546792513188, 2861.413410250894, 2897.840618765967, 2939.514980028293, 38081.42877856834, 38594.80702596469, 38629.42055869164, 38713.419298710825, 38891.61108388908, 6331.493480521547, 6383.425491705769, 6440.549161558646, 6472.676366181672, 6624.0395142705, 11273.774524509465, 11280.041196498225, 11281.21031527785, 11289.15331350152, 11290.362897379833, 5786.450287222707, 5824.708764561755, 5884.6469211847425, 6015.458608725148, 6148.292946311231, 3664.560941289187, 3686.318031164243, 3751.7373783835415, 3783.2055268393397, 3898.161895192547, 2582.9354266143496, 2596.2211336598943, 2600.557905156128, 2604.270804174834, 2607.3220962549494, 395.2628348130773, 398.6352487473929, 407.43366720258865, 407.904142526506, 407.97756123413495, 558.6508432229856, 576.6568891509545, 577.5956830218863, 607.134832863177, 620.8297359477327, 6717.462602991749, 7096.7516136934955, 7190.496665233383, 7280.854382912418, 7378.926210737931, 452.79171581072416, 463.9582437580634, 488.504168269207, 516.2772119033308, 559.0747313196666, 3405.897823065312, 3438.3123375325035, 3487.790732556004, 3500.334936362083, 3537.646235376493, 45500.54499454963, 45603.315950260774, 45702.0, 45765.771171144595, 46027.539724603, 39417.211655766725, 39728.40407393892, 40331.798341008696, 40552.391714124315, 40707.38938915919, 33645.32709345848, 34009.0, 34016.48975265373, 34117.147071323416, 34227.14432139217, 6790.25307216196, 6862.451003919774, 6970.756023539152, 7037.7184912602925, 7058.858822823412, 23333.0, 23943.16198933029, 23958.161464348665, 24024.87987560051, 24045.27864164078, 33339.33321333608, 33963.66036339605, 34868.47697284492, 35072.29855402827, 35142.29715405728, 6689.531732778659, 6756.831079223059, 6832.555883867532, 6875.346842049998, 6960.443164546723, 9494.335396522178, 9511.096445837635, 9553.140217380469, 9762.219022478042, 10340.53467593945, 8935.0, 9128.28742443369, 9189.448633081769, 9230.630774768933, 9791.314607977372, 8951.083714456257, 9011.954940225258, 9056.547172641473, 9215.032421595635, 9311.255099591881, 9072.50101244438, 9186.586603602987, 9208.217301529445, 9260.120288572574, 9389.906100938902, 8035.477693949874, 8185.30424913889, 8331.875021874555, 8370.330373570221, 8412.537310447984, 7800.882986755317, 7977.760667179994, 8207.861161740318, 8223.301019413417, 8314.0]}, "summary": {"suite": 6642.469611381058, "subtests": {"jquery.html": {"filtered": 6610.690152044679, "value": 6610.690152044679}, "dojo.html": {"filtered": 5401.171453316186, "value": 5401.171453316186}, "mootools.html": {"filtered": 4929.74888487699, "value": 4929.74888487699}, "ext.html": {"filtered": 19132.26135916789, "value": 19132.26135916789}, "prototype.html": {"filtered": 4827.445329702127, "value": 4827.445329702127}, "yui.html": {"filtered": 5283.204940179737, "value": 5283.204940179737}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0047"}, "testrun": {"date": 1445647768, "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.0a1", "id": "20151023153832", "branch": "Firefox", "revision": "9b328712d6cd729984ab946294bad62e426e5713"}}, {"talos_counters": {}, "results": {"audio-dft": [160.0, 161.0, 160.0, 159.0, 158.0, 158.0, 159.0, 160.0, 159.0, 159.0], "ai-astar": [106.0, 101.0, 106.0, 107.0, 108.0, 105.0, 109.0, 106.0, 106.0, 107.0], "imaging-gaussian-blur": [120.0, 115.0, 115.0, 120.0, 120.0, 114.0, 120.0, 121.0, 120.0, 120.0], "audio-beat-detection": [142.0, 137.0, 156.0, 166.0, 144.0, 140.0, 144.0, 138.0, 163.0, 144.0], "json-stringify-tinderbox": [63.0, 65.0, 64.0, 61.0, 64.0, 64.0, 62.0, 63.0, 71.0, 61.0], "stanford-crypto-pbkdf2": [140.0, 151.0, 148.0, 150.0, 149.0, 141.0, 150.0, 149.0, 152.0, 148.0], "json-parse-financial": [62.0, 61.0, 62.0, 60.0, 62.0, 62.0, 61.0, 69.0, 60.0, 61.0], "stanford-crypto-sha256-iterative": [74.0, 75.0, 76.0, 74.0, 72.0, 72.0, 73.0, 73.0, 73.0, 74.0], "audio-fft": [81.0, 81.0, 82.0, 83.0, 78.0, 82.0, 80.0, 81.0, 81.0, 81.0], "imaging-darkroom": [126.0, 125.0, 125.0, 125.0, 125.0, 125.0, 125.0, 125.0, 125.0, 125.0], "stanford-crypto-ccm": [134.0, 124.0, 129.0, 123.0, 129.0, 124.0, 128.0, 122.0, 130.0, 127.0], "audio-oscillator": [105.0, 105.0, 134.0, 103.0, 103.0, 105.0, 140.0, 104.0, 105.0, 141.0], "stanford-crypto-aes": [86.0, 85.0, 85.0, 85.0, 84.0, 85.0, 85.0, 85.0, 85.0, 85.0], "imaging-desaturate": [101.0, 100.0, 101.0, 100.0, 102.0, 101.0, 100.0, 101.0, 101.0, 101.0]}, "summary": {"suite": 1511.8999999999999, "subtests": {"audio-fft": {"filtered": 81.0, "value": 81.0}, "stanford-crypto-pbkdf2": {"filtered": 147.8, "value": 147.8}, "audio-beat-detection": {"filtered": 147.4, "value": 147.4}, "stanford-crypto-ccm": {"filtered": 127.0, "value": 127.0}, "imaging-darkroom": {"filtered": 125.1, "value": 125.1}, "json-parse-financial": {"filtered": 62.0, "value": 62.0}, "audio-oscillator": {"filtered": 114.5, "value": 114.5}, "ai-astar": {"filtered": 106.1, "value": 106.1}, "audio-dft": {"filtered": 159.3, "value": 159.3}, "stanford-crypto-sha256-iterative": {"filtered": 73.6, "value": 73.6}, "json-stringify-tinderbox": {"filtered": 63.8, "value": 63.8}, "imaging-gaussian-blur": {"filtered": 118.5, "value": 118.5}, "stanford-crypto-aes": {"filtered": 85.0, "value": 85.0}, "imaging-desaturate": {"filtered": 100.8, "value": 100.8}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0047"}, "testrun": {"date": 1445647768, "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.0a1", "id": "20151023153832", "branch": "Firefox", "revision": "9b328712d6cd729984ab946294bad62e426e5713"}}, {"talos_counters": {}, "results": {"DeltaBlue": [199.68051118210863], "Encrypt": [323.41526520051747], "NavierStokes": [5786.127167630058], "Decrypt": [5758.620689655172], "Splay": [631.7119393556538], "Richards": [166.63889351774705], "RegExp": [30235.29411764706], "Earley": [951.4747859181732], "Boyer": [12797.468354430379], "RayTrace": [2047.034764826176]}, "summary": {"suite": 18044.822874763857, "subtests": {"DeltaBlue": {"filtered": 331.1189440000001, "value": 331.1189440000001}, "Encrypt": {"filtered": 823.0316520000002, "value": 823.0316520000002}, "NavierStokes": {"filtered": 256.4755244755246, "value": 256.4755244755246}, "Decrypt": {"filtered": 46.22304790419163, "value": 46.22304790419163}, "Splay": {"filtered": 129.000253, "value": 129.000253}, "RegExp": {"filtered": 30.12985408560309, "value": 30.12985408560309}, "Richards": {"filtered": 211.84730199999996, "value": 211.84730199999996}, "Earley": {"filtered": 700.4526129999999, "value": 700.4526129999999}, "Boyer": {"filtered": 52.07772205736891, "value": 52.07772205736891}, "RayTrace": {"filtered": 361.49312787212784, "value": 361.49312787212784}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0047"}, "testrun": {"date": 1445647768, "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.0a1", "id": "20151023153832", "branch": "Firefox", "revision": "9b328712d6cd729984ab946294bad62e426e5713"}}] 18:09:39 INFO - RETURN: dromaeo_css: 6642.47 18:09:39 INFO - RETURN: kraken: 1511.90 18:09:39 INFO - RETURN: v8_7: 18044.82 18:09:39 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,55]]", "result": "18044.82"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,55]]", "result": "1511.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,55]]", "result": "6642.47"}}} 18:09:39 INFO - Return code: 0 18:09:39 INFO - # TBPL SUCCESS # 18:09:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:09:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:09:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:09:39 INFO - 2015-10-23 18:09:39.193 screenresolution[1658:9679] starting screenresolution argv=screenresolution get 18:09:39 INFO - 2015-10-23 18:09:39.197 screenresolution[1658:9679] Display 0: 1600x1200x32@60 18:09:39 INFO - 2015-10-23 18:09:39.203 screenresolution[1659:9682] starting screenresolution argv=screenresolution list 18:09:39 INFO - Available Modes on Display 0 18:09:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:09:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:09:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:09:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:09:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:09:39 INFO - Intel HD Graphics 3000: 18:09:39 INFO - Chipset Model: Intel HD Graphics 3000 18:09:39 INFO - Type: GPU 18:09:39 INFO - Bus: Built-In 18:09:39 INFO - VRAM (Total): 512 MB 18:09:39 INFO - VRAM (Dynamic, Max): 10 18:09:39 INFO - Vendor: Intel (0x8086) 18:09:39 INFO - Device ID: 0x0116 18:09:39 INFO - Revision ID: 0x0009 18:09:39 INFO - Displays: 18:09:39 INFO - Display: 18:09:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:09:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:09:39 INFO - Display Serial Number: 1600x1200 60 18:09:39 INFO - Main Display: Yes 18:09:39 INFO - Mirror: Off 18:09:39 INFO - Online: Yes 18:09:39 INFO - Rotation: Supported 18:09:39 INFO - Return code: 0 18:09:39 INFO - Running post-action listener: _resource_record_post_action 18:09:39 INFO - Running post-run listener: _resource_record_post_run 18:09:40 INFO - Total resource usage - Wall time: 1247s; CPU: 30.0%; Read bytes: 39846912; Write bytes: 683732992; Read time: 4501; Write time: 76563 18:09:40 INFO - install - Wall time: 36s; CPU: 30.0%; Read bytes: 341574144; Write bytes: 345380864; Read time: 31773; Write time: 7938 18:09:40 INFO - run-tests - Wall time: 1212s; CPU: 30.0%; Read bytes: 37729280; Write bytes: 337070080; Read time: 4032; Write time: 68597 18:09:40 INFO - Running post-run listener: _upload_blobber_files 18:09:40 INFO - Blob upload gear active. 18:09:40 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 18:09:40 INFO - Copying logs to upload dir... 18:09:40 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1300.440096 ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 40 secs) (at 2015-10-23 18:09:40.691222) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-23 18:09:40.699147) ========= 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.1KUwu8NaCv/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.K8x8Wlr7Oo/Listeners TMPDIR=/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/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/Pt0-O-58R9-Uhmxy_coewQ/artifacts/public/build/firefox-44.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010099 build_url: 'https://queue.taskcluster.net/v1/task/Pt0-O-58R9-Uhmxy_coewQ/artifacts/public/build/firefox-44.0a1.en-US.mac.dmg' ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-23 18:09:41.259384) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2015-10-23 18:09:41.267932) ========= 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.1KUwu8NaCv/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.K8x8Wlr7Oo/Listeners TMPDIR=/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/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.005361 ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2015-10-23 18:09:42.360788) ========= ========= Started reboot slave lost (results: 0, elapsed: 2 secs) (at 2015-10-23 18:09:42.361185) ========= ========= Finished reboot slave lost (results: 0, elapsed: 2 secs) (at 2015-10-23 18:09:44.469737) =========