[56.696981] Initializing watchdogs [56.697069] /dev/watchdog0 [56.710998] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [56.715017] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [56.717205] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [56.720414] [001/130] (960s left) gem_mmap_gtt (cpuset-basic-small-copy-xy) [56.839105] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s) [56.885365] [002/130] (960s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render) [56.992833] Starting subtest: fbc-rgb565-draw-render [60.262639] Subtest fbc-rgb565-draw-render: SUCCESS (3.307s) [60.410950] [003/130] (956s left) gem_madvise (dontneed-after-mmap) [60.447278] Starting subtest: dontneed-after-mmap [60.472472] Subtest dontneed-after-mmap: SUCCESS (0.026s) [60.581183] [004/130] (956s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled) [60.636178] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled [60.638203] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s) [60.730172] [005/130] (956s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt) [60.826794] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt [60.830469] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [60.917026] [006/130] (956s left) gem_lmem_swapping (heavy-verify-random) [60.959234] Subtest heavy-verify-random: SKIP (0.000s) [60.988578] [007/130] (956s left) gem_fenced_exec_thrash (no-spare-fences-interruptible) [61.043916] Subtest no-spare-fences-interruptible: SKIP (0.000s) [61.103181] [008/130] (956s left) kms_psr2_su (page_flip-xrgb8888) [61.164035] Subtest page_flip-XRGB8888: SKIP (0.000s) [61.215243] [009/130] (956s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-blt) [61.320161] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-blt [64.467837] Subtest fbc-1p-offscren-pri-shrfb-draw-blt: SUCCESS (3.169s) [64.593758] [010/130] (952s left) gem_eio (in-flight-internal-10ms) [64.756162] Starting subtest: in-flight-internal-10ms [66.002863] Subtest in-flight-internal-10ms: SUCCESS (1.251s) [66.171093] [011/130] (951s left) kms_psr (fbc-psr-sprite-mmap-cpu) [66.271166] Starting subtest: fbc-psr-sprite-mmap-cpu [66.273548] Starting dynamic subtest: eDP-1 [66.277779] Dynamic subtest eDP-1: SKIP (0.000s) [66.282039] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.000s) [66.338614] [012/130] (951s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20) [66.427692] Starting subtest: planes-downscale-factor-0-75-upscale-20x20 [66.430062] Starting dynamic subtest: pipe-A [66.502464] Dynamic subtest pipe-A: SUCCESS (0.075s) [66.511863] Starting dynamic subtest: pipe-B [67.600656] Dynamic subtest pipe-B: SUCCESS (1.102s) [67.608542] Starting dynamic subtest: pipe-C [68.696831] Dynamic subtest pipe-C: SUCCESS (1.099s) [68.707086] Starting dynamic subtest: pipe-D [69.828499] Dynamic subtest pipe-D: SUCCESS (1.134s) [69.831064] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.411s) [70.962039] [013/130] (946s left) gem_userptr_blits (relocations) [71.053134] Starting subtest: relocations [71.057736] Subtest relocations: SKIP (0.000s) [71.680964] [014/130] (945s left) gem_eio (in-flight-contexts-1us) [71.997419] Starting subtest: in-flight-contexts-1us [85.959250] Subtest in-flight-contexts-1us: SUCCESS (13.970s) [86.069901] [015/130] (931s left) kms_cursor_crc (cursor-offscreen-512x512) [86.332715] Starting subtest: cursor-offscreen-512x512 [86.337189] Subtest cursor-offscreen-512x512: SKIP (0.001s) [86.485848] [016/130] (931s left) gem_tiled_partial_pwrite_pread (reads) [86.556898] Subtest reads: SKIP (0.000s) [86.621116] [017/130] (931s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180) [86.730416] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180 [88.006031] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.277s) [88.157074] [018/130] (929s left) gem_mmap_gtt (basic-write-read) [88.211228] Subtest basic-write-read: SKIP (0.000s) [88.265893] [019/130] (929s left) gem_ctx_persistence (heartbeat-close) [88.326522] Starting subtest: heartbeat-close [88.330216] Subtest heartbeat-close: SKIP (0.000s) [88.419777] [020/130] (929s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt) [88.516412] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt [88.520206] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [88.628495] [021/130] (929s left) drm_buddy (drm_buddy) [88.664972] Starting subtest: drm_buddy [88.686047] Starting dynamic subtest: drm_test_buddy_alloc_limit [88.817681] Dynamic subtest drm_test_buddy_alloc_limit: SUCCESS (0.132s) [88.827243] Starting dynamic subtest: drm_test_buddy_alloc_optimistic [88.921511] Dynamic subtest drm_test_buddy_alloc_optimistic: SUCCESS (0.105s) [88.930343] Starting dynamic subtest: drm_test_buddy_alloc_pessimistic [89.040550] Dynamic subtest drm_test_buddy_alloc_pessimistic: SUCCESS (0.118s) [89.047951] Starting dynamic subtest: drm_test_buddy_alloc_pathological [89.139984] Dynamic subtest drm_test_buddy_alloc_pathological: SUCCESS (0.100s) [89.147517] Starting dynamic subtest: drm_test_buddy_alloc_contiguous [89.262554] Dynamic subtest drm_test_buddy_alloc_contiguous: SUCCESS (0.122s) [89.270508] Starting dynamic subtest: drm_test_buddy_alloc_clear [89.420196] Dynamic subtest drm_test_buddy_alloc_clear: SUCCESS (0.157s) [89.429540] Starting dynamic subtest: drm_test_buddy_alloc_range_bias [89.524825] Dynamic subtest drm_test_buddy_alloc_range_bias: SUCCESS (0.104s) [89.526844] Subtest drm_buddy: SUCCESS (0.863s) [89.692349] [022/130] (928s left) kms_psr (psr2-basic) [89.792267] Starting subtest: psr2-basic [89.794693] Starting dynamic subtest: eDP-1 [91.402823] Dynamic subtest eDP-1: SUCCESS (1.609s) [91.405288] Subtest psr2-basic: SUCCESS (1.610s) [92.195312] [023/130] (925s left) kms_chamelium_hpd (vga-hpd-for-each-pipe) [92.576715] Subtest vga-hpd-for-each-pipe: SKIP (0.000s) [93.394127] [024/130] (924s left) kms_joiner (basic-force-ultra-joiner) [93.503056] Starting subtest: basic-force-ultra-joiner [93.507736] Subtest basic-force-ultra-joiner: SKIP (0.000s) [93.560665] [025/130] (924s left) gem_ctx_shared (q-smoketest-all) [93.623409] Starting subtest: Q-smoketest-all [126.049485] Subtest Q-smoketest-all: SUCCESS (32.375s) [127.949376] [026/130] (889s left) gem_mmap_offset (mmap-boundaries) [128.008052] Starting subtest: mmap-boundaries [128.010440] Starting dynamic subtest: smem0 [129.103088] Dynamic subtest smem0: SUCCESS (1.097s) [129.105736] Subtest mmap-boundaries: SUCCESS (1.097s) [129.284491] [027/130] (888s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [129.403201] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt [129.407289] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [129.503626] [028/130] (888s left) gem_pxp (create-regular-context-1) [129.623759] Starting subtest: create-regular-context-1 [129.626207] Subtest create-regular-context-1: SUCCESS (0.003s) [129.740652] [029/130] (888s left) kms_flip (dpms-vs-vblank-race) [129.831113] Starting subtest: dpms-vs-vblank-race [129.833526] Starting dynamic subtest: A-eDP1 [134.774509] Dynamic subtest A-eDP1: SUCCESS (4.943s) [134.786074] Starting dynamic subtest: B-eDP1 [139.387891] Dynamic subtest B-eDP1: SUCCESS (4.610s) [139.395504] Starting dynamic subtest: C-eDP1 [143.975737] Dynamic subtest C-eDP1: SUCCESS (4.590s) [143.984808] Starting dynamic subtest: D-eDP1 [148.574229] Dynamic subtest D-eDP1: SUCCESS (4.597s) [148.576641] Subtest dpms-vs-vblank-race: SUCCESS (18.745s) [149.449410] [030/130] (868s left) kms_hdr (invalid-hdr) [149.547991] Starting subtest: invalid-hdr [150.620806] Starting dynamic subtest: pipe-A-eDP-1 [153.752544] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.132s) [153.755282] Subtest invalid-hdr: SUCCESS (4.205s) [153.862056] [031/130] (864s left) api_intel_bb (render-ccs) [153.916040] Starting subtest: render-ccs [154.272354] Subtest render-ccs: SUCCESS (0.356s) [154.373718] [032/130] (863s left) kms_atomic_interruptible (universal-setplane-cursor) [154.469944] Starting subtest: universal-setplane-cursor [154.472287] Starting dynamic subtest: pipe-A-eDP-1 [161.821500] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.352s) [161.823785] Subtest universal-setplane-cursor: SUCCESS (7.353s) [162.660662] [033/130] (855s left) gen7_exec_parse (cmd-crossing-page) [162.727815] Subtest cmd-crossing-page: SKIP (0.000s) [162.796939] [034/130] (855s left) kms_big_fb (y-tiled-addfb-size-overflow) [162.904642] Starting subtest: y-tiled-addfb-size-overflow [162.908967] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s) [163.015377] [035/130] (855s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu) [163.121354] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu [163.125663] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [163.210007] [036/130] (855s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs) [163.307845] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs [163.310118] Starting dynamic subtest: pipe-A-eDP-1 [163.332487] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [163.342300] Starting dynamic subtest: pipe-B-eDP-1 [163.363258] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [163.371993] Starting dynamic subtest: pipe-C-eDP-1 [163.393276] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [163.401321] Starting dynamic subtest: pipe-D-eDP-1 [163.424371] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [163.428421] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.007s) [165.525729] [037/130] (852s left) kms_psr (psr2-sprite-render) [165.631249] Starting subtest: psr2-sprite-render [165.633463] Starting dynamic subtest: eDP-1 [167.320363] Dynamic subtest eDP-1: SUCCESS (1.688s) [167.322961] Subtest psr2-sprite-render: SUCCESS (1.689s) [168.175122] [038/130] (850s left) kms_flip (dpms-off-confusion) [168.273207] Starting subtest: dpms-off-confusion [168.275605] Starting dynamic subtest: A-eDP1 [176.982196] Dynamic subtest A-eDP1: SUCCESS (8.708s) [176.991477] Starting dynamic subtest: B-eDP1 [185.707597] Dynamic subtest B-eDP1: SUCCESS (8.725s) [185.717278] Starting dynamic subtest: C-eDP1 [194.415393] Dynamic subtest C-eDP1: SUCCESS (8.706s) [194.423909] Starting dynamic subtest: D-eDP1 [203.138560] Dynamic subtest D-eDP1: SUCCESS (8.722s) [203.140879] Subtest dpms-off-confusion: SUCCESS (34.868s) [204.294685] [039/130] (814s left) kms_properties (plane-properties-legacy) [204.395112] Starting subtest: plane-properties-legacy [204.397465] Starting dynamic subtest: pipe-A-eDP-1 [204.956756] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.559s) [204.966740] Starting dynamic subtest: pipe-B-eDP-1 [206.255252] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.298s) [206.264057] Starting dynamic subtest: pipe-C-eDP-1 [207.471032] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.214s) [207.484604] Starting dynamic subtest: pipe-D-eDP-1 [208.702062] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.231s) [208.704455] Subtest plane-properties-legacy: SUCCESS (4.306s) [209.491234] [040/130] (808s left) gem_exec_whisper (basic-fds-priority) [209.547640] Starting subtest: basic-fds-priority [233.421957] Subtest basic-fds-priority: SUCCESS (23.871s) [233.599448] [041/130] (784s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt) [233.717442] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt [233.721469] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [233.808095] [042/130] (784s left) gem_eio (in-flight-external) [234.036583] Starting subtest: in-flight-external [236.018483] Subtest in-flight-external: SUCCESS (1.982s) [236.169114] [043/130] (782s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc) [236.283041] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc [236.287248] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [236.386580] [044/130] (782s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf) [241.447134] Starting subtest: fbc-pr-cursor-plane-update-sf [241.454805] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.005s) [242.294328] [045/130] (776s left) gem_exec_suspend (basic-s3) [242.363271] Starting subtest: basic-S3 [242.365606] Starting dynamic subtest: smem [262.400627] Dynamic subtest smem: SUCCESS (6.609s) [262.403138] Subtest basic-S3: SUCCESS (6.611s) [262.580237] [046/130] (769s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs) [262.647460] Starting subtest: mixed-tiled-to-yf-tiled-ccs [262.651831] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s) [262.821566] [047/130] (769s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled) [262.880098] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled [262.882451] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s) [262.980862] [048/130] (769s left) kms_flip (2x-flip-vs-dpms) [263.091324] Starting subtest: 2x-flip-vs-dpms [263.102382] Subtest 2x-flip-vs-dpms: SKIP (0.011s) [263.174305] [049/130] (768s left) kms_big_fb (yf-tiled-64bpp-rotate-180) [263.291568] Starting subtest: yf-tiled-64bpp-rotate-180 [263.295904] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s) [263.380925] [050/130] (768s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted) [263.435690] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted [263.539229] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.106s) [263.611506] [051/130] (768s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0) [263.711963] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0 [264.769564] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.078s) [264.912567] [052/130] (767s left) kms_draw_crc (draw-method-render) [265.021007] Starting subtest: draw-method-render [265.023242] Starting dynamic subtest: xrgb8888-untiled [265.257753] Dynamic subtest xrgb8888-untiled: SUCCESS (0.242s) [265.266622] Starting dynamic subtest: rgb565-untiled [265.476902] Dynamic subtest rgb565-untiled: SUCCESS (0.221s) [265.485951] Starting dynamic subtest: xrgb2101010-untiled [265.706418] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.233s) [265.715261] Starting dynamic subtest: xbgr16161616f-untiled [265.980566] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.276s) [265.993968] Starting dynamic subtest: xrgb8888-xtiled [266.111658] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s) [266.120261] Starting dynamic subtest: rgb565-xtiled [266.232651] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s) [266.243141] Starting dynamic subtest: xrgb2101010-xtiled [266.342070] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.111s) [266.350435] Starting dynamic subtest: xbgr16161616f-xtiled [266.484767] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.144s) [266.493534] Starting dynamic subtest: xrgb8888-4tiled [266.605380] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.122s) [266.614392] Starting dynamic subtest: rgb565-4tiled [266.714758] Dynamic subtest rgb565-4tiled: SUCCESS (0.111s) [266.723257] Starting dynamic subtest: xrgb2101010-4tiled [266.835682] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.122s) [266.844382] Starting dynamic subtest: xbgr16161616f-4tiled [266.989313] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.155s) [266.991418] Subtest draw-method-render: SUCCESS (1.998s) [267.098285] [053/130] (765s left) perf_pmu (event-wait) [267.138659] Starting subtest: event-wait [267.140568] Starting dynamic subtest: rcs0 [267.144326] Dynamic subtest rcs0: SKIP (0.000s) [267.147948] Subtest event-wait: SKIP (0.000s) [267.244089] [054/130] (764s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render) [267.340927] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render [267.344294] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [267.434220] [055/130] (764s left) kms_flip (bo-too-big-interruptible) [267.536242] Starting subtest: bo-too-big-interruptible [267.540300] Starting dynamic subtest: A-eDP1 [269.223632] Dynamic subtest A-eDP1: SUCCESS (1.701s) [269.233257] Starting dynamic subtest: B-eDP1 [270.951775] Dynamic subtest B-eDP1: SUCCESS (1.741s) [270.962526] Starting dynamic subtest: C-eDP1 [272.665137] Dynamic subtest C-eDP1: SUCCESS (1.722s) [272.674350] Starting dynamic subtest: D-eDP1 [274.386863] Dynamic subtest D-eDP1: SUCCESS (1.730s) [274.389769] Subtest bo-too-big-interruptible: SUCCESS (6.904s) [275.626916] [056/130] (756s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180) [275.732344] Starting subtest: primary-yf-tiled-reflect-x-180 [275.794073] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.059s) [275.889430] [057/130] (756s left) i915_pm_rps (thresholds-idle) [275.947533] Starting subtest: thresholds-idle [275.952368] Subtest thresholds-idle: SKIP (0.001s) [276.023182] [058/130] (756s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt) [276.125579] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt [280.708396] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (4.600s) [280.836606] [059/130] (751s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite) [280.942813] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite [280.946933] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [281.023146] [060/130] (751s left) kms_async_flips (test-time-stamp-atomic) [281.122536] Starting subtest: test-time-stamp-atomic [281.496264] Starting dynamic subtest: pipe-A-eDP-1 [282.256832] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.763s) [282.622885] Starting dynamic subtest: pipe-B-eDP-1 [283.378708] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.765s) [283.749796] Starting dynamic subtest: pipe-C-eDP-1 [284.502981] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.758s) [284.864614] Starting dynamic subtest: pipe-D-eDP-1 [285.631646] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.773s) [285.634264] Subtest test-time-stamp-atomic: SUCCESS (4.515s) [286.771179] [061/130] (745s left) kms_flip (plain-flip-ts-check) [286.876275] Starting subtest: plain-flip-ts-check [286.878470] Starting dynamic subtest: A-eDP1 [295.778936] Dynamic subtest A-eDP1: SUCCESS (8.905s) [295.789283] Starting dynamic subtest: B-eDP1 [304.697466] Dynamic subtest B-eDP1: SUCCESS (8.916s) [304.706916] Starting dynamic subtest: C-eDP1 [313.615893] Dynamic subtest C-eDP1: SUCCESS (8.919s) [313.626080] Starting dynamic subtest: D-eDP1 [322.540925] Dynamic subtest D-eDP1: SUCCESS (8.926s) [322.546033] Subtest plain-flip-ts-check: SUCCESS (35.677s) [323.703750] [062/130] (708s left) gem_ctx_exec (basic) [323.771229] Starting subtest: basic [323.774643] Subtest basic: SUCCESS (0.006s) [323.902875] [063/130] (708s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs) [324.002410] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs [324.004684] Starting dynamic subtest: pipe-A-eDP-1 [324.062297] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [324.072450] Starting dynamic subtest: pipe-B-eDP-1 [324.129452] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [324.139281] Starting dynamic subtest: pipe-C-eDP-1 [324.197027] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [324.208142] Starting dynamic subtest: pipe-D-eDP-1 [324.266779] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [324.271088] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.009s) [326.141753] [064/130] (706s left) gem_render_copy (y-tiled-ccs-to-linear) [326.204752] Starting subtest: y-tiled-ccs-to-linear [326.209287] Subtest y-tiled-ccs-to-linear: SKIP (0.000s) [326.380606] [065/130] (706s left) gem_exec_params (dr1-dirt) [326.440082] Starting subtest: DR1-dirt [326.442558] Subtest DR1-dirt: SUCCESS (0.000s) [326.536650] [066/130] (705s left) gem_exec_reloc (basic-gtt) [326.604491] Subtest basic-gtt: SKIP (0.000s) [326.688845] [067/130] (705s left) gem_spin_batch (user-each) [326.749674] Starting subtest: user-each [330.025772] Subtest user-each: SUCCESS (3.271s) [330.464614] [068/130] (702s left) prime_busy (hang-wait) [330.530034] Starting subtest: hang-wait [330.532421] Starting dynamic subtest: rcs0 [356.895180] Dynamic subtest rcs0: SUCCESS (26.368s) [356.905608] Starting dynamic subtest: bcs0 [363.984243] Dynamic subtest bcs0: SUCCESS (7.086s) [363.992735] Starting dynamic subtest: vcs0 [371.030254] Dynamic subtest vcs0: SUCCESS (7.039s) [371.040112] Starting dynamic subtest: vcs1 [377.997579] Dynamic subtest vcs1: SUCCESS (6.965s) [378.006448] Starting dynamic subtest: vecs0 [384.972114] Dynamic subtest vecs0: SUCCESS (6.971s) [384.982053] Starting dynamic subtest: ccs0 [398.875421] Dynamic subtest ccs0: SUCCESS (13.901s) [398.877994] Subtest hang-wait: SUCCESS (68.343s) [399.004680] [069/130] (633s left) gem_partial_pwrite_pread (reads-uncached) [399.062696] Subtest reads-uncached: SKIP (0.000s) [399.141507] [070/130] (633s left) syncobj_wait (single-wait-all-for-submit-signaled) [399.198181] Starting subtest: single-wait-all-for-submit-signaled [399.200756] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [399.293303] [071/130] (633s left) gem_exec_schedule (promotion) [399.366794] Starting subtest: promotion [399.369134] Starting dynamic subtest: rcs0 [399.531055] Dynamic subtest rcs0: SUCCESS (0.167s) [399.542973] Starting dynamic subtest: vcs0 [399.645230] Dynamic subtest vcs0: SUCCESS (0.113s) [399.656985] Starting dynamic subtest: vcs1 [399.759901] Dynamic subtest vcs1: SUCCESS (0.114s) [399.771974] Starting dynamic subtest: vecs0 [399.852879] Dynamic subtest vecs0: SUCCESS (0.093s) [399.864224] Starting dynamic subtest: ccs0 [399.978270] Dynamic subtest ccs0: SUCCESS (0.125s) [399.980816] Subtest promotion: SUCCESS (0.616s) [401.518791] [072/130] (631s left) syncobj_timeline (wait-any-snapshot) [401.581711] Starting subtest: wait-any-snapshot [401.662501] Subtest wait-any-snapshot: SUCCESS (0.081s) [401.730283] [073/130] (631s left) drm_fdinfo (virtual-busy-all) [401.769572] Starting subtest: virtual-busy-all [401.774382] Subtest virtual-busy-all: SKIP (0.000s) [401.828538] [074/130] (630s left) sysfs_heartbeat_interval (precise) [401.883270] Starting subtest: precise [401.885504] Starting dynamic subtest: vecs0 [409.430528] Dynamic subtest vecs0: SUCCESS (7.547s) [409.442106] Starting dynamic subtest: ccs0 [410.563849] Dynamic subtest ccs0: SUCCESS (1.130s) [410.576046] Starting dynamic subtest: vcs0 [418.393230] Dynamic subtest vcs0: SUCCESS (7.827s) [418.404732] Starting dynamic subtest: bcs0 [419.550842] Dynamic subtest bcs0: SUCCESS (1.158s) [419.562432] Starting dynamic subtest: rcs0 [420.746187] Dynamic subtest rcs0: SUCCESS (1.194s) [420.755749] Starting dynamic subtest: vcs1 [428.427453] Dynamic subtest vcs1: SUCCESS (7.682s) [428.429972] Subtest precise: SUCCESS (26.549s) [428.500551] [075/130] (604s left) kms_plane_scaling (invalid-num-scalers) [428.604332] Starting subtest: invalid-num-scalers [428.606680] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers [428.623484] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.016s) [428.635937] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers [428.656326] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.034s) [428.667633] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers [428.690522] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.030s) [428.699252] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers [428.720467] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.027s) [428.722324] Subtest invalid-num-scalers: SUCCESS (0.114s) [428.805249] [076/130] (604s left) kms_lease (lease-uevent) [428.907449] Starting subtest: lease-uevent [429.920234] Subtest lease-uevent: SUCCESS (1.012s) [429.991157] [077/130] (602s left) gem_exec_balancer (parallel-keep-submit-fence) [430.237248] Starting subtest: parallel-keep-submit-fence [431.266882] Subtest parallel-keep-submit-fence: SUCCESS (1.029s) [431.365413] [078/130] (601s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling) [431.460402] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling [431.462674] Starting dynamic subtest: pipe-A-default-mode [434.121698] Dynamic subtest pipe-A-default-mode: SUCCESS (2.660s) [434.124126] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.661s) [434.993003] [079/130] (597s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen) [435.102536] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen [435.106727] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [435.208085] [080/130] (597s left) perf (polling-parameterized) [435.313340] Starting subtest: polling-parameterized [455.348247] Subtest polling-parameterized: SUCCESS (20.039s) [455.391427] [081/130] (577s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs) [455.505181] Starting subtest: ccs-on-another-bo-yf-tiled-ccs [455.507440] Starting dynamic subtest: pipe-A-eDP-1 [455.529142] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [455.538324] Starting dynamic subtest: pipe-B-eDP-1 [455.559003] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [455.567186] Starting dynamic subtest: pipe-C-eDP-1 [455.588042] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [455.596102] Starting dynamic subtest: pipe-D-eDP-1 [455.618033] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [455.622471] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.004s) [457.632528] [082/130] (575s left) gem_sync (basic-each) [457.708212] Starting subtest: basic-each [459.950209] Subtest basic-each: SUCCESS (2.252s) [460.127252] [083/130] (572s left) kms_cursor_crc (cursor-onscreen-256x256) [460.353634] Starting subtest: cursor-onscreen-256x256 [460.355839] Starting dynamic subtest: pipe-A-eDP-1 [462.610604] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.253s) [462.640904] Starting dynamic subtest: pipe-D-eDP-1 [465.527975] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.896s) [465.530423] Subtest cursor-onscreen-256x256: SUCCESS (5.176s) [466.381861] [084/130] (566s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt) [466.488316] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt [466.492490] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [466.578733] [085/130] (566s left) gem_flink_basic (flink-lifetime) [466.634851] Starting subtest: flink-lifetime [466.637248] Subtest flink-lifetime: SUCCESS (0.002s) [466.731402] [086/130] (566s left) gem_ctx_persistence (legacy-engines-hostile) [466.788445] Starting subtest: legacy-engines-hostile [466.790666] Starting dynamic subtest: render [466.879876] Dynamic subtest render: SUCCESS (0.091s) [466.890781] Starting dynamic subtest: bsd1 [467.002006] Dynamic subtest bsd1: SUCCESS (0.120s) [467.021354] Starting dynamic subtest: bsd2 [467.120408] Dynamic subtest bsd2: SUCCESS (0.115s) [467.133392] Starting dynamic subtest: blt [467.216909] Dynamic subtest blt: SUCCESS (0.095s) [467.228138] Starting dynamic subtest: vebox [467.331077] Dynamic subtest vebox: SUCCESS (0.112s) [467.333454] Subtest legacy-engines-hostile: SUCCESS (0.543s) [467.407056] [087/130] (565s left) gem_workarounds (basic-read) [467.480252] Starting subtest: basic-read [467.493274] Subtest basic-read: SUCCESS (0.013s) [467.622066] [088/130] (565s left) kms_chamelium_edid (dp-edid-stress-resolution-4k) [468.006721] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s) [468.788948] [089/130] (564s left) gem_exec_parallel (engines) [468.857125] Starting subtest: engines [468.859739] Starting dynamic subtest: basic [470.399658] Dynamic subtest basic: SUCCESS (1.544s) [470.415110] Starting dynamic subtest: contexts [474.602187] Dynamic subtest contexts: SUCCESS (4.203s) [474.617467] Starting dynamic subtest: fds [478.481769] Dynamic subtest fds: SUCCESS (3.879s) [478.494574] Starting dynamic subtest: userptr [480.404037] Dynamic subtest userptr: SUCCESS (1.921s) [480.406771] Subtest engines: SUCCESS (11.553s) [480.595580] [090/130] (552s left) kms_frontbuffer_tracking (psr-slowdraw) [480.720563] Starting subtest: psr-slowdraw [503.757621] Subtest psr-slowdraw: SUCCESS (23.032s) [503.910408] [091/130] (529s left) i915_pm_rc6_residency (rc6-accuracy) [503.964261] Starting subtest: rc6-accuracy [503.966153] Starting dynamic subtest: gt0 [507.136796] Dynamic subtest gt0: SUCCESS (3.168s) [507.147984] Starting dynamic subtest: gt1 [510.308455] Dynamic subtest gt1: SUCCESS (3.167s) [510.311033] Subtest rc6-accuracy: SUCCESS (6.340s) [510.384061] [092/130] (523s left) kms_vblank (accuracy-idle) [510.481248] Starting subtest: accuracy-idle [510.483467] Starting dynamic subtest: pipe-A-eDP-1 [512.247059] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.764s) [512.260298] Starting dynamic subtest: pipe-D-eDP-1 [514.700676] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.450s) [514.703022] Subtest accuracy-idle: SUCCESS (4.217s) [515.511255] [093/130] (517s left) kms_big_fb (linear-64bpp-rotate-270) [515.611561] Starting subtest: linear-64bpp-rotate-270 [515.630072] Subtest linear-64bpp-rotate-270: SKIP (0.018s) [515.748821] [094/130] (517s left) gem_softpin (evict-snoop-interruptible) [515.813010] Starting subtest: evict-snoop-interruptible [515.817535] Subtest evict-snoop-interruptible: SKIP (0.000s) [515.940046] [095/130] (517s left) gem_eio (in-flight-contexts-immediate) [516.171322] Starting subtest: in-flight-contexts-immediate [527.445960] Subtest in-flight-contexts-immediate: SUCCESS (11.273s) [527.562701] [096/130] (505s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt) [527.672888] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt [527.676947] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [527.784427] [097/130] (505s left) gem_exec_balancer (waits) [527.858481] Starting subtest: waits [534.235266] Subtest waits: SUCCESS (6.375s) [534.500030] [098/130] (499s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt) [534.607582] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt [534.611702] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [534.708965] [099/130] (498s left) syncobj_wait (single-wait-all-for-submit-submitted) [534.777657] Starting subtest: single-wait-all-for-submit-submitted [534.884697] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.105s) [534.955015] [100/130] (498s left) kms_big_fb (4-tiled-32bpp-rotate-180) [535.051041] Starting subtest: 4-tiled-32bpp-rotate-180 [536.742087] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.691s) [536.918659] [101/130] (496s left) kms_plane_alpha_blend (coverage-7efc) [537.021261] Starting subtest: coverage-7efc [537.451726] Starting dynamic subtest: pipe-A-eDP-1 [537.990464] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.538s) [538.015771] Starting dynamic subtest: pipe-D-eDP-1 [539.304454] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.296s) [539.306862] Subtest coverage-7efc: SUCCESS (2.281s) [540.171603] [102/130] (493s left) gem_create (create-ext-placement-sanity-check) [540.346957] Starting subtest: create-ext-placement-sanity-check [540.352878] Subtest create-ext-placement-sanity-check: SUCCESS (0.005s) [540.446588] [103/130] (493s left) kms_addfb_basic (bo-too-small) [540.545620] Starting subtest: bo-too-small [540.547544] Subtest bo-too-small: SUCCESS (0.000s) [540.632044] [104/130] (493s left) kms_selftest (drm_framebuffer) [540.668260] Starting subtest: drm_framebuffer [540.715011] Starting dynamic subtest: drm_test_framebuffer_check_src_coords [540.884812] Dynamic subtest drm_test_framebuffer_check_src_coords: SUCCESS (0.172s) [540.894395] Starting dynamic subtest: drm_test_framebuffer_cleanup [541.036661] Dynamic subtest drm_test_framebuffer_cleanup: SUCCESS (0.152s) [541.048041] Starting dynamic subtest: drm_test_framebuffer_create [541.259386] Dynamic subtest drm_test_framebuffer_create: SUCCESS (0.221s) [541.268756] Starting dynamic subtest: drm_test_framebuffer_free [541.514570] Dynamic subtest drm_test_framebuffer_free: FAIL (0.194s) [541.519457] Subtest drm_framebuffer: FAIL (0.784s) [541.632032] Aborting: Kernel badly tainted (0x40240, 0x200) (check dmesg for details): TAINT_WARN: WARN_ON has happened. [541.646634] [FACT kms_selftest (drm_framebuffer)] new: kernel.is_tainted.taint_warn: true [541.647553] Closing watchdogs results: parsing output: 0/ for test: gem_mmap_gtt results: parsing output: 1/ for test: kms_frontbuffer_tracking results: parsing output: 2/ for test: gem_madvise results: parsing output: 3/ for test: syncobj_timeline results: parsing output: 4/ for test: kms_frontbuffer_tracking results: parsing output: 5/ for test: gem_lmem_swapping results: parsing output: 6/ for test: gem_fenced_exec_thrash results: parsing output: 7/ for test: kms_psr2_su results: parsing output: 8/ for test: kms_frontbuffer_tracking results: parsing output: 9/ for test: gem_eio results: parsing output: 10/ for test: kms_psr results: parsing output: 11/ for test: kms_plane_scaling results: parsing output: 12/ for test: gem_userptr_blits results: parsing output: 13/ for test: gem_eio results: parsing output: 14/ for test: kms_cursor_crc results: parsing output: 15/ for test: gem_tiled_partial_pwrite_pread results: parsing output: 16/ for test: kms_big_fb results: parsing output: 17/ for test: gem_mmap_gtt results: parsing output: 18/ for test: gem_ctx_persistence results: parsing output: 19/ for test: kms_frontbuffer_tracking results: parsing output: 20/ for test: drm_buddy results: parsing output: 21/ for test: kms_psr results: parsing output: 22/ for test: kms_chamelium_hpd results: parsing output: 23/ for test: kms_joiner results: parsing output: 24/ for test: gem_ctx_shared results: parsing output: 25/ for test: gem_mmap_offset results: parsing output: 26/ for test: kms_frontbuffer_tracking results: parsing output: 27/ for test: gem_pxp results: parsing output: 28/ for test: kms_flip results: parsing output: 29/ for test: kms_hdr results: parsing output: 30/ for test: api_intel_bb results: parsing output: 31/ for test: kms_atomic_interruptible results: parsing output: 32/ for test: gen7_exec_parse results: parsing output: 33/ for test: kms_big_fb results: parsing output: 34/ for test: kms_frontbuffer_tracking results: parsing output: 35/ for test: kms_ccs results: parsing output: 36/ for test: kms_psr results: parsing output: 37/ for test: kms_flip results: parsing output: 38/ for test: kms_properties results: parsing output: 39/ for test: gem_exec_whisper results: parsing output: 40/ for test: kms_frontbuffer_tracking results: parsing output: 41/ for test: gem_eio results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: kms_psr2_sf results: parsing output: 44/ for test: gem_exec_suspend results: parsing output: 45/ for test: gem_render_copy results: parsing output: 46/ for test: syncobj_timeline results: parsing output: 47/ for test: kms_flip results: parsing output: 48/ for test: kms_big_fb results: parsing output: 49/ for test: syncobj_timeline results: parsing output: 50/ for test: kms_big_fb results: parsing output: 51/ for test: kms_draw_crc results: parsing output: 52/ for test: perf_pmu results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: kms_flip results: parsing output: 55/ for test: kms_rotation_crc results: parsing output: 56/ for test: i915_pm_rps results: parsing output: 57/ for test: kms_frontbuffer_tracking results: parsing output: 58/ for test: kms_frontbuffer_tracking results: parsing output: 59/ for test: kms_async_flips results: parsing output: 60/ for test: kms_flip results: parsing output: 61/ for test: gem_ctx_exec results: parsing output: 62/ for test: kms_ccs results: parsing output: 63/ for test: gem_render_copy results: parsing output: 64/ for test: gem_exec_params results: parsing output: 65/ for test: gem_exec_reloc results: parsing output: 66/ for test: gem_spin_batch results: parsing output: 67/ for test: prime_busy results: parsing output: 68/ for test: gem_partial_pwrite_pread results: parsing output: 69/ for test: syncobj_wait results: parsing output: 70/ for test: gem_exec_schedule results: parsing output: 71/ for test: syncobj_timeline results: parsing output: 72/ for test: drm_fdinfo results: parsing output: 73/ for test: sysfs_heartbeat_interval results: parsing output: 74/ for test: kms_plane_scaling results: parsing output: 75/ for test: kms_lease results: parsing output: 76/ for test: gem_exec_balancer results: parsing output: 77/ for test: kms_flip_scaled_crc results: parsing output: 78/ for test: kms_frontbuffer_tracking results: parsing output: 79/ for test: perf results: parsing output: 80/ for test: kms_ccs results: parsing output: 81/ for test: gem_sync results: parsing output: 82/ for test: kms_cursor_crc results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: gem_flink_basic results: parsing output: 85/ for test: gem_ctx_persistence results: parsing output: 86/ for test: gem_workarounds results: parsing output: 87/ for test: kms_chamelium_edid results: parsing output: 88/ for test: gem_exec_parallel results: parsing output: 89/ for test: kms_frontbuffer_tracking results: parsing output: 90/ for test: i915_pm_rc6_residency results: parsing output: 91/ for test: kms_vblank results: parsing output: 92/ for test: kms_big_fb results: parsing output: 93/ for test: gem_softpin results: parsing output: 94/ for test: gem_eio results: parsing output: 95/ for test: kms_frontbuffer_tracking results: parsing output: 96/ for test: gem_exec_balancer results: parsing output: 97/ for test: kms_frontbuffer_tracking results: parsing output: 98/ for test: syncobj_wait results: parsing output: 99/ for test: kms_big_fb results: parsing output: 100/ for test: kms_plane_alpha_blend results: parsing output: 101/ for test: gem_create results: parsing output: 102/ for test: kms_addfb_basic results: parsing output: 103/ for test: kms_selftest results: parsing output: 104/ for test: kms_flip_scaled_crc results: no output, setting notrun results: parsing output: 105/ for test: kms_cursor_crc results: no output, setting notrun results: parsing output: 106/ for test: kms_psr results: no output, setting notrun results: parsing output: 107/ for test: gem_exec_fence results: no output, setting notrun results: parsing output: 108/ for test: kms_cursor_legacy results: no output, setting notrun results: parsing output: 109/ for test: api_intel_bb results: no output, setting notrun results: parsing output: 110/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 111/ for test: gem_exec_schedule results: no output, setting notrun results: parsing output: 112/ for test: gem_render_copy results: no output, setting notrun results: parsing output: 113/ for test: gem_ccs results: no output, setting notrun results: parsing output: 114/ for test: kms_vrr results: no output, setting notrun results: parsing output: 115/ for test: kms_ccs results: no output, setting notrun results: parsing output: 116/ for test: i915_query results: no output, setting notrun results: parsing output: 117/ for test: kms_psr2_sf results: no output, setting notrun results: parsing output: 118/ for test: kms_ccs results: no output, setting notrun results: parsing output: 119/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 120/ for test: gem_ctx_param results: no output, setting notrun results: parsing output: 121/ for test: kms_chamelium_hpd results: no output, setting notrun results: parsing output: 122/ for test: debugfs_test results: no output, setting notrun results: parsing output: 123/ for test: kms_big_fb results: no output, setting notrun results: parsing output: 124/ for test: kms_cursor_legacy results: no output, setting notrun results: parsing output: 125/ for test: gen9_exec_parse results: no output, setting notrun results: parsing output: 126/ for test: kms_plane_scaling results: no output, setting notrun results: parsing output: 127/ for test: syncobj_timeline results: no output, setting notrun results: parsing output: 128/ for test: gem_flink_basic results: no output, setting notrun results: parsing output: 129/ for test: kms_psr results: no output, setting notrun Done.