[67.676644] Initializing watchdogs
[67.676751]   /dev/watchdog0
[67.715600] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[67.732496] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[67.737239] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[67.739661] [001/156] (960s left) kms_cursor_edge_walk (256x256-top-bottom)
[69.309423] Starting subtest: 256x256-top-bottom
[69.310375] Starting dynamic subtest: pipe-A-HDMI-A-3
[72.668311] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (3.361s)
[72.676749] Starting dynamic subtest: pipe-D-HDMI-A-3
[75.900393] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (3.232s)
[75.901251] Subtest 256x256-top-bottom: SUCCESS (6.596s)
[76.099266] [002/156] (952s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[77.598978] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[77.599904] Starting dynamic subtest: pipe-A
[78.178626] Dynamic subtest pipe-A: SUCCESS (0.580s)
[78.188354] Starting dynamic subtest: pipe-B
[78.738124] Dynamic subtest pipe-B: SUCCESS (0.559s)
[78.753968] Starting dynamic subtest: pipe-C
[79.313794] Dynamic subtest pipe-C: SUCCESS (0.575s)
[79.330393] Starting dynamic subtest: pipe-D
[79.888028] Dynamic subtest pipe-D: SUCCESS (0.574s)
[79.889135] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (2.289s)
[80.103891] [003/156] (948s left) kms_dirtyfb (drrs-dirtyfb-ioctl)
[81.610118] Starting subtest: drrs-dirtyfb-ioctl
[81.615066] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s)
[81.747579] [004/156] (946s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[83.283635] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[83.285350] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[83.408845] [005/156] (945s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[83.511036] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[83.597851] [006/156] (944s left) kms_chamelium_color (ctm-blue-to-red)
[85.101889] Subtest ctm-blue-to-red: SKIP (0.000s)
[85.150118] [007/156] (943s left) gem_eio (wait-immediate)
[85.430232] Starting subtest: wait-immediate
[86.004536] Subtest wait-immediate: SUCCESS (0.575s)
[87.523610] [008/156] (941s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[89.043984] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[89.045833] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[89.252812] [009/156] (939s left) perf (invalid-oa-exponent)
[89.632298] Starting subtest: invalid-oa-exponent
[89.655124] Subtest invalid-oa-exponent: SUCCESS (0.022s)
[89.703103] [010/156] (939s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[91.219808] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-mmap-gtt
[91.221464] Subtest hdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[91.391991] [011/156] (937s left) perf_pmu (render-node-busy)
[91.520577] Starting subtest: render-node-busy
[91.521491] Starting dynamic subtest: rcs0
[92.134338] Dynamic subtest rcs0: SUCCESS (0.613s)
[92.146626] Starting dynamic subtest: bcs0
[92.694189] Dynamic subtest bcs0: SUCCESS (0.559s)
[92.706293] Starting dynamic subtest: vcs0
[93.251488] Dynamic subtest vcs0: SUCCESS (0.556s)
[93.263174] Starting dynamic subtest: vcs1
[93.809491] Dynamic subtest vcs1: SUCCESS (0.557s)
[93.821172] Starting dynamic subtest: vecs0
[94.367367] Dynamic subtest vecs0: SUCCESS (0.557s)
[94.379855] Starting dynamic subtest: vecs1
[94.928609] Dynamic subtest vecs1: SUCCESS (0.560s)
[94.941597] Starting dynamic subtest: ccs0
[95.486543] Dynamic subtest ccs0: SUCCESS (0.557s)
[95.488172] Subtest render-node-busy: SUCCESS (3.966s)
[95.577606] [012/156] (933s left) kms_vrr (seamless-rr-switch-drrs)
[97.079958] Starting subtest: seamless-rr-switch-drrs
[97.082481] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[97.182022] [013/156] (931s left) kms_color (ctm-red-to-blue)
[98.707155] Starting subtest: ctm-red-to-blue
[98.708035] Starting dynamic subtest: pipe-A-HDMI-A-3
[99.403798] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.695s)
[99.414556] Starting dynamic subtest: pipe-B-HDMI-A-3
[99.864359] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.461s)
[99.873209] Starting dynamic subtest: pipe-C-HDMI-A-3
[100.327343] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.463s)
[100.336239] Starting dynamic subtest: pipe-D-HDMI-A-3
[100.844434] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.517s)
[100.845352] Subtest ctm-red-to-blue: SUCCESS (2.137s)
[101.044204] [014/156] (928s left) kms_plane_multiple (2x-tiling-4)
[102.548878] Starting subtest: 2x-tiling-4
[102.550635] Subtest 2x-tiling-4: SKIP (0.000s)
[102.635819] [015/156] (926s left) syncobj_wait (single-wait-for-submit-submitted)
[102.719199] Starting subtest: single-wait-for-submit-submitted
[102.824572] Subtest single-wait-for-submit-submitted: SUCCESS (0.105s)
[102.993920] [016/156] (926s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[104.510936] Starting subtest: yf-tiled-addfb-size-offset-overflow
[104.513073] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[104.639722] [017/156] (924s left) kms_flip (wf_vblank-ts-check)
[106.163833] Starting subtest: wf_vblank-ts-check
[106.169009] Starting dynamic subtest: A-HDMI-A3
[114.210549] Dynamic subtest A-HDMI-A3: SUCCESS (8.041s)
[114.220649] Starting dynamic subtest: B-HDMI-A3
[122.177380] Dynamic subtest B-HDMI-A3: SUCCESS (7.966s)
[122.186788] Starting dynamic subtest: C-HDMI-A3
[130.144577] Dynamic subtest C-HDMI-A3: SUCCESS (7.967s)
[130.154177] Starting dynamic subtest: D-HDMI-A3
[138.111215] Dynamic subtest D-HDMI-A3: SUCCESS (7.966s)
[138.112156] Subtest wf_vblank-ts-check: SUCCESS (31.948s)
[138.319596] [018/156] (891s left) gen7_exec_parse (oacontrol-tracking)
[138.400490] Subtest oacontrol-tracking: SKIP (0.000s)
[138.490330] [019/156] (890s left) kms_async_flips (invalid-async-flip-atomic)
[139.991155] Starting subtest: invalid-async-flip-atomic
[140.222112] Starting dynamic subtest: pipe-A-HDMI-A-3
[140.575571] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.354s)
[140.706807] Starting dynamic subtest: pipe-B-HDMI-A-3
[140.801998] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.103s)
[140.965587] Starting dynamic subtest: pipe-C-HDMI-A-3
[141.059604] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.102s)
[141.219379] Starting dynamic subtest: pipe-D-HDMI-A-3
[141.321500] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.110s)
[141.322412] Subtest invalid-async-flip-atomic: SUCCESS (1.331s)
[141.718247] [020/156] (887s left) gem_mmap_wc (pf-nonblock)
[141.788997] Subtest pf-nonblock: SKIP (0.000s)
[141.860418] [021/156] (887s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[143.368197] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[143.369976] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[143.500757] [022/156] (886s left) perf (mi-rpc)
[143.730931] Starting subtest: mi-rpc
[143.733122] Subtest mi-rpc: SKIP (0.000s)
[143.778764] [023/156] (885s left) kms_pm_backlight (fade-with-dpms)
[145.286223] Subtest fade-with-dpms: SKIP (0.000s)
[145.342575] [024/156] (884s left) gem_exec_schedule (u-semaphore-resolve)
[145.428039] Starting subtest: u-semaphore-resolve
[145.508758] Subtest u-semaphore-resolve: SUCCESS (0.081s)
[145.920586] [025/156] (883s left) kms_flip (2x-plain-flip)
[147.422117] Starting subtest: 2x-plain-flip
[147.435445] Subtest 2x-plain-flip: SKIP (0.013s)
[147.574721] [026/156] (882s left) gem_workarounds (basic-read-fd)
[147.690253] Starting subtest: basic-read-fd
[147.731481] Subtest basic-read-fd: SUCCESS (0.041s)
[147.904499] [027/156] (881s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[149.411530] Starting subtest: basic-busy-flip-before-cursor-legacy
[149.413288] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[149.499109] [028/156] (880s left) i915_pm_freq_api (freq-basic-api)
[149.596339] Starting subtest: freq-basic-api
[149.597220] Starting dynamic subtest: gt0
[149.601023] Dynamic subtest gt0: SUCCESS (0.005s)
[149.601856] Subtest freq-basic-api: SUCCESS (0.005s)
[149.771406] [029/156] (880s left) prime_busy (after-wait)
[149.846458] Starting subtest: after-wait
[149.850986] Starting dynamic subtest: rcs0
[149.905417] Dynamic subtest rcs0: SUCCESS (0.054s)
[149.915212] Starting dynamic subtest: bcs0
[149.959567] Dynamic subtest bcs0: SUCCESS (0.049s)
[149.971508] Starting dynamic subtest: vcs0
[149.995345] Dynamic subtest vcs0: SUCCESS (0.040s)
[150.011759] Starting dynamic subtest: vcs1
[150.038019] Dynamic subtest vcs1: SUCCESS (0.042s)
[150.060400] Starting dynamic subtest: vecs0
[150.080971] Dynamic subtest vecs0: SUCCESS (0.042s)
[150.102734] Starting dynamic subtest: vecs1
[150.121449] Dynamic subtest vecs1: SUCCESS (0.040s)
[150.136703] Starting dynamic subtest: ccs0
[150.162485] Dynamic subtest ccs0: SUCCESS (0.040s)
[150.277284] Subtest after-wait: SUCCESS (0.423s)
[150.409402] [030/156] (879s left) syncobj_wait (invalid-single-wait-unsubmitted)
[150.480068] Starting subtest: invalid-single-wait-unsubmitted
[150.480923] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[150.673748] [031/156] (879s left) kms_frontbuffer_tracking (hdr-rgb565-draw-mmap-wc)
[152.181645] Starting subtest: hdr-rgb565-draw-mmap-wc
[152.183281] Subtest hdr-rgb565-draw-mmap-wc: SKIP (0.000s)
[152.324750] [032/156] (877s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[153.853440] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[153.855229] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[153.961319] [033/156] (876s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[155.497247] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu
[155.498940] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[155.661717] [034/156] (874s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[157.914410] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[157.975939] [035/156] (872s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[159.480462] Starting subtest: cursorA-vs-flipA-toggle
[170.390900] Subtest cursorA-vs-flipA-toggle: SUCCESS (10.911s)
[170.603790] [036/156] (859s left) kms_getfb (getfb2-handle-zero)
[172.111425] Starting subtest: getfb2-handle-zero
[172.112281] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[172.238075] [037/156] (858s left) gem_busy (parallel)
[172.508323] Starting subtest: parallel
[172.509283] Starting dynamic subtest: rcs0
[172.624029] Dynamic subtest rcs0: SUCCESS (0.116s)
[172.638400] Starting dynamic subtest: bcs0
[172.692122] Dynamic subtest bcs0: SUCCESS (0.067s)
[172.712521] Starting dynamic subtest: vcs0
[172.768471] Dynamic subtest vcs0: SUCCESS (0.075s)
[172.782063] Starting dynamic subtest: vcs1
[172.833300] Dynamic subtest vcs1: SUCCESS (0.064s)
[172.854312] Starting dynamic subtest: vecs0
[172.913350] Dynamic subtest vecs0: SUCCESS (0.079s)
[172.927303] Starting dynamic subtest: vecs1
[172.980054] Dynamic subtest vecs1: SUCCESS (0.066s)
[172.999263] Starting dynamic subtest: ccs0
[173.057481] Dynamic subtest ccs0: SUCCESS (0.076s)
[173.058489] Subtest parallel: SUCCESS (0.551s)
[173.349554] [038/156] (857s left) gem_exec_reloc (basic-softpin)
[173.426442] Subtest basic-softpin: SKIP (0.000s)
[173.502403] [039/156] (857s left) tools_test (sysfs_l3_parity)
[173.552773] Starting subtest: sysfs_l3_parity
[173.630171] Subtest sysfs_l3_parity: SKIP (0.082s)
[173.731660] [040/156] (857s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[173.808970] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[173.810932] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[174.049626] [041/156] (856s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[175.555290] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[178.410661] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (2.856s)
[178.613294] [042/156] (852s left) perf_pmu (all-busy-check-all)
[178.676206] Starting subtest: all-busy-check-all
[179.265037] Subtest all-busy-check-all: SUCCESS (0.589s)
[179.374505] [043/156] (851s left) sysfs_timeslice_duration (idempotent)
[179.451058] Starting subtest: idempotent
[179.452067] Starting dynamic subtest: vecs0
[179.452980] Dynamic subtest vecs0: SUCCESS (0.001s)
[179.462883] Starting dynamic subtest: ccs0
[179.464010] Dynamic subtest ccs0: SUCCESS (0.000s)
[179.473497] Starting dynamic subtest: vcs0
[179.474583] Dynamic subtest vcs0: SUCCESS (0.000s)
[179.483819] Starting dynamic subtest: bcs0
[179.484912] Dynamic subtest bcs0: SUCCESS (0.001s)
[179.494186] Starting dynamic subtest: vecs1
[179.495332] Dynamic subtest vecs1: SUCCESS (0.001s)
[179.504462] Starting dynamic subtest: rcs0
[179.505291] Dynamic subtest rcs0: SUCCESS (0.000s)
[179.514717] Starting dynamic subtest: vcs1
[179.515717] Dynamic subtest vcs1: SUCCESS (0.001s)
[179.516587] Subtest idempotent: SUCCESS (0.009s)
[179.590480] [044/156] (851s left) gem_exec_fence (keep-in-fence)
[179.814091] Starting subtest: keep-in-fence
[179.815635] Starting dynamic subtest: rcs0
[179.898556] Dynamic subtest rcs0: SUCCESS (0.086s)
[179.908392] Starting dynamic subtest: bcs0
[179.951607] Dynamic subtest bcs0: SUCCESS (0.052s)
[179.967946] Starting dynamic subtest: vcs0
[180.010078] Dynamic subtest vcs0: SUCCESS (0.057s)
[180.043662] Starting dynamic subtest: vcs1
[180.085669] Dynamic subtest vcs1: SUCCESS (0.074s)
[180.103247] Starting dynamic subtest: vecs0
[180.144230] Dynamic subtest vecs0: SUCCESS (0.057s)
[180.174285] Starting dynamic subtest: vecs1
[180.212552] Dynamic subtest vecs1: SUCCESS (0.067s)
[180.232771] Starting dynamic subtest: ccs0
[180.446145] Dynamic subtest ccs0: SUCCESS (0.233s)
[180.447023] Subtest keep-in-fence: SUCCESS (0.635s)
[181.171565] [FACT gem_exec_fence (keep-in-fence)] new: kernel.kmod_is_loaded.vgem: true
[181.173419] [045/156] (849s left) gem_exec_schedule (preempt-other-chain)
[181.269510] Starting subtest: preempt-other-chain
[181.270437] Starting dynamic subtest: rcs0
[181.724589] Dynamic subtest rcs0: SUCCESS (0.455s)
[181.734426] Starting dynamic subtest: bcs0
[182.148973] Dynamic subtest bcs0: SUCCESS (0.424s)
[182.158708] Starting dynamic subtest: vcs0
[182.572280] Dynamic subtest vcs0: SUCCESS (0.423s)
[182.582040] Starting dynamic subtest: vcs1
[183.010981] Dynamic subtest vcs1: SUCCESS (0.438s)
[183.020891] Starting dynamic subtest: vecs0
[183.433051] Dynamic subtest vecs0: SUCCESS (0.421s)
[183.442750] Starting dynamic subtest: vecs1
[183.868859] Dynamic subtest vecs1: SUCCESS (0.435s)
[183.878814] Starting dynamic subtest: ccs0
[184.296100] Dynamic subtest ccs0: SUCCESS (0.427s)
[184.297085] Subtest preempt-other-chain: SUCCESS (3.027s)
[184.767664] [046/156] (846s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-blt)
[186.285136] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-blt
[186.286983] Subtest fbchdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[186.414966] [047/156] (844s left) kms_cursor_crc (cursor-random-64x64)
[188.099985] Starting subtest: cursor-random-64x64
[188.104442] Starting dynamic subtest: pipe-A-HDMI-A-3
[192.583549] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (4.479s)
[192.620587] Starting dynamic subtest: pipe-D-HDMI-A-3
[196.863380] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (4.253s)
[196.864362] Subtest cursor-random-64x64: SUCCESS (8.764s)
[197.249127] [048/156] (834s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[198.759672] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[198.987792] Starting dynamic subtest: pipe-A-HDMI-A-3
[201.243576] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.255s)
[201.444577] Starting dynamic subtest: pipe-B-HDMI-A-3
[203.498835] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (2.063s)
[203.662570] Starting dynamic subtest: pipe-C-HDMI-A-3
[205.719147] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (2.065s)
[205.876450] Starting dynamic subtest: pipe-D-HDMI-A-3
[207.924412] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.056s)
[207.925475] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (9.166s)
[208.326475] [049/156] (823s left) gem_exec_create (madvise)
[208.420406] Starting subtest: madvise
[208.421290] Starting dynamic subtest: smem
[228.555704] Dynamic subtest smem: SUCCESS (20.135s)
[228.566088] Starting dynamic subtest: lmem0
[248.796762] Dynamic subtest lmem0: SUCCESS (20.240s)
[248.797591] Subtest madvise: SUCCESS (40.377s)
[249.921500] [050/156] (781s left) kms_joiner (basic-max-non-joiner)
[251.434127] Starting subtest: basic-max-non-joiner
[251.435789] Subtest basic-max-non-joiner: SKIP (0.000s)
[251.522109] [051/156] (779s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-indfb-plflip-blt)
[253.053647] Starting subtest: hdr-2p-scndscrn-indfb-plflip-blt
[253.055332] Subtest hdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[253.201045] [052/156] (778s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[254.748547] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[254.750190] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[254.905715] [053/156] (776s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[256.453474] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[256.455255] Subtest fbcpsr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[256.605295] [054/156] (775s left) gem_ctx_persistence (heartbeat-close)
[256.723247] Starting subtest: heartbeat-close
[256.725176] Subtest heartbeat-close: SKIP (0.000s)
[256.861296] [055/156] (774s left) kms_psr (psr-basic)
[258.375306] Subtest psr-basic: SKIP (0.000s)
[258.432228] [056/156] (773s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-blt)
[259.950411] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-blt
[259.952152] Subtest psrhdr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[260.065993] [057/156] (771s left) kms_lease (lease-invalid-crtc)
[261.597789] Starting subtest: lease-invalid-crtc
[261.598585] Starting dynamic subtest: pipe-A-HDMI-A-3
[261.599456] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.000s)
[261.609627] Starting dynamic subtest: pipe-B-HDMI-A-3
[261.610527] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.000s)
[261.620237] Starting dynamic subtest: pipe-C-HDMI-A-3
[261.621157] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.000s)
[261.631173] Starting dynamic subtest: pipe-D-HDMI-A-3
[261.632239] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.000s)
[261.633281] Subtest lease-invalid-crtc: SUCCESS (0.006s)
[261.772103] [058/156] (770s left) kms_chamelium_hpd (dp-hpd-fast)
[263.345243] Subtest dp-hpd-fast: SKIP (0.000s)
[263.449378] [059/156] (768s left) kms_dsc (dsc-basic)
[264.968980] Starting subtest: dsc-basic
[264.974148] Subtest dsc-basic: SKIP (0.000s)
[265.148230] [060/156] (767s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[266.696183] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-mmap-cpu
[266.697904] Subtest fbchdr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[266.846952] [061/156] (765s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[268.395239] Starting subtest: fbcpsr-tiling-4
[268.396996] Subtest fbcpsr-tiling-4: SKIP (0.000s)
[268.552538] [062/156] (763s left) kms_addfb_basic (unused-pitches)
[268.658395] Starting subtest: unused-pitches
[268.659272] Subtest unused-pitches: SUCCESS (0.000s)
[270.244700] [063/156] (762s left) kms_properties (crtc-properties-legacy)
[271.786609] Starting subtest: crtc-properties-legacy
[271.787521] Starting dynamic subtest: pipe-A-HDMI-A-3
[272.082484] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.294s)
[272.112937] Starting dynamic subtest: pipe-B-HDMI-A-3
[272.372884] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.288s)
[272.384692] Starting dynamic subtest: pipe-C-HDMI-A-3
[272.640663] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.266s)
[272.652216] Starting dynamic subtest: pipe-D-HDMI-A-3
[272.889344] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.246s)
[272.890306] Subtest crtc-properties-legacy: SUCCESS (1.103s)
[273.148310] [064/156] (759s left) gem_ctx_isolation (preservation-s3)
[273.236982] Starting subtest: preservation-S3
[273.237940] Starting dynamic subtest: rcs0
[292.880077] Dynamic subtest rcs0: SUCCESS (4.145s)
[292.892187] Starting dynamic subtest: bcs0
[312.871694] Dynamic subtest bcs0: SUCCESS (3.788s)
[312.883500] Starting dynamic subtest: vcs0
[332.847017] Dynamic subtest vcs0: SUCCESS (3.749s)
[332.858852] Starting dynamic subtest: vcs1
[352.855812] Dynamic subtest vcs1: SUCCESS (3.776s)
[352.867616] Starting dynamic subtest: vecs0
[372.831636] Dynamic subtest vecs0: SUCCESS (3.773s)
[372.844248] Starting dynamic subtest: vecs1
[392.869053] Dynamic subtest vecs1: SUCCESS (3.782s)
[392.880790] Starting dynamic subtest: ccs0
[412.862504] Dynamic subtest ccs0: SUCCESS (3.715s)
[412.863438] Subtest preservation-S3: SUCCESS (26.734s)
[424.174773] [065/156] (619s left) gem_mmap_offset (mmap-unmap)
[424.265709] Starting subtest: mmap-unmap
[424.266611] Starting dynamic subtest: lmem0
[425.270019] Dynamic subtest lmem0: SUCCESS (0.967s)
[425.282641] Starting dynamic subtest: smem0
[426.699369] Dynamic subtest smem0: SUCCESS (1.382s)
[426.700379] Subtest mmap-unmap: SUCCESS (2.351s)
[426.892859] [066/156] (616s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[428.499238] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[431.595436] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (3.036s)
[431.790408] [067/156] (612s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[433.329498] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[433.384156] [068/156] (610s left) gem_exec_balancer (semaphore)
[433.479858] Starting subtest: semaphore
[435.182206] Subtest semaphore: SUCCESS (1.683s)
[435.631436] [069/156] (608s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[437.163150] Starting subtest: cursor-vs-flip-legacy
[468.156802] Subtest cursor-vs-flip-legacy: SUCCESS (30.935s)
[468.343850] [070/156] (575s left) gem_partial_pwrite_pread (write-display)
[468.428671] Subtest write-display: SKIP (0.000s)
[468.510004] [071/156] (575s left) i915_query (query-garbage)
[468.590655] Starting subtest: query-garbage
[468.591684] Subtest query-garbage: SUCCESS (0.000s)
[468.722972] [072/156] (575s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[470.242436] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[470.244142] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SKIP (0.000s)
[470.335048] [073/156] (573s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[471.865838] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[471.867512] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[472.009756] [074/156] (572s left) prime_self_import (reimport-vs-gem_close-race)
[472.084299] Starting subtest: reimport-vs-gem_close-race
[477.171508] Subtest reimport-vs-gem_close-race: SUCCESS (5.087s)
[477.286919] [075/156] (567s left) sw_sync (timeline_closed)
[477.366688] Starting subtest: timeline_closed
[477.367604] Subtest timeline_closed: SUCCESS (0.000s)
[477.450013] [076/156] (566s left) gem_exec_schedule (fifo)
[477.543397] Starting subtest: fifo
[477.544296] Starting dynamic subtest: rcs0
[477.821867] Dynamic subtest rcs0: SUCCESS (0.278s)
[477.833827] Starting dynamic subtest: bcs0
[478.022265] Dynamic subtest bcs0: SUCCESS (0.199s)
[478.034052] Starting dynamic subtest: vcs0
[478.233974] Dynamic subtest vcs0: SUCCESS (0.211s)
[478.246431] Starting dynamic subtest: vcs1
[478.449924] Dynamic subtest vcs1: SUCCESS (0.215s)
[478.461879] Starting dynamic subtest: vecs0
[478.665654] Dynamic subtest vecs0: SUCCESS (0.215s)
[478.677432] Starting dynamic subtest: vecs1
[478.904212] Dynamic subtest vecs1: SUCCESS (0.237s)
[478.916439] Starting dynamic subtest: ccs0
[479.116141] Dynamic subtest ccs0: SUCCESS (0.211s)
[479.116999] Subtest fifo: SUCCESS (1.573s)
[479.560731] [077/156] (564s left) kms_frontbuffer_tracking (fbcpsrhdr-indfb-scaledprimary)
[481.086704] Starting subtest: fbcpsrhdr-indfb-scaledprimary
[481.088442] Subtest fbcpsrhdr-indfb-scaledprimary: SKIP (0.000s)
[481.230345] [078/156] (563s left) api_intel_bb (delta-check)
[481.330678] Starting subtest: delta-check
[481.361640] Subtest delta-check: SUCCESS (0.031s)
[481.540040] [079/156] (563s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-render)
[483.057566] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-render
[483.059340] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[483.200947] [080/156] (561s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-render)
[484.760893] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-render
[484.762590] Subtest hdr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[484.937101] [081/156] (559s left) gem_render_copy_redux (flink-interruptible)
[485.037501] Starting subtest: flink-interruptible
[488.311845] Subtest flink-interruptible: SUCCESS (3.274s)
[488.492892] [082/156] (556s left) gem_softpin (allocator-evict)
[488.582544] Starting subtest: allocator-evict
[488.583390] Starting dynamic subtest: rcs0
[515.355055] Dynamic subtest rcs0: SUCCESS (26.762s)
[515.367532] Starting dynamic subtest: bcs0
[542.174720] Dynamic subtest bcs0: SUCCESS (26.825s)
[542.187349] Starting dynamic subtest: vcs0
[569.394112] Dynamic subtest vcs0: SUCCESS (27.218s)
[569.406744] Starting dynamic subtest: vcs1
[596.469534] Dynamic subtest vcs1: SUCCESS (27.070s)
[596.482006] Starting dynamic subtest: vecs0
[623.460582] Dynamic subtest vecs0: SUCCESS (26.983s)
[623.473291] Starting dynamic subtest: vecs1
[650.338535] Dynamic subtest vecs1: SUCCESS (26.871s)
[650.351254] Starting dynamic subtest: ccs0
[677.500591] Dynamic subtest ccs0: SUCCESS (27.166s)
[677.501545] Subtest allocator-evict: SUCCESS (188.902s)
[677.629221] [083/156] (367s left) api_intel_bb (blit-reloc-keep-cache)
[677.785666] Starting subtest: blit-reloc-keep-cache
[677.787410] Subtest blit-reloc-keep-cache: SKIP (0.000s)
[677.957278] [084/156] (367s left) gem_render_copy_redux (normal)
[678.051032] Starting subtest: normal
[678.770221] Subtest normal: SUCCESS (0.719s)
[678.917449] [085/156] (366s left) vgem_basic (sysfs)
[678.974597] Starting subtest: sysfs
[678.975480] Subtest sysfs: SUCCESS (0.000s)
[679.060727] [086/156] (366s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[679.149610] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[679.252597] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.102s)
[679.370531] [087/156] (365s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[680.893693] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[680.895457] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[681.040724] [088/156] (364s left) gem_wait (write-busy)
[681.161814] Starting subtest: write-busy
[681.162703] Starting dynamic subtest: all-engines
[681.759532] Dynamic subtest all-engines: SUCCESS (0.597s)
[681.772673] Starting dynamic subtest: rcs0
[682.310037] Dynamic subtest rcs0: SUCCESS (0.549s)
[682.323100] Starting dynamic subtest: bcs0
[682.855569] Dynamic subtest bcs0: SUCCESS (0.545s)
[682.868613] Starting dynamic subtest: vcs0
[683.399122] Dynamic subtest vcs0: SUCCESS (0.543s)
[683.412244] Starting dynamic subtest: vcs1
[683.941319] Dynamic subtest vcs1: SUCCESS (0.541s)
[683.954357] Starting dynamic subtest: vecs0
[684.483165] Dynamic subtest vecs0: SUCCESS (0.541s)
[684.496251] Starting dynamic subtest: vecs1
[685.025137] Dynamic subtest vecs1: SUCCESS (0.541s)
[685.038331] Starting dynamic subtest: ccs0
[685.568177] Dynamic subtest ccs0: SUCCESS (0.542s)
[685.569175] Subtest write-busy: SUCCESS (4.407s)
[685.822083] [089/156] (359s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[687.340017] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[687.341982] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[687.491029] [090/156] (357s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[689.040873] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[689.042517] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[689.192509] [091/156] (356s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[690.740730] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[690.742383] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[690.901519] [092/156] (354s left) kms_big_fb (linear-64bpp-rotate-0)
[692.455867] Starting subtest: linear-64bpp-rotate-0
[694.823533] Subtest linear-64bpp-rotate-0: SUCCESS (2.369s)
[695.050122] [093/156] (350s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[695.129488] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[695.130502] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[695.285162] [094/156] (350s left) i915_drm_fdinfo (most-busy-idle-check-all)
[695.357649] Starting subtest: most-busy-idle-check-all
[695.358554] Starting dynamic subtest: rcs0
[695.387324] Dynamic subtest rcs0: SKIP (0.028s)
[695.400311] Starting dynamic subtest: bcs0
[695.402112] Dynamic subtest bcs0: SKIP (0.000s)
[695.414976] Starting dynamic subtest: vcs0
[695.417347] Dynamic subtest vcs0: SKIP (0.000s)
[695.429936] Starting dynamic subtest: vcs1
[695.431817] Dynamic subtest vcs1: SKIP (0.000s)
[695.445447] Starting dynamic subtest: vecs0
[695.447503] Dynamic subtest vecs0: SKIP (0.001s)
[695.460095] Starting dynamic subtest: vecs1
[695.462410] Dynamic subtest vecs1: SKIP (0.000s)
[695.474679] Starting dynamic subtest: ccs0
[695.476840] Dynamic subtest ccs0: SKIP (0.000s)
[695.478914] Subtest most-busy-idle-check-all: SKIP (0.038s)
[695.527699] [095/156] (350s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[697.074171] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[697.076036] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[697.273991] [096/156] (348s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[698.805396] Starting subtest: x-tiled-64bpp-rotate-0
[700.628458] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.822s)
[700.844999] [097/156] (345s left) kms_flip (nonblocking-read)
[702.354489] Starting subtest: nonblocking-read
[702.355415] Subtest nonblocking-read: SUCCESS (0.000s)
[702.476890] [098/156] (343s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[704.021260] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[704.727515] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.706s)
[704.973169] [099/156] (341s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-pwrite)
[706.490795] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-pwrite
[706.492426] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[706.649576] [100/156] (339s left) kms_psr (fbc-pr-cursor-render)
[708.191670] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[708.258034] [101/156] (338s left) gem_eio (throttle)
[708.558682] Starting subtest: throttle
[709.024552] Subtest throttle: SUCCESS (0.467s)
[710.581389] [102/156] (335s left) kms_vblank (wait-forked-hang)
[712.120566] Starting subtest: wait-forked-hang
[712.121438] Starting dynamic subtest: pipe-A-HDMI-A-3
[714.485346] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.363s)
[714.502568] Starting dynamic subtest: pipe-D-HDMI-A-3
[716.722602] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.234s)
[716.725165] Subtest wait-forked-hang: SUCCESS (4.604s)
[716.907035] [103/156] (329s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[718.424680] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.000s)
[718.493078] [104/156] (328s left) gem_close (many-handles-one-vma)
[718.580704] Starting subtest: many-handles-one-vma
[718.610155] Subtest many-handles-one-vma: SUCCESS (0.029s)
[718.763664] [105/156] (327s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-msflip-blt)
[720.280066] Starting subtest: psrhdr-2p-scndscrn-shrfb-msflip-blt
[720.281787] Subtest psrhdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[720.423525] [106/156] (326s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[721.968096] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[721.970017] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[722.103770] [107/156] (324s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[723.646072] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[723.647698] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[723.797573] [108/156] (323s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-blt)
[725.345118] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-blt
[725.347029] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[725.514011] [109/156] (321s left) prime_mmap_coherency (ioctl-errors)
[725.619643] Starting subtest: ioctl-errors
[726.841468] Subtest ioctl-errors: SUCCESS (1.221s)
[727.043116] [110/156] (320s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[728.616452] Starting subtest: yf-tiled-32bpp-rotate-0
[728.618407] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[728.765936] [111/156] (318s left) kms_psr (fbc-psr-sprite-plane-onoff)
[730.311658] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.000s)
[730.378347] [112/156] (316s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[731.894345] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[731.896280] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[732.017680] [113/156] (315s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[733.550333] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[733.551292] Starting dynamic subtest: pipe-A-HDMI-A-3
[733.559590] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s)
[733.572702] Starting dynamic subtest: pipe-B-HDMI-A-3
[733.581202] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s)
[733.593652] Starting dynamic subtest: pipe-C-HDMI-A-3
[733.602006] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s)
[733.614532] Starting dynamic subtest: pipe-D-HDMI-A-3
[733.623432] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s)
[733.625527] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SKIP (0.010s)
[733.820751] [114/156] (313s left) i915_suspend (debugfs-reader)
[733.914480] Starting subtest: debugfs-reader
[754.700914] Subtest debugfs-reader: SUCCESS (5.779s)
[758.802483] [115/156] (292s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[760.374093] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[760.375940] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[760.537102] [116/156] (291s left) kms_pm_dc (dc6-psr)
[763.150625] Starting subtest: dc6-psr
[763.152412] Subtest dc6-psr: SKIP (0.000s)
[763.247868] [117/156] (288s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[764.818763] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[764.820699] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[765.047953] [118/156] (286s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[766.607966] Starting subtest: y-tiled-64bpp-rotate-270
[766.609885] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[766.753474] [119/156] (285s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[766.863012] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[766.945719] [120/156] (284s left) gem_mmap_gtt (big-copy-odd)
[767.025147] Subtest big-copy-odd: SKIP (0.000s)
[767.097953] [121/156] (284s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[768.635946] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[768.636910] Starting dynamic subtest: pipe-A-HDMI-A-3
[768.645705] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[768.659439] Starting dynamic subtest: pipe-B-HDMI-A-3
[768.668343] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[768.681733] Starting dynamic subtest: pipe-C-HDMI-A-3
[768.690573] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[768.704231] Starting dynamic subtest: pipe-D-HDMI-A-3
[768.714586] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[768.716486] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.007s)
[768.949006] [122/156] (283s left) kms_psr (pr-primary-blt)
[770.487456] Subtest pr-primary-blt: SKIP (0.000s)
[770.544560] [123/156] (281s left) gem_render_copy (yf-tiled-ccs-to-linear)
[770.633921] Starting subtest: yf-tiled-ccs-to-linear
[770.635821] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[770.871464] [124/156] (281s left) gem_exec_balancer (bonded-dual)
[770.969124] Starting subtest: bonded-dual
[770.971155] Subtest bonded-dual: SKIP (0.000s)
[771.438837] [125/156] (280s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-shrfb-pgflip-blt)
[772.972662] Starting subtest: psrhdr-2p-primscrn-shrfb-pgflip-blt
[772.974340] Subtest psrhdr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[773.134328] [126/156] (279s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-indfb-msflip-blt)
[774.695945] Starting subtest: psrhdr-2p-scndscrn-indfb-msflip-blt
[774.697743] Subtest psrhdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[774.900721] [127/156] (277s left) gem_softpin (softpin)
[774.995276] Starting subtest: softpin
[807.290551] Subtest softpin: SUCCESS (32.238s)
[807.421722] [128/156] (245s left) kms_pipe_crc_basic (nonblocking-crc)
[808.938909] Starting subtest: nonblocking-crc
[808.941282] Starting dynamic subtest: pipe-A-HDMI-A-3
[809.669157] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.728s)
[809.684215] Starting dynamic subtest: pipe-B-HDMI-A-3
[810.213966] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.543s)
[810.230937] Starting dynamic subtest: pipe-C-HDMI-A-3
[810.729158] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.513s)
[810.744607] Starting dynamic subtest: pipe-D-HDMI-A-3
[811.251595] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.520s)
[811.252448] Subtest nonblocking-crc: SUCCESS (2.312s)
[811.433445] [129/156] (241s left) kms_chamelium_edid (dp-edid-resolution-list)
[812.993132] Subtest dp-edid-resolution-list: SKIP (0.000s)
[813.098931] [130/156] (239s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-indfb-pgflip-blt)
[814.624392] Starting subtest: fbchdr-2p-scndscrn-indfb-pgflip-blt
[814.626008] Subtest fbchdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[814.827441] [131/156] (237s left) kms_cursor_crc (cursor-onscreen-32x10)
[816.465520] Starting subtest: cursor-onscreen-32x10
[816.514521] Subtest cursor-onscreen-32x10: SKIP (0.047s)
[816.889744] [132/156] (235s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[818.410665] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[820.715112] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (2.304s)
[820.903064] [133/156] (232s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[822.428810] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt
[822.430663] Subtest psrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[822.604436] [134/156] (230s left) kms_psr (psr-sprite-mmap-gtt)
[824.133201] Subtest psr-sprite-mmap-gtt: SKIP (0.000s)
[824.196271] [135/156] (228s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-pwrite)
[825.717752] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-pwrite
[825.719592] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[825.868162] [136/156] (227s left) kms_busy (extended-pageflip-hang-newfb)
[827.418017] Starting subtest: extended-pageflip-hang-newfb
[827.418937] Starting dynamic subtest: pipe-A
[835.294057] Dynamic subtest pipe-A: SUCCESS (7.871s)
[835.309335] Starting dynamic subtest: pipe-D
[843.079937] Dynamic subtest pipe-D: SUCCESS (7.779s)
[843.080868] Subtest extended-pageflip-hang-newfb: SUCCESS (15.657s)
[843.291223] [137/156] (209s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[843.369740] Starting subtest: etime-multi-wait-for-submit-submitted
[843.474709] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.104s)
[843.624712] [138/156] (209s left) gem_userptr_blits (sync-unmap)
[843.720330] Starting subtest: sync-unmap
[843.742429] Subtest sync-unmap: SUCCESS (0.021s)
[843.926355] [139/156] (209s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[845.446585] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt
[845.448213] Subtest psrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[845.596743] [140/156] (207s left) dmabuf_sync_file (export-before-signal)
[845.681224] Starting subtest: export-before-signal
[845.682141] Subtest export-before-signal: SUCCESS (0.001s)
[845.835034] [141/156] (207s left) i915_pm_rpm (debugfs-read)
[849.983213] Starting subtest: debugfs-read
[850.975356] Subtest debugfs-read: SUCCESS (0.987s)
[852.011000] [142/156] (201s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[852.111109] Starting subtest: single-wait-all-for-submit-available-signaled
[852.112050] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[852.305216] [143/156] (201s left) kms_frontbuffer_tracking (hdr-1p-primscrn-shrfb-msflip-blt)
[853.821535] Starting subtest: hdr-1p-primscrn-shrfb-msflip-blt
[853.823117] Subtest hdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[854.006663] [144/156] (199s left) gem_lmem_swapping (parallel-random-engines)
[858.630794] Starting subtest: parallel-random-engines
[858.631993] Starting dynamic subtest: lmem0
[888.077073] Dynamic subtest lmem0: SUCCESS (29.455s)
[888.078159] Subtest parallel-random-engines: SUCCESS (29.456s)
[889.022331] [FACT gem_lmem_swapping (parallel-random-engines)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[889.023281] [FACT gem_lmem_swapping (parallel-random-engines)] deleted: kernel.kmod_is_loaded.i915: true
[889.025243] [145/156] (164s left) kms_flip (2x-absolute-wf_vblank)
[893.906118] Starting subtest: 2x-absolute-wf_vblank
[893.919317] Subtest 2x-absolute-wf_vblank: SKIP (0.013s)
[894.116454] [FACT kms_flip (2x-absolute-wf_vblank)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[894.120233] [FACT kms_flip (2x-absolute-wf_vblank)] new: kernel.kmod_is_loaded.i915: true
[894.123705] [146/156] (159s left) gem_create (create-ext-cpu-access-sanity-check)
[894.324360] Starting subtest: create-ext-cpu-access-sanity-check
[894.355894] Subtest create-ext-cpu-access-sanity-check: SUCCESS (0.032s)
[894.521670] [147/156] (159s left) gem_exec_whisper (basic-normal-all)
[894.617909] Starting subtest: basic-normal-all
[896.866746] Subtest basic-normal-all: SUCCESS (2.248s)
[897.157663] [148/156] (156s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[898.676918] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[898.678668] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[898.888016] [149/156] (155s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[900.405978] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[900.407748] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.000s)
[900.505899] [150/156] (153s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[902.039783] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[902.040703] Starting dynamic subtest: pipe-A-HDMI-A-3
[902.048757] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s)
[902.060941] Starting dynamic subtest: pipe-B-HDMI-A-3
[902.069555] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s)
[902.082280] Starting dynamic subtest: pipe-C-HDMI-A-3
[902.090778] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s)
[902.102271] Starting dynamic subtest: pipe-D-HDMI-A-3
[902.110911] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s)
[902.112911] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SKIP (0.010s)
[902.306835] [151/156] (152s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[903.822197] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[903.881917] [152/156] (150s left) kms_content_protection (lic-type-0)
[905.473267] Starting subtest: lic-type-0
[905.477303] Subtest lic-type-0: SKIP (0.002s)
[905.656394] [153/156] (148s left) gem_eio (create-ext)
[905.946178] Starting subtest: create-ext
[906.419163] Subtest create-ext: SUCCESS (0.473s)
[907.962877] [154/156] (146s left) syncobj_timeline (invalid-signal-bad-pad)
[908.060674] Starting subtest: invalid-signal-bad-pad
[908.061655] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[908.204724] [155/156] (146s left) gem_exec_reloc (basic-gtt-read-noreloc)
[908.299429] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[908.392208] [156/156] (146s left) kms_prime (d3hot)
[909.909202] Subtest D3hot: SKIP (0.000s)
[910.111786] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_edge_walk
results: parsing output: 1/ for test: kms_plane_scaling
results: parsing output: 2/ for test: kms_dirtyfb
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_pipe_b_c_ivb
results: parsing output: 5/ for test: kms_chamelium_color
results: parsing output: 6/ for test: gem_eio
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: perf
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: perf_pmu
results: parsing output: 11/ for test: kms_vrr
results: parsing output: 12/ for test: kms_color
results: parsing output: 13/ for test: kms_plane_multiple
results: parsing output: 14/ for test: syncobj_wait
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: kms_flip
results: parsing output: 17/ for test: gen7_exec_parse
results: parsing output: 18/ for test: kms_async_flips
results: parsing output: 19/ for test: gem_mmap_wc
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: perf
results: parsing output: 22/ for test: kms_pm_backlight
results: parsing output: 23/ for test: gem_exec_schedule
results: parsing output: 24/ for test: kms_flip
results: parsing output: 25/ for test: gem_workarounds
results: parsing output: 26/ for test: kms_cursor_legacy
results: parsing output: 27/ for test: i915_pm_freq_api
results: parsing output: 28/ for test: prime_busy
results: parsing output: 29/ for test: syncobj_wait
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_flip_scaled_crc
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_tiled_display
results: parsing output: 34/ for test: kms_cursor_legacy
results: parsing output: 35/ for test: kms_getfb
results: parsing output: 36/ for test: gem_busy
results: parsing output: 37/ for test: gem_exec_reloc
results: parsing output: 38/ for test: tools_test
results: parsing output: 39/ for test: gem_render_copy
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: perf_pmu
results: parsing output: 42/ for test: sysfs_timeslice_duration
results: parsing output: 43/ for test: gem_exec_fence
results: parsing output: 44/ for test: gem_exec_schedule
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_cursor_crc
results: parsing output: 47/ for test: kms_async_flips
results: parsing output: 48/ for test: gem_exec_create
results: parsing output: 49/ for test: kms_joiner
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gem_ctx_persistence
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_lease
results: parsing output: 57/ for test: kms_chamelium_hpd
results: parsing output: 58/ for test: kms_dsc
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_addfb_basic
results: parsing output: 62/ for test: kms_properties
results: parsing output: 63/ for test: gem_ctx_isolation
results: parsing output: 64/ for test: gem_mmap_offset
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_psr2_sf
results: parsing output: 67/ for test: gem_exec_balancer
results: parsing output: 68/ for test: kms_cursor_legacy
results: parsing output: 69/ for test: gem_partial_pwrite_pread
results: parsing output: 70/ for test: i915_query
results: parsing output: 71/ for test: kms_plane
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: prime_self_import
results: parsing output: 74/ for test: sw_sync
results: parsing output: 75/ for test: gem_exec_schedule
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: api_intel_bb
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: gem_render_copy_redux
results: parsing output: 81/ for test: gem_softpin
results: parsing output: 82/ for test: api_intel_bb
results: parsing output: 83/ for test: gem_render_copy_redux
results: parsing output: 84/ for test: vgem_basic
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_wait
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: syncobj_timeline
results: parsing output: 93/ for test: i915_drm_fdinfo
results: parsing output: 94/ for test: kms_ccs
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: gem_eio
results: parsing output: 101/ for test: kms_vblank
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: gem_close
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: prime_mmap_coherency
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: kms_psr
results: parsing output: 111/ for test: kms_flip_scaled_crc
results: parsing output: 112/ for test: kms_ccs
results: parsing output: 113/ for test: i915_suspend
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_pm_dc
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: gem_mmap_gtt
results: parsing output: 119/ for test: gem_mmap_gtt
results: parsing output: 120/ for test: kms_ccs
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: gem_render_copy
results: parsing output: 123/ for test: gem_exec_balancer
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_softpin
results: parsing output: 127/ for test: kms_pipe_crc_basic
results: parsing output: 128/ for test: kms_chamelium_edid
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_cursor_crc
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: kms_psr
results: parsing output: 134/ for test: kms_frontbuffer_tracking
results: parsing output: 135/ for test: kms_busy
results: parsing output: 136/ for test: syncobj_timeline
results: parsing output: 137/ for test: gem_userptr_blits
results: parsing output: 138/ for test: kms_frontbuffer_tracking
results: parsing output: 139/ for test: dmabuf_sync_file
results: parsing output: 140/ for test: i915_pm_rpm
results: parsing output: 141/ for test: syncobj_timeline
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: gem_lmem_swapping
results: parsing output: 144/ for test: kms_flip
results: parsing output: 145/ for test: gem_create
results: parsing output: 146/ for test: gem_exec_whisper
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: kms_flip_scaled_crc
results: parsing output: 149/ for test: kms_ccs
results: parsing output: 150/ for test: kms_psr2_sf
results: parsing output: 151/ for test: kms_content_protection
results: parsing output: 152/ for test: gem_eio
results: parsing output: 153/ for test: syncobj_timeline
results: parsing output: 154/ for test: gem_exec_reloc
results: parsing output: 155/ for test: kms_prime
Done.