[61.961676] Initializing watchdogs
[61.961736]   /dev/watchdog0
[61.976743] [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]
[61.980931] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.983178] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.986597] [001/133] (960s left) kms_big_fb (y-tiled-addfb-size-overflow)
[62.119393] Starting subtest: y-tiled-addfb-size-overflow
[62.124033] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[62.214260] [002/133] (960s left) kms_psr (fbc-pr-sprite-plane-move)
[62.314719] Starting subtest: fbc-pr-sprite-plane-move
[62.319334] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[62.381956] [003/133] (960s left) kms_psr (psr2-primary-page-flip)
[62.473277] Starting subtest: psr2-primary-page-flip
[62.475582] Starting dynamic subtest: eDP-1
[64.261482] Dynamic subtest eDP-1: SUCCESS (1.786s)
[64.263816] Subtest psr2-primary-page-flip: SUCCESS (1.787s)
[65.127766] [004/133] (957s left) gem_ctx_persistence (engines-mixed-process)
[65.198931] Starting subtest: engines-mixed-process
[65.201202] Starting dynamic subtest: rcs0
[66.902464] Dynamic subtest rcs0: SUCCESS (1.701s)
[66.911511] Starting dynamic subtest: bcs0
[68.889958] Dynamic subtest bcs0: SUCCESS (1.985s)
[68.897266] Starting dynamic subtest: vcs0
[70.945707] Dynamic subtest vcs0: SUCCESS (2.052s)
[70.955798] Starting dynamic subtest: vcs1
[72.932074] Dynamic subtest vcs1: SUCCESS (1.986s)
[72.941437] Starting dynamic subtest: vecs0
[74.910578] Dynamic subtest vecs0: SUCCESS (1.977s)
[74.920702] Starting dynamic subtest: ccs0
[76.933823] Dynamic subtest ccs0: SUCCESS (2.021s)
[76.936337] Subtest engines-mixed-process: SUCCESS (11.726s)
[77.033921] [005/133] (945s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[77.137769] Starting subtest: fbc-rgb101010-draw-blt
[81.757596] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.621s)
[82.938369] [006/133] (939s left) kms_lease (lease-unleased-connector)
[83.030064] Starting subtest: lease-unleased-connector
[83.032681] Starting dynamic subtest: pipe-A-eDP-1
[83.037985] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[83.049887] Starting dynamic subtest: pipe-B-eDP-1
[83.052681] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.006s)
[83.060398] Starting dynamic subtest: pipe-C-eDP-1
[83.062253] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.006s)
[83.069759] Starting dynamic subtest: pipe-D-eDP-1
[83.071661] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[83.073584] Subtest lease-unleased-connector: SUCCESS (0.030s)
[83.173858] [007/133] (939s left) kms_pm_dc (dc5-psr)
[84.265938] Starting subtest: dc5-psr
[87.243811] Subtest dc5-psr: SUCCESS (2.978s)
[88.038913] [008/133] (934s left) kms_fence_pin_leak
[88.210882] [009/133] (934s left) i915_drm_fdinfo (most-busy-check-all)
[88.248394] Starting subtest: most-busy-check-all
[88.250436] Starting dynamic subtest: rcs0
[88.257550] Dynamic subtest rcs0: SKIP (0.007s)
[88.266247] Starting dynamic subtest: bcs0
[88.270569] Dynamic subtest bcs0: SKIP (0.001s)
[88.278228] Starting dynamic subtest: vcs0
[88.282250] Dynamic subtest vcs0: SKIP (0.001s)
[88.289270] Starting dynamic subtest: vcs1
[88.293453] Dynamic subtest vcs1: SKIP (0.000s)
[88.300267] Starting dynamic subtest: vecs0
[88.304328] Dynamic subtest vecs0: SKIP (0.001s)
[88.311215] Starting dynamic subtest: ccs0
[88.315267] Dynamic subtest ccs0: SKIP (0.000s)
[88.319294] Subtest most-busy-check-all: SKIP (0.013s)
[88.352711] [010/133] (934s left) gem_exec_nop (basic-sequential)
[88.451616] Starting subtest: basic-sequential
[103.414722] Subtest basic-sequential: SUCCESS (14.946s)
[103.602887] [011/133] (919s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[103.717736] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[103.719965] Starting dynamic subtest: pipe-A-eDP-1
[103.791889] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[103.802054] Starting dynamic subtest: pipe-B-eDP-1
[104.913236] Dynamic subtest pipe-B-eDP-1: SKIP (1.121s)
[104.917731] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.200s)
[106.109072] [012/133] (916s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[106.161624] Starting subtest: yf-tiled-to-vebox-x-tiled
[106.166246] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[106.355375] [013/133] (916s left) prime_vgem (fence-write-hang)
[106.468677] Subtest fence-write-hang: SKIP (0.000s)
[106.565213] [FACT prime_vgem (fence-write-hang)] new: kernel.kmod_is_loaded.vgem: true
[106.569252] [014/133] (916s left) vgem_basic (bad-flag)
[106.620329] Starting subtest: bad-flag
[106.622255] Subtest bad-flag: SUCCESS (0.000s)
[106.679160] [015/133] (916s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[106.765794] Starting subtest: fbc-psr2-sprite-plane-onoff
[106.767994] Starting dynamic subtest: eDP-1
[106.772090] Dynamic subtest eDP-1: SKIP (0.000s)
[106.776423] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.000s)
[106.837852] [016/133] (916s left) gem_lmem_swapping (heavy-multi)
[106.884538] Subtest heavy-multi: SKIP (0.000s)
[106.924881] [017/133] (916s left) gem_readwrite (new-obj)
[106.988573] Subtest new-obj: SKIP (0.000s)
[107.041592] [018/133] (916s left) gem_create (busy-create)
[107.099808] Starting subtest: busy-create
[107.102106] Starting dynamic subtest: smem0
[140.885877] Dynamic subtest smem0: SUCCESS (33.784s)
[140.888315] Subtest busy-create: SUCCESS (33.785s)
[141.084598] [019/133] (882s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[141.199412] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[141.203921] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[141.296335] [020/133] (881s left) gem_softpin (allocator-nopin-reserve)
[141.356403] Starting subtest: allocator-nopin-reserve
[141.445936] Subtest allocator-nopin-reserve: SUCCESS (0.089s)
[141.562596] [021/133] (881s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[141.681766] Starting subtest: basic-flip-after-cursor-legacy
[142.627610] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.946s)
[143.429574] [022/133] (879s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[143.488082] Starting subtest: multi-wait-for-submit-unsubmitted
[143.595282] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.106s)
[143.669199] [023/133] (879s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[143.782380] Starting subtest: fbc-pr-cursor-mmap-gtt
[143.786858] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[143.852062] [024/133] (879s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k)
[144.232808] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s)
[145.039316] [025/133] (878s left) gem_exec_balancer (parallel)
[145.289549] Starting subtest: parallel
[146.251295] Subtest parallel: SUCCESS (0.961s)
[146.941773] [026/133] (876s left) gem_pxp (create-protected-buffer)
[147.060159] Starting subtest: create-protected-buffer
[147.062646] Subtest create-protected-buffer: SUCCESS (0.000s)
[147.173128] [027/133] (876s left) gem_exec_schedule (preempt-queue)
[147.264629] Subtest preempt-queue: SKIP (0.000s)
[147.571177] [028/133] (875s left) kms_addfb_basic (addfb25-4-tiled)
[147.670063] Starting subtest: addfb25-4-tiled
[147.672385] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[147.766145] [029/133] (875s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[147.833099] Subtest writes-after-reads-snoop: SKIP (0.000s)
[147.932941] [030/133] (875s left) perf_pmu (rc6-suspend)
[147.968061] Starting subtest: rc6-suspend
[170.580686] Subtest rc6-suspend: SUCCESS (7.815s)
[171.483376] [031/133] (852s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[171.604520] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[171.608948] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[171.690771] [032/133] (852s left) core_sysfs (read-all-entries)
[171.741454] Starting subtest: read-all-entries
[171.743312] Subtest read-all-entries: SUCCESS (0.003s)
[171.826641] [033/133] (851s left) kms_plane_cursor (primary)
[171.929815] Starting subtest: primary
[171.933985] Starting dynamic subtest: pipe-A-eDP-1-size-64
[174.512593] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.566s)
[174.537576] Starting dynamic subtest: pipe-A-eDP-1-size-128
[177.103654] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.561s)
[177.130041] Starting dynamic subtest: pipe-A-eDP-1-size-256
[179.668271] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.539s)
[179.989139] Starting dynamic subtest: pipe-B-eDP-1-size-64
[183.350886] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.364s)
[183.374903] Starting dynamic subtest: pipe-B-eDP-1-size-128
[185.957058] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.583s)
[185.981278] Starting dynamic subtest: pipe-B-eDP-1-size-256
[188.517118] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.538s)
[188.835877] Starting dynamic subtest: pipe-C-eDP-1-size-64
[191.780688] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.952s)
[191.808177] Starting dynamic subtest: pipe-C-eDP-1-size-128
[193.971582] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.170s)
[193.997731] Starting dynamic subtest: pipe-C-eDP-1-size-256
[196.173566] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.181s)
[196.491270] Starting dynamic subtest: pipe-D-eDP-1-size-64
[199.400321] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.919s)
[199.426415] Starting dynamic subtest: pipe-D-eDP-1-size-128
[201.604009] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.183s)
[201.628928] Starting dynamic subtest: pipe-D-eDP-1-size-256
[203.857545] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.236s)
[204.165720] Subtest primary: SUCCESS (32.170s)
[204.971728] [034/133] (818s left) kms_vblank (wait-busy-hang)
[205.071876] Starting subtest: wait-busy-hang
[205.073861] Starting dynamic subtest: pipe-A-eDP-1
[231.413547] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.330s)
[231.428425] Starting dynamic subtest: pipe-D-eDP-1
[246.392989] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.967s)
[246.395286] Subtest wait-busy-hang: SUCCESS (41.302s)
[247.238170] [035/133] (776s left) kms_feature_discovery (dp-mst)
[247.344250] Starting subtest: dp-mst
[247.348608] Subtest dp-mst: SKIP (0.000s)
[247.418189] [036/133] (776s left) prime_busy (hang-wait)
[247.486652] Starting subtest: hang-wait
[247.489108] Starting dynamic subtest: rcs0
[273.114382] Dynamic subtest rcs0: SUCCESS (25.623s)
[273.125622] Starting dynamic subtest: bcs0
[280.260277] Dynamic subtest bcs0: SUCCESS (7.146s)
[280.271011] Starting dynamic subtest: vcs0
[287.237373] Dynamic subtest vcs0: SUCCESS (6.979s)
[287.246316] Starting dynamic subtest: vcs1
[294.284394] Dynamic subtest vcs1: SUCCESS (7.041s)
[294.298141] Starting dynamic subtest: vecs0
[301.253551] Dynamic subtest vecs0: SUCCESS (6.968s)
[301.265061] Starting dynamic subtest: ccs0
[315.153113] Dynamic subtest ccs0: SUCCESS (13.895s)
[315.155672] Subtest hang-wait: SUCCESS (67.668s)
[315.277976] [037/133] (708s left) kms_color (ctm-0-25)
[315.371383] Starting subtest: ctm-0-25
[315.373649] Starting dynamic subtest: pipe-A-eDP-1
[318.938399] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.567s)
[318.948427] Starting dynamic subtest: pipe-B-eDP-1
[323.216205] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.276s)
[323.225199] Starting dynamic subtest: pipe-C-eDP-1
[327.180905] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.961s)
[327.192617] Starting dynamic subtest: pipe-D-eDP-1
[331.179076] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.998s)
[331.181401] Subtest ctm-0-25: SUCCESS (15.806s)
[331.999572] [038/133] (691s left) kms_cursor_crc (cursor-sliding-256x256)
[332.246168] Starting subtest: cursor-sliding-256x256
[332.252043] Starting dynamic subtest: pipe-A-eDP-1
[335.553657] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.302s)
[335.583370] Starting dynamic subtest: pipe-D-eDP-1
[339.503902] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.925s)
[339.506051] Subtest cursor-sliding-256x256: SUCCESS (7.255s)
[340.377748] [039/133] (683s left) i915_suspend (sysfs-reader)
[340.452906] Starting subtest: sysfs-reader
[358.181107] Subtest sysfs-reader: SUCCESS (3.106s)
[358.269752] [040/133] (665s left) gem_eio (wait-wedge-10ms)
[358.512303] Starting subtest: wait-wedge-10ms
[360.353088] Subtest wait-wedge-10ms: SUCCESS (1.817s)
[360.481368] [041/133] (663s left) i915_pm_rpm (system-suspend)
[362.439362] Starting subtest: system-suspend
[380.002143] Subtest system-suspend: SUCCESS (2.859s)
[380.399503] [042/133] (643s left) gem_exec_balancer (sequential)
[380.475819] Starting subtest: sequential
[383.566435] Subtest sequential: SUCCESS (3.057s)
[383.872224] [043/133] (640s left) kms_pm_rpm (system-suspend-idle)
[386.105330] Starting subtest: system-suspend-idle
[405.459959] Subtest system-suspend-idle: SUCCESS (4.282s)
[405.840929] [044/133] (618s left) gem_ctx_persistence (heartbeat-many)
[405.909073] Starting subtest: heartbeat-many
[405.914828] Subtest heartbeat-many: SKIP (0.000s)
[406.027160] [045/133] (618s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[406.113840] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[406.119150] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[406.238245] [046/133] (618s left) gem_ctx_exec (basic)
[406.294105] Starting subtest: basic
[406.299719] Subtest basic: SUCCESS (0.006s)
[406.419910] [047/133] (617s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[406.525074] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[406.529937] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[406.609948] [048/133] (617s left) gem_ccs (ctrl-surf-copy)
[406.664335] Starting subtest: ctrl-surf-copy
[406.669576] Subtest ctrl-surf-copy: SKIP (0.000s)
[406.758217] [049/133] (617s left) kms_cursor_crc (cursor-sliding-128x42)
[406.991460] Starting subtest: cursor-sliding-128x42
[407.044890] Subtest cursor-sliding-128x42: SKIP (0.049s)
[407.255635] [050/133] (617s left) kms_cursor_crc (cursor-onscreen-128x128)
[407.483438] Starting subtest: cursor-onscreen-128x128
[407.488457] Starting dynamic subtest: pipe-A-eDP-1
[409.616367] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.111s)
[409.644555] Starting dynamic subtest: pipe-D-eDP-1
[412.475219] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.822s)
[412.477783] Subtest cursor-onscreen-128x128: SUCCESS (4.958s)
[413.339438] [051/133] (611s left) kms_flip (2x-flip-vs-panning-vs-hang)
[413.437225] Starting subtest: 2x-flip-vs-panning-vs-hang
[413.445800] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.011s)
[413.534225] [052/133] (611s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[413.595665] Starting subtest: yf-tiled-ccs-to-yf-tiled
[413.600593] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[413.785299] [053/133] (610s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[413.873671] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[413.876621] Starting dynamic subtest: pipe-A-eDP-1
[414.295442] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.420s)
[414.307540] Starting dynamic subtest: pipe-B-eDP-1
[414.328694] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.003s)
[414.339707] Starting dynamic subtest: pipe-C-eDP-1
[414.363177] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.005s)
[414.372566] Starting dynamic subtest: pipe-D-eDP-1
[414.395660] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[414.398497] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.441s)
[416.618848] [054/133] (608s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[417.019813] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[417.848532] [055/133] (606s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[417.948526] Starting subtest: psr-rgb565-draw-pwrite
[425.005981] Subtest psr-rgb565-draw-pwrite: SUCCESS (7.046s)
[425.112227] [056/133] (599s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[425.213463] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[425.218645] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[425.303873] [057/133] (599s left) gem_ctx_sseu (mmap-args)
[425.358120] Subtest mmap-args: SKIP (0.000s)
[425.428228] [058/133] (599s left) kms_getfb (getfb2-into-addfb2)
[425.529379] Starting subtest: getfb2-into-addfb2
[425.532431] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[425.628982] [059/133] (599s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[425.727142] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[425.732422] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[425.827169] [060/133] (599s left) gem_exec_params (invalid-batch-start-offset)
[425.884092] Starting subtest: invalid-batch-start-offset
[425.890129] Subtest invalid-batch-start-offset: SUCCESS (0.002s)
[425.997050] [061/133] (599s left) kms_flip (2x-dpms-vs-vblank-race)
[426.081427] Starting subtest: 2x-dpms-vs-vblank-race
[426.090370] Subtest 2x-dpms-vs-vblank-race: SKIP (0.010s)
[426.179092] [062/133] (598s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[426.236962] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[426.345521] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.107s)
[426.428932] [063/133] (598s left) gem_mmap_gtt (fault-concurrent-x)
[426.488490] Subtest fault-concurrent-X: SKIP (0.000s)
[426.555666] [064/133] (598s left) gem_render_copy_redux (normal)
[426.612680] Starting subtest: normal
[426.902892] Subtest normal: SUCCESS (0.289s)
[427.018700] [065/133] (598s left) kms_psr (psr2-cursor-blt)
[427.106686] Starting subtest: psr2-cursor-blt
[427.109445] Starting dynamic subtest: eDP-1
[428.832950] Dynamic subtest eDP-1: SUCCESS (1.725s)
[428.835618] Subtest psr2-cursor-blt: SUCCESS (1.727s)
[429.714412] [066/133] (595s left) gem_exec_capture (userptr)
[429.773289] Starting subtest: userptr
[430.611087] Subtest userptr: SUCCESS (0.835s)
[430.719681] [067/133] (594s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[430.811704] Starting subtest: flip-vs-dpms-off-vs-modeset
[430.814507] Starting dynamic subtest: A-eDP1
[434.473559] Dynamic subtest A-eDP1: SUCCESS (3.662s)
[434.484444] Starting dynamic subtest: B-eDP1
[437.672702] Dynamic subtest B-eDP1: SUCCESS (3.197s)
[437.684432] Starting dynamic subtest: C-eDP1
[440.805814] Dynamic subtest C-eDP1: SUCCESS (3.132s)
[440.816824] Starting dynamic subtest: D-eDP1
[443.922390] Dynamic subtest D-eDP1: SUCCESS (3.117s)
[443.925056] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.115s)
[444.718063] [068/133] (580s left) kms_properties (plane-properties-legacy)
[444.807734] Starting subtest: plane-properties-legacy
[444.810469] Starting dynamic subtest: pipe-A-eDP-1
[445.354842] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.548s)
[445.369491] Starting dynamic subtest: pipe-B-eDP-1
[446.608430] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.253s)
[446.629346] Starting dynamic subtest: pipe-C-eDP-1
[447.848671] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.236s)
[447.863384] Starting dynamic subtest: pipe-D-eDP-1
[449.083794] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.236s)
[449.086666] Subtest plane-properties-legacy: SUCCESS (4.278s)
[449.885961] [069/133] (575s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[449.986616] Starting subtest: x-tiled-16bpp-rotate-270
[450.008689] Subtest x-tiled-16bpp-rotate-270: SKIP (0.021s)
[450.134275] [070/133] (575s left) gem_exec_params (no-bsd)
[450.207418] Starting subtest: no-bsd
[450.209534] Subtest no-bsd: SUCCESS (0.002s)
[452.087584] [071/133] (573s left) gem_eio (wait-10ms)
[452.296717] Starting subtest: wait-10ms
[452.634585] Subtest wait-10ms: SUCCESS (0.338s)
[452.777228] [072/133] (572s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[452.834613] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[452.837508] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[452.926637] [073/133] (572s left) gem_exec_fence (syncobj-export)
[453.367356] Starting subtest: syncobj-export
[453.373718] Subtest syncobj-export: SUCCESS (0.005s)
[455.101239] [074/133] (570s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[455.207138] Starting subtest: fbc-rgb565-draw-pwrite
[460.033485] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.829s)
[461.192440] [075/133] (564s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[461.296000] Starting subtest: fbcpsr-indfb-scaledprimary
[467.062578] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.768s)
[467.187067] [076/133] (558s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[467.287612] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[467.292675] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[467.383072] [077/133] (558s left) api_intel_bb (object-noreloc-keep-cache-simple)
[467.434832] Starting subtest: object-noreloc-keep-cache-simple
[467.439420] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.007s)
[467.570917] [078/133] (558s left) syncobj_wait (wait-for-submit-delayed-submit)
[467.622637] Starting subtest: wait-for-submit-delayed-submit
[467.723290] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[467.806286] [079/133] (557s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[467.898278] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[467.900904] Starting dynamic subtest: pipe-A-eDP-1
[467.929676] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[467.950811] Starting dynamic subtest: pipe-B-eDP-1
[467.978547] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[468.000155] Starting dynamic subtest: pipe-C-eDP-1
[468.025914] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[468.046236] Starting dynamic subtest: pipe-D-eDP-1
[468.069053] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[468.073004] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.005s)
[470.159126] [080/133] (555s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[470.264167] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[470.268963] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[470.354043] [081/133] (555s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[470.442589] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[470.452977] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.010s)
[470.538143] [082/133] (555s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[470.628816] Starting subtest: fbc-dirtyfb-ioctl
[470.631468] Starting dynamic subtest: A-eDP-1
[473.258277] Dynamic subtest A-eDP-1: SUCCESS (2.630s)
[473.260847] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.631s)
[474.127471] [083/133] (551s left) gem_caching (reads)
[474.181706] Subtest reads: SKIP (0.000s)
[474.252696] [084/133] (551s left) kms_pipe_crc_basic (read-crc)
[474.340106] Starting subtest: read-crc
[474.342457] Starting dynamic subtest: pipe-A-eDP-1
[475.052579] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.711s)
[475.063535] Starting dynamic subtest: pipe-B-eDP-1
[476.402542] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.348s)
[476.416894] Starting dynamic subtest: pipe-C-eDP-1
[477.678770] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.276s)
[477.690233] Starting dynamic subtest: pipe-D-eDP-1
[479.034570] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.353s)
[479.037490] Subtest read-crc: SUCCESS (4.694s)
[479.862171] [085/133] (546s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[479.920441] Starting subtest: single-wait-for-submit-available-signaled
[479.922553] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[480.013537] [086/133] (546s left) gem_render_copy (y-tiled)
[480.072676] Starting subtest: y-tiled
[480.077597] Subtest y-tiled: SKIP (0.000s)
[480.254556] [087/133] (545s left) gem_userptr_blits (map-fixed-invalidate-busy)
[480.336859] Starting subtest: map-fixed-invalidate-busy
[480.342268] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[480.453516] [088/133] (545s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[480.549801] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[480.554716] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[480.653475] [089/133] (545s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[480.759688] Starting subtest: 4-tiled-16bpp-rotate-90
[480.779704] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.019s)
[480.895162] [090/133] (545s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[480.993441] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[480.995796] Starting dynamic subtest: pipe-A-eDP-1
[481.019241] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[481.029784] Starting dynamic subtest: pipe-B-eDP-1
[481.055740] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[481.065265] Starting dynamic subtest: pipe-C-eDP-1
[481.089568] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[481.098994] Starting dynamic subtest: pipe-D-eDP-1
[481.123928] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[481.129185] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[483.228433] [091/133] (543s left) gen9_exec_parse (bb-start-cmd)
[483.296771] Subtest bb-start-cmd: SKIP (0.000s)
[483.377169] [092/133] (542s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[483.478549] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[483.481300] Starting dynamic subtest: pipe-A-eDP-1
[484.198840] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.711s)
[484.208383] Starting dynamic subtest: pipe-B-eDP-1
[485.949445] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.747s)
[485.960537] Starting dynamic subtest: pipe-C-eDP-1
[487.787776] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.837s)
[487.802613] Starting dynamic subtest: pipe-D-eDP-1
[489.600842] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.808s)
[489.603633] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.111s)
[490.740147] [093/133] (535s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[490.860658] Starting subtest: cursorB-vs-flipB-atomic-transitions
[490.866417] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s)
[491.003586] [094/133] (535s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[491.111400] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[491.113741] Starting dynamic subtest: pipe-A
[491.129519] Dynamic subtest pipe-A: SKIP (0.016s)
[491.140310] Starting dynamic subtest: pipe-B
[491.162236] Dynamic subtest pipe-B: SKIP (0.029s)
[491.172797] Starting dynamic subtest: pipe-C
[491.191596] Dynamic subtest pipe-C: SKIP (0.029s)
[491.202389] Starting dynamic subtest: pipe-D
[491.219505] Dynamic subtest pipe-D: SKIP (0.029s)
[491.223814] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.106s)
[491.306600] [095/133] (535s left) kms_big_fb (linear-16bpp-rotate-180)
[491.411773] Starting subtest: linear-16bpp-rotate-180
[492.836573] Subtest linear-16bpp-rotate-180: SUCCESS (1.426s)
[492.960364] [096/133] (533s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[493.061608] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[493.064186] Starting dynamic subtest: pipe-A-eDP-1
[493.159113] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[493.169340] Starting dynamic subtest: pipe-B-eDP-1
[494.331453] Dynamic subtest pipe-B-eDP-1: SKIP (1.169s)
[494.336406] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.272s)
[495.607099] [097/133] (530s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[495.707266] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[495.709631] Starting dynamic subtest: pipe-A-eDP-1
[495.719223] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[495.729243] Starting dynamic subtest: pipe-B-eDP-1
[495.739463] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[495.749709] Starting dynamic subtest: pipe-C-eDP-1
[495.759232] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[495.768524] Starting dynamic subtest: pipe-D-eDP-1
[495.777789] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[495.782507] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[497.980342] [098/133] (528s left) kms_invalid_mode (bad-hsync-end)
[498.070718] Starting subtest: bad-hsync-end
[498.073311] Starting dynamic subtest: pipe-A-eDP-1
[498.363280] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.293s)
[498.374836] Starting dynamic subtest: pipe-B-eDP-1
[498.377246] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[498.387051] Starting dynamic subtest: pipe-C-eDP-1
[498.389564] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[498.402054] Starting dynamic subtest: pipe-D-eDP-1
[498.404677] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[498.407359] Subtest bad-hsync-end: SUCCESS (0.299s)
[499.212982] [099/133] (527s left) kms_properties (get_properties-sanity-atomic)
[499.312720] Starting subtest: get_properties-sanity-atomic
[499.315724] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[499.394528] [100/133] (527s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[499.507600] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[499.512724] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[499.582140] [101/133] (527s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[499.693460] Starting subtest: short-flip-before-cursor-toggle
[500.617402] Subtest short-flip-before-cursor-toggle: SUCCESS (0.925s)
[501.449369] [102/133] (525s left) gem_exec_schedule (submit-golden-slice)
[501.524677] Starting subtest: submit-golden-slice
[501.527464] Starting dynamic subtest: rcs0
[501.565380] Dynamic subtest rcs0: SUCCESS (0.052s)
[501.577524] Starting dynamic subtest: bcs0
[501.609813] Dynamic subtest bcs0: SUCCESS (0.044s)
[501.621548] Starting dynamic subtest: vcs0
[501.647867] Dynamic subtest vcs0: SUCCESS (0.037s)
[501.658445] Starting dynamic subtest: vcs1
[501.693873] Dynamic subtest vcs1: SUCCESS (0.045s)
[501.705516] Starting dynamic subtest: vecs0
[501.757970] Dynamic subtest vecs0: SUCCESS (0.062s)
[501.770549] Starting dynamic subtest: ccs0
[501.798274] Dynamic subtest ccs0: SUCCESS (0.040s)
[501.800959] Subtest submit-golden-slice: SUCCESS (0.286s)
[503.105640] [103/133] (523s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[503.208649] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[509.974854] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.773s)
[510.102479] [104/133] (516s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[510.228487] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[542.118348] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.889s)
[542.926980] [105/133] (483s left) kms_vblank (query-busy-hang)
[543.029537] Starting subtest: query-busy-hang
[543.032133] Starting dynamic subtest: pipe-A-eDP-1
[569.765432] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.726s)
[569.783076] Starting dynamic subtest: pipe-D-eDP-1
[594.729098] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.958s)
[594.731815] Subtest query-busy-hang: SUCCESS (51.689s)
[595.611799] [106/133] (431s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[595.705550] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[595.710822] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s)
[595.831362] [107/133] (431s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[595.943707] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[595.948374] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[596.039522] [108/133] (431s left) perf (gen12-oa-tlb-invalidate)
[596.164157] Starting subtest: gen12-oa-tlb-invalidate
[596.166906] Starting dynamic subtest: 0-rcs0
[606.277519] Dynamic subtest 0-rcs0: SUCCESS (10.062s)
[606.290132] Starting dynamic subtest: 1-vcs1
[616.327682] Dynamic subtest 1-vcs1: SUCCESS (10.044s)
[616.331186] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.109s)
[616.374881] [109/133] (410s left) gem_exec_params (invalid-bsd1-flag-on-render)
[616.456004] Starting subtest: invalid-bsd1-flag-on-render
[616.458600] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[616.549130] [110/133] (410s left) gem_partial_pwrite_pread (write-snoop)
[616.610796] Subtest write-snoop: SKIP (0.000s)
[616.673503] [111/133] (410s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[616.770473] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[616.775482] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[616.870579] [112/133] (410s left) gem_userptr_blits (vma-merge)
[616.950685] Starting subtest: vma-merge
[616.989773] Subtest vma-merge: SUCCESS (0.042s)
[617.114935] [113/133] (410s left) syncobj_timeline (etime-single-wait-all-submitted)
[617.174634] Starting subtest: etime-single-wait-all-submitted
[617.280499] Subtest etime-single-wait-all-submitted: SUCCESS (0.107s)
[617.359191] [114/133] (409s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[617.486003] Starting subtest: 2x-long-flip-vs-cursor-legacy
[617.491630] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s)
[617.642098] [115/133] (409s left) gem_mmap_wc (write)
[617.693483] Subtest write: SKIP (0.000s)
[617.750374] [116/133] (409s left) kms_plane (pixel-format-x-tiled-modifier)
[617.842069] Starting subtest: pixel-format-x-tiled-modifier
[617.868133] Starting dynamic subtest: pipe-A-plane-0
[618.545584] Dynamic subtest pipe-A-plane-0: SUCCESS (0.678s)
[618.555216] Starting dynamic subtest: pipe-A-plane-3
[619.002068] Dynamic subtest pipe-A-plane-3: SUCCESS (0.455s)
[619.011727] Starting dynamic subtest: pipe-A-plane-5
[619.015781] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[620.109224] Starting dynamic subtest: pipe-B-plane-0
[620.835077] Dynamic subtest pipe-B-plane-0: SUCCESS (0.733s)
[620.847269] Starting dynamic subtest: pipe-B-plane-3
[621.301600] Dynamic subtest pipe-B-plane-3: SUCCESS (0.465s)
[621.314056] Starting dynamic subtest: pipe-B-plane-5
[621.318100] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[621.617599] Subtest pixel-format-x-tiled-modifier: SUCCESS (3.776s)
[622.480098] [117/133] (404s left) kms_content_protection (dp-mst-type-0-hdcp14)
[622.625001] Starting subtest: dp-mst-type-0-hdcp14
[622.630833] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[622.747387] [118/133] (404s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[622.835661] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[623.870679] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.037s)
[624.006403] [119/133] (403s left) gem_exec_whisper (basic-forked-all)
[624.072814] Starting subtest: basic-forked-all
[637.993087] Subtest basic-forked-all: SUCCESS (13.918s)
[638.181200] [120/133] (389s left) kms_async_flips (crc-atomic)
[638.278608] Starting subtest: crc-atomic
[638.648787] Starting dynamic subtest: pipe-A-eDP-1
[641.620086] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.949s)
[641.979321] Starting dynamic subtest: pipe-B-eDP-1
[644.993442] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.006s)
[645.335341] Starting dynamic subtest: pipe-C-eDP-1
[648.220909] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.897s)
[648.587483] Starting dynamic subtest: pipe-D-eDP-1
[651.486651] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.879s)
[651.489846] Subtest crc-atomic: SUCCESS (13.179s)
[652.625157] [121/133] (375s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[652.685166] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[652.748647] [122/133] (374s left) sw_sync (sync_merge_same)
[652.784344] Starting subtest: sync_merge_same
[652.786801] Subtest sync_merge_same: SUCCESS (0.000s)
[652.840652] [123/133] (374s left) syncobj_wait (multi-wait-signaled)
[652.892952] Starting subtest: multi-wait-signaled
[652.895632] Subtest multi-wait-signaled: SUCCESS (0.000s)
[652.999039] [124/133] (374s left) gem_mmap_gtt (hang-user)
[653.057584] Subtest hang-user: SKIP (0.000s)
[653.123314] [125/133] (374s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[653.216684] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[653.219416] Starting dynamic subtest: pipe-A
[654.454973] Dynamic subtest pipe-A: SUCCESS (1.241s)
[654.468599] Starting dynamic subtest: pipe-B
[656.761595] Dynamic subtest pipe-B: SUCCESS (2.306s)
[656.777531] Starting dynamic subtest: pipe-C
[657.934983] Dynamic subtest pipe-C: SUCCESS (1.171s)
[657.946574] Starting dynamic subtest: pipe-D
[659.161287] Dynamic subtest pipe-D: SUCCESS (1.225s)
[659.163667] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.948s)
[660.349886] [126/133] (367s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[660.452138] Starting subtest: primary-4-tiled-reflect-x-180
[667.691233] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.239s)
[668.908659] [127/133] (358s left) i915_module_load (reload)
[668.946707] Starting subtest: reload
[673.062414] Subtest reload: SUCCESS (4.113s)
[673.111299] [128/133] (354s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[674.959732] Starting subtest: multi-wait-all-for-submit-available-submitted
[674.962813] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.001s)
[675.084844] [129/133] (352s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[675.181658] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[675.186677] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[675.264858] [130/133] (352s left) kms_fbcon_fbt (psr-suspend)
[675.321671] Starting subtest: psr-suspend
[725.266262] Subtest psr-suspend: SUCCESS (20.590s)
[725.319014] [131/133] (302s left) gem_exec_gttfill (basic)
[725.390239] Starting subtest: basic
[728.081302] Subtest basic: SUCCESS (2.670s)
[728.278961] [132/133] (299s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[728.403123] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[728.470199] [133/133] (299s left) syncobj_wait (invalid-wait-illegal-handle)
[728.542885] Starting subtest: invalid-wait-illegal-handle
[728.545960] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[728.640150] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: kms_psr
results: parsing output: 2/ for test: kms_psr
results: parsing output: 3/ for test: gem_ctx_persistence
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_lease
results: parsing output: 6/ for test: kms_pm_dc
results: parsing output: 7/ for test: kms_fence_pin_leak
results: parsing output: 8/ for test: i915_drm_fdinfo
results: parsing output: 9/ for test: gem_exec_nop
results: parsing output: 10/ for test: kms_psr2_sf
results: parsing output: 11/ for test: gem_render_copy
results: parsing output: 12/ for test: prime_vgem
results: parsing output: 13/ for test: vgem_basic
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: gem_lmem_swapping
results: parsing output: 16/ for test: gem_readwrite
results: parsing output: 17/ for test: gem_create
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_softpin
results: parsing output: 20/ for test: kms_cursor_legacy
results: parsing output: 21/ for test: syncobj_wait
results: parsing output: 22/ for test: kms_psr
results: parsing output: 23/ for test: kms_chamelium_edid
results: parsing output: 24/ for test: gem_exec_balancer
results: parsing output: 25/ for test: gem_pxp
results: parsing output: 26/ for test: gem_exec_schedule
results: parsing output: 27/ for test: kms_addfb_basic
results: parsing output: 28/ for test: gem_partial_pwrite_pread
results: parsing output: 29/ for test: perf_pmu
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: core_sysfs
results: parsing output: 32/ for test: kms_plane_cursor
results: parsing output: 33/ for test: kms_vblank
results: parsing output: 34/ for test: kms_feature_discovery
results: parsing output: 35/ for test: prime_busy
results: parsing output: 36/ for test: kms_color
results: parsing output: 37/ for test: kms_cursor_crc
results: parsing output: 38/ for test: i915_suspend
results: parsing output: 39/ for test: gem_eio
results: parsing output: 40/ for test: i915_pm_rpm
results: parsing output: 41/ for test: gem_exec_balancer
results: parsing output: 42/ for test: kms_pm_rpm
results: parsing output: 43/ for test: gem_ctx_persistence
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_ctx_exec
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: gem_ccs
results: parsing output: 48/ for test: kms_cursor_crc
results: parsing output: 49/ for test: kms_cursor_crc
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: gem_render_copy
results: parsing output: 52/ for test: kms_ccs
results: parsing output: 53/ for test: kms_chamelium_hpd
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_ctx_sseu
results: parsing output: 57/ for test: kms_getfb
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_exec_params
results: parsing output: 60/ for test: kms_flip
results: parsing output: 61/ for test: syncobj_timeline
results: parsing output: 62/ for test: gem_mmap_gtt
results: parsing output: 63/ for test: gem_render_copy_redux
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: gem_exec_capture
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: kms_properties
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: gem_exec_params
results: parsing output: 70/ for test: gem_eio
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: gem_exec_fence
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: api_intel_bb
results: parsing output: 77/ for test: syncobj_wait
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: kms_dirtyfb
results: parsing output: 82/ for test: gem_caching
results: parsing output: 83/ for test: kms_pipe_crc_basic
results: parsing output: 84/ for test: syncobj_timeline
results: parsing output: 85/ for test: gem_render_copy
results: parsing output: 86/ for test: gem_userptr_blits
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: gen9_exec_parse
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: kms_cursor_legacy
results: parsing output: 93/ for test: kms_plane_scaling
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: kms_psr2_sf
results: parsing output: 96/ for test: kms_ccs
results: parsing output: 97/ for test: kms_invalid_mode
results: parsing output: 98/ for test: kms_properties
results: parsing output: 99/ for test: kms_flip_scaled_crc
results: parsing output: 100/ for test: kms_cursor_legacy
results: parsing output: 101/ for test: gem_exec_schedule
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_cursor_legacy
results: parsing output: 104/ for test: kms_vblank
results: parsing output: 105/ for test: kms_flip_scaled_crc
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: perf
results: parsing output: 108/ for test: gem_exec_params
results: parsing output: 109/ for test: gem_partial_pwrite_pread
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: gem_userptr_blits
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: kms_cursor_legacy
results: parsing output: 114/ for test: gem_mmap_wc
results: parsing output: 115/ for test: kms_plane
results: parsing output: 116/ for test: kms_content_protection
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: gem_exec_whisper
results: parsing output: 119/ for test: kms_async_flips
results: parsing output: 120/ for test: gem_fenced_exec_thrash
results: parsing output: 121/ for test: sw_sync
results: parsing output: 122/ for test: syncobj_wait
results: parsing output: 123/ for test: gem_mmap_gtt
results: parsing output: 124/ for test: kms_plane_scaling
results: parsing output: 125/ for test: kms_rotation_crc
results: parsing output: 126/ for test: i915_module_load
results: parsing output: 127/ for test: syncobj_timeline
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_fbcon_fbt
results: parsing output: 130/ for test: gem_exec_gttfill
results: parsing output: 131/ for test: gem_mmap_gtt
results: parsing output: 132/ for test: syncobj_wait
Done.