[57.880338] Initializing watchdogs [57.880388] /dev/watchdog0 [57.894888] [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] [57.899524] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.901734] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.904800] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt) [58.018766] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt [58.023056] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [58.112866] [002/133] (960s left) kms_plane (plane-position-hole-dpms) [58.210108] Starting subtest: plane-position-hole-dpms [58.757792] Starting dynamic subtest: pipe-A-plane-1 [61.152571] Dynamic subtest pipe-A-plane-1: SUCCESS (2.379s) [61.162821] Starting dynamic subtest: pipe-A-plane-2 [63.504518] Dynamic subtest pipe-A-plane-2: SUCCESS (2.338s) [63.511867] Starting dynamic subtest: pipe-A-plane-3 [65.806488] Dynamic subtest pipe-A-plane-3: SUCCESS (2.295s) [65.815786] Starting dynamic subtest: pipe-A-plane-4 [68.162941] Dynamic subtest pipe-A-plane-4: SUCCESS (2.350s) [68.175772] Starting dynamic subtest: pipe-A-plane-5 [68.190152] Dynamic subtest pipe-A-plane-5: SUCCESS (0.026s) [69.348728] Starting dynamic subtest: pipe-B-plane-1 [71.761770] Dynamic subtest pipe-B-plane-1: SUCCESS (2.416s) [71.770853] Starting dynamic subtest: pipe-B-plane-2 [74.182992] Dynamic subtest pipe-B-plane-2: SUCCESS (2.417s) [74.191859] Starting dynamic subtest: pipe-B-plane-3 [76.517980] Dynamic subtest pipe-B-plane-3: SUCCESS (2.333s) [76.527119] Starting dynamic subtest: pipe-B-plane-4 [78.815333] Dynamic subtest pipe-B-plane-4: SUCCESS (2.296s) [78.824656] Starting dynamic subtest: pipe-B-plane-5 [78.842787] Dynamic subtest pipe-B-plane-5: SUCCESS (0.026s) [78.844777] Subtest plane-position-hole-dpms: SUCCESS (20.572s) [79.629490] [003/133] (938s left) gem_render_copy (yf-tiled-to-vebox-linear) [79.699983] Starting subtest: yf-tiled-to-vebox-linear [79.704551] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s) [79.892345] [004/133] (938s left) kms_psr (fbc-psr2-sprite-mmap-gtt) [79.981189] Starting subtest: fbc-psr2-sprite-mmap-gtt [79.983587] Starting dynamic subtest: eDP-1 [79.988200] Dynamic subtest eDP-1: SKIP (0.000s) [79.992689] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s) [80.055947] [005/133] (938s left) kms_rotation_crc (primary-rotation-270) [80.138119] Starting subtest: primary-rotation-270 [80.142640] Subtest primary-rotation-270: SKIP (0.001s) [80.207068] [006/133] (938s left) syncobj_timeline (invalid-wait-bad-flags) [80.273504] Starting subtest: invalid-wait-bad-flags [80.275796] Subtest invalid-wait-bad-flags: SUCCESS (0.000s) [80.376456] [007/133] (938s left) gem_exec_reloc (basic-wc-read-active) [80.444754] Subtest basic-wc-read-active: SKIP (0.000s) [80.512365] [008/133] (938s left) gem_exec_fence (syncobj-channel) [80.948242] Starting subtest: syncobj-channel [81.968161] Subtest syncobj-channel: SUCCESS (1.018s) [82.991264] [FACT gem_exec_fence (syncobj-channel)] new: kernel.kmod_is_loaded.vgem: true [82.993938] [009/133] (935s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [83.098949] Starting subtest: addfb25-y-tiled-small-legacy [83.103418] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [83.207405] [010/133] (935s left) gem_exec_whisper (basic-contexts-forked) [83.267094] Starting subtest: basic-contexts-forked [106.656591] Subtest basic-contexts-forked: SUCCESS (23.379s) [106.840215] [011/133] (911s left) gem_bad_reloc (negative-reloc-lut) [106.898968] Subtest negative-reloc-lut: SKIP (0.000s) [106.968152] [012/133] (911s left) kms_lease (lease-revoke) [107.061770] Starting subtest: lease-revoke [107.064169] Starting dynamic subtest: pipe-A-eDP-1 [107.095981] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.033s) [107.105760] Starting dynamic subtest: pipe-B-eDP-1 [107.122381] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.026s) [107.130543] Starting dynamic subtest: pipe-C-eDP-1 [107.150111] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.026s) [107.158502] Starting dynamic subtest: pipe-D-eDP-1 [107.182149] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.031s) [107.184246] Subtest lease-revoke: SUCCESS (0.120s) [107.300925] [013/133] (911s left) kms_pwrite_crc [108.974221] [014/133] (909s left) kms_async_flips (invalid-async-flip) [109.061856] Starting subtest: invalid-async-flip [109.446637] Starting dynamic subtest: pipe-A-eDP-1 [110.311712] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.866s) [110.672822] Starting dynamic subtest: pipe-B-eDP-1 [111.530557] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.867s) [111.889383] Starting dynamic subtest: pipe-C-eDP-1 [112.665876] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.783s) [113.036372] Starting dynamic subtest: pipe-D-eDP-1 [113.809283] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.780s) [113.811601] Subtest invalid-async-flip: SUCCESS (4.748s) [114.944289] [015/133] (904s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt) [115.035353] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt [115.039681] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [115.120300] [016/133] (903s left) kms_flip (nonblocking-read) [115.201399] Starting subtest: nonblocking-read [115.203362] Subtest nonblocking-read: SUCCESS (0.000s) [115.309942] [017/133] (903s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180) [115.417630] Starting subtest: linear-max-hw-stride-64bpp-rotate-180 [116.539970] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.123s) [116.657972] [018/133] (902s left) kms_color (ctm-blue-to-red) [116.754224] Starting subtest: ctm-blue-to-red [116.755768] Starting dynamic subtest: pipe-A-eDP-1 [117.514639] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.759s) [117.531396] Starting dynamic subtest: pipe-B-eDP-1 [118.936347] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.422s) [118.945887] Starting dynamic subtest: pipe-C-eDP-1 [120.224071] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.285s) [120.233616] Starting dynamic subtest: pipe-D-eDP-1 [121.555173] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.331s) [121.557071] Subtest ctm-blue-to-red: SUCCESS (4.799s) [122.393204] [019/133] (896s left) syncobj_wait (invalid-multi-wait-unsubmitted) [122.465490] Starting subtest: invalid-multi-wait-unsubmitted [122.467895] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s) [122.562094] [020/133] (896s left) gem_pxp (verify-pxp-stale-ctx-execution) [122.694277] Starting subtest: verify-pxp-stale-ctx-execution [123.757399] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.062s) [123.875446] [021/133] (895s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite) [123.975347] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite [130.111529] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.138s) [131.317482] [022/133] (887s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear) [131.411253] Starting subtest: fbcpsr-tiling-linear [137.961318] Subtest fbcpsr-tiling-linear: SUCCESS (6.553s) [138.095932] [023/133] (881s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0) [138.193405] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0 [138.197819] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s) [138.285818] [024/133] (881s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf) [138.389828] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf [138.394066] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [138.454039] [025/133] (880s left) kms_properties (plane-properties-legacy) [138.536867] Starting subtest: plane-properties-legacy [138.538756] Starting dynamic subtest: pipe-A-eDP-1 [139.094341] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.556s) [139.103805] Starting dynamic subtest: pipe-B-eDP-1 [140.384771] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.289s) [140.394276] Starting dynamic subtest: pipe-C-eDP-1 [141.629077] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.245s) [141.638315] Starting dynamic subtest: pipe-D-eDP-1 [142.884372] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.252s) [142.886647] Subtest plane-properties-legacy: SUCCESS (4.348s) [143.671021] [026/133] (875s left) gem_eio (in-flight-internal-1us) [143.899933] Starting subtest: in-flight-internal-1us [144.993461] Subtest in-flight-internal-1us: SUCCESS (1.092s) [145.133897] [027/133] (874s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite) [145.243907] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite [145.248093] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [145.365955] [028/133] (874s left) prime_mmap (test_aperture_limit) [145.418381] Starting subtest: test_aperture_limit [145.420638] Starting dynamic subtest: test_aperture_limit-smem [145.427442] Dynamic subtest test_aperture_limit-smem: SKIP (0.007s) [145.431652] Subtest test_aperture_limit: SKIP (0.008s) [145.503992] [029/133] (874s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt) [145.608758] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt [145.613405] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [145.712852] [030/133] (873s left) vgem_basic (mmap) [145.758784] Starting subtest: mmap [145.794630] Subtest mmap: SUCCESS (0.038s) [145.848789] [031/133] (873s left) kms_psr (fbc-pr-sprite-plane-move) [145.963508] Starting subtest: fbc-pr-sprite-plane-move [145.966986] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s) [146.038062] [032/133] (873s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted) [146.092602] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted [146.094685] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s) [146.195200] [033/133] (873s left) gem_softpin (safe-alignment) [146.255273] Starting subtest: safe-alignment [146.278154] Subtest safe-alignment: SUCCESS (0.023s) [147.968316] [034/133] (871s left) kms_flip (modeset-vs-vblank-race) [148.076397] Starting subtest: modeset-vs-vblank-race [148.078776] Starting dynamic subtest: A-eDP1 [152.798927] Dynamic subtest A-eDP1: SUCCESS (4.724s) [152.813338] Starting dynamic subtest: B-eDP1 [157.530405] Dynamic subtest B-eDP1: SUCCESS (4.729s) [157.541285] Starting dynamic subtest: C-eDP1 [162.156184] Dynamic subtest C-eDP1: SUCCESS (4.623s) [162.166237] Starting dynamic subtest: D-eDP1 [166.797922] Dynamic subtest D-eDP1: SUCCESS (4.641s) [166.803099] Subtest modeset-vs-vblank-race: SUCCESS (18.729s) [167.955176] [035/133] (851s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc) [168.039709] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc [168.042065] Starting dynamic subtest: pipe-A-eDP-1 [168.051542] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [168.062332] Starting dynamic subtest: pipe-B-eDP-1 [168.071309] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [168.080861] Starting dynamic subtest: pipe-C-eDP-1 [168.089282] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [168.097647] Starting dynamic subtest: pipe-D-eDP-1 [168.105997] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [168.110547] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [170.243117] [036/133] (849s left) kms_psr_stress_test (invalidate-primary-flip-overlay) [170.341523] Starting subtest: invalidate-primary-flip-overlay [181.149490] Subtest invalidate-primary-flip-overlay: SUCCESS (10.810s) [181.264798] [037/133] (838s left) gem_mmap_offset (close-race) [181.325421] Starting subtest: close-race [201.483615] Subtest close-race: SUCCESS (20.105s) [201.578667] [038/133] (818s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0) [201.690939] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0 [201.695564] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s) [201.788302] [039/133] (818s left) kms_cursor_legacy (cursora-vs-flipb-atomic) [201.889290] Starting subtest: cursorA-vs-flipB-atomic [201.893779] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s) [202.047903] [040/133] (817s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled) [202.104815] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled [202.210263] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.106s) [202.291249] [041/133] (817s left) syncobj_wait (invalid-reset-illegal-handle) [202.351555] Starting subtest: invalid-reset-illegal-handle [202.353543] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [202.447388] [042/133] (817s left) gem_eio (wait-wedge-10ms) [202.678092] Starting subtest: wait-wedge-10ms [204.000204] Subtest wait-wedge-10ms: SUCCESS (1.321s) [204.114950] [043/133] (815s left) kms_universal_plane (disable-primary-vs-flip) [204.204165] Starting subtest: disable-primary-vs-flip [204.206503] Starting dynamic subtest: pipe-A-eDP-1 [205.730496] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.527s) [205.739576] Starting dynamic subtest: pipe-B-eDP-1 [207.985688] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.254s) [207.994887] Starting dynamic subtest: pipe-C-eDP-1 [210.230475] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.241s) [210.240399] Starting dynamic subtest: pipe-D-eDP-1 [212.390555] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.158s) [212.392725] Subtest disable-primary-vs-flip: SUCCESS (8.185s) [213.201167] [044/133] (806s left) gem_exec_params (invalid-bsd2-flag-on-render) [213.257106] Starting subtest: invalid-bsd2-flag-on-render [213.259436] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s) [213.354399] [045/133] (806s left) kms_cursor_edge_walk (128x128-left-edge) [213.448308] Starting subtest: 128x128-left-edge [213.450565] Starting dynamic subtest: pipe-A-eDP-1 [216.959890] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.510s) [216.969485] Starting dynamic subtest: pipe-D-eDP-1 [220.081513] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.120s) [220.084017] Subtest 128x128-left-edge: SUCCESS (6.633s) [220.887301] [046/133] (799s left) gem_ctx_isolation (preservation-s3) [220.956865] Starting subtest: preservation-S3 [220.959161] Starting dynamic subtest: rcs0 [237.195884] Dynamic subtest rcs0: SUCCESS (1.436s) [237.205898] Starting dynamic subtest: bcs0 [253.191678] Dynamic subtest bcs0: SUCCESS (1.305s) [253.203618] Starting dynamic subtest: vcs0 [269.200860] Dynamic subtest vcs0: SUCCESS (2.310s) [269.212402] Starting dynamic subtest: vcs1 [287.217975] Dynamic subtest vcs1: SUCCESS (4.866s) [287.229292] Starting dynamic subtest: vecs0 [305.219978] Dynamic subtest vecs0: SUCCESS (4.867s) [305.231774] Starting dynamic subtest: ccs0 [323.209287] Dynamic subtest ccs0: SUCCESS (3.026s) [323.212230] Subtest preservation-S3: SUCCESS (17.817s) [323.465517] [047/133] (696s left) i915_pm_rc6_residency (rc6-idle) [323.526809] Starting subtest: rc6-idle [323.552883] Starting dynamic subtest: gt0-rcs0 [348.024055] Dynamic subtest gt0-rcs0: SUCCESS (24.209s) [348.035993] Starting dynamic subtest: gt0-bcs0 [372.371438] Dynamic subtest gt0-bcs0: SUCCESS (24.333s) [372.383231] Starting dynamic subtest: gt0-ccs0 [396.747216] Dynamic subtest gt0-ccs0: SUCCESS (24.365s) [396.758781] Starting dynamic subtest: gt1-vcs0 [402.975778] Dynamic subtest gt1-vcs0: SUCCESS (6.169s) [402.989502] Starting dynamic subtest: gt1-vecs0 [409.149857] Dynamic subtest gt1-vecs0: SUCCESS (6.169s) [409.153018] Subtest rc6-idle: SUCCESS (85.285s) [409.194740] [048/133] (611s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot) [409.314932] Starting subtest: modeset-atomic-cursor-hotspot [409.320067] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s) [409.459958] [049/133] (610s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt) [409.551990] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt [416.817212] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.264s) [416.920134] [050/133] (603s left) i915_pciid [417.107517] [051/133] (603s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt) [417.212008] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt [417.216813] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [417.320134] [052/133] (603s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc) [417.410750] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc [417.415231] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [417.510009] [053/133] (603s left) kms_big_fb (y-tiled-64bpp-rotate-90) [417.608113] Starting subtest: y-tiled-64bpp-rotate-90 [417.613590] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s) [417.705170] [054/133] (602s left) gem_mmap_wc (write-read-distinct) [417.767183] Subtest write-read-distinct: SKIP (0.000s) [417.823353] [055/133] (602s left) kms_getfb (getfb2-handle-zero) [417.915207] Starting subtest: getfb2-handle-zero [417.917695] Subtest getfb2-handle-zero: SUCCESS (0.000s) [417.999278] [056/133] (602s left) syncobj_timeline (wait-for-submit-snapshot) [418.049076] Starting subtest: wait-for-submit-snapshot [418.130973] Subtest wait-for-submit-snapshot: SUCCESS (0.083s) [418.207584] [057/133] (602s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted) [418.261175] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted [418.369794] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.108s) [418.448554] [058/133] (602s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc) [418.543001] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc [418.548503] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [418.638052] [059/133] (602s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff) [418.733971] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff [418.738533] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [418.817747] [060/133] (601s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area) [418.911011] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area [418.916018] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s) [418.978517] [061/133] (601s left) gem_eio (in-flight-contexts-1us) [419.204491] Starting subtest: in-flight-contexts-1us [430.996612] Subtest in-flight-contexts-1us: SUCCESS (11.798s) [431.123284] [062/133] (589s left) kms_pm_dc (dc6-dpms) [432.210963] Starting subtest: dc6-dpms [434.327656] Subtest dc6-dpms: SUCCESS (2.117s) [434.410955] [063/133] (586s left) gem_exec_fence (syncobj-wait) [434.871914] Starting subtest: syncobj-wait [435.988186] Subtest syncobj-wait: SUCCESS (1.115s) [438.065817] [064/133] (582s left) syncobj_timeline (etime-single-wait-all-submitted) [438.124213] Starting subtest: etime-single-wait-all-submitted [438.224781] Subtest etime-single-wait-all-submitted: SUCCESS (0.102s) [438.302408] [065/133] (582s left) kms_invalid_mode (bad-vsync-end) [438.405444] Starting subtest: bad-vsync-end [438.407769] Starting dynamic subtest: pipe-A-eDP-1 [438.688951] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s) [438.699407] Starting dynamic subtest: pipe-B-eDP-1 [438.702008] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [438.711741] Starting dynamic subtest: pipe-C-eDP-1 [438.714090] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [438.723467] Starting dynamic subtest: pipe-D-eDP-1 [438.725846] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [438.728169] Subtest bad-vsync-end: SUCCESS (0.291s) [439.506071] [066/133] (581s left) gem_pxp (fail-invalid-protected-context) [439.618222] Starting subtest: fail-invalid-protected-context [439.621082] Subtest fail-invalid-protected-context: SUCCESS (0.000s) [439.736998] [067/133] (581s left) perf_pmu (init-busy) [439.780520] Starting subtest: init-busy [439.783315] Starting dynamic subtest: rcs0 [439.786077] Dynamic subtest rcs0: SUCCESS (0.001s) [439.795991] Starting dynamic subtest: bcs0 [439.798382] Dynamic subtest bcs0: SUCCESS (0.001s) [439.807624] Starting dynamic subtest: vcs0 [439.809817] Dynamic subtest vcs0: SUCCESS (0.001s) [439.818900] Starting dynamic subtest: vcs1 [439.821137] Dynamic subtest vcs1: SUCCESS (0.001s) [439.830488] Starting dynamic subtest: vecs0 [439.832546] Dynamic subtest vecs0: SUCCESS (0.001s) [439.841731] Starting dynamic subtest: ccs0 [439.843951] Dynamic subtest ccs0: SUCCESS (0.001s) [439.846162] Subtest init-busy: SUCCESS (0.008s) [439.886590] [068/133] (581s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt) [439.984760] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt [439.989206] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [440.073702] [069/133] (581s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt) [440.172799] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt [440.178450] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [440.311122] [070/133] (580s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt) [440.425324] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt [447.767191] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.346s) [447.882206] [071/133] (573s left) perf (enable-disable) [447.995121] Starting subtest: enable-disable [447.997809] Starting dynamic subtest: 0-rcs0 [450.317190] Dynamic subtest 0-rcs0: SUCCESS (2.269s) [450.328918] Starting dynamic subtest: 1-vcs1 [454.694275] Dynamic subtest 1-vcs1: SUCCESS (4.429s) [454.697194] Subtest enable-disable: SUCCESS (6.700s) [454.745870] [072/133] (566s left) kms_dsc (dsc-with-formats) [454.840099] Starting subtest: dsc-with-formats [454.887471] Subtest dsc-with-formats: SKIP (0.001s) [454.929705] [073/133] (566s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary) [455.022317] Starting subtest: fbcpsr-shrfb-scaledprimary [460.881966] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.864s) [461.017083] [074/133] (560s left) kms_psr (fbc-pr-cursor-plane-move) [461.114431] Starting subtest: fbc-pr-cursor-plane-move [461.119330] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s) [461.186635] [075/133] (560s left) kms_chamelium_hpd (hdmi-hpd-storm) [461.577774] Subtest hdmi-hpd-storm: SKIP (0.000s) [462.392718] [076/133] (559s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs) [462.484496] Starting subtest: ccs-on-another-bo-yf-tiled-ccs [462.486776] Starting dynamic subtest: pipe-A-eDP-1 [462.510533] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [462.522106] Starting dynamic subtest: pipe-B-eDP-1 [462.547255] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [462.556957] Starting dynamic subtest: pipe-C-eDP-1 [462.582493] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [462.591970] Starting dynamic subtest: pipe-D-eDP-1 [462.617567] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [462.622110] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.005s) [464.680970] [077/133] (556s left) kms_pm_rpm (fences-dpms) [466.211519] Starting subtest: fences-dpms [466.217010] Subtest fences-dpms: SKIP (0.000s) [466.919847] [078/133] (554s left) kms_big_fb (linear-8bpp-rotate-0) [467.020228] Starting subtest: linear-8bpp-rotate-0 [468.323856] Subtest linear-8bpp-rotate-0: SUCCESS (1.303s) [468.459494] [079/133] (553s left) kms_psr (pr-primary-mmap-cpu) [468.547782] Starting subtest: pr-primary-mmap-cpu [468.552805] Subtest pr-primary-mmap-cpu: SKIP (0.000s) [468.620431] [080/133] (553s left) kms_vblank (ts-continuation-dpms-suspend) [468.711753] Starting subtest: ts-continuation-dpms-suspend [468.713887] Starting dynamic subtest: pipe-A-eDP-1 [485.706319] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.826s) [485.722492] Starting dynamic subtest: pipe-D-eDP-1 [503.740663] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.444s) [503.743176] Subtest ts-continuation-dpms-suspend: SUCCESS (4.274s) [504.572273] [081/133] (517s left) kms_flip (2x-absolute-wf_vblank) [504.674290] Starting subtest: 2x-absolute-wf_vblank [504.685171] Subtest 2x-absolute-wf_vblank: SKIP (0.010s) [504.779057] [082/133] (516s left) gem_lmem_swapping (heavy-multi) [504.820651] Subtest heavy-multi: SKIP (0.000s) [504.870511] [083/133] (516s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt) [504.964726] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt [504.969018] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [505.085650] [084/133] (516s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu) [505.186700] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu [505.191239] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [505.277999] [085/133] (516s left) kms_psr (psr2-sprite-blt) [505.377517] Starting subtest: psr2-sprite-blt [505.379868] Starting dynamic subtest: eDP-1 [507.129784] Dynamic subtest eDP-1: SUCCESS (1.707s) [507.132212] Subtest psr2-sprite-blt: SUCCESS (1.708s) [508.014645] [086/133] (513s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling) [508.104255] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling [508.106668] Starting dynamic subtest: pipe-A-default-mode [509.328941] Dynamic subtest pipe-A-default-mode: SKIP (1.199s) [509.334137] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.200s) [509.472583] [087/133] (512s left) kms_chamelium_frames (dp-crc-fast) [509.861255] Subtest dp-crc-fast: SKIP (0.000s) [510.722491] [088/133] (511s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping) [510.829752] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping [510.855928] Starting dynamic subtest: pipe-A-plane-0 [511.306279] Dynamic subtest pipe-A-plane-0: SUCCESS (0.444s) [511.316541] Starting dynamic subtest: pipe-A-plane-3 [511.577600] Dynamic subtest pipe-A-plane-3: SUCCESS (0.265s) [512.651511] Starting dynamic subtest: pipe-B-plane-0 [513.125994] Dynamic subtest pipe-B-plane-0: SUCCESS (0.478s) [513.136924] Starting dynamic subtest: pipe-B-plane-3 [513.406835] Dynamic subtest pipe-B-plane-3: SUCCESS (0.277s) [513.720648] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.856s) [514.938267] [089/133] (507s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs) [515.035178] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs [515.037308] Starting dynamic subtest: pipe-A-eDP-1 [515.059047] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [515.071669] Starting dynamic subtest: pipe-B-eDP-1 [515.093070] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [515.102445] Starting dynamic subtest: pipe-C-eDP-1 [515.123583] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [515.133032] Starting dynamic subtest: pipe-D-eDP-1 [515.154997] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [515.158975] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s) [517.236198] [090/133] (504s left) perf_pmu (busy-accuracy-50) [517.282050] Starting subtest: busy-accuracy-50 [517.284220] Starting dynamic subtest: rcs0 [518.814593] Dynamic subtest rcs0: SUCCESS (1.521s) [518.824362] Starting dynamic subtest: bcs0 [520.361984] Dynamic subtest bcs0: SUCCESS (1.537s) [520.372704] Starting dynamic subtest: vcs0 [521.908688] Dynamic subtest vcs0: SUCCESS (1.539s) [521.919628] Starting dynamic subtest: vcs1 [523.455024] Dynamic subtest vcs1: SUCCESS (1.539s) [523.465877] Starting dynamic subtest: vecs0 [525.001369] Dynamic subtest vecs0: SUCCESS (1.540s) [525.013154] Starting dynamic subtest: ccs0 [526.551449] Dynamic subtest ccs0: SUCCESS (1.543s) [526.554197] Subtest busy-accuracy-50: SUCCESS (9.233s) [526.685307] [091/133] (495s left) gem_close (many-handles-one-vma) [526.761095] Starting subtest: many-handles-one-vma [526.795499] Subtest many-handles-one-vma: SUCCESS (0.038s) [526.888985] [092/133] (495s left) gem_exec_capture (capture-invisible) [526.950428] Starting subtest: capture-invisible [526.952872] Starting dynamic subtest: smem0 [526.957400] Dynamic subtest smem0: SKIP (0.000s) [526.961512] Subtest capture-invisible: SKIP (0.001s) [527.048376] [093/133] (495s left) kms_cursor_crc (cursor-onscreen-512x512) [527.330944] Starting subtest: cursor-onscreen-512x512 [527.335329] Subtest cursor-onscreen-512x512: SKIP (0.001s) [527.495172] [094/133] (494s left) kms_cursor_crc (cursor-random-64x64) [527.678767] Starting subtest: cursor-random-64x64 [527.680596] Starting dynamic subtest: pipe-A-eDP-1 [531.020313] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.334s) [531.053844] Starting dynamic subtest: pipe-D-eDP-1 [535.020799] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.970s) [535.023064] Subtest cursor-random-64x64: SUCCESS (7.333s) [535.844832] [095/133] (486s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt) [535.936507] Starting subtest: psr-rgb101010-draw-mmap-gtt [535.940607] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [536.051379] [096/133] (486s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs) [536.153914] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs [536.156290] Starting dynamic subtest: pipe-A-eDP-1 [536.179649] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [536.189556] Starting dynamic subtest: pipe-B-eDP-1 [536.210913] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [536.220138] Starting dynamic subtest: pipe-C-eDP-1 [536.241852] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [536.255970] Starting dynamic subtest: pipe-D-eDP-1 [536.277671] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [536.282018] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.004s) [538.415154] [097/133] (483s left) gem_fence_thrash (bo-write-verify-none) [538.451617] Starting subtest: bo-write-verify-none [538.475521] Subtest bo-write-verify-none: SKIP (0.020s) [538.541192] [098/133] (483s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5) [538.629833] Starting subtest: planes-upscale-20x20-downscale-factor-0-5 [538.632032] Starting dynamic subtest: pipe-A [538.649357] Dynamic subtest pipe-A: SKIP (0.017s) [538.659669] Starting dynamic subtest: pipe-B [538.682622] Dynamic subtest pipe-B: SKIP (0.030s) [538.694210] Starting dynamic subtest: pipe-C [538.712044] Dynamic subtest pipe-C: SKIP (0.030s) [538.721888] Starting dynamic subtest: pipe-D [538.741906] Dynamic subtest pipe-D: SKIP (0.030s) [538.745623] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.109s) [538.853376] [099/133] (483s left) gem_eio (wait-immediate) [539.071457] Starting subtest: wait-immediate [539.431873] Subtest wait-immediate: SUCCESS (0.360s) [539.565108] [100/133] (482s left) gem_vm_create (create-ext) [539.620662] Starting subtest: create-ext [539.622327] Subtest create-ext: SUCCESS (0.003s) [539.753035] [101/133] (482s left) kms_cdclk (plane-scaling) [539.846755] Starting subtest: plane-scaling [539.848554] Starting dynamic subtest: pipe-A-eDP-1 [540.140209] Dynamic subtest pipe-A-eDP-1: SKIP (0.289s) [540.150674] Starting dynamic subtest: pipe-B-eDP-1 [540.155300] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [540.164998] Starting dynamic subtest: pipe-C-eDP-1 [540.169679] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [540.179476] Starting dynamic subtest: pipe-D-eDP-1 [540.183874] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [540.188144] Subtest plane-scaling: SKIP (0.297s) [540.935494] [102/133] (481s left) kms_flip (wf_vblank-ts-check-interruptible) [541.034737] Starting subtest: wf_vblank-ts-check-interruptible [541.037236] Starting dynamic subtest: A-eDP1 [550.007402] Dynamic subtest A-eDP1: SUCCESS (8.943s) [550.017698] Starting dynamic subtest: B-eDP1 [558.948824] Dynamic subtest B-eDP1: SUCCESS (8.935s) [558.964944] Starting dynamic subtest: C-eDP1 [567.875098] Dynamic subtest C-eDP1: SUCCESS (8.913s) [567.886591] Starting dynamic subtest: D-eDP1 [576.715944] Dynamic subtest D-eDP1: SUCCESS (8.834s) [576.718342] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.637s) [577.913616] [103/133] (444s left) gem_ctx_sseu (invalid-args) [577.976909] Subtest invalid-args: SKIP (0.000s) [578.065333] [104/133] (444s left) kms_big_fb (4-tiled-32bpp-rotate-180) [578.163216] Starting subtest: 4-tiled-32bpp-rotate-180 [579.621809] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.458s) [579.756416] [105/133] (443s left) syncobj_timeline (wait-any-interrupted) [579.810807] Starting subtest: wait-any-interrupted [579.911523] Subtest wait-any-interrupted: SUCCESS (0.101s) [579.991903] [106/133] (442s left) kms_plane_alpha_blend (alpha-basic) [580.083283] Starting subtest: alpha-basic [580.366276] Starting dynamic subtest: pipe-A-eDP-1 [582.309862] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.940s) [582.347055] Starting dynamic subtest: pipe-D-eDP-1 [584.971509] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.642s) [584.974494] Subtest alpha-basic: SUCCESS (4.887s) [585.776739] [107/133] (437s left) gem_mmap_gtt (cpuset-basic-small-copy-odd) [585.845903] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s) [585.913854] [108/133] (436s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt) [586.024242] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt [586.028478] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [586.142379] [109/133] (436s left) gem_ctx_persistence (processes) [586.211676] Starting subtest: processes [587.669349] Subtest processes: SUCCESS (1.457s) [587.750642] [110/133] (435s left) dumb_buffer (map-invalid-size) [587.811363] Starting subtest: map-invalid-size [587.813322] Subtest map-invalid-size: SUCCESS (0.000s) [587.909352] [111/133] (435s left) kms_addfb_basic (bad-pitch-32) [587.966849] Starting subtest: bad-pitch-32 [587.968961] Subtest bad-pitch-32: SUCCESS (0.000s) [588.112949] [112/133] (434s left) i915_query (test-query-geometry-subslices) [588.166808] Starting subtest: test-query-geometry-subslices [588.168919] Subtest test-query-geometry-subslices: SUCCESS (0.000s) [588.282436] [113/133] (434s left) gem_exec_reloc (basic-wc-cpu-active) [588.337565] Subtest basic-wc-cpu-active: SKIP (0.000s) [588.409072] [114/133] (434s left) kms_big_fb (yf-tiled-16bpp-rotate-90) [588.504950] Starting subtest: yf-tiled-16bpp-rotate-90 [588.509271] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s) [588.591092] [115/133] (434s left) gem_exec_schedule (preempt) [588.657951] Starting subtest: preempt [588.659632] Starting dynamic subtest: rcs0 [588.672896] Dynamic subtest rcs0: SUCCESS (0.022s) [588.682167] Starting dynamic subtest: bcs0 [588.691558] Dynamic subtest bcs0: SUCCESS (0.018s) [588.700436] Starting dynamic subtest: vcs0 [588.712370] Dynamic subtest vcs0: SUCCESS (0.020s) [588.721381] Starting dynamic subtest: vcs1 [588.733243] Dynamic subtest vcs1: SUCCESS (0.020s) [588.742321] Starting dynamic subtest: vecs0 [588.753113] Dynamic subtest vecs0: SUCCESS (0.019s) [588.761902] Starting dynamic subtest: ccs0 [588.774273] Dynamic subtest ccs0: SUCCESS (0.020s) [588.776127] Subtest preempt: SUCCESS (0.124s) [590.743729] [116/133] (432s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary) [590.843521] Starting subtest: psr-shrfb-scaledprimary [596.625862] Subtest psr-shrfb-scaledprimary: SUCCESS (5.783s) [596.762514] [117/133] (426s left) api_intel_bb (intel-bb-blit-y) [596.825006] Starting subtest: intel-bb-blit-y [600.434838] Subtest intel-bb-blit-y: SUCCESS (3.610s) [600.564981] [118/133] (422s left) kms_draw_crc (fill-fb) [600.661887] Starting subtest: fill-fb [601.079678] Subtest fill-fb: SUCCESS (0.419s) [601.173007] [119/133] (422s left) gen9_exec_parse (cmd-crossing-page) [601.237699] Subtest cmd-crossing-page: SKIP (0.000s) [601.319560] [120/133] (422s left) gem_ctx_engines (execute-oneforall) [601.371228] Starting subtest: execute-oneforall [602.040039] Subtest execute-oneforall: SUCCESS (0.667s) [603.724611] [121/133] (419s left) kms_flip (2x-flip-vs-suspend-interruptible) [603.826431] Starting subtest: 2x-flip-vs-suspend-interruptible [603.837327] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.010s) [603.934975] [122/133] (419s left) gem_exec_balancer (bonded-chain) [603.995453] Starting subtest: bonded-chain [610.974009] Subtest bonded-chain: SUCCESS (6.978s) [611.288066] [123/133] (412s left) gem_partial_pwrite_pread (writes-after-reads-snoop) [611.346417] Subtest writes-after-reads-snoop: SKIP (0.000s) [611.429267] [124/133] (412s left) kms_content_protection (legacy) [611.571580] Starting subtest: legacy [611.575934] Subtest legacy: SKIP (0.000s) [611.689729] [125/133] (411s left) gem_render_copy (x-tiled) [611.759376] Starting subtest: x-tiled [611.761770] Starting dynamic subtest: smem [611.799496] Dynamic subtest smem: SUCCESS (0.040s) [611.801928] Subtest x-tiled: SUCCESS (0.041s) [612.053689] [126/133] (411s left) gem_exec_schedule (semaphore-codependency) [612.128741] Starting subtest: semaphore-codependency [612.133828] Subtest semaphore-codependency: SUCCESS (0.010s) [612.470290] [127/133] (411s left) i915_drm_fdinfo (most-busy-idle-check-all) [612.510371] Starting subtest: most-busy-idle-check-all [612.512643] Starting dynamic subtest: rcs0 [612.517174] Dynamic subtest rcs0: SKIP (0.004s) [612.527820] Starting dynamic subtest: bcs0 [612.531892] Dynamic subtest bcs0: SKIP (0.000s) [612.541613] Starting dynamic subtest: vcs0 [612.545847] Dynamic subtest vcs0: SKIP (0.000s) [612.555377] Starting dynamic subtest: vcs1 [612.559524] Dynamic subtest vcs1: SKIP (0.000s) [612.568941] Starting dynamic subtest: vecs0 [612.573168] Dynamic subtest vecs0: SKIP (0.000s) [612.584771] Starting dynamic subtest: ccs0 [612.589188] Dynamic subtest ccs0: SKIP (0.000s) [612.593397] Subtest most-busy-idle-check-all: SKIP (0.009s) [612.631014] [128/133] (411s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping) [612.754004] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping [612.758335] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.000s) [612.850200] [129/133] (410s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move) [612.958036] Starting subtest: psr-1p-primscrn-spr-indfb-move [620.469096] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.515s) [620.571161] [130/133] (403s left) prime_vgem (fence-write-hang) [620.639118] Subtest fence-write-hang: SKIP (0.000s) [620.728399] [131/133] (403s left) gem_userptr_blits (sync-unmap-cycles) [620.793596] Starting subtest: sync-unmap-cycles [626.175484] Subtest sync-unmap-cycles: SUCCESS (5.381s) [626.296173] [132/133] (397s left) gem_ppgtt (blt-vs-render-ctxn) [626.363409] Starting subtest: blt-vs-render-ctxN [659.442748] Subtest blt-vs-render-ctxN: SUCCESS (33.072s) [659.578510] [133/133] (364s left) prime_busy (after-wait) [659.676883] Starting subtest: after-wait [659.683294] Starting dynamic subtest: rcs0 [659.724618] Dynamic subtest rcs0: SUCCESS (0.044s) [659.736964] Starting dynamic subtest: bcs0 [659.776856] Dynamic subtest bcs0: SUCCESS (0.050s) [659.787841] Starting dynamic subtest: vcs0 [659.819292] Dynamic subtest vcs0: SUCCESS (0.042s) [659.829816] Starting dynamic subtest: vcs1 [659.860532] Dynamic subtest vcs1: SUCCESS (0.040s) [659.870274] Starting dynamic subtest: vecs0 [659.901272] Dynamic subtest vecs0: SUCCESS (0.040s) [659.911457] Starting dynamic subtest: ccs0 [659.943663] Dynamic subtest ccs0: SUCCESS (0.042s) [660.053299] Subtest after-wait: SUCCESS (0.374s) [660.126541] Closing watchdogs results: parsing output: 0/ for test: kms_frontbuffer_tracking results: parsing output: 1/ for test: kms_plane results: parsing output: 2/ for test: gem_render_copy results: parsing output: 3/ for test: kms_psr results: parsing output: 4/ for test: kms_rotation_crc results: parsing output: 5/ for test: syncobj_timeline results: parsing output: 6/ for test: gem_exec_reloc results: parsing output: 7/ for test: gem_exec_fence results: parsing output: 8/ for test: kms_addfb_basic results: parsing output: 9/ for test: gem_exec_whisper results: parsing output: 10/ for test: gem_bad_reloc results: parsing output: 11/ for test: kms_lease results: parsing output: 12/ for test: kms_pwrite_crc results: parsing output: 13/ for test: kms_async_flips results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: kms_flip results: parsing output: 16/ for test: kms_big_fb results: parsing output: 17/ for test: kms_color results: parsing output: 18/ for test: syncobj_wait results: parsing output: 19/ for test: gem_pxp results: parsing output: 20/ for test: kms_frontbuffer_tracking results: parsing output: 21/ for test: kms_frontbuffer_tracking results: parsing output: 22/ for test: kms_big_fb results: parsing output: 23/ for test: kms_psr2_sf results: parsing output: 24/ for test: kms_properties results: parsing output: 25/ for test: gem_eio results: parsing output: 26/ for test: kms_frontbuffer_tracking results: parsing output: 27/ for test: prime_mmap results: parsing output: 28/ for test: kms_frontbuffer_tracking results: parsing output: 29/ for test: vgem_basic results: parsing output: 30/ for test: kms_psr results: parsing output: 31/ for test: syncobj_timeline results: parsing output: 32/ for test: gem_softpin results: parsing output: 33/ for test: kms_flip results: parsing output: 34/ for test: kms_ccs results: parsing output: 35/ for test: kms_psr_stress_test results: parsing output: 36/ for test: gem_mmap_offset results: parsing output: 37/ for test: kms_big_fb results: parsing output: 38/ for test: kms_cursor_legacy results: parsing output: 39/ for test: syncobj_wait results: parsing output: 40/ for test: syncobj_wait results: parsing output: 41/ for test: gem_eio results: parsing output: 42/ for test: kms_universal_plane results: parsing output: 43/ for test: gem_exec_params results: parsing output: 44/ for test: kms_cursor_edge_walk results: parsing output: 45/ for test: gem_ctx_isolation results: parsing output: 46/ for test: i915_pm_rc6_residency results: parsing output: 47/ for test: kms_cursor_legacy results: parsing output: 48/ for test: kms_frontbuffer_tracking results: parsing output: 49/ for test: i915_pciid results: parsing output: 50/ for test: kms_frontbuffer_tracking results: parsing output: 51/ for test: kms_frontbuffer_tracking results: parsing output: 52/ for test: kms_big_fb results: parsing output: 53/ for test: gem_mmap_wc results: parsing output: 54/ for test: kms_getfb results: parsing output: 55/ for test: syncobj_timeline results: parsing output: 56/ for test: syncobj_timeline 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_psr2_sf results: parsing output: 60/ for test: gem_eio results: parsing output: 61/ for test: kms_pm_dc results: parsing output: 62/ for test: gem_exec_fence results: parsing output: 63/ for test: syncobj_timeline results: parsing output: 64/ for test: kms_invalid_mode results: parsing output: 65/ for test: gem_pxp results: parsing output: 66/ for test: perf_pmu results: parsing output: 67/ for test: kms_frontbuffer_tracking results: parsing output: 68/ for test: kms_frontbuffer_tracking results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: perf results: parsing output: 71/ for test: kms_dsc results: parsing output: 72/ for test: kms_frontbuffer_tracking results: parsing output: 73/ for test: kms_psr results: parsing output: 74/ for test: kms_chamelium_hpd results: parsing output: 75/ for test: kms_ccs results: parsing output: 76/ for test: kms_pm_rpm results: parsing output: 77/ for test: kms_big_fb results: parsing output: 78/ for test: kms_psr results: parsing output: 79/ for test: kms_vblank results: parsing output: 80/ for test: kms_flip results: parsing output: 81/ for test: gem_lmem_swapping results: parsing output: 82/ for test: kms_frontbuffer_tracking results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: kms_psr results: parsing output: 85/ for test: kms_flip_scaled_crc results: parsing output: 86/ for test: kms_chamelium_frames results: parsing output: 87/ for test: kms_plane results: parsing output: 88/ for test: kms_ccs results: parsing output: 89/ for test: perf_pmu results: parsing output: 90/ for test: gem_close results: parsing output: 91/ for test: gem_exec_capture results: parsing output: 92/ for test: kms_cursor_crc results: parsing output: 93/ for test: kms_cursor_crc results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: kms_ccs results: parsing output: 96/ for test: gem_fence_thrash results: parsing output: 97/ for test: kms_plane_scaling results: parsing output: 98/ for test: gem_eio results: parsing output: 99/ for test: gem_vm_create results: parsing output: 100/ for test: kms_cdclk results: parsing output: 101/ for test: kms_flip results: parsing output: 102/ for test: gem_ctx_sseu results: parsing output: 103/ for test: kms_big_fb results: parsing output: 104/ for test: syncobj_timeline results: parsing output: 105/ for test: kms_plane_alpha_blend results: parsing output: 106/ for test: gem_mmap_gtt results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: gem_ctx_persistence results: parsing output: 109/ for test: dumb_buffer results: parsing output: 110/ for test: kms_addfb_basic results: parsing output: 111/ for test: i915_query results: parsing output: 112/ for test: gem_exec_reloc results: parsing output: 113/ for test: kms_big_fb results: parsing output: 114/ for test: gem_exec_schedule results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: api_intel_bb results: parsing output: 117/ for test: kms_draw_crc results: parsing output: 118/ for test: gen9_exec_parse results: parsing output: 119/ for test: gem_ctx_engines results: parsing output: 120/ for test: kms_flip results: parsing output: 121/ for test: gem_exec_balancer results: parsing output: 122/ for test: gem_partial_pwrite_pread results: parsing output: 123/ for test: kms_content_protection results: parsing output: 124/ for test: gem_render_copy results: parsing output: 125/ for test: gem_exec_schedule results: parsing output: 126/ for test: i915_drm_fdinfo results: parsing output: 127/ for test: kms_plane results: parsing output: 128/ for test: kms_frontbuffer_tracking results: parsing output: 129/ for test: prime_vgem results: parsing output: 130/ for test: gem_userptr_blits results: parsing output: 131/ for test: gem_ppgtt results: parsing output: 132/ for test: prime_busy Done.