[57.959796] Initializing watchdogs
[57.959855]   /dev/watchdog0
[57.974708] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.979116] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.981613] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.984823] [001/156] (960s left) syncobj_timeline (multi-wait-all-available-signaled)
[58.066375] Starting subtest: multi-wait-all-available-signaled
[58.068731] Subtest multi-wait-all-available-signaled: SUCCESS (0.001s)
[58.170675] [002/156] (960s left) gem_eio (create-ext)
[58.318072] Starting subtest: create-ext
[58.485456] Subtest create-ext: SUCCESS (0.168s)
[58.633711] [003/156] (959s left) i915_hangman (engine-error-state-capture)
[58.703774] Starting subtest: engine-error-state-capture
[58.706367] Starting dynamic subtest: rcs0
[62.235629] Dynamic subtest rcs0: SUCCESS (3.554s)
[62.246243] Starting dynamic subtest: bcs0
[68.249256] Dynamic subtest bcs0: SUCCESS (6.033s)
[68.259405] Starting dynamic subtest: vcs0
[74.202071] Dynamic subtest vcs0: SUCCESS (5.961s)
[74.212765] Starting dynamic subtest: vcs1
[79.194275] Dynamic subtest vcs1: SUCCESS (4.994s)
[79.205498] Starting dynamic subtest: vecs0
[83.224793] Dynamic subtest vecs0: SUCCESS (4.031s)
[83.236467] Starting dynamic subtest: ccs0
[89.242427] Dynamic subtest ccs0: SUCCESS (6.016s)
[89.245259] Subtest engine-error-state-capture: SUCCESS (30.597s)
[89.371919] [004/156] (929s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-pwrite)
[89.482900] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-pwrite
[89.487360] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[89.574409] [005/156] (929s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[89.672231] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-mmap-gtt
[89.676199] Subtest hdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[89.764103] [006/156] (928s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[89.852217] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[89.854475] Starting dynamic subtest: pipe-A-eDP-1
[89.877739] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[89.889064] Starting dynamic subtest: pipe-B-eDP-1
[89.910722] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[89.918254] Starting dynamic subtest: pipe-C-eDP-1
[89.939795] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[89.947083] Starting dynamic subtest: pipe-D-eDP-1
[89.969086] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[89.973591] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.002s)
[92.149306] [007/156] (926s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-pwrite)
[92.263149] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-pwrite
[92.267394] Subtest psrhdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[92.374407] [008/156] (926s left) gem_tiled_partial_pwrite_pread (writes)
[92.441427] Subtest writes: SKIP (0.000s)
[92.506962] [009/156] (926s left) gem_lmem_swapping (heavy-multi)
[92.548347] Subtest heavy-multi: SKIP (0.000s)
[92.587260] [010/156] (926s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-indfb-msflip-blt)
[92.677475] Starting subtest: fbchdr-2p-scndscrn-indfb-msflip-blt
[92.681878] Subtest fbchdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[92.768965] [011/156] (926s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[92.869813] Starting subtest: psr-shrfb-scaledprimary
[98.586297] Subtest psr-shrfb-scaledprimary: SUCCESS (5.723s)
[98.706809] [012/156] (920s left) kms_flip (2x-plain-flip-ts-check)
[98.812042] Starting subtest: 2x-plain-flip-ts-check
[98.827555] Subtest 2x-plain-flip-ts-check: SKIP (0.015s)
[98.902437] [013/156] (920s left) prime_vgem (basic-gtt)
[99.003707] Starting subtest: basic-gtt
[99.008125] Subtest basic-gtt: SKIP (0.000s)
[99.095308] [FACT prime_vgem (basic-gtt)] new: kernel.kmod_is_loaded.vgem: true
[99.098778] [014/156] (919s left) gem_exec_whisper (basic-queues-all)
[99.154623] Starting subtest: basic-queues-all
[110.127760] Subtest basic-queues-all: SUCCESS (10.970s)
[110.312998] [015/156] (908s left) syncobj_eventfd (timeline-wait-signaled)
[110.359371] Starting subtest: timeline-wait-signaled
[110.361644] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[110.453455] [016/156] (908s left) gem_reg_read (timestamp-monotonic)
[110.508867] Starting subtest: timestamp-monotonic
[115.021938] Subtest timestamp-monotonic: SUCCESS (4.513s)
[115.108708] [017/156] (904s left) kms_chamelium_frames (dp-crc-single)
[115.492105] Subtest dp-crc-single: SKIP (0.000s)
[116.288698] [018/156] (902s left) gem_exec_flush (basic-wb-prw-default)
[116.363624] Starting subtest: basic-wb-prw-default
[121.829196] Subtest basic-wb-prw-default: SUCCESS (5.466s)
[122.026805] [019/156] (897s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[122.132458] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[122.136551] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[122.230636] [020/156] (897s left) gem_exec_fence (submit3)
[122.411800] Starting subtest: submit3
[122.416538] Subtest submit3: SKIP (0.000s)
[124.353889] [021/156] (894s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[124.461596] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-mmap-cpu
[124.465609] Subtest hdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[124.569422] [022/156] (894s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[124.676081] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[131.204840] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.535s)
[131.326843] [023/156] (888s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[131.432647] Starting subtest: fbcpsr-stridechange
[137.568807] Subtest fbcpsr-stridechange: SUCCESS (6.140s)
[137.707402] [024/156] (881s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-pwrite)
[137.807649] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-pwrite
[137.811768] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[137.922190] [025/156] (881s left) prime_mmap (test_userptr)
[137.983020] Starting subtest: test_userptr
[137.984951] Starting dynamic subtest: test_userptr-smem
[137.986868] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[137.988735] Subtest test_userptr: SUCCESS (0.001s)
[138.071236] [026/156] (881s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[138.180374] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[170.031078] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.848s)
[170.873541] [027/156] (848s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[170.968678] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[170.971030] Starting dynamic subtest: pipe-A-eDP-1
[171.029820] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[171.038828] Starting dynamic subtest: pipe-B-eDP-1
[171.095777] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[171.105781] Starting dynamic subtest: pipe-C-eDP-1
[171.162134] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[171.172017] Starting dynamic subtest: pipe-D-eDP-1
[171.230088] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[171.234498] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.007s)
[173.215131] [028/156] (846s left) gen9_exec_parse (basic-rejected-ctx-param)
[173.281145] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[173.346860] [029/156] (846s left) kms_psr (fbc-psr2-no-drrs)
[173.433212] Starting subtest: fbc-psr2-no-drrs
[173.435090] Starting dynamic subtest: eDP-1
[173.439175] Dynamic subtest eDP-1: SKIP (0.000s)
[173.443276] Subtest fbc-psr2-no-drrs: SKIP (0.000s)
[173.510873] [030/156] (846s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-mmap-gtt)
[173.602535] Starting subtest: psrhdr-rgb565-draw-mmap-gtt
[173.606790] Subtest psrhdr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[173.683129] [031/156] (846s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-blt)
[173.774247] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-blt
[173.778825] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[173.878661] [032/156] (845s left) api_intel_bb (simple-bb-ctx)
[173.937675] Starting subtest: simple-bb-ctx
[173.945123] Subtest simple-bb-ctx: SUCCESS (0.010s)
[174.067246] [033/156] (845s left) kms_chamelium_audio (dp-audio-edid)
[174.450555] Subtest dp-audio-edid: SKIP (0.000s)
[175.237572] [034/156] (844s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[175.350129] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[180.264270] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.920s)
[181.455247] [035/156] (838s left) template (b)
[181.513422] Starting subtest: B
[181.515386] Subtest B: SUCCESS (0.000s)
[181.623111] [036/156] (838s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[181.745602] Starting subtest: cursorA-vs-flipA-varying-size
[192.921618] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.177s)
[193.783946] [037/156] (826s left) kms_chamelium_hpd (common-hpd-after-suspend)
[194.166228] Subtest common-hpd-after-suspend: SKIP (0.000s)
[194.990549] [038/156] (825s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-wc)
[195.102396] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-wc
[195.106657] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[195.220194] [039/156] (824s left) kms_vblank (wait-busy)
[195.304247] Starting subtest: wait-busy
[195.306130] Starting dynamic subtest: pipe-A-eDP-1
[197.183055] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.877s)
[197.199033] Starting dynamic subtest: pipe-D-eDP-1
[199.780412] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.595s)
[199.782910] Subtest wait-busy: SUCCESS (4.477s)
[200.589125] [040/156] (819s left) kms_frontbuffer_tracking (hdr-1p-primscrn-indfb-msflip-blt)
[200.690377] Starting subtest: hdr-1p-primscrn-indfb-msflip-blt
[200.694734] Subtest hdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[200.791332] [041/156] (819s left) gem_media_vme
[200.954480] [042/156] (819s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[201.044099] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[201.046608] Starting dynamic subtest: pipe-A-eDP-1
[217.791416] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.496s)
[217.801786] Starting dynamic subtest: pipe-B-eDP-1
[234.776482] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.460s)
[234.785810] Starting dynamic subtest: pipe-C-eDP-1
[251.728419] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.417s)
[251.738693] Starting dynamic subtest: pipe-D-eDP-1
[268.730076] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.368s)
[268.733323] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.745s)
[269.956991] [043/156] (750s left) kms_debugfs (display-off-read-all)
[270.059847] Starting subtest: display-off-read-all
[270.342715] Subtest display-off-read-all: SUCCESS (0.286s)
[271.171414] [044/156] (749s left) kms_flip (flip-vs-modeset-vs-hang)
[271.277060] Starting subtest: flip-vs-modeset-vs-hang
[271.279386] Starting dynamic subtest: A-eDP1
[322.805337] Dynamic subtest A-eDP1: SUCCESS (51.623s)
[322.819060] Starting dynamic subtest: D-eDP1
[372.794996] Dynamic subtest D-eDP1: SUCCESS (49.995s)
[372.797966] Subtest flip-vs-modeset-vs-hang: SUCCESS (101.625s)
[373.153284] [045/156] (647s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier)
[373.251581] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier
[373.257154] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier: SKIP (0.000s)
[373.323225] [046/156] (647s left) prime_mmap (test_forked)
[373.395263] Starting subtest: test_forked
[373.398267] Starting dynamic subtest: test_forked-smem
[373.440448] Dynamic subtest test_forked-smem: SUCCESS (0.047s)
[373.443566] Subtest test_forked: SUCCESS (0.048s)
[373.541932] [047/156] (646s left) kms_cursor_crc (cursor-sliding-max-size)
[373.885640] Starting subtest: cursor-sliding-max-size
[373.893311] Subtest cursor-sliding-max-size: SKIP (0.000s)
[373.995967] [048/156] (646s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[374.090865] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[380.970919] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.882s)
[381.110962] [049/156] (639s left) i915_pm_rpm (system-suspend-devices)
[382.645110] Starting subtest: system-suspend-devices
[390.279028] Subtest system-suspend-devices: SUCCESS (7.636s)
[390.680038] [050/156] (629s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-render)
[390.801017] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-render
[390.805881] Subtest hdr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[390.889579] [051/156] (629s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[390.994524] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[390.999448] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[391.078772] [052/156] (629s left) kms_joiner (basic-force-ultra-joiner)
[391.177947] Starting subtest: basic-force-ultra-joiner
[391.182984] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[391.246620] [053/156] (629s left) gem_exec_schedule (out-order)
[391.327808] Starting subtest: out-order
[391.329849] Starting dynamic subtest: rcs0
[391.426871] Dynamic subtest rcs0: SUCCESS (0.105s)
[391.439335] Starting dynamic subtest: vcs0
[391.515793] Dynamic subtest vcs0: SUCCESS (0.089s)
[391.527493] Starting dynamic subtest: vcs1
[391.597200] Dynamic subtest vcs1: SUCCESS (0.081s)
[391.610022] Starting dynamic subtest: vecs0
[391.672845] Dynamic subtest vecs0: SUCCESS (0.076s)
[391.685350] Starting dynamic subtest: ccs0
[391.757851] Dynamic subtest ccs0: SUCCESS (0.083s)
[391.760541] Subtest out-order: SUCCESS (0.438s)
[393.419695] [054/156] (627s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[393.532221] Starting subtest: cursor-vs-flip-atomic-transitions
[423.819131] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (30.292s)
[424.682613] [055/156] (596s left) i915_query (query-topology-garbage-items)
[424.738652] Starting subtest: query-topology-garbage-items
[424.741381] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[424.829700] [056/156] (595s left) kms_frontbuffer_tracking (fbchdr-farfromfence-mmap-gtt)
[424.929866] Starting subtest: fbchdr-farfromfence-mmap-gtt
[424.934537] Subtest fbchdr-farfromfence-mmap-gtt: SKIP (0.000s)
[425.030355] [057/156] (595s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[425.126568] Starting subtest: 4-tiled-64bpp-rotate-180
[426.704745] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.578s)
[426.869634] [058/156] (593s left) syncobj_wait (reset-signaled)
[426.924117] Starting subtest: reset-signaled
[426.926701] Subtest reset-signaled: SUCCESS (0.000s)
[427.041522] [059/156] (593s left) syncobj_timeline (signal-point-0)
[427.093766] Starting subtest: signal-point-0
[427.096307] Subtest signal-point-0: SUCCESS (0.000s)
[427.190195] [060/156] (593s left) gem_exec_balancer (parallel-keep-submit-fence)
[427.454494] Starting subtest: parallel-keep-submit-fence
[428.728293] Subtest parallel-keep-submit-fence: SUCCESS (1.274s)
[428.821356] [061/156] (592s left) kms_plane_lowres (tiling-yf)
[428.915429] Starting subtest: tiling-yf
[428.920496] Subtest tiling-yf: SKIP (0.000s)
[429.000788] [062/156] (592s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs)
[429.054302] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs
[429.059530] Subtest yf-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[429.252707] [063/156] (591s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[429.346668] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[429.351499] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[429.450197] [064/156] (591s left) gem_exec_reloc (basic-gtt-active)
[429.504522] Subtest basic-gtt-active: SKIP (0.000s)
[429.565404] [065/156] (591s left) gem_userptr_blits (sync-unmap-after-close)
[429.626112] Starting subtest: sync-unmap-after-close
[429.635821] Subtest sync-unmap-after-close: SUCCESS (0.011s)
[429.758828] [066/156] (591s left) kms_getfb (getfb2-handle-closed)
[429.847496] Starting subtest: getfb2-handle-closed
[429.850367] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[429.958905] [067/156] (591s left) kms_prop_blob (blob-prop-validate)
[430.010360] Starting subtest: blob-prop-validate
[430.012922] Subtest blob-prop-validate: SUCCESS (0.000s)
[430.117777] [068/156] (591s left) kms_color_pipeline (plane-ctm3x4)
[430.208240] Starting subtest: plane-ctm3x4
[430.331319] Starting dynamic subtest: pipe-A-plane-0
[430.476085] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s)
[430.486328] Starting dynamic subtest: pipe-A-plane-1
[430.587285] Dynamic subtest pipe-A-plane-1: SUCCESS (0.111s)
[430.597517] Starting dynamic subtest: pipe-A-plane-2
[430.698200] Dynamic subtest pipe-A-plane-2: SUCCESS (0.110s)
[431.874493] Starting dynamic subtest: pipe-B-plane-0
[431.981777] Dynamic subtest pipe-B-plane-0: SUCCESS (0.121s)
[431.993487] Starting dynamic subtest: pipe-B-plane-1
[432.093278] Dynamic subtest pipe-B-plane-1: SUCCESS (0.110s)
[432.104511] Starting dynamic subtest: pipe-B-plane-2
[432.216372] Dynamic subtest pipe-B-plane-2: SUCCESS (0.122s)
[433.397300] Starting dynamic subtest: pipe-C-plane-0
[433.500008] Dynamic subtest pipe-C-plane-0: SUCCESS (0.111s)
[433.511419] Starting dynamic subtest: pipe-C-plane-1
[433.610424] Dynamic subtest pipe-C-plane-1: SUCCESS (0.110s)
[433.621436] Starting dynamic subtest: pipe-C-plane-2
[433.721327] Dynamic subtest pipe-C-plane-2: SUCCESS (0.110s)
[434.955820] Starting dynamic subtest: pipe-D-plane-0
[435.057878] Dynamic subtest pipe-D-plane-0: SUCCESS (0.111s)
[435.069223] Starting dynamic subtest: pipe-D-plane-1
[435.168783] Dynamic subtest pipe-D-plane-1: SUCCESS (0.110s)
[435.179974] Starting dynamic subtest: pipe-D-plane-2
[435.280168] Dynamic subtest pipe-D-plane-2: SUCCESS (0.110s)
[435.574265] Subtest plane-ctm3x4: SUCCESS (5.365s)
[436.408972] [069/156] (584s left) kms_frontbuffer_tracking (hdr-2p-primscrn-shrfb-plflip-blt)
[436.503292] Starting subtest: hdr-2p-primscrn-shrfb-plflip-blt
[436.508145] Subtest hdr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[436.600066] [070/156] (584s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-pwrite)
[436.693707] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-pwrite
[436.698668] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[436.795169] [071/156] (584s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[436.890510] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[436.892989] Starting dynamic subtest: pipe-A-default-mode
[438.077187] Dynamic subtest pipe-A-default-mode: SKIP (1.184s)
[438.082219] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.185s)
[438.199585] [072/156] (583s left) syncobj_timeline (etime-multi-wait-submitted)
[438.263491] Starting subtest: etime-multi-wait-submitted
[438.369902] Subtest etime-multi-wait-submitted: SUCCESS (0.106s)
[438.463894] [073/156] (583s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-indfb-plflip-blt)
[438.560901] Starting subtest: fbcpsrhdr-2p-primscrn-indfb-plflip-blt
[438.565489] Subtest fbcpsrhdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[438.664579] [074/156] (582s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-pwrite)
[438.761489] Starting subtest: fbchdr-rgb565-draw-pwrite
[438.766368] Subtest fbchdr-rgb565-draw-pwrite: SKIP (0.000s)
[438.852516] [075/156] (582s left) kms_pm_rpm (basic-rte)
[438.887857] Starting subtest: basic-rte
[441.960502] Subtest basic-rte: SUCCESS (3.075s)
[443.779362] [076/156] (577s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[443.887217] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[443.892668] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[443.978025] [077/156] (577s left) kms_content_protection (legacy)
[444.118544] Starting subtest: legacy
[444.123330] Subtest legacy: SKIP (0.000s)
[444.236232] [078/156] (577s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[444.287382] Starting subtest: single-wait-all-for-submit-available-submitted
[444.290375] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[444.390248] [079/156] (577s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[444.498074] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf
[444.500570] Starting dynamic subtest: pipe-A-eDP-1
[444.597665] Dynamic subtest pipe-A-eDP-1: SKIP (0.101s)
[444.608489] Starting dynamic subtest: pipe-B-eDP-1
[445.736495] Dynamic subtest pipe-B-eDP-1: SKIP (1.135s)
[445.742043] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.239s)
[447.027056] [080/156] (574s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[447.121276] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[453.652317] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.538s)
[453.764164] [081/156] (568s left) gem_ctx_param (invalid-get-no-zeromap)
[453.817783] Starting subtest: invalid-get-no-zeromap
[453.820501] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[453.931183] [082/156] (567s left) syncobj_wait (invalid-reset-illegal-handle)
[453.988891] Starting subtest: invalid-reset-illegal-handle
[453.991277] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[454.072852] [083/156] (567s left) gem_request_retire (retire-vma-not-inactive)
[454.125126] Starting subtest: retire-vma-not-inactive
[454.186502] Subtest retire-vma-not-inactive: SUCCESS (0.057s)
[454.305897] [084/156] (567s left) gem_ctx_engines (independent)
[454.356622] Starting subtest: independent
[454.359664] Starting dynamic subtest: rcs0
[454.483441] Dynamic subtest rcs0: SUCCESS (0.125s)
[454.496767] Starting dynamic subtest: bcs0
[454.583255] Dynamic subtest bcs0: SUCCESS (0.101s)
[454.594109] Starting dynamic subtest: vcs0
[454.713435] Dynamic subtest vcs0: SUCCESS (0.128s)
[454.724949] Starting dynamic subtest: vcs1
[454.835651] Dynamic subtest vcs1: SUCCESS (0.122s)
[454.846815] Starting dynamic subtest: vecs0
[454.952321] Dynamic subtest vecs0: SUCCESS (0.116s)
[454.962524] Starting dynamic subtest: ccs0
[455.075568] Dynamic subtest ccs0: SUCCESS (0.122s)
[455.087356] Starting dynamic subtest: all-engines
[455.603201] Dynamic subtest all-engines: SUCCESS (0.526s)
[455.605179] Subtest independent: SUCCESS (1.246s)
[456.477318] [085/156] (565s left) syncobj_wait (wait-for-submit-snapshot)
[456.526363] Starting subtest: wait-for-submit-snapshot
[456.608918] Subtest wait-for-submit-snapshot: SUCCESS (0.083s)
[456.685444] [086/156] (565s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-blt)
[456.782863] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-blt
[456.788393] Subtest psrhdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[456.903041] [087/156] (565s left) kms_plane_scaling (planes-upscale-factor-0-25)
[456.996541] Starting subtest: planes-upscale-factor-0-25
[456.998809] Starting dynamic subtest: pipe-A
[457.056209] Dynamic subtest pipe-A: SUCCESS (0.062s)
[457.069501] Starting dynamic subtest: pipe-B
[458.170484] Dynamic subtest pipe-B: SUCCESS (1.114s)
[458.183480] Starting dynamic subtest: pipe-C
[459.283136] Dynamic subtest pipe-C: SUCCESS (1.112s)
[459.294002] Starting dynamic subtest: pipe-D
[460.413629] Dynamic subtest pipe-D: SUCCESS (1.130s)
[460.416568] Subtest planes-upscale-factor-0-25: SUCCESS (3.421s)
[461.581065] [088/156] (560s left) gem_tiled_pread_basic (basic)
[461.635065] Subtest basic: SKIP (0.000s)
[461.691781] [089/156] (560s left) kms_plane_alpha_blend (alpha-opaque-fb)
[461.779237] Starting subtest: alpha-opaque-fb
[462.075363] Starting dynamic subtest: pipe-A-eDP-1
[462.710681] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.632s)
[462.722973] Starting dynamic subtest: pipe-D-eDP-1
[464.111191] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.402s)
[464.114057] Subtest alpha-opaque-fb: SUCCESS (2.335s)
[464.942894] [090/156] (557s left) gem_exec_balancer (full-late)
[465.001520] Starting subtest: full-late
[469.172841] Subtest full-late: SUCCESS (4.174s)
[469.484575] [091/156] (552s left) kms_psr2_su (page_flip-xrgb8888)
[469.544353] Subtest page_flip-XRGB8888: SKIP (0.000s)
[469.602777] [092/156] (552s left) gem_fence_thrash (bo-copy)
[469.638529] Starting subtest: bo-copy
[469.655302] Subtest bo-copy: SKIP (0.016s)
[469.739023] [093/156] (552s left) kms_psr (fbc-psr-primary-mmap-cpu)
[469.832328] Starting subtest: fbc-psr-primary-mmap-cpu
[469.835236] Starting dynamic subtest: eDP-1
[469.840329] Dynamic subtest eDP-1: SKIP (0.000s)
[469.845532] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[469.908165] [094/156] (552s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[470.011533] Starting subtest: x-tiled-32bpp-rotate-270
[470.030512] Subtest x-tiled-32bpp-rotate-270: SKIP (0.018s)
[470.134320] [095/156] (552s left) kms_sequence (get-forked)
[470.231102] Starting subtest: get-forked
[470.233133] Starting dynamic subtest: pipe-A-eDP-1
[472.110549] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.881s)
[472.122800] Starting dynamic subtest: pipe-B-eDP-1
[474.675985] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.565s)
[474.687754] Starting dynamic subtest: pipe-C-eDP-1
[477.194502] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.515s)
[477.205933] Starting dynamic subtest: pipe-D-eDP-1
[479.728519] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.535s)
[479.731170] Subtest get-forked: SUCCESS (9.500s)
[480.569409] [096/156] (541s left) gem_barrier_race (remote-request)
[480.632186] Starting subtest: remote-request
[480.634687] Starting dynamic subtest: rcs0
[485.793543] Dynamic subtest rcs0: SUCCESS (5.164s)
[485.796974] Subtest remote-request: SUCCESS (5.165s)
[485.938750] [097/156] (536s left) kms_properties (get_properties-sanity-atomic)
[486.032271] Starting subtest: get_properties-sanity-atomic
[486.034908] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[486.107186] [098/156] (536s left) api_intel_bb (blit-noreloc-purge-cache)
[486.167147] Starting subtest: blit-noreloc-purge-cache
[486.175770] Subtest blit-noreloc-purge-cache: SUCCESS (0.012s)
[486.297295] [099/156] (536s left) perf_pmu (init-wait)
[486.335309] Starting subtest: init-wait
[486.337823] Starting dynamic subtest: rcs0
[486.339992] Dynamic subtest rcs0: SUCCESS (0.001s)
[486.351916] Starting dynamic subtest: bcs0
[486.354215] Dynamic subtest bcs0: SUCCESS (0.001s)
[486.364212] Starting dynamic subtest: vcs0
[486.366179] Dynamic subtest vcs0: SUCCESS (0.001s)
[486.375982] Starting dynamic subtest: vcs1
[486.378033] Dynamic subtest vcs1: SUCCESS (0.000s)
[486.387917] Starting dynamic subtest: vecs0
[486.389975] Dynamic subtest vecs0: SUCCESS (0.001s)
[486.402964] Starting dynamic subtest: ccs0
[486.405346] Dynamic subtest ccs0: SUCCESS (0.000s)
[486.407639] Subtest init-wait: SUCCESS (0.008s)
[486.448147] [100/156] (536s left) sysfs_preempt_timeout (idempotent)
[486.514246] Starting subtest: idempotent
[486.516587] Starting dynamic subtest: vecs0
[486.519410] Dynamic subtest vecs0: SUCCESS (0.000s)
[486.531300] Starting dynamic subtest: ccs0
[486.533512] Dynamic subtest ccs0: SUCCESS (0.000s)
[486.543892] Starting dynamic subtest: vcs0
[486.546238] Dynamic subtest vcs0: SUCCESS (0.000s)
[486.556527] Starting dynamic subtest: bcs0
[486.559234] Dynamic subtest bcs0: SUCCESS (0.000s)
[486.570235] Starting dynamic subtest: rcs0
[486.572269] Dynamic subtest rcs0: SUCCESS (0.001s)
[486.581794] Starting dynamic subtest: vcs1
[486.584250] Dynamic subtest vcs1: SUCCESS (0.000s)
[486.586258] Subtest idempotent: SUCCESS (0.007s)
[486.627546] [101/156] (536s left) prime_busy (hang)
[486.678312] Starting subtest: hang
[486.680200] Starting dynamic subtest: rcs0
[512.819384] Dynamic subtest rcs0: SUCCESS (26.142s)
[512.830600] Starting dynamic subtest: bcs0
[519.980014] Dynamic subtest bcs0: SUCCESS (7.160s)
[519.992880] Starting dynamic subtest: vcs0
[527.019397] Dynamic subtest vcs0: SUCCESS (7.040s)
[527.029796] Starting dynamic subtest: vcs1
[533.993510] Dynamic subtest vcs1: SUCCESS (6.977s)
[534.004162] Starting dynamic subtest: vecs0
[540.967293] Dynamic subtest vecs0: SUCCESS (6.970s)
[540.977857] Starting dynamic subtest: ccs0
[554.875483] Dynamic subtest ccs0: SUCCESS (13.909s)
[554.877927] Subtest hang: SUCCESS (68.204s)
[555.003788] [102/156] (467s left) kms_flip (flip-vs-suspend)
[555.098322] Starting subtest: flip-vs-suspend
[555.101332] Starting dynamic subtest: A-eDP1
[700.593211] Dynamic subtest A-eDP1: SUCCESS (11.182s)
[700.597156] Subtest flip-vs-suspend: SUCCESS (11.184s)
[700.724751] [103/156] (322s left) gem_mmap_gtt (ptrace)
[700.794452] Subtest ptrace: SKIP (0.000s)
[700.871653] [104/156] (322s left) kms_fbcon_fbt (psr-suspend)
[700.933079] Starting subtest: psr-suspend
[750.581918] Subtest psr-suspend: SUCCESS (19.937s)
[750.658694] [105/156] (272s left) kms_addfb_basic (bad-pitch-1024)
[750.710543] Starting subtest: bad-pitch-1024
[750.712362] Subtest bad-pitch-1024: SUCCESS (0.000s)
[750.846993] [106/156] (272s left) i915_drm_fdinfo (idle)
[750.884448] Starting subtest: idle
[750.886347] Starting dynamic subtest: rcs0
[751.444587] Dynamic subtest rcs0: SUCCESS (0.566s)
[751.458764] Starting dynamic subtest: bcs0
[751.951793] Dynamic subtest bcs0: SUCCESS (0.507s)
[751.965490] Starting dynamic subtest: vcs0
[752.457956] Dynamic subtest vcs0: SUCCESS (0.506s)
[752.471979] Starting dynamic subtest: vcs1
[752.968447] Dynamic subtest vcs1: SUCCESS (0.506s)
[752.981481] Starting dynamic subtest: vecs0
[753.469977] Dynamic subtest vecs0: SUCCESS (0.506s)
[753.483274] Starting dynamic subtest: ccs0
[753.976289] Dynamic subtest ccs0: SUCCESS (0.506s)
[753.979165] Subtest idle: SUCCESS (3.114s)
[754.058226] [107/156] (268s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[754.164097] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[754.168268] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[754.271235] [108/156] (268s left) gem_exec_reloc (basic-range)
[754.332120] Subtest basic-range: SKIP (0.000s)
[754.408816] [109/156] (268s left) dmabuf_sync_file (import-multiple-read-only)
[754.448740] Starting subtest: import-multiple-read-only
[754.450998] Subtest import-multiple-read-only: SUCCESS (0.003s)
[754.507216] [110/156] (268s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[754.601724] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[754.606135] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[754.712118] [111/156] (268s left) gem_exec_schedule (thriceslice)
[754.792985] Starting subtest: thriceslice
[754.795002] Starting dynamic subtest: rcs0
[754.812156] Dynamic subtest rcs0: SUCCESS (0.030s)
[754.825650] Starting dynamic subtest: bcs0
[754.843572] Dynamic subtest bcs0: SUCCESS (0.030s)
[754.855283] Starting dynamic subtest: vcs0
[754.893191] Dynamic subtest vcs0: SUCCESS (0.048s)
[754.907581] Starting dynamic subtest: vcs1
[754.925768] Dynamic subtest vcs1: SUCCESS (0.029s)
[754.939020] Starting dynamic subtest: vecs0
[754.954519] Dynamic subtest vecs0: SUCCESS (0.028s)
[754.969812] Starting dynamic subtest: ccs0
[754.985524] Dynamic subtest ccs0: SUCCESS (0.031s)
[754.987657] Subtest thriceslice: SUCCESS (0.205s)
[755.287940] [112/156] (267s left) kms_psr (psr2-sprite-blt)
[755.379224] Starting subtest: psr2-sprite-blt
[755.381474] Starting dynamic subtest: eDP-1
[757.080320] Dynamic subtest eDP-1: SUCCESS (1.709s)
[757.082760] Subtest psr2-sprite-blt: SUCCESS (1.710s)
[757.939231] [113/156] (265s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[758.058185] Starting subtest: verify-pxp-execution-after-suspend-resume
[765.130875] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.092s)
[765.283191] [114/156] (258s left) gem_mmap_wc (bad-offset)
[765.345600] Subtest bad-offset: SKIP (0.000s)
[765.409861] [115/156] (257s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[765.660150] Starting subtest: cursor-rapid-movement-256x85
[765.706461] Subtest cursor-rapid-movement-256x85: SKIP (0.041s)
[765.873853] [116/156] (257s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[765.994362] Starting subtest: flip-vs-cursor-legacy
[773.512187] Subtest flip-vs-cursor-legacy: SUCCESS (7.518s)
[774.322778] [117/156] (249s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[774.424082] Starting subtest: fbcpsr-rgb101010-draw-render
[779.183938] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (4.766s)
[779.300008] [118/156] (244s left) kms_async_flips (alternate-sync-async-flip-atomic)
[779.394702] Starting subtest: alternate-sync-async-flip-atomic
[779.765689] Starting dynamic subtest: pipe-A-eDP-1
[782.526445] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.762s)
[782.897373] Starting dynamic subtest: pipe-B-eDP-1
[785.655144] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.769s)
[786.044223] Starting dynamic subtest: pipe-C-eDP-1
[788.798260] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.765s)
[789.162974] Starting dynamic subtest: pipe-D-eDP-1
[791.929133] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.777s)
[791.931126] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.540s)
[793.095914] [119/156] (230s left) syncobj_wait (wait-all-snapshot)
[793.153000] Starting subtest: wait-all-snapshot
[793.233419] Subtest wait-all-snapshot: SUCCESS (0.081s)
[793.337208] [120/156] (230s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-fullscreen)
[793.426526] Starting subtest: hdr-2p-scndscrn-spr-indfb-fullscreen
[793.430621] Subtest hdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[793.537832] [121/156] (230s left) kms_big_fb (linear-8bpp-rotate-0)
[793.642894] Starting subtest: linear-8bpp-rotate-0
[794.866463] Subtest linear-8bpp-rotate-0: SUCCESS (1.224s)
[794.988214] [122/156] (228s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[795.087146] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[795.089094] Starting dynamic subtest: pipe-A-eDP-1
[806.403666] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.315s)
[806.415600] Starting dynamic subtest: pipe-B-eDP-1
[818.409547] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.007s)
[818.411897] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.326s)
[819.264543] [123/156] (204s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc)
[819.375564] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc
[819.379537] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[819.476572] [124/156] (204s left) gem_userptr_blits (probe)
[819.542257] Starting subtest: probe
[819.618458] Subtest probe: SUCCESS (0.078s)
[819.731995] [125/156] (204s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[819.837511] Starting subtest: psr-rgb565-draw-mmap-gtt
[819.841506] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[819.925882] [126/156] (203s left) kms_draw_crc (draw-method-pwrite)
[820.021278] Starting subtest: draw-method-pwrite
[820.023212] Starting dynamic subtest: xrgb8888-untiled
[820.565635] Dynamic subtest xrgb8888-untiled: SUCCESS (0.546s)
[820.579295] Starting dynamic subtest: rgb565-untiled
[821.010032] Dynamic subtest rgb565-untiled: SUCCESS (0.444s)
[821.021075] Starting dynamic subtest: xrgb2101010-untiled
[821.554037] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.544s)
[821.566339] Starting dynamic subtest: xbgr16161616f-untiled
[822.298731] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.744s)
[822.310691] Starting dynamic subtest: xrgb8888-xtiled
[824.065497] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.766s)
[824.079327] Starting dynamic subtest: rgb565-xtiled
[825.132102] Dynamic subtest rgb565-xtiled: SUCCESS (1.066s)
[825.144503] Starting dynamic subtest: xrgb2101010-xtiled
[826.886670] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.753s)
[826.898005] Starting dynamic subtest: xbgr16161616f-xtiled
[830.219413] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.331s)
[830.230894] Starting dynamic subtest: xrgb8888-4tiled
[831.308621] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.088s)
[831.321631] Starting dynamic subtest: rgb565-4tiled
[831.840857] Dynamic subtest rgb565-4tiled: SUCCESS (0.532s)
[831.852323] Starting dynamic subtest: xrgb2101010-4tiled
[832.918638] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.077s)
[832.930475] Starting dynamic subtest: xbgr16161616f-4tiled
[835.906815] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (2.988s)
[835.909118] Subtest draw-method-pwrite: SUCCESS (15.891s)
[836.017225] [127/156] (187s left) kms_properties (crtc-properties-legacy)
[836.114128] Starting subtest: crtc-properties-legacy
[836.116394] Starting dynamic subtest: pipe-A-eDP-1
[836.548191] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.432s)
[836.560377] Starting dynamic subtest: pipe-B-eDP-1
[837.708214] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.158s)
[837.719271] Starting dynamic subtest: pipe-C-eDP-1
[838.841555] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.131s)
[838.854461] Starting dynamic subtest: pipe-D-eDP-1
[839.971144] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.131s)
[839.973537] Subtest crtc-properties-legacy: SUCCESS (3.858s)
[840.807631] [128/156] (183s left) gem_mmap_gtt (basic-small-copy-odd)
[840.863844] Subtest basic-small-copy-odd: SKIP (0.000s)
[840.920207] [129/156] (183s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[841.011617] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[845.477122] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.473s)
[846.625568] [130/156] (177s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[846.723643] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[847.690679] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (0.968s)
[847.824855] [131/156] (176s left) gem_mmap_wc (write-read-distinct)
[847.881973] Subtest write-read-distinct: SKIP (0.000s)
[847.938458] [132/156] (176s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[848.053202] Starting subtest: 2x-flip-vs-cursor-atomic
[848.056988] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[848.204001] [133/156] (175s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[848.301473] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc
[848.304983] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[848.421814] [134/156] (175s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[848.522355] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[848.526000] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[848.628713] [135/156] (175s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-blt)
[848.732203] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-blt
[848.735743] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[848.813989] [136/156] (175s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[848.909530] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[848.911499] Starting dynamic subtest: pipe-A-eDP-1
[848.931208] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[848.944432] Starting dynamic subtest: pipe-B-eDP-1
[848.962251] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[848.972790] Starting dynamic subtest: pipe-C-eDP-1
[848.991038] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[849.000821] Starting dynamic subtest: pipe-D-eDP-1
[849.018906] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[849.022551] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[851.175388] [137/156] (173s left) kms_cursor_crc (cursor-offscreen-256x256)
[851.430228] Starting subtest: cursor-offscreen-256x256
[851.432571] Starting dynamic subtest: pipe-A-eDP-1
[853.388804] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.956s)
[853.415628] Starting dynamic subtest: pipe-D-eDP-1
[855.984166] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.578s)
[855.986427] Subtest cursor-offscreen-256x256: SUCCESS (4.558s)
[856.833249] [138/156] (167s left) perf (gen12-unprivileged-single-ctx-counters)
[856.924112] Starting subtest: gen12-unprivileged-single-ctx-counters
[856.926400] Starting dynamic subtest: rcs0
[856.998068] Dynamic subtest rcs0: SUCCESS (0.074s)
[857.000400] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.075s)
[857.051598] [139/156] (167s left) kms_psr (psr-suspend)
[857.167401] Starting subtest: psr-suspend
[857.169747] Starting dynamic subtest: eDP-1
[875.013080] Dynamic subtest eDP-1: SUCCESS (2.951s)
[875.016059] Subtest psr-suspend: SUCCESS (2.952s)
[875.873940] [140/156] (148s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[875.982468] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[875.988119] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[876.082715] [141/156] (148s left) gem_exec_reloc (basic-cpu-active)
[876.131863] Subtest basic-cpu-active: SKIP (0.000s)
[876.209276] [142/156] (148s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[876.308015] Starting subtest: yf-tiled-8bpp-rotate-0
[876.313107] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[876.404407] [143/156] (148s left) kms_plane (plane-panning-bottom-right-suspend)
[876.489779] Starting subtest: plane-panning-bottom-right-suspend
[876.492023] Starting dynamic subtest: pipe-A
[893.956983] Dynamic subtest pipe-A: SUCCESS (2.847s)
[893.968673] Starting dynamic subtest: pipe-B
[911.977709] Dynamic subtest pipe-B: SUCCESS (3.512s)
[911.980028] Subtest plane-panning-bottom-right-suspend: SUCCESS (6.363s)
[912.802216] [144/156] (111s left) kms_lease (master-vs-lease)
[912.903420] Starting subtest: master-vs-lease
[912.905715] Subtest master-vs-lease: SUCCESS (0.001s)
[913.032553] [145/156] (111s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[913.132190] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[913.136191] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[913.241450] [146/156] (111s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[913.336272] Starting subtest: fbc-rgb101010-draw-pwrite
[916.656552] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (3.355s)
[917.850285] [147/156] (106s left) gem_exec_reloc (basic-cpu)
[917.907097] Subtest basic-cpu: SKIP (0.000s)
[917.980026] [148/156] (106s left) gem_userptr_blits (process-exit)
[918.047387] Starting subtest: process-exit
[918.055646] Subtest process-exit: SUCCESS (0.009s)
[918.187103] [149/156] (106s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[918.296520] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[918.300911] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[918.406802] [150/156] (106s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[918.496572] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[918.500796] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[918.611591] [151/156] (106s left) gem_exec_reloc (basic-cpu-read-noreloc)
[918.672883] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[918.745917] [152/156] (106s left) kms_async_flips (invalid-async-flip-atomic)
[918.831527] Starting subtest: invalid-async-flip-atomic
[919.211824] Starting dynamic subtest: pipe-A-eDP-1
[920.043822] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.836s)
[920.412413] Starting dynamic subtest: pipe-B-eDP-1
[921.271504] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.871s)
[921.635419] Starting dynamic subtest: pipe-C-eDP-1
[922.490211] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.869s)
[922.851519] Starting dynamic subtest: pipe-D-eDP-1
[923.635530] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.795s)
[923.637392] Subtest invalid-async-flip-atomic: SUCCESS (4.824s)
[924.800652] [153/156] (100s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-pwrite)
[924.910055] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-pwrite
[924.914079] Subtest fbchdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[925.025605] [154/156] (100s left) gem_ctx_persistence (idempotent)
[925.089099] Starting subtest: idempotent
[925.091457] Subtest idempotent: SUCCESS (0.000s)
[925.197101] [155/156] ( 99s left) kms_psr (pr-cursor-plane-move)
[925.297378] Starting subtest: pr-cursor-plane-move
[925.301735] Subtest pr-cursor-plane-move: SKIP (0.000s)
[925.373360] [156/156] ( 99s left) gem_exec_params (invalid-fence-in-submit)
[925.444061] Starting subtest: invalid-fence-in-submit
[925.449342] Subtest invalid-fence-in-submit: SUCCESS (0.004s)
[925.561547] Closing watchdogs
results: parsing output: 0/ for test: syncobj_timeline
results: parsing output: 1/ for test: gem_eio
results: parsing output: 2/ for test: i915_hangman
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_ccs
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 8/ for test: gem_lmem_swapping
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_flip
results: parsing output: 12/ for test: prime_vgem
results: parsing output: 13/ for test: gem_exec_whisper
results: parsing output: 14/ for test: syncobj_eventfd
results: parsing output: 15/ for test: gem_reg_read
results: parsing output: 16/ for test: kms_chamelium_frames
results: parsing output: 17/ for test: gem_exec_flush
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_exec_fence
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: prime_mmap
results: parsing output: 25/ for test: kms_cursor_legacy
results: parsing output: 26/ for test: kms_ccs
results: parsing output: 27/ for test: gen9_exec_parse
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: api_intel_bb
results: parsing output: 32/ for test: kms_chamelium_audio
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: template
results: parsing output: 35/ for test: kms_cursor_legacy
results: parsing output: 36/ for test: kms_chamelium_hpd
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_vblank
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_media_vme
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: kms_debugfs
results: parsing output: 43/ for test: kms_flip
results: parsing output: 44/ for test: kms_plane
results: parsing output: 45/ for test: prime_mmap
results: parsing output: 46/ for test: kms_cursor_crc
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: i915_pm_rpm
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_joiner
results: parsing output: 52/ for test: gem_exec_schedule
results: parsing output: 53/ for test: kms_cursor_legacy
results: parsing output: 54/ for test: i915_query
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: syncobj_wait
results: parsing output: 58/ for test: syncobj_timeline
results: parsing output: 59/ for test: gem_exec_balancer
results: parsing output: 60/ for test: kms_plane_lowres
results: parsing output: 61/ for test: gem_render_copy
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_exec_reloc
results: parsing output: 64/ for test: gem_userptr_blits
results: parsing output: 65/ for test: kms_getfb
results: parsing output: 66/ for test: kms_prop_blob
results: parsing output: 67/ for test: kms_color_pipeline
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_flip_scaled_crc
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_pm_rpm
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_content_protection
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: kms_psr2_sf
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: gem_ctx_param
results: parsing output: 81/ for test: syncobj_wait
results: parsing output: 82/ for test: gem_request_retire
results: parsing output: 83/ for test: gem_ctx_engines
results: parsing output: 84/ for test: syncobj_wait
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_plane_scaling
results: parsing output: 87/ for test: gem_tiled_pread_basic
results: parsing output: 88/ for test: kms_plane_alpha_blend
results: parsing output: 89/ for test: gem_exec_balancer
results: parsing output: 90/ for test: kms_psr2_su
results: parsing output: 91/ for test: gem_fence_thrash
results: parsing output: 92/ for test: kms_psr
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: kms_sequence
results: parsing output: 95/ for test: gem_barrier_race
results: parsing output: 96/ for test: kms_properties
results: parsing output: 97/ for test: api_intel_bb
results: parsing output: 98/ for test: perf_pmu
results: parsing output: 99/ for test: sysfs_preempt_timeout
results: parsing output: 100/ for test: prime_busy
results: parsing output: 101/ for test: kms_flip
results: parsing output: 102/ for test: gem_mmap_gtt
results: parsing output: 103/ for test: kms_fbcon_fbt
results: parsing output: 104/ for test: kms_addfb_basic
results: parsing output: 105/ for test: i915_drm_fdinfo
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_exec_reloc
results: parsing output: 108/ for test: dmabuf_sync_file
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: gem_exec_schedule
results: parsing output: 111/ for test: kms_psr
results: parsing output: 112/ for test: gem_pxp
results: parsing output: 113/ for test: gem_mmap_wc
results: parsing output: 114/ for test: kms_cursor_crc
results: parsing output: 115/ for test: kms_cursor_legacy
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_async_flips
results: parsing output: 118/ for test: syncobj_wait
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: kms_psr2_sf
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gem_userptr_blits
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_draw_crc
results: parsing output: 126/ for test: kms_properties
results: parsing output: 127/ for test: gem_mmap_gtt
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: gem_mmap_wc
results: parsing output: 131/ for test: kms_cursor_legacy
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: kms_big_fb
results: parsing output: 134/ for test: kms_frontbuffer_tracking
results: parsing output: 135/ for test: kms_ccs
results: parsing output: 136/ for test: kms_cursor_crc
results: parsing output: 137/ for test: perf
results: parsing output: 138/ for test: kms_psr
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: gem_exec_reloc
results: parsing output: 141/ for test: kms_big_fb
results: parsing output: 142/ for test: kms_plane
results: parsing output: 143/ for test: kms_lease
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: gem_exec_reloc
results: parsing output: 147/ for test: gem_userptr_blits
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: gem_exec_reloc
results: parsing output: 151/ for test: kms_async_flips
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: parsing output: 153/ for test: gem_ctx_persistence
results: parsing output: 154/ for test: kms_psr
results: parsing output: 155/ for test: gem_exec_params
Done.