[73.326496] Initializing watchdogs
[73.326578]   /dev/watchdog0
[73.357589] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[73.373492] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[73.378450] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[73.381658] [001/132] (960s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[74.875899] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[74.877404] Starting dynamic subtest: pipe-A-HDMI-A-1
[74.882879] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[74.891431] Starting dynamic subtest: pipe-B-HDMI-A-1
[74.897199] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[74.905371] Starting dynamic subtest: pipe-C-HDMI-A-1
[74.910985] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[74.919640] Starting dynamic subtest: pipe-D-HDMI-A-1
[74.925419] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[74.928370] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[75.139489] [002/132] (958s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[76.625614] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[76.627199] Starting dynamic subtest: pipe-A-HDMI-A-1
[76.643314] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[76.651832] Starting dynamic subtest: pipe-B-HDMI-A-1
[76.668427] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[76.676876] Starting dynamic subtest: pipe-C-HDMI-A-1
[76.691987] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[76.699986] Starting dynamic subtest: pipe-D-HDMI-A-1
[76.714136] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[76.716865] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.006s)
[76.885556] [003/132] (957s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[76.932950] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[76.934415] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[77.036763] [004/132] (957s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[78.548639] Starting subtest: y-tiled-64bpp-rotate-180
[81.422289] Subtest y-tiled-64bpp-rotate-180: SUCCESS (2.875s)
[81.642914] [005/132] (952s left) syncobj_wait (invalid-reset-zero-handles)
[81.689709] Starting subtest: invalid-reset-zero-handles
[81.691262] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[81.801734] [006/132] (952s left) i915_drm_fdinfo (most-busy-idle-check-all)
[81.857259] Starting subtest: most-busy-idle-check-all
[81.858905] Starting dynamic subtest: rcs0
[81.876099] Dynamic subtest rcs0: SKIP (0.017s)
[81.885276] Starting dynamic subtest: bcs0
[81.888654] Dynamic subtest bcs0: SKIP (0.001s)
[81.897567] Starting dynamic subtest: vcs0
[81.901213] Dynamic subtest vcs0: SKIP (0.000s)
[81.910496] Starting dynamic subtest: vcs1
[81.914043] Dynamic subtest vcs1: SKIP (0.000s)
[81.924590] Starting dynamic subtest: vecs0
[81.928055] Dynamic subtest vecs0: SKIP (0.000s)
[81.932063] Subtest most-busy-idle-check-all: SKIP (0.020s)
[81.988892] [007/132] (952s left) gem_mmap (basic-small-bo)
[82.067854] Subtest basic-small-bo: SKIP (0.000s)
[82.151669] [008/132] (952s left) gem_exec_fence (basic-await)
[82.350919] Starting subtest: basic-await
[82.352398] Starting dynamic subtest: rcs0
[82.451228] Dynamic subtest rcs0: SUCCESS (0.101s)
[82.461596] Starting dynamic subtest: bcs0
[82.538847] Dynamic subtest bcs0: SUCCESS (0.087s)
[82.549577] Starting dynamic subtest: vcs0
[82.628134] Dynamic subtest vcs0: SUCCESS (0.089s)
[82.639255] Starting dynamic subtest: vcs1
[82.718666] Dynamic subtest vcs1: SUCCESS (0.090s)
[82.729939] Starting dynamic subtest: vecs0
[82.809377] Dynamic subtest vecs0: SUCCESS (0.090s)
[82.811098] Subtest basic-await: SUCCESS (0.460s)
[83.559358] [FACT gem_exec_fence (basic-await)] new: kernel.kmod_is_loaded.vgem: true
[83.562099] [009/132] (950s left) gem_pxp (hw-rejects-pxp-buffer)
[86.133870] Starting subtest: hw-rejects-pxp-buffer
[86.135632] Subtest hw-rejects-pxp-buffer: SUCCESS (0.000s)
[86.277071] [010/132] (948s left) kms_hdr (bpc-switch-dpms)
[87.763192] Starting subtest: bpc-switch-dpms
[87.768075] Subtest bpc-switch-dpms: SKIP (0.001s)
[87.906442] [011/132] (946s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[89.404481] Starting subtest: fbc-rgb565-draw-mmap-wc
[89.407895] Subtest fbc-rgb565-draw-mmap-wc: SKIP (0.000s)
[89.572360] [012/132] (945s left) perf (non-zero-reason)
[89.705793] Starting subtest: non-zero-reason
[89.707376] Starting dynamic subtest: 0-rcs0
[100.670991] Dynamic subtest 0-rcs0: SUCCESS (10.961s)
[100.672766] Subtest non-zero-reason: SUCCESS (10.962s)
[100.737379] [013/132] (934s left) kms_async_flips (crc-atomic)
[102.225634] Starting subtest: crc-atomic
[102.492506] Starting dynamic subtest: pipe-A-HDMI-A-1
[104.893630] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.397s)
[105.085319] Starting dynamic subtest: pipe-B-HDMI-A-1
[107.248304] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.169s)
[107.417636] Starting dynamic subtest: pipe-C-HDMI-A-1
[109.583872] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.172s)
[109.762403] Starting dynamic subtest: pipe-D-HDMI-A-1
[111.928759] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.172s)
[111.930211] Subtest crc-atomic: SUCCESS (9.702s)
[112.356408] [014/132] (922s left) gem_exec_balancer (nop)
[112.414841] Starting subtest: nop
[151.485710] Subtest nop: SUCCESS (39.070s)
[151.904258] [015/132] (883s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[153.397848] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[153.401210] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[153.575797] [016/132] (881s left) syncobj_timeline (wait-all-interrupted)
[153.621902] Starting subtest: wait-all-interrupted
[153.727870] Subtest wait-all-interrupted: SUCCESS (0.102s)
[153.873414] [017/132] (881s left) kms_invalid_mode (bad-htotal)
[155.359160] Starting subtest: bad-htotal
[155.360719] Starting dynamic subtest: pipe-A-HDMI-A-1
[155.395805] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.035s)
[155.405157] Starting dynamic subtest: pipe-B-HDMI-A-1
[155.406821] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[155.415860] Starting dynamic subtest: pipe-C-HDMI-A-1
[155.417516] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[155.426408] Starting dynamic subtest: pipe-D-HDMI-A-1
[155.427827] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[155.429247] Subtest bad-htotal: SUCCESS (0.043s)
[155.572739] [018/132] (879s left) kms_big_fb (linear-8bpp-rotate-0)
[157.081031] Starting subtest: linear-8bpp-rotate-0
[158.756233] Subtest linear-8bpp-rotate-0: SUCCESS (1.675s)
[159.029044] [019/132] (876s left) kms_cursor_edge_walk (128x128-top-bottom)
[160.516564] Starting subtest: 128x128-top-bottom
[160.518158] Starting dynamic subtest: pipe-A-HDMI-A-1
[163.833959] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.317s)
[163.843354] Starting dynamic subtest: pipe-D-HDMI-A-1
[167.055427] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (3.219s)
[167.057106] Subtest 128x128-top-bottom: SUCCESS (6.540s)
[167.229545] [020/132] (868s left) api_intel_bb (render)
[167.276964] Starting subtest: render
[167.278365] Starting dynamic subtest: render-none-512
[167.317269] Dynamic subtest render-none-512: SUCCESS (0.040s)
[167.326573] Starting dynamic subtest: render-none-1024
[167.384600] Dynamic subtest render-none-1024: SUCCESS (0.067s)
[167.393546] Starting dynamic subtest: render-x-512
[167.405701] Dynamic subtest render-x-512: SUCCESS (0.021s)
[167.414771] Starting dynamic subtest: render-x-1024
[167.475268] Dynamic subtest render-x-1024: SUCCESS (0.069s)
[167.484820] Starting dynamic subtest: render-y-512
[167.496043] Dynamic subtest render-y-512: SUCCESS (0.020s)
[167.505395] Starting dynamic subtest: render-y-1024
[167.553351] Dynamic subtest render-y-1024: SUCCESS (0.057s)
[167.554938] Subtest render: SUCCESS (0.277s)
[167.787998] [021/132] (867s left) kms_cursor_legacy (torture-bo)
[169.276142] Starting subtest: torture-bo
[169.277589] Starting dynamic subtest: pipe-A
[174.778065] Dynamic subtest pipe-A: SUCCESS (5.494s)
[174.790442] Starting dynamic subtest: pipe-B
[180.246689] Dynamic subtest pipe-B: SUCCESS (5.476s)
[180.258053] Starting dynamic subtest: pipe-C
[185.723604] Dynamic subtest pipe-C: SUCCESS (5.477s)
[185.733992] Starting dynamic subtest: pipe-D
[191.193196] Dynamic subtest pipe-D: SUCCESS (5.469s)
[191.209804] Starting dynamic subtest: all-pipes
[196.688573] Dynamic subtest all-pipes: SUCCESS (5.494s)
[196.691052] Subtest torture-bo: SUCCESS (27.413s)
[196.795227] [022/132] (838s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[198.289830] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[198.293259] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[198.462773] [023/132] (837s left) kms_plane_lowres (tiling-y)
[199.949512] Starting subtest: tiling-y
[199.950960] Starting dynamic subtest: pipe-A-HDMI-A-1
[209.456607] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (9.506s)
[209.537440] Starting dynamic subtest: pipe-B-HDMI-A-1
[218.739467] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (9.210s)
[218.803862] Starting dynamic subtest: pipe-C-HDMI-A-1
[228.028685] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (9.233s)
[228.111835] Starting dynamic subtest: pipe-D-HDMI-A-1
[237.307350] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (9.204s)
[237.363983] Subtest tiling-y: SUCCESS (37.414s)
[237.566156] [024/132] (798s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[241.843797] Starting subtest: heavy-verify-multi-ccs
[241.845831] Starting dynamic subtest: lmem0
[241.849247] Dynamic subtest lmem0: SKIP (0.000s)
[241.852726] Subtest heavy-verify-multi-ccs: SKIP (0.004s)
[245.645253] [FACT gem_lmem_swapping (heavy-verify-multi-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[245.646658] [FACT gem_lmem_swapping (heavy-verify-multi-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[245.649337] [025/132] (790s left) kms_sequence (get-busy)
[250.400217] Starting subtest: get-busy
[250.401490] Starting dynamic subtest: pipe-A-HDMI-A-1
[252.992350] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.591s)
[253.006565] Starting dynamic subtest: pipe-B-HDMI-A-1
[255.407105] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.412s)
[255.419571] Starting dynamic subtest: pipe-C-HDMI-A-1
[257.825991] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.416s)
[257.838561] Starting dynamic subtest: pipe-D-HDMI-A-1
[260.252183] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.422s)
[260.253660] Subtest get-busy: SUCCESS (9.852s)
[260.462024] [FACT kms_sequence (get-busy)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[260.465413] [FACT kms_sequence (get-busy)] new: kernel.kmod_is_loaded.i915: true
[260.469405] [026/132] (775s left) kms_flip (2x-blocking-absolute-wf_vblank)
[261.961099] Starting subtest: 2x-blocking-absolute-wf_vblank
[261.983472] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.021s)
[262.121651] [027/132] (773s left) intel_hwmon (hwmon-write)
[262.169214] Starting subtest: hwmon-write
[262.189375] Subtest hwmon-write: SUCCESS (0.022s)
[262.302371] [028/132] (773s left) gem_eio (wait-wedge-10ms)
[262.444141] Starting subtest: wait-wedge-10ms
[263.845918] Subtest wait-wedge-10ms: SUCCESS (1.402s)
[265.433144] [029/132] (770s left) kms_flip (2x-busy-flip)
[266.923778] Starting subtest: 2x-busy-flip
[266.946163] Subtest 2x-busy-flip: SKIP (0.021s)
[267.098338] [030/132] (769s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[268.589156] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[268.673730] [031/132] (767s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[270.176325] Starting subtest: fbc-rgb101010-draw-blt
[273.120872] Subtest fbc-rgb101010-draw-blt: SUCCESS (2.946s)
[273.301230] [032/132] (763s left) kms_psr (pr-sprite-mmap-gtt)
[274.791302] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[274.866068] [033/132] (761s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[276.357938] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[276.432651] [034/132] (760s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[277.937671] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[277.940766] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[278.100998] [035/132] (758s left) kms_chamelium_edid (dp-edid-read)
[279.628117] Subtest dp-edid-read: SKIP (0.000s)
[279.749871] [036/132] (756s left) kms_rotation_crc (sprite-rotation-180)
[281.237628] Starting subtest: sprite-rotation-180
[291.594701] Subtest sprite-rotation-180: SUCCESS (10.356s)
[291.832487] [037/132] (744s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[293.342603] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[294.630676] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.287s)
[294.850039] [038/132] (742s left) gem_ctx_shared (disjoint-timelines)
[294.908420] Starting subtest: disjoint-timelines
[294.949643] Subtest disjoint-timelines: SUCCESS (0.041s)
[295.269697] [039/132] (741s left) gem_sync (basic-each)
[295.331626] Starting subtest: basic-each
[297.721919] Subtest basic-each: SUCCESS (2.392s)
[297.993165] [040/132] (739s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[299.486654] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[299.489828] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[299.663894] [041/132] (737s left) gem_sync (basic-many-each)
[299.725672] Starting subtest: basic-many-each
[302.127772] Subtest basic-many-each: SUCCESS (2.404s)
[302.441350] [042/132] (734s left) gem_exec_schedule (u-semaphore-user)
[302.510897] Starting subtest: u-semaphore-user
[302.548509] Subtest u-semaphore-user: SUCCESS (0.041s)
[302.952295] [043/132] (734s left) gem_softpin (evict-snoop)
[303.010123] Starting subtest: evict-snoop
[303.012870] Subtest evict-snoop: SKIP (0.000s)
[303.167983] [044/132] (734s left) gen9_exec_parse (bb-start-far)
[303.229784] Subtest bb-start-far: SKIP (0.000s)
[303.308164] [045/132] (734s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[304.802096] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[304.805060] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[304.979952] [046/132] (732s left) perf_pmu (event-wait)
[305.031737] Starting subtest: event-wait
[305.033132] Starting dynamic subtest: rcs0
[305.035871] Dynamic subtest rcs0: SKIP (0.000s)
[305.038881] Subtest event-wait: SKIP (0.001s)
[305.151596] [047/132] (732s left) gem_mmap_offset (perf)
[305.199027] Starting subtest: perf
[305.201128] Starting dynamic subtest: lmem0
[305.338789] Dynamic subtest lmem0: SUCCESS (0.140s)
[305.350237] Starting dynamic subtest: smem0
[305.358246] Dynamic subtest smem0: SUCCESS (0.004s)
[305.359888] Subtest perf: SUCCESS (0.147s)
[305.532268] [048/132] (732s left) kms_cursor_crc (cursor-onscreen-64x21)
[307.175405] Starting subtest: cursor-onscreen-64x21
[307.182926] Starting dynamic subtest: pipe-A-HDMI-A-1
[310.001859] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.819s)
[310.036311] Starting dynamic subtest: pipe-D-HDMI-A-1
[312.669148] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.640s)
[312.670627] Subtest cursor-onscreen-64x21: SUCCESS (5.493s)
[313.119754] [049/132] (724s left) gem_mmap_gtt (basic-write-read-distinct)
[313.170606] Subtest basic-write-read-distinct: SKIP (0.000s)
[313.266569] [050/132] (724s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[314.762156] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[314.765535] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[314.924129] [051/132] (723s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[316.412565] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[316.413941] Starting dynamic subtest: pipe-A
[316.574533] Dynamic subtest pipe-A: SUCCESS (0.161s)
[316.593680] Starting dynamic subtest: pipe-B
[316.732638] Dynamic subtest pipe-B: SUCCESS (0.156s)
[316.743847] Starting dynamic subtest: pipe-C
[316.873404] Dynamic subtest pipe-C: SUCCESS (0.140s)
[316.886027] Starting dynamic subtest: pipe-D
[317.014598] Dynamic subtest pipe-D: SUCCESS (0.140s)
[317.016030] Subtest planes-upscale-20x20-downscale-factor-0-5: SUCCESS (0.603s)
[317.264814] [052/132] (720s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[318.774243] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[318.777611] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[318.966367] [053/132] (719s left) i915_pm_rps (thresholds-idle-park)
[319.025540] Starting subtest: thresholds-idle-park
[319.028418] Subtest thresholds-idle-park: SKIP (0.000s)
[319.154767] [054/132] (719s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[319.202497] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[319.203998] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[319.332142] [055/132] (719s left) kms_chamelium_color (ctm-0-75)
[320.821154] Subtest ctm-0-75: SKIP (0.000s)
[320.909655] [056/132] (717s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[322.482446] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[322.483826] Starting dynamic subtest: pipe-A-valid-mode
[323.703227] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.220s)
[323.704734] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SUCCESS (1.222s)
[323.889257] [057/132] (714s left) kms_psr (fbc-psr-no-drrs)
[325.379180] Subtest fbc-psr-no-drrs: SKIP (0.000s)
[325.453202] [058/132] (713s left) prime_mmap_coherency (write)
[325.504682] Starting subtest: write
[330.907923] Subtest write: SUCCESS (5.403s)
[331.085705] [059/132] (707s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[332.578791] Starting subtest: plane-lut1d-ctm3x4
[332.777247] Starting dynamic subtest: pipe-A-plane-0
[333.024197] Dynamic subtest pipe-A-plane-0: SUCCESS (0.247s)
[333.065050] Starting dynamic subtest: pipe-A-plane-1
[333.225696] Dynamic subtest pipe-A-plane-1: SUCCESS (0.192s)
[333.262341] Starting dynamic subtest: pipe-A-plane-2
[333.425178] Dynamic subtest pipe-A-plane-2: SUCCESS (0.192s)
[333.743252] Starting dynamic subtest: pipe-B-plane-0
[333.904559] Dynamic subtest pipe-B-plane-0: SUCCESS (0.198s)
[333.937701] Starting dynamic subtest: pipe-B-plane-1
[334.105938] Dynamic subtest pipe-B-plane-1: SUCCESS (0.192s)
[334.138033] Starting dynamic subtest: pipe-B-plane-2
[334.305555] Dynamic subtest pipe-B-plane-2: SUCCESS (0.192s)
[334.595526] Starting dynamic subtest: pipe-C-plane-0
[334.767989] Dynamic subtest pipe-C-plane-0: SUCCESS (0.197s)
[334.798732] Starting dynamic subtest: pipe-C-plane-1
[334.980695] Dynamic subtest pipe-C-plane-1: SUCCESS (0.209s)
[334.996125] Starting dynamic subtest: pipe-C-plane-2
[335.161863] Dynamic subtest pipe-C-plane-2: SUCCESS (0.177s)
[335.458056] Starting dynamic subtest: pipe-D-plane-0
[335.631837] Dynamic subtest pipe-D-plane-0: SUCCESS (0.197s)
[335.663580] Starting dynamic subtest: pipe-D-plane-1
[335.848626] Dynamic subtest pipe-D-plane-1: SUCCESS (0.209s)
[335.882745] Starting dynamic subtest: pipe-D-plane-2
[336.065252] Dynamic subtest pipe-D-plane-2: SUCCESS (0.209s)
[336.119572] Subtest plane-lut1d-ctm3x4: SUCCESS (3.542s)
[336.309662] [060/132] (702s left) gem_vm_create (invalid-destroy)
[336.363102] Starting subtest: invalid-destroy
[336.366222] Subtest invalid-destroy: SUCCESS (0.002s)
[336.543521] [061/132] (702s left) api_intel_allocator (reloc-allocator)
[336.589851] Starting subtest: reloc-allocator
[336.591227] Starting dynamic subtest: basic
[336.606623] Dynamic subtest basic: SUCCESS (0.016s)
[336.619749] Starting dynamic subtest: parallel-one
[336.621089] Dynamic subtest parallel-one: SUCCESS (0.005s)
[336.631658] Starting dynamic subtest: print
[336.632984] Dynamic subtest print: SUCCESS (0.000s)
[336.643830] Starting dynamic subtest: reuse
[336.645219] Dynamic subtest reuse: SUCCESS (0.000s)
[336.655848] Starting dynamic subtest: fork-reopen-allocator
[336.657499] Dynamic subtest fork-reopen-allocator: SUCCESS (0.016s)
[336.659160] Subtest reloc-allocator: SUCCESS (0.045s)
[336.807895] [062/132] (702s left) perf (disabled-read-error)
[336.934309] Starting subtest: disabled-read-error
[336.974533] Subtest disabled-read-error: SUCCESS (0.041s)
[337.052312] [063/132] (702s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[338.559812] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[338.562914] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[338.726650] [064/132] (700s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[340.215430] Starting subtest: primary-y-tiled-reflect-x-0
[350.732986] Subtest primary-y-tiled-reflect-x-0: SUCCESS (10.517s)
[350.985926] [065/132] (688s left) gem_exec_fence (syncobj-channel)
[351.426207] Starting subtest: syncobj-channel
[352.451215] Subtest syncobj-channel: SUCCESS (1.025s)
[352.930380] [066/132] (686s left) gem_mmap_wc (pf-nonblock)
[352.979493] Subtest pf-nonblock: SKIP (0.000s)
[353.083977] [067/132] (686s left) gem_mmap_wc (coherency)
[353.132906] Subtest coherency: SKIP (0.000s)
[353.213317] [068/132] (686s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[354.708778] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[354.712195] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[354.873353] [069/132] (684s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[356.369910] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[356.373202] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[356.569085] [070/132] (683s left) gem_exec_schedule (preempt-other-chain)
[356.633358] Starting subtest: preempt-other-chain
[356.634947] Starting dynamic subtest: rcs0
[356.798731] Dynamic subtest rcs0: SUCCESS (0.161s)
[356.810268] Starting dynamic subtest: bcs0
[356.943974] Dynamic subtest bcs0: SUCCESS (0.144s)
[356.955376] Starting dynamic subtest: vcs0
[357.085213] Dynamic subtest vcs0: SUCCESS (0.140s)
[357.096371] Starting dynamic subtest: vcs1
[357.228117] Dynamic subtest vcs1: SUCCESS (0.141s)
[357.239512] Starting dynamic subtest: vecs0
[357.371196] Dynamic subtest vecs0: SUCCESS (0.141s)
[357.372941] Subtest preempt-other-chain: SUCCESS (0.735s)
[357.837887] [071/132] (682s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[359.327871] Starting subtest: cursorA-vs-flipA-legacy
[370.238231] Subtest cursorA-vs-flipA-legacy: SUCCESS (10.911s)
[370.412808] [072/132] (669s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[371.902832] Starting subtest: basic-flip-after-cursor-varying-size
[372.932919] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.031s)
[373.111870] [073/132] (666s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[374.599437] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[374.602409] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.000s)
[374.742407] [074/132] (665s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[376.234788] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[376.237490] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[376.366437] [075/132] (663s left) gem_exec_whisper (basic-normal-all)
[376.429880] Starting subtest: basic-normal-all
[378.035011] Subtest basic-normal-all: SUCCESS (1.603s)
[378.324248] [076/132] (662s left) kms_busy (extended-pageflip-hang-oldfb)
[379.817664] Starting subtest: extended-pageflip-hang-oldfb
[379.819166] Starting dynamic subtest: pipe-A
[379.998697] Dynamic subtest pipe-A: SUCCESS (0.180s)
[380.013117] Starting dynamic subtest: pipe-D
[380.183639] Dynamic subtest pipe-D: SUCCESS (0.178s)
[380.185243] Subtest extended-pageflip-hang-oldfb: SUCCESS (0.366s)
[380.375302] [077/132] (660s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[381.866595] Starting subtest: stress-xrgb8888-ytiled
[395.192113] Subtest stress-xrgb8888-ytiled: SUCCESS (13.325s)
[395.320211] [078/132] (645s left) kms_frontbuffer_tracking (basic)
[396.818122] Starting subtest: basic
[399.771143] Subtest basic: SUCCESS (2.956s)
[400.004133] [079/132] (640s left) gem_exec_fence (syncobj-unused-fence)
[400.406799] Starting subtest: syncobj-unused-fence
[400.428892] Subtest syncobj-unused-fence: SUCCESS (0.022s)
[400.919260] [080/132] (639s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[402.423155] Starting subtest: flip-vs-cursor-atomic-transitions
[414.109457] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (11.687s)
[414.286780] [081/132] (626s left) gem_spin_batch (legacy-resubmit)
[414.345799] Starting subtest: legacy-resubmit
[414.347279] Starting dynamic subtest: default
[414.366097] Dynamic subtest default: SUCCESS (0.019s)
[414.377747] Starting dynamic subtest: render
[414.379240] Dynamic subtest render: SUCCESS (0.002s)
[414.390813] Starting dynamic subtest: bsd
[414.392542] Dynamic subtest bsd: SUCCESS (0.002s)
[414.403888] Starting dynamic subtest: bsd1
[414.405603] Dynamic subtest bsd1: SUCCESS (0.003s)
[414.416438] Starting dynamic subtest: bsd2
[414.418108] Dynamic subtest bsd2: SUCCESS (0.002s)
[414.428894] Starting dynamic subtest: blt
[414.430612] Dynamic subtest blt: SUCCESS (0.002s)
[414.441456] Starting dynamic subtest: vebox
[414.443170] Dynamic subtest vebox: SUCCESS (0.002s)
[414.444882] Subtest legacy-resubmit: SUCCESS (0.044s)
[414.747688] [082/132] (626s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[416.241523] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[416.244536] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[416.460518] [083/132] (624s left) kms_prop_blob (basic)
[416.507852] Starting subtest: basic
[416.509357] Subtest basic: SUCCESS (0.000s)
[416.615235] [084/132] (624s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[418.102433] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[418.105948] Starting dynamic subtest: pipe-A-HDMI-A-1
[418.120270] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[418.131455] Starting dynamic subtest: pipe-B-HDMI-A-1
[418.146155] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[418.157127] Starting dynamic subtest: pipe-C-HDMI-A-1
[418.172050] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[418.182986] Starting dynamic subtest: pipe-D-HDMI-A-1
[418.198669] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[418.201784] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SKIP (0.010s)
[418.360999] [085/132] (622s left) syncobj_timeline (invalid-query-illegal-handle)
[418.411326] Starting subtest: invalid-query-illegal-handle
[418.413073] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[418.537169] [086/132] (622s left) gem_mmap_gtt (cpuset-big-copy-xy)
[418.585248] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[418.676355] [087/132] (622s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[420.171070] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[420.174609] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[420.335539] [088/132] (621s left) gem_exec_params (secure-non-root)
[420.387432] Starting subtest: secure-non-root
[420.390976] Subtest secure-non-root: SKIP (0.000s)
[420.527652] [089/132] (620s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[420.575422] Starting subtest: etime-multi-wait-for-submit-submitted
[420.684378] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.103s)
[420.814479] [090/132] (620s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[422.308945] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[422.311831] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[422.508993] [091/132] (619s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[424.005129] Starting subtest: psr-2p-primscrn-cur-indfb-move
[424.008977] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[424.179585] [092/132] (617s left) syncobj_basic (bad-flags-fd-to-handle)
[424.237622] Starting subtest: bad-flags-fd-to-handle
[424.239240] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[424.352649] [093/132] (617s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[425.847624] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[425.850311] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[426.022981] [094/132] (616s left) kms_plane (plane-panning-bottom-right)
[427.510783] Starting subtest: plane-panning-bottom-right
[427.512363] Starting dynamic subtest: pipe-A
[428.205363] Dynamic subtest pipe-A: SUCCESS (0.693s)
[428.218999] Starting dynamic subtest: pipe-B
[428.740151] Dynamic subtest pipe-B: SUCCESS (0.531s)
[428.741951] Subtest plane-panning-bottom-right: SUCCESS (1.230s)
[428.920514] [095/132] (613s left) gem_render_linear_blits (basic)
[428.973841] Starting subtest: basic
[429.048508] Subtest basic: SUCCESS (0.075s)
[429.169655] [096/132] (613s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[430.663153] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[430.685821] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.021s)
[430.830739] [097/132] (611s left) i915_query (query-topology-coherent-slice-mask)
[430.878843] Starting subtest: query-topology-coherent-slice-mask
[430.880491] Subtest query-topology-coherent-slice-mask: SUCCESS (0.000s)
[431.004340] [098/132] (611s left) gem_create (create-massive)
[431.050862] Starting subtest: create-massive
[431.052468] Subtest create-massive: SUCCESS (0.000s)
[431.304706] [099/132] (611s left) sysfs_heartbeat_interval (precise)
[431.357535] Starting subtest: precise
[431.358983] Starting dynamic subtest: vecs0
[432.645391] Dynamic subtest vecs0: SUCCESS (1.286s)
[432.656949] Starting dynamic subtest: vcs0
[433.924904] Dynamic subtest vcs0: SUCCESS (1.277s)
[433.936590] Starting dynamic subtest: bcs0
[435.178796] Dynamic subtest bcs0: SUCCESS (1.253s)
[435.189990] Starting dynamic subtest: rcs0
[436.423924] Dynamic subtest rcs0: SUCCESS (1.244s)
[436.437805] Starting dynamic subtest: vcs1
[437.654145] Dynamic subtest vcs1: SUCCESS (1.228s)
[437.655739] Subtest precise: SUCCESS (6.297s)
[437.807785] [100/132] (604s left) kms_pm_dc (dc6-dpms)
[440.303657] Starting subtest: dc6-dpms
[440.307956] Subtest dc6-dpms: SKIP (0.000s)
[440.453264] [101/132] (602s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[441.948416] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[441.951604] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[442.180593] [102/132] (600s left) syncobj_basic (bad-destroy-pad)
[442.228040] Starting subtest: bad-destroy-pad
[442.229482] Subtest bad-destroy-pad: SUCCESS (0.000s)
[442.355666] [103/132] (600s left) syncobj_eventfd (timeline-wait-signaled)
[442.403494] Starting subtest: timeline-wait-signaled
[442.404962] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[442.524385] [104/132] (600s left) gem_ctx_param (non-root-set)
[442.571922] Starting subtest: non-root-set
[442.590308] Subtest non-root-set: SUCCESS (0.019s)
[442.754689] [105/132] (600s left) prime_mmap (test_dup)
[442.803219] Starting subtest: test_dup
[442.804783] Starting dynamic subtest: test_dup-smem
[442.902849] Dynamic subtest test_dup-smem: SUCCESS (0.101s)
[442.914223] Starting dynamic subtest: test_dup-lmem0
[443.006565] Dynamic subtest test_dup-lmem0: SUCCESS (0.102s)
[443.008180] Subtest test_dup: SUCCESS (0.206s)
[443.120529] [106/132] (599s left) kms_psr (psr-sprite-blt)
[444.608027] Subtest psr-sprite-blt: SKIP (0.000s)
[444.682181] [107/132] (598s left) kms_dsc (dsc-basic)
[446.170355] Starting subtest: dsc-basic
[446.179236] Subtest dsc-basic: SKIP (0.000s)
[446.318349] [108/132] (596s left) i915_pm_rpm (gem-mmap-type)
[450.035880] Starting subtest: gem-mmap-type
[450.037521] Starting dynamic subtest: fixed-lmem0
[452.241323] Dynamic subtest fixed-lmem0: SUCCESS (2.206s)
[452.252311] Starting dynamic subtest: fixed-smem0
[454.358556] Dynamic subtest fixed-smem0: SUCCESS (2.116s)
[454.360019] Subtest gem-mmap-type: SUCCESS (4.325s)
[455.293784] [109/132] (588s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[455.350022] Starting subtest: y-tiled-to-vebox-x-tiled
[455.351291] Starting dynamic subtest: smem
[455.433009] Dynamic subtest smem: SUCCESS (0.082s)
[455.446423] Starting dynamic subtest: lmem0
[456.189573] Dynamic subtest lmem0: SUCCESS (0.752s)
[456.191114] Subtest y-tiled-to-vebox-x-tiled: SUCCESS (0.837s)
[456.497694] [110/132] (587s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[457.986918] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[457.988608] Starting dynamic subtest: pipe-A-HDMI-A-1
[460.436057] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.439s)
[460.472745] Starting dynamic subtest: pipe-B-HDMI-A-1
[461.362046] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.912s)
[461.396314] Starting dynamic subtest: pipe-C-HDMI-A-1
[462.284850] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.911s)
[462.322563] Starting dynamic subtest: pipe-D-HDMI-A-1
[463.208593] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.912s)
[463.210989] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SUCCESS (5.219s)
[463.452184] [111/132] (580s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[464.994384] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[465.115014] [112/132] (578s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[466.608519] Subtest psr2-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[466.701169] [113/132] (577s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[468.203544] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[468.217442] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[468.382610] [114/132] (575s left) kms_properties (get_properties-sanity-non-atomic)
[469.872982] Starting subtest: get_properties-sanity-non-atomic
[469.874721] Subtest get_properties-sanity-non-atomic: SUCCESS (0.004s)
[469.999368] [115/132] (573s left) kms_addfb_basic (invalid-set-prop)
[470.050600] Starting subtest: invalid-set-prop
[470.051987] Subtest invalid-set-prop: SUCCESS (0.000s)
[471.676957] [116/132] (572s left) i915_hangman (hangcheck-unterminated)
[471.741636] Starting subtest: hangcheck-unterminated
[481.065046] Subtest hangcheck-unterminated: SUCCESS (9.324s)
[481.262608] [117/132] (562s left) kms_concurrent (multi-plane-atomic-lowres)
[482.751351] Starting subtest: multi-plane-atomic-lowres
[482.752650] Starting dynamic subtest: pipe-A-HDMI-A-1
[483.105362] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.352s)
[483.122700] Starting dynamic subtest: pipe-B-HDMI-A-1
[483.456777] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.348s)
[483.470422] Starting dynamic subtest: pipe-C-HDMI-A-1
[483.815288] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.355s)
[483.827140] Starting dynamic subtest: pipe-D-HDMI-A-1
[484.160667] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.342s)
[484.162198] Subtest multi-plane-atomic-lowres: SUCCESS (1.409s)
[484.352435] [118/132] (559s left) gem_mmap_gtt (medium-copy)
[484.406657] Subtest medium-copy: SKIP (0.000s)
[484.492990] [119/132] (559s left) gem_exec_suspend (basic-s3-devices)
[484.552956] Starting subtest: basic-S3-devices
[484.554777] Starting dynamic subtest: smem
[494.947343] Dynamic subtest smem: SUCCESS (10.394s)
[494.961624] Starting dynamic subtest: lmem0
[505.277374] Dynamic subtest lmem0: SUCCESS (10.328s)
[505.279040] Subtest basic-S3-devices: SUCCESS (20.726s)
[513.586990] [120/132] (538s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[515.078608] Starting subtest: flip-vs-cursor-crc-legacy
[515.662654] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.584s)
[515.841459] [121/132] (536s left) gem_exec_reloc (basic-gtt-noreloc)
[515.896577] Subtest basic-gtt-noreloc: SKIP (0.000s)
[516.015673] [122/132] (536s left) sriov_basic (bind-unbind-vf)
[516.065392] Subtest bind-unbind-vf: SKIP (0.000s)
[516.157538] [123/132] (536s left) gem_ctx_shared (create-shared-gtt)
[516.215784] Starting subtest: create-shared-gtt
[518.370175] Subtest create-shared-gtt: SUCCESS (2.151s)
[519.359747] [124/132] (533s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier)
[520.847334] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier
[520.887621] Starting dynamic subtest: pipe-A-plane-0
[521.421951] Dynamic subtest pipe-A-plane-0: SUCCESS (0.533s)
[521.469457] Starting dynamic subtest: pipe-A-plane-3
[521.754943] Dynamic subtest pipe-A-plane-3: SUCCESS (0.326s)
[521.803675] Starting dynamic subtest: pipe-A-plane-5
[522.088092] Dynamic subtest pipe-A-plane-5: SUCCESS (0.328s)
[522.131335] Starting dynamic subtest: pipe-A-plane-7
[522.134659] Dynamic subtest pipe-A-plane-7: SKIP (0.000s)
[522.238572] Starting dynamic subtest: pipe-B-plane-0
[522.628240] Dynamic subtest pipe-B-plane-0: SUCCESS (0.400s)
[522.670158] Starting dynamic subtest: pipe-B-plane-3
[522.961331] Dynamic subtest pipe-B-plane-3: SUCCESS (0.328s)
[523.015017] Starting dynamic subtest: pipe-B-plane-5
[523.294195] Dynamic subtest pipe-B-plane-5: SUCCESS (0.325s)
[523.339586] Starting dynamic subtest: pipe-B-plane-7
[523.342821] Dynamic subtest pipe-B-plane-7: SKIP (0.000s)
[523.366398] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SUCCESS (2.519s)
[523.545929] [125/132] (529s left) gem_ctx_persistence (engines-mixed)
[523.598925] Starting subtest: engines-mixed
[523.600682] Starting dynamic subtest: rcs0
[523.674102] Dynamic subtest rcs0: SUCCESS (0.074s)
[523.690106] Starting dynamic subtest: bcs0
[523.711039] Dynamic subtest bcs0: SUCCESS (0.035s)
[523.731531] Starting dynamic subtest: vcs0
[523.761405] Dynamic subtest vcs0: SUCCESS (0.048s)
[523.789624] Starting dynamic subtest: vcs1
[523.825557] Dynamic subtest vcs1: SUCCESS (0.061s)
[523.867066] Starting dynamic subtest: vecs0
[523.895264] Dynamic subtest vecs0: SUCCESS (0.066s)
[523.897189] Subtest engines-mixed: SUCCESS (0.297s)
[524.078160] [126/132] (528s left) kms_vblank (ts-continuation-modeset-hang)
[525.566091] Starting subtest: ts-continuation-modeset-hang
[525.567762] Starting dynamic subtest: pipe-A-HDMI-A-1
[552.483207] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (26.917s)
[552.500891] Starting dynamic subtest: pipe-D-HDMI-A-1
[577.486807] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (24.998s)
[577.488608] Subtest ts-continuation-modeset-hang: SUCCESS (51.924s)
[577.676722] [127/132] (475s left) kms_psr (psr2-primary-render)
[579.170218] Subtest psr2-primary-render: SKIP (0.000s)
[579.258014] [128/132] (473s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[580.770466] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[582.025197] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.254s)
[582.230703] [129/132] (470s left) dmabuf_sync_file (export-multiwait)
[582.292028] Starting subtest: export-multiwait
[582.293713] Subtest export-multiwait: SUCCESS (0.001s)
[582.415288] [130/132] (470s left) kms_psr (fbc-psr2-primary-render)
[583.905428] Subtest fbc-psr2-primary-render: SKIP (0.000s)
[583.988133] [131/132] (469s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[585.564450] Starting subtest: cursor-rapid-movement-32x32
[585.619426] Subtest cursor-rapid-movement-32x32: SKIP (0.051s)
[586.092635] [132/132] (467s left) gem_busy (busy)
[586.153184] Starting subtest: busy
[586.154516] Starting dynamic subtest: all-engines
[586.218997] Dynamic subtest all-engines: SUCCESS (0.063s)
[586.231778] Starting dynamic subtest: rcs0
[586.282835] Dynamic subtest rcs0: SUCCESS (0.065s)
[586.298804] Starting dynamic subtest: bcs0
[586.331476] Dynamic subtest bcs0: SUCCESS (0.046s)
[586.346652] Starting dynamic subtest: vcs0
[586.371058] Dynamic subtest vcs0: SUCCESS (0.038s)
[586.399179] Starting dynamic subtest: vcs1
[586.412668] Dynamic subtest vcs1: SUCCESS (0.040s)
[586.439156] Starting dynamic subtest: vecs0
[586.454768] Dynamic subtest vecs0: SUCCESS (0.039s)
[586.456217] Subtest busy: SUCCESS (0.302s)
[586.877158] Closing watchdogs
results: parsing output: 0/ for test: kms_ccs
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: syncobj_timeline
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: syncobj_wait
results: parsing output: 5/ for test: i915_drm_fdinfo
results: parsing output: 6/ for test: gem_mmap
results: parsing output: 7/ for test: gem_exec_fence
results: parsing output: 8/ for test: gem_pxp
results: parsing output: 9/ for test: kms_hdr
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: perf
results: parsing output: 12/ for test: kms_async_flips
results: parsing output: 13/ for test: gem_exec_balancer
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: kms_invalid_mode
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: kms_cursor_edge_walk
results: parsing output: 19/ for test: api_intel_bb
results: parsing output: 20/ for test: kms_cursor_legacy
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_plane_lowres
results: parsing output: 23/ for test: gem_lmem_swapping
results: parsing output: 24/ for test: kms_sequence
results: parsing output: 25/ for test: kms_flip
results: parsing output: 26/ for test: intel_hwmon
results: parsing output: 27/ for test: gem_eio
results: parsing output: 28/ for test: kms_flip
results: parsing output: 29/ for test: kms_psr2_sf
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_psr
results: parsing output: 32/ for test: kms_psr2_sf
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_chamelium_edid
results: parsing output: 35/ for test: kms_rotation_crc
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: gem_ctx_shared
results: parsing output: 38/ for test: gem_sync
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_sync
results: parsing output: 41/ for test: gem_exec_schedule
results: parsing output: 42/ for test: gem_softpin
results: parsing output: 43/ for test: gen9_exec_parse
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: perf_pmu
results: parsing output: 46/ for test: gem_mmap_offset
results: parsing output: 47/ for test: kms_cursor_crc
results: parsing output: 48/ for test: gem_mmap_gtt
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_plane_scaling
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: i915_pm_rps
results: parsing output: 53/ for test: syncobj_wait
results: parsing output: 54/ for test: kms_chamelium_color
results: parsing output: 55/ for test: kms_flip_scaled_crc
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: prime_mmap_coherency
results: parsing output: 58/ for test: kms_color_pipeline
results: parsing output: 59/ for test: gem_vm_create
results: parsing output: 60/ for test: api_intel_allocator
results: parsing output: 61/ for test: perf
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: kms_rotation_crc
results: parsing output: 64/ for test: gem_exec_fence
results: parsing output: 65/ for test: gem_mmap_wc
results: parsing output: 66/ for test: gem_mmap_wc
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: gem_exec_schedule
results: parsing output: 70/ for test: kms_cursor_legacy
results: parsing output: 71/ for test: kms_cursor_legacy
results: parsing output: 72/ for test: kms_flip_scaled_crc
results: parsing output: 73/ for test: kms_joiner
results: parsing output: 74/ for test: gem_exec_whisper
results: parsing output: 75/ for test: kms_busy
results: parsing output: 76/ for test: kms_pipe_stress
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_exec_fence
results: parsing output: 79/ for test: kms_cursor_legacy
results: parsing output: 80/ for test: gem_spin_batch
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_prop_blob
results: parsing output: 83/ for test: kms_ccs
results: parsing output: 84/ for test: syncobj_timeline
results: parsing output: 85/ for test: gem_mmap_gtt
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_exec_params
results: parsing output: 88/ for test: syncobj_timeline
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: syncobj_basic
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_plane
results: parsing output: 94/ for test: gem_render_linear_blits
results: parsing output: 95/ for test: kms_flip
results: parsing output: 96/ for test: i915_query
results: parsing output: 97/ for test: gem_create
results: parsing output: 98/ for test: sysfs_heartbeat_interval
results: parsing output: 99/ for test: kms_pm_dc
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: syncobj_basic
results: parsing output: 102/ for test: syncobj_eventfd
results: parsing output: 103/ for test: gem_ctx_param
results: parsing output: 104/ for test: prime_mmap
results: parsing output: 105/ for test: kms_psr
results: parsing output: 106/ for test: kms_dsc
results: parsing output: 107/ for test: i915_pm_rpm
results: parsing output: 108/ for test: gem_render_copy
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: kms_chamelium_hpd
results: parsing output: 111/ for test: kms_psr2_sf
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_properties
results: parsing output: 114/ for test: kms_addfb_basic
results: parsing output: 115/ for test: i915_hangman
results: parsing output: 116/ for test: kms_concurrent
results: parsing output: 117/ for test: gem_mmap_gtt
results: parsing output: 118/ for test: gem_exec_suspend
results: parsing output: 119/ for test: kms_cursor_legacy
results: parsing output: 120/ for test: gem_exec_reloc
results: parsing output: 121/ for test: sriov_basic
results: parsing output: 122/ for test: gem_ctx_shared
results: parsing output: 123/ for test: kms_plane
results: parsing output: 124/ for test: gem_ctx_persistence
results: parsing output: 125/ for test: kms_vblank
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: dmabuf_sync_file
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: kms_cursor_crc
results: parsing output: 131/ for test: gem_busy
Done.