[50.376710] Initializing watchdogs
[50.376770]   /dev/watchdog0
[50.393970] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[50.399951] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[50.402556] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[50.404622] [001/133] (960s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[50.499542] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[50.500938] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[50.599186] [002/133] (960s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[50.643937] Starting subtest: y-tiled-to-vebox-x-tiled
[50.644655] Starting dynamic subtest: smem
[50.738738] Dynamic subtest smem: SUCCESS (0.098s)
[50.739445] Subtest y-tiled-to-vebox-x-tiled: SUCCESS (0.098s)
[50.913986] [003/133] (960s left) perf (missing-sample-flags)
[50.991056] Starting subtest: missing-sample-flags
[50.991786] Subtest missing-sample-flags: SUCCESS (0.000s)
[51.021635] [004/133] (959s left) kms_psr (psr2-suspend)
[51.104458] Subtest psr2-suspend: SKIP (0.000s)
[51.143621] [005/133] (959s left) kms_hdmi_inject (inject-4k)
[51.231323] Starting subtest: inject-4k
[51.407855] Subtest inject-4k: SUCCESS (0.182s)
[51.507623] [006/133] (959s left) gem_mmap (bad-object)
[51.542609] Starting subtest: bad-object
[51.543281] Subtest bad-object: SUCCESS (0.000s)
[51.618565] [007/133] (959s left) kms_plane (pixel-format-y-tiled-modifier)
[51.700340] Starting subtest: pixel-format-y-tiled-modifier
[51.724678] Starting dynamic subtest: pipe-A-plane-0
[52.212739] Dynamic subtest pipe-A-plane-0: SUCCESS (0.500s)
[52.224925] Starting dynamic subtest: pipe-A-plane-3
[52.627523] Dynamic subtest pipe-A-plane-3: SUCCESS (0.424s)
[52.637389] Starting dynamic subtest: pipe-A-plane-5
[52.961662] Dynamic subtest pipe-A-plane-5: SUCCESS (0.341s)
[52.975509] Starting dynamic subtest: pipe-A-plane-7
[52.977163] Dynamic subtest pipe-A-plane-7: SKIP (0.000s)
[53.110449] Starting dynamic subtest: pipe-B-plane-0
[53.506184] Dynamic subtest pipe-B-plane-0: SUCCESS (0.408s)
[53.518040] Starting dynamic subtest: pipe-B-plane-3
[53.922587] Dynamic subtest pipe-B-plane-3: SUCCESS (0.424s)
[53.934215] Starting dynamic subtest: pipe-B-plane-5
[54.233610] Dynamic subtest pipe-B-plane-5: SUCCESS (0.316s)
[54.246084] Starting dynamic subtest: pipe-B-plane-7
[54.248016] Dynamic subtest pipe-B-plane-7: SKIP (0.000s)
[54.304460] Subtest pixel-format-y-tiled-modifier: SUCCESS (2.663s)
[54.444268] [008/133] (956s left) syncobj_timeline (wait-for-submit-complex)
[54.481497] Starting subtest: wait-for-submit-complex
[54.544290] Subtest wait-for-submit-complex: SUCCESS (0.064s)
[54.619919] [009/133] (956s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[54.707579] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[54.708911] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[54.786479] [010/133] (956s left) gem_ctx_persistence (legacy-engines-hang)
[54.822405] Starting subtest: legacy-engines-hang
[54.823138] Starting dynamic subtest: render
[54.862497] Dynamic subtest render: SUCCESS (0.040s)
[54.877587] Starting dynamic subtest: bsd1
[54.912346] Dynamic subtest bsd1: SUCCESS (0.050s)
[54.926819] Starting dynamic subtest: bsd2
[54.973961] Dynamic subtest bsd2: SUCCESS (0.062s)
[54.980763] Starting dynamic subtest: blt
[55.017538] Dynamic subtest blt: SUCCESS (0.043s)
[55.029897] Starting dynamic subtest: vebox
[55.059355] Dynamic subtest vebox: SUCCESS (0.042s)
[55.060471] Subtest legacy-engines-hang: SUCCESS (0.241s)
[55.131215] [011/133] (956s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[55.216654] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[55.218098] Starting dynamic subtest: pipe-A-HDMI-A-1
[71.708370] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.367s)
[71.717146] Starting dynamic subtest: pipe-B-HDMI-A-1
[88.708935] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.328s)
[88.715430] Starting dynamic subtest: pipe-C-HDMI-A-1
[105.701523] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.380s)
[105.707648] Starting dynamic subtest: pipe-D-HDMI-A-1
[121.691703] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.330s)
[121.692468] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SUCCESS (5.409s)
[129.885379] [012/133] (889s left) syncobj_timeline (invalid-signal-illegal-point)
[129.922617] Starting subtest: invalid-signal-illegal-point
[129.923351] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[129.994969] [013/133] (889s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[130.082111] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[130.083518] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[130.177518] [014/133] (889s left) i915_selftest (live)
[131.102369] Starting subtest: live
[131.103222] Starting dynamic subtest: sanitycheck
[132.289209] Dynamic subtest sanitycheck: SUCCESS (1.224s)
[132.295218] Starting dynamic subtest: uncore
[133.480105] Dynamic subtest uncore: SUCCESS (1.222s)
[133.486134] Starting dynamic subtest: workarounds
[135.023132] Dynamic subtest workarounds: SUCCESS (1.576s)
[135.029351] Starting dynamic subtest: gt_engines
[136.792543] Dynamic subtest gt_engines: SUCCESS (1.800s)
[136.802215] Starting dynamic subtest: gt_timelines
[145.402512] Dynamic subtest gt_timelines: SUCCESS (8.691s)
[145.412308] Starting dynamic subtest: gt_contexts
[146.756620] Dynamic subtest gt_contexts: SUCCESS (1.360s)
[146.765250] Starting dynamic subtest: gt_lrc
[151.001436] Dynamic subtest gt_lrc: SUCCESS (4.259s)
[151.007402] Starting dynamic subtest: gt_mocs
[152.406396] Dynamic subtest gt_mocs: SUCCESS (1.408s)
[152.415697] Starting dynamic subtest: gt_pm
[173.796400] Dynamic subtest gt_pm: SUCCESS (21.397s)
[173.802630] Starting dynamic subtest: gt_heartbeat
[175.030502] Dynamic subtest gt_heartbeat: SUCCESS (1.233s)
[175.041381] Starting dynamic subtest: gt_tlb
[178.530412] Dynamic subtest gt_tlb: SUCCESS (3.499s)
[178.536588] Starting dynamic subtest: requests
[187.155602] Dynamic subtest requests: SUCCESS (8.625s)
[187.165615] Starting dynamic subtest: migrate
[191.388668] Dynamic subtest migrate: SUCCESS (4.233s)
[191.398984] Starting dynamic subtest: active
[192.629605] Dynamic subtest active: SUCCESS (1.240s)
[192.639728] Starting dynamic subtest: objects
[194.345454] Dynamic subtest objects: SUCCESS (1.715s)
[194.351751] Starting dynamic subtest: mman
[199.041324] Dynamic subtest mman: SUCCESS (4.696s)
[199.051309] Starting dynamic subtest: dmabuf
[200.362526] Dynamic subtest dmabuf: SUCCESS (1.320s)
[200.377125] Starting dynamic subtest: vma
[201.634368] Dynamic subtest vma: SUCCESS (1.271s)
[201.644474] Starting dynamic subtest: coherency
[204.498643] Dynamic subtest coherency: SUCCESS (2.864s)
[204.508679] Starting dynamic subtest: gtt
[212.861360] Dynamic subtest gtt: SUCCESS (8.364s)
[212.869505] Starting dynamic subtest: gem
[215.027482] Dynamic subtest gem: SUCCESS (2.165s)
[215.037536] Starting dynamic subtest: evict
[217.244368] Dynamic subtest evict: SUCCESS (2.216s)
[217.250025] Starting dynamic subtest: hugepages
[224.913490] Dynamic subtest hugepages: SUCCESS (7.670s)
[224.924148] Starting dynamic subtest: gem_contexts
[240.315301] Dynamic subtest gem_contexts: SUCCESS (15.395s)
[240.320869] Starting dynamic subtest: client
[241.575607] Dynamic subtest client: SUCCESS (1.258s)
[241.582328] Starting dynamic subtest: gem_migrate
[242.886727] Dynamic subtest gem_migrate: SUCCESS (1.309s)
[242.896794] Starting dynamic subtest: reset
[247.836502] Dynamic subtest reset: SUCCESS (4.947s)
[247.842492] Starting dynamic subtest: memory_region
[249.056531] Dynamic subtest memory_region: SUCCESS (1.218s)
[249.066135] Starting dynamic subtest: hangcheck
[278.998346] Dynamic subtest hangcheck: SUCCESS (29.942s)
[279.004734] Starting dynamic subtest: execlists
[292.853499] Dynamic subtest execlists: SUCCESS (13.855s)
[292.860584] Starting dynamic subtest: ring_submission
[294.032511] Dynamic subtest ring_submission: SUCCESS (1.176s)
[294.038741] Starting dynamic subtest: perf
[295.314358] Dynamic subtest perf: SUCCESS (1.280s)
[295.320560] Starting dynamic subtest: slpc
[296.557564] Dynamic subtest slpc: SUCCESS (1.241s)
[296.563872] Starting dynamic subtest: guc
[297.855487] Dynamic subtest guc: SUCCESS (1.296s)
[297.865624] Starting dynamic subtest: guc_multi_lrc
[299.060429] Dynamic subtest guc_multi_lrc: SUCCESS (1.203s)
[299.066657] Starting dynamic subtest: guc_hang
[300.347610] Dynamic subtest guc_hang: SUCCESS (1.285s)
[300.358497] Starting dynamic subtest: late_gt_pm
[301.676330] Dynamic subtest late_gt_pm: SUCCESS (1.327s)
[301.677132] Subtest live: SUCCESS (170.838s)
[301.702820] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[301.704743] [015/133] (717s left) gem_softpin (invalid)
[302.742842] Starting subtest: invalid
[302.749858] Subtest invalid: SUCCESS (0.008s)
[302.842069] [FACT gem_softpin (invalid)] new: kernel.kmod_is_loaded.i915: true
[302.844930] [016/133] (716s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[302.932616] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.000s)
[302.969771] [017/133] (716s left) gem_tiled_partial_pwrite_pread (reads)
[303.007301] Starting subtest: reads
[303.438070] Subtest reads: SUCCESS (0.431s)
[303.544581] [018/133] (715s left) kms_getfb (getfb2-handle-zero)
[303.631983] Starting subtest: getfb2-handle-zero
[303.632712] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[303.737389] [019/133] (715s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[303.826007] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[303.826712] Starting dynamic subtest: pipe-A
[303.952150] Dynamic subtest pipe-A: SUCCESS (0.124s)
[304.001419] Starting dynamic subtest: pipe-B
[304.083953] Dynamic subtest pipe-B: SUCCESS (0.134s)
[304.094807] Starting dynamic subtest: pipe-C
[304.217966] Dynamic subtest pipe-C: SUCCESS (0.133s)
[304.227842] Starting dynamic subtest: pipe-D
[304.342840] Dynamic subtest pipe-D: SUCCESS (0.124s)
[304.343567] Subtest planes-upscale-20x20-downscale-factor-0-5: SUCCESS (0.518s)
[304.524435] [020/133] (715s left) gem_exec_whisper (basic-fds-priority-all)
[304.567749] Starting subtest: basic-fds-priority-all
[308.926539] Subtest basic-fds-priority-all: SUCCESS (4.350s)
[309.092606] [021/133] (710s left) i915_hangman (gt-engine-error)
[309.137013] Starting subtest: gt-engine-error
[309.137751] Starting dynamic subtest: rcs0
[309.193696] Dynamic subtest rcs0: SUCCESS (0.056s)
[309.210575] Starting dynamic subtest: bcs0
[309.263890] Dynamic subtest bcs0: SUCCESS (0.068s)
[309.281884] Starting dynamic subtest: vcs0
[309.334635] Dynamic subtest vcs0: SUCCESS (0.068s)
[309.351946] Starting dynamic subtest: vcs1
[309.402488] Dynamic subtest vcs1: SUCCESS (0.066s)
[309.418871] Starting dynamic subtest: vecs0
[309.471953] Dynamic subtest vecs0: SUCCESS (0.067s)
[309.476405] Subtest gt-engine-error: SUCCESS (0.336s)
[309.591949] [022/133] (710s left) i915_pm_rpm (system-suspend-devices)
[321.036125] Starting subtest: system-suspend-devices
[328.792329] Subtest system-suspend-devices: SUCCESS (7.758s)
[336.023296] [023/133] (690s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[336.123912] Starting subtest: y-tiled-32bpp-rotate-180
[337.472503] Subtest y-tiled-32bpp-rotate-180: SUCCESS (1.349s)
[337.589245] [024/133] (689s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[337.679849] Starting subtest: cursor-rapid-movement-32x10
[337.731764] Subtest cursor-rapid-movement-32x10: SKIP (0.051s)
[337.815359] [025/133] (688s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[337.900760] Starting subtest: primary-4-tiled-reflect-x-180
[337.956750] Subtest primary-4-tiled-reflect-x-180: SKIP (0.055s)
[338.045504] [026/133] (688s left) kms_psr (fbc-pr-primary-page-flip)
[338.134728] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[338.178452] [027/133] (688s left) core_getversion (basic)
[338.212784] Starting subtest: basic
[338.214167] Subtest basic: SUCCESS (0.000s)
[338.279088] [028/133] (688s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[338.367520] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[338.368882] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[338.476702] [029/133] (688s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[338.510111] Starting subtest: etime-multi-wait-for-submit-submitted
[338.615114] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.104s)
[338.694758] [030/133] (688s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[338.729061] Starting subtest: multi-wait-for-submit-available-signaled
[338.729777] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.001s)
[338.793274] [031/133] (688s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[338.886959] Starting subtest: yf-tiled-addfb-size-offset-overflow
[338.888354] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[338.973134] [032/133] (688s left) kms_cursor_edge_walk (128x128-top-bottom)
[339.057862] Starting subtest: 128x128-top-bottom
[339.058560] Starting dynamic subtest: pipe-A-HDMI-A-1
[340.782183] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.723s)
[340.790721] Starting dynamic subtest: pipe-D-HDMI-A-1
[342.470920] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.687s)
[342.471637] Subtest 128x128-top-bottom: SUCCESS (3.414s)
[342.575082] [033/133] (684s left) gem_exec_reloc (basic-active)
[342.614628] Starting subtest: basic-active
[342.615298] Starting dynamic subtest: all-engines
[342.728922] Dynamic subtest all-engines: SUCCESS (0.106s)
[342.736928] Starting dynamic subtest: rcs0
[342.780445] Dynamic subtest rcs0: SUCCESS (0.059s)
[342.789201] Starting dynamic subtest: bcs0
[342.911548] Dynamic subtest bcs0: SUCCESS (0.122s)
[342.919080] Starting dynamic subtest: vcs0
[342.962680] Dynamic subtest vcs0: SUCCESS (0.058s)
[342.972253] Starting dynamic subtest: vcs1
[343.022503] Dynamic subtest vcs1: SUCCESS (0.059s)
[343.032010] Starting dynamic subtest: vecs0
[343.081959] Dynamic subtest vecs0: SUCCESS (0.058s)
[343.082763] Subtest basic-active: SUCCESS (0.468s)
[343.189588] [034/133] (683s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[343.277680] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[343.325789] [035/133] (683s left) gem_mmap_wc (write)
[343.359827] Starting subtest: write
[343.394379] Subtest write: SUCCESS (0.035s)
[343.470385] [036/133] (683s left) kms_pm_backlight (brightness-with-dpms)
[343.556498] Subtest brightness-with-dpms: SKIP (0.000s)
[343.594181] [037/133] (683s left) core_getstats (basic)
[343.627636] Starting subtest: basic
[343.628318] Subtest basic: SUCCESS (0.000s)
[343.681750] [038/133] (683s left) kms_atomic (atomic-plane-damage)
[343.767762] Starting subtest: atomic-plane-damage
[343.824737] Starting dynamic subtest: pipe-A-HDMI-A-1
[344.015667] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.192s)
[344.016373] Subtest atomic-plane-damage: SUCCESS (0.249s)
[344.137901] [039/133] (683s left) kms_flip (basic-flip-vs-dpms)
[344.226469] Starting subtest: basic-flip-vs-dpms
[344.228463] Starting dynamic subtest: A-HDMI-A1
[344.933731] Dynamic subtest A-HDMI-A1: SUCCESS (0.705s)
[344.943160] Starting dynamic subtest: B-HDMI-A1
[345.617292] Dynamic subtest B-HDMI-A1: SUCCESS (0.682s)
[345.624748] Starting dynamic subtest: C-HDMI-A1
[346.307305] Dynamic subtest C-HDMI-A1: SUCCESS (0.689s)
[346.315083] Starting dynamic subtest: D-HDMI-A1
[346.990051] Dynamic subtest D-HDMI-A1: SUCCESS (0.682s)
[346.991746] Subtest basic-flip-vs-dpms: SUCCESS (2.766s)
[347.107821] [040/133] (680s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[347.143801] Starting subtest: invalid-smem-bo-on-discrete
[347.145170] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[347.282300] [041/133] (680s left) gem_eio (wait-wedge-10ms)
[347.325952] Starting subtest: wait-wedge-10ms
[347.607965] Subtest wait-wedge-10ms: SUCCESS (0.281s)
[347.714861] [042/133] (679s left) gem_ctx_persistence (engines-mixed-process)
[347.751983] Starting subtest: engines-mixed-process
[347.752711] Starting dynamic subtest: rcs0
[348.110353] Dynamic subtest rcs0: SUCCESS (0.359s)
[348.121253] Starting dynamic subtest: bcs0
[348.470503] Dynamic subtest bcs0: SUCCESS (0.359s)
[348.486173] Starting dynamic subtest: vcs0
[348.838497] Dynamic subtest vcs0: SUCCESS (0.366s)
[348.855275] Starting dynamic subtest: vcs1
[349.190455] Dynamic subtest vcs1: SUCCESS (0.350s)
[349.206572] Starting dynamic subtest: vecs0
[349.555464] Dynamic subtest vecs0: SUCCESS (0.363s)
[349.558561] Subtest engines-mixed-process: SUCCESS (1.806s)
[349.625240] [043/133] (677s left) gem_exec_reloc (basic-wc)
[349.664120] Starting subtest: basic-wc
[349.669639] Subtest basic-wc: SUCCESS (0.005s)
[349.783575] [044/133] (677s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[349.868122] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[349.912728] [045/133] (677s left) kms_plane_cursor (viewport)
[349.996863] Starting subtest: viewport
[349.999961] Starting dynamic subtest: pipe-A-HDMI-A-1-size-64
[351.399521] Dynamic subtest pipe-A-HDMI-A-1-size-64: SUCCESS (1.401s)
[351.446119] Starting dynamic subtest: pipe-A-HDMI-A-1-size-128
[352.841423] Dynamic subtest pipe-A-HDMI-A-1-size-128: SUCCESS (1.408s)
[352.889191] Starting dynamic subtest: pipe-A-HDMI-A-1-size-256
[354.283378] Dynamic subtest pipe-A-HDMI-A-1-size-256: SUCCESS (1.408s)
[354.373258] Starting dynamic subtest: pipe-B-HDMI-A-1-size-64
[355.810514] Dynamic subtest pipe-B-HDMI-A-1-size-64: SUCCESS (1.444s)
[355.848727] Starting dynamic subtest: pipe-B-HDMI-A-1-size-128
[357.252290] Dynamic subtest pipe-B-HDMI-A-1-size-128: SUCCESS (1.416s)
[357.287290] Starting dynamic subtest: pipe-B-HDMI-A-1-size-256
[358.694156] Dynamic subtest pipe-B-HDMI-A-1-size-256: SUCCESS (1.417s)
[358.777143] Starting dynamic subtest: pipe-C-HDMI-A-1-size-64
[360.183799] Dynamic subtest pipe-C-HDMI-A-1-size-64: SUCCESS (1.414s)
[360.218009] Starting dynamic subtest: pipe-C-HDMI-A-1-size-128
[361.584039] Dynamic subtest pipe-C-HDMI-A-1-size-128: SUCCESS (1.375s)
[361.621965] Starting dynamic subtest: pipe-C-HDMI-A-1-size-256
[362.984068] Dynamic subtest pipe-C-HDMI-A-1-size-256: SUCCESS (1.375s)
[363.067229] Starting dynamic subtest: pipe-D-HDMI-A-1-size-64
[364.465579] Dynamic subtest pipe-D-HDMI-A-1-size-64: SUCCESS (1.405s)
[364.501885] Starting dynamic subtest: pipe-D-HDMI-A-1-size-128
[365.865832] Dynamic subtest pipe-D-HDMI-A-1-size-128: SUCCESS (1.375s)
[365.902665] Starting dynamic subtest: pipe-D-HDMI-A-1-size-256
[367.265797] Dynamic subtest pipe-D-HDMI-A-1-size-256: SUCCESS (1.375s)
[367.342022] Subtest viewport: SUCCESS (17.346s)
[367.449872] [046/133] (660s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[367.548291] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[367.549673] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[367.636425] [047/133] (659s left) kms_chamelium_frames (dp-crc-multiple)
[367.776220] Subtest dp-crc-multiple: SKIP (0.000s)
[367.862155] [048/133] (659s left) gem_spin_batch (engines)
[367.904436] Starting subtest: engines
[367.905234] Starting dynamic subtest: rcs0
[371.257919] Dynamic subtest rcs0: SUCCESS (3.318s)
[371.268607] Starting dynamic subtest: bcs0
[374.579157] Dynamic subtest bcs0: SUCCESS (3.319s)
[374.589490] Starting dynamic subtest: vcs0
[377.899509] Dynamic subtest vcs0: SUCCESS (3.318s)
[377.910112] Starting dynamic subtest: vcs1
[381.220201] Dynamic subtest vcs1: SUCCESS (3.319s)
[381.236968] Starting dynamic subtest: vecs0
[384.541014] Dynamic subtest vecs0: SUCCESS (3.319s)
[384.541974] Subtest engines: SUCCESS (16.604s)
[384.678155] [049/133] (643s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[384.764737] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs
[384.765467] Starting dynamic subtest: pipe-A-HDMI-A-1
[384.771431] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[384.779428] Starting dynamic subtest: pipe-B-HDMI-A-1
[384.785406] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[384.793183] Starting dynamic subtest: pipe-C-HDMI-A-1
[384.799062] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[384.806611] Starting dynamic subtest: pipe-D-HDMI-A-1
[384.812363] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[384.813046] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SUCCESS (0.012s)
[385.006202] [050/133] (642s left) kms_vblank (wait-busy-hang)
[385.091861] Starting subtest: wait-busy-hang
[385.092527] Starting dynamic subtest: pipe-A-HDMI-A-1
[398.692545] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (13.601s)
[398.703253] Starting dynamic subtest: pipe-D-HDMI-A-1
[413.026999] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (14.332s)
[413.028855] Subtest wait-busy-hang: SUCCESS (27.940s)
[413.171323] [051/133] (614s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[413.269973] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[413.528300] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.259s)
[413.677425] [052/133] (614s left) perf (invalid-remove-userspace-config)
[413.757034] Starting subtest: invalid-remove-userspace-config
[413.768829] Subtest invalid-remove-userspace-config: SUCCESS (0.011s)
[413.812150] [053/133] (614s left) sw_sync (sync_multi_consumer)
[413.845616] Starting subtest: sync_multi_consumer
[414.390301] Subtest sync_multi_consumer: SUCCESS (0.546s)
[414.452341] [054/133] (613s left) kms_plane (pixel-format-yf-tiled-modifier)
[414.539387] Starting subtest: pixel-format-yf-tiled-modifier
[414.540835] Subtest pixel-format-yf-tiled-modifier: SKIP (0.000s)
[414.594386] [055/133] (613s left) prime_busy (after-wait)
[414.632989] Starting subtest: after-wait
[414.636691] Starting dynamic subtest: rcs0
[414.659657] Dynamic subtest rcs0: SUCCESS (0.023s)
[414.669105] Starting dynamic subtest: bcs0
[414.677489] Dynamic subtest bcs0: SUCCESS (0.017s)
[414.692751] Starting dynamic subtest: vcs0
[414.695818] Dynamic subtest vcs0: SUCCESS (0.017s)
[414.704988] Starting dynamic subtest: vcs1
[414.710689] Dynamic subtest vcs1: SUCCESS (0.014s)
[414.719877] Starting dynamic subtest: vecs0
[414.727109] Dynamic subtest vecs0: SUCCESS (0.015s)
[414.844118] Subtest after-wait: SUCCESS (0.203s)
[414.919692] [056/133] (613s left) template (a)
[414.952474] Starting subtest: A
[414.953145] Subtest A: SUCCESS (0.000s)
[415.015651] [057/133] (612s left) gem_exec_schedule (semaphore-codependency)
[415.060111] Starting subtest: semaphore-codependency
[415.067922] Subtest semaphore-codependency: SUCCESS (0.008s)
[415.367553] [058/133] (612s left) kms_chamelium_hpd (vga-hpd)
[415.507071] Subtest vga-hpd: SKIP (0.000s)
[415.605096] [059/133] (612s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[415.690513] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[415.691261] Starting dynamic subtest: pipe-A-valid-mode
[417.586611] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.895s)
[417.587338] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SUCCESS (1.897s)
[417.727127] [060/133] (610s left) gem_mmap_wc (read)
[417.761569] Starting subtest: read
[417.768949] Subtest read: SUCCESS (0.008s)
[417.859365] [061/133] (610s left) api_intel_allocator (execbuf-with-allocator)
[417.892672] Starting subtest: execbuf-with-allocator
[417.895190] Subtest execbuf-with-allocator: SUCCESS (0.003s)
[418.003903] [062/133] (610s left) gem_cs_tlb (engines)
[418.041189] Starting subtest: engines
[418.041932] Starting dynamic subtest: rcs0
[420.226165] Dynamic subtest rcs0: SUCCESS (2.150s)
[420.234664] Starting dynamic subtest: bcs0
[422.376458] Dynamic subtest bcs0: SUCCESS (2.149s)
[422.385507] Starting dynamic subtest: vcs0
[424.527205] Dynamic subtest vcs0: SUCCESS (2.150s)
[424.535529] Starting dynamic subtest: vcs1
[426.677622] Dynamic subtest vcs1: SUCCESS (2.150s)
[426.685940] Starting dynamic subtest: vecs0
[428.828868] Dynamic subtest vecs0: SUCCESS (2.150s)
[428.829823] Subtest engines: SUCCESS (10.755s)
[428.902682] [063/133] (599s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[428.994251] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[428.995634] Subtest psr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[429.090233] [064/133] (599s left) kms_content_protection (atomic-dpms)
[429.179007] Starting subtest: atomic-dpms
[429.193338] Subtest atomic-dpms: SKIP (0.013s)
[429.285099] [065/133] (599s left) kms_big_fb (linear-16bpp-rotate-270)
[429.383215] Starting subtest: linear-16bpp-rotate-270
[429.478930] Subtest linear-16bpp-rotate-270: SKIP (0.096s)
[429.577731] [066/133] (598s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[429.672907] Starting subtest: x-tiled-16bpp-rotate-180
[430.799467] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.127s)
[430.920159] [067/133] (597s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[431.022102] Starting subtest: verify-pxp-key-change-after-suspend-resume
[447.685458] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (16.667s)
[456.854307] [068/133] (580s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[456.955624] Starting subtest: psr-modesetfrombusy
[456.957027] Subtest psr-modesetfrombusy: SKIP (0.000s)
[457.048638] [069/133] (580s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[457.146156] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[457.699056] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.554s)
[457.818722] [070/133] (579s left) gen7_exec_parse (bitmasks)
[457.855603] Subtest bitmasks: SKIP (0.000s)
[457.895085] [071/133] (579s left) gem_exec_flush (basic-uc-set-default)
[457.937651] Starting subtest: basic-uc-set-default
[463.389049] Subtest basic-uc-set-default: SUCCESS (5.453s)
[463.589075] [072/133] (574s left) gem_exec_fence (keep-in-fence)
[463.753810] Starting subtest: keep-in-fence
[463.754733] Starting dynamic subtest: rcs0
[463.783193] Dynamic subtest rcs0: SUCCESS (0.030s)
[463.801636] Starting dynamic subtest: bcs0
[463.813051] Dynamic subtest bcs0: SUCCESS (0.028s)
[463.826846] Starting dynamic subtest: vcs0
[463.849335] Dynamic subtest vcs0: SUCCESS (0.034s)
[463.865923] Starting dynamic subtest: vcs1
[463.882157] Dynamic subtest vcs1: SUCCESS (0.030s)
[463.897119] Starting dynamic subtest: vecs0
[463.913176] Dynamic subtest vecs0: SUCCESS (0.028s)
[463.916105] Subtest keep-in-fence: SUCCESS (0.162s)
[464.417658] [FACT gem_exec_fence (keep-in-fence)] new: kernel.kmod_is_loaded.vgem: true
[464.420258] [073/133] (573s left) kms_cursor_crc (cursor-onscreen-32x32)
[464.508958] Starting subtest: cursor-onscreen-32x32
[464.563078] Subtest cursor-onscreen-32x32: SKIP (0.052s)
[464.644525] [074/133] (573s left) gen3_render_tiledy_blits
[464.732746] [075/133] (573s left) gem_exec_schedule (pi-distinct-iova)
[464.897674] Starting subtest: pi-distinct-iova
[464.898715] Starting dynamic subtest: rcs0
[464.924041] Dynamic subtest rcs0: SUCCESS (0.026s)
[464.936796] Starting dynamic subtest: bcs0
[464.952125] Dynamic subtest bcs0: SUCCESS (0.027s)
[464.966153] Starting dynamic subtest: vcs0
[464.978890] Dynamic subtest vcs0: SUCCESS (0.025s)
[464.991646] Starting dynamic subtest: vcs1
[465.004514] Dynamic subtest vcs1: SUCCESS (0.024s)
[465.014609] Starting dynamic subtest: vecs0
[465.028959] Dynamic subtest vecs0: SUCCESS (0.022s)
[465.029748] Subtest pi-distinct-iova: SUCCESS (0.132s)
[465.217496] [076/133] (572s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[465.302991] Starting subtest: bad-pixel-format-y-tiled-ccs
[465.303713] Starting dynamic subtest: pipe-A-HDMI-A-1
[465.310600] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[465.318930] Starting dynamic subtest: pipe-B-HDMI-A-1
[465.325715] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[465.334056] Starting dynamic subtest: pipe-C-HDMI-A-1
[465.340883] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[465.348976] Starting dynamic subtest: pipe-D-HDMI-A-1
[465.355778] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[465.357159] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.007s)
[465.540445] [077/133] (572s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[465.629864] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[465.631281] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[465.731373] [078/133] (572s left) gem_wait (write-busy)
[465.777867] Starting subtest: write-busy
[465.778580] Starting dynamic subtest: all-engines
[466.300718] Dynamic subtest all-engines: SUCCESS (0.524s)
[466.310641] Starting dynamic subtest: rcs0
[466.816884] Dynamic subtest rcs0: SUCCESS (0.515s)
[466.829142] Starting dynamic subtest: bcs0
[467.333854] Dynamic subtest bcs0: SUCCESS (0.516s)
[467.343339] Starting dynamic subtest: vcs0
[467.849767] Dynamic subtest vcs0: SUCCESS (0.515s)
[467.862347] Starting dynamic subtest: vcs1
[468.365766] Dynamic subtest vcs1: SUCCESS (0.514s)
[468.374111] Starting dynamic subtest: vecs0
[468.884767] Dynamic subtest vecs0: SUCCESS (0.519s)
[468.885478] Subtest write-busy: SUCCESS (3.109s)
[469.077474] [079/133] (568s left) gem_ctx_shared (q-out-order)
[469.119138] Starting subtest: Q-out-order
[469.119861] Starting dynamic subtest: rcs0
[469.167823] Dynamic subtest rcs0: SUCCESS (0.048s)
[469.180338] Starting dynamic subtest: bcs0
[469.222263] Dynamic subtest bcs0: SUCCESS (0.051s)
[469.235977] Starting dynamic subtest: vcs0
[469.273616] Dynamic subtest vcs0: SUCCESS (0.048s)
[469.288386] Starting dynamic subtest: vcs1
[469.324826] Dynamic subtest vcs1: SUCCESS (0.049s)
[469.339856] Starting dynamic subtest: vecs0
[469.376615] Dynamic subtest vecs0: SUCCESS (0.049s)
[469.378041] Subtest Q-out-order: SUCCESS (0.258s)
[469.578982] [080/133] (568s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[469.665771] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[469.667644] Starting dynamic subtest: pipe-A-valid-mode
[470.655184] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.987s)
[470.655924] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SUCCESS (0.989s)
[470.823093] [081/133] (567s left) gem_pxp (create-regular-context-1)
[470.861566] Starting subtest: create-regular-context-1
[470.862240] Subtest create-regular-context-1: SUCCESS (0.000s)
[470.931995] [082/133] (567s left) kms_color (gamma)
[471.018660] Starting subtest: gamma
[471.019371] Starting dynamic subtest: pipe-A-HDMI-A-1
[471.339454] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.321s)
[471.347748] Starting dynamic subtest: pipe-B-HDMI-A-1
[471.643344] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.302s)
[471.651900] Starting dynamic subtest: pipe-C-HDMI-A-1
[471.940119] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.296s)
[471.948524] Starting dynamic subtest: pipe-D-HDMI-A-1
[472.227365] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.286s)
[472.228068] Subtest gamma: SUCCESS (1.210s)
[472.371820] [083/133] (565s left) kms_addfb_basic (invalid-set-prop)
[472.406409] Starting subtest: invalid-set-prop
[472.407166] Subtest invalid-set-prop: SUCCESS (0.000s)
[472.547500] [084/133] (565s left) syncobj_basic (bad-pad-fd-to-handle)
[472.580993] Starting subtest: bad-pad-fd-to-handle
[472.581739] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[472.645954] [085/133] (565s left) gem_exec_balancer (sliced)
[472.689436] Starting subtest: sliced
[474.151593] Subtest sliced: SUCCESS (1.454s)
[474.339040] [086/133] (563s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[474.431032] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[474.440728] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.009s)
[474.503593] [087/133] (563s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[474.592587] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[474.593971] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[474.690933] [088/133] (563s left) kms_chamelium_audio (dp-audio)
[474.833387] Subtest dp-audio: SKIP (0.000s)
[474.920647] [089/133] (563s left) kms_addfb_basic (invalid-get-prop-any)
[474.956297] Starting subtest: invalid-get-prop-any
[474.957078] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[475.110965] [090/133] (563s left) kms_flip (flip-vs-modeset-vs-hang)
[475.197898] Starting subtest: flip-vs-modeset-vs-hang
[475.200156] Starting dynamic subtest: A-HDMI-A1
[502.613311] Dynamic subtest A-HDMI-A1: SUCCESS (27.385s)
[502.623033] Starting dynamic subtest: D-HDMI-A1
[530.773294] Dynamic subtest D-HDMI-A1: SUCCESS (28.162s)
[530.774032] Subtest flip-vs-modeset-vs-hang: SUCCESS (55.555s)
[530.863322] [091/133] (507s left) kms_psr (pr-sprite-mmap-gtt)
[530.953496] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[530.997670] [092/133] (507s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[531.086547] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[531.087911] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[531.178925] [093/133] (507s left) kms_lease (lease-invalid-connector)
[531.265514] Starting subtest: lease-invalid-connector
[531.267729] Starting dynamic subtest: pipe-A-HDMI-A-1
[531.268505] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.000s)
[531.279518] Starting dynamic subtest: pipe-B-HDMI-A-1
[531.280214] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[531.289247] Starting dynamic subtest: pipe-C-HDMI-A-1
[531.290034] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.000s)
[531.298511] Starting dynamic subtest: pipe-D-HDMI-A-1
[531.299270] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.000s)
[531.299989] Subtest lease-invalid-connector: SUCCESS (0.010s)
[531.334252] [094/133] (507s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[531.423055] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[532.689947] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (1.267s)
[532.811044] [095/133] (505s left) gem_caching (read-writes)
[532.847880] Starting subtest: read-writes
[544.818977] Subtest read-writes: SUCCESS (11.973s)
[544.929720] [096/133] (493s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[545.018126] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[545.018870] Starting dynamic subtest: pipe-A-HDMI-A-1
[545.859635] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.838s)
[545.873842] Starting dynamic subtest: pipe-B-HDMI-A-1
[546.259753] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.396s)
[546.277130] Starting dynamic subtest: pipe-C-HDMI-A-1
[546.660043] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.396s)
[546.677647] Starting dynamic subtest: pipe-D-HDMI-A-1
[547.062441] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.398s)
[547.063647] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SUCCESS (2.044s)
[547.246870] [097/133] (491s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[547.337935] Starting subtest: cursorB-vs-flipA-atomic
[547.340111] Subtest cursorB-vs-flipA-atomic: SKIP (0.002s)
[547.403606] [098/133] (491s left) gem_mmap_gtt (basic)
[547.437101] Starting subtest: basic
[547.437800] Subtest basic: SUCCESS (0.001s)
[547.515409] [099/133] (491s left) gem_mmap_offset (open-flood)
[547.548588] Starting subtest: open-flood
[569.044584] Subtest open-flood: SUCCESS (21.500s)
[569.179002] [100/133] (469s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[569.272246] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[569.273669] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[569.381529] [101/133] (469s left) kms_pm_rpm (universal-planes)
[580.811724] Starting subtest: universal-planes
[580.812955] Starting dynamic subtest: plane-34
[589.134614] Dynamic subtest plane-34: SUCCESS (8.324s)
[589.147798] Starting dynamic subtest: plane-64
[597.359879] Dynamic subtest plane-64: SUCCESS (8.216s)
[597.389053] Starting dynamic subtest: plane-94
[605.773152] Dynamic subtest plane-94: SUCCESS (8.421s)
[605.786537] Starting dynamic subtest: plane-124
[614.000800] Dynamic subtest plane-124: SUCCESS (8.219s)
[614.012510] Starting dynamic subtest: plane-134
[622.511803] Dynamic subtest plane-134: SUCCESS (8.511s)
[622.523567] Starting dynamic subtest: plane-144
[631.023844] Dynamic subtest plane-144: SUCCESS (8.512s)
[631.039386] Starting dynamic subtest: plane-154
[639.629644] Dynamic subtest plane-154: SUCCESS (8.614s)
[639.642961] Starting dynamic subtest: plane-164
[647.948557] Dynamic subtest plane-164: SUCCESS (8.318s)
[647.951511] Subtest universal-planes: SUCCESS (67.151s)
[648.155801] [102/133] (390s left) kms_flip (2x-flip-vs-dpms)
[648.243408] Starting subtest: 2x-flip-vs-dpms
[648.253185] Subtest 2x-flip-vs-dpms: SKIP (0.009s)
[648.320679] [103/133] (390s left) perf (per-context-mode-unprivileged)
[648.399424] Starting subtest: per-context-mode-unprivileged
[648.400906] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[648.444548] [104/133] (390s left) gem_mmap_gtt (basic-small-bo-tiledx)
[648.476801] Starting subtest: basic-small-bo-tiledX
[649.129898] Subtest basic-small-bo-tiledX: SUCCESS (0.653s)
[649.233610] [105/133] (389s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[649.383596] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[649.385081] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[649.444729] [106/133] (389s left) prime_udl
[649.527085] [107/133] (389s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[649.613935] Starting subtest: flip-vs-cursor-busy-crc-legacy
[650.023305] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.409s)
[650.158901] [108/133] (388s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[650.247849] Starting subtest: basic-busy-flip-before-cursor-legacy
[650.249196] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[650.306551] [109/133] (388s left) gem_tiled_wb
[655.371173] [110/133] (383s left) kms_pipe_crc_basic (suspend-read-crc)
[655.460694] Starting subtest: suspend-read-crc
[655.462440] Starting dynamic subtest: pipe-A-HDMI-A-1
[672.899308] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.826s)
[672.913561] Starting dynamic subtest: pipe-B-HDMI-A-1
[689.874556] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.733s)
[689.885014] Starting dynamic subtest: pipe-C-HDMI-A-1
[706.858667] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.642s)
[706.872005] Starting dynamic subtest: pipe-D-HDMI-A-1
[723.852768] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.642s)
[723.853539] Subtest suspend-read-crc: SUCCESS (6.852s)
[733.046350] [111/133] (315s left) gem_exec_balancer (nohangcheck)
[733.223468] Starting subtest: nohangcheck
[734.553827] Subtest nohangcheck: SUCCESS (1.325s)
[734.605940] [112/133] (313s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[734.697653] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[734.699054] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[734.790698] [113/133] (313s left) i915_drm_fdinfo (all-busy-check-all)
[734.828678] Starting subtest: all-busy-check-all
[735.349018] Subtest all-busy-check-all: SUCCESS (0.520s)
[735.421472] [114/133] (312s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[735.506413] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[735.550514] [115/133] (312s left) kms_hdr (static-swap)
[735.634750] Starting subtest: static-swap
[735.636836] Subtest static-swap: SKIP (0.001s)
[735.697628] [116/133] (312s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[735.786553] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[737.218190] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (1.432s)
[737.353639] [117/133] (311s left) gem_exec_whisper (basic-queues-priority-all)
[737.398218] Starting subtest: basic-queues-priority-all
[740.374271] Subtest basic-queues-priority-all: SUCCESS (2.976s)
[740.560263] [118/133] (308s left) syncobj_eventfd (invalid-bad-flags)
[740.601974] Starting subtest: invalid-bad-flags
[740.602699] Subtest invalid-bad-flags: SUCCESS (0.000s)
[740.666466] [119/133] (307s left) prime_self_import (basic-llseek-bad)
[740.699192] Starting subtest: basic-llseek-bad
[740.700601] Subtest basic-llseek-bad: SUCCESS (0.002s)
[740.798790] [120/133] (307s left) syncobj_wait (multi-wait-for-submit-signaled)
[740.833743] Starting subtest: multi-wait-for-submit-signaled
[740.834495] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[740.903821] [121/133] (307s left) syncobj_timeline (transfer-timeline-point)
[740.939110] Starting subtest: transfer-timeline-point
[740.939827] Subtest transfer-timeline-point: SUCCESS (0.001s)
[741.010637] [122/133] (307s left) perf_pmu (busy-check-all)
[741.047240] Starting subtest: busy-check-all
[741.047962] Starting dynamic subtest: rcs0
[741.567769] Dynamic subtest rcs0: SUCCESS (0.518s)
[741.581101] Starting dynamic subtest: bcs0
[742.090938] Dynamic subtest bcs0: SUCCESS (0.522s)
[742.103594] Starting dynamic subtest: vcs0
[742.615883] Dynamic subtest vcs0: SUCCESS (0.523s)
[742.628384] Starting dynamic subtest: vcs1
[743.139857] Dynamic subtest vcs1: SUCCESS (0.522s)
[743.152572] Starting dynamic subtest: vecs0
[743.662569] Dynamic subtest vecs0: SUCCESS (0.520s)
[743.663617] Subtest busy-check-all: SUCCESS (2.617s)
[743.733671] [123/133] (305s left) perf (short-reads)
[743.818298] Starting subtest: short-reads
[743.833955] Subtest short-reads: SUCCESS (0.016s)
[743.880032] [124/133] (304s left) perf_pmu (most-busy-check-all)
[743.915039] Starting subtest: most-busy-check-all
[743.915758] Starting dynamic subtest: rcs0
[744.433724] Dynamic subtest rcs0: SUCCESS (0.542s)
[744.445958] Starting dynamic subtest: bcs0
[744.952850] Dynamic subtest bcs0: SUCCESS (0.540s)
[744.965723] Starting dynamic subtest: vcs0
[745.471972] Dynamic subtest vcs0: SUCCESS (0.537s)
[745.484431] Starting dynamic subtest: vcs1
[745.990982] Dynamic subtest vcs1: SUCCESS (0.536s)
[746.003822] Starting dynamic subtest: vecs0
[746.508250] Dynamic subtest vecs0: SUCCESS (0.532s)
[746.509214] Subtest most-busy-check-all: SUCCESS (2.698s)
[746.581441] [125/133] (302s left) kms_selftest (drm_dp_mst_helper)
[746.618007] Starting subtest: drm_dp_mst_helper
[746.636488] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[746.709029] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.072s)
[746.725040] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[746.789724] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.084s)
[746.802367] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[746.892105] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.104s)
[746.893186] Subtest drm_dp_mst_helper: SUCCESS (0.284s)
[747.042965] [126/133] (301s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[747.135052] Starting subtest: blocking-absolute-wf_vblank-interruptible
[747.137781] Starting dynamic subtest: A-HDMI-A1
[754.823419] Dynamic subtest A-HDMI-A1: SUCCESS (7.814s)
[754.832267] Starting dynamic subtest: B-HDMI-A1
[762.490674] Dynamic subtest B-HDMI-A1: SUCCESS (7.712s)
[762.499728] Starting dynamic subtest: C-HDMI-A1
[770.158944] Dynamic subtest C-HDMI-A1: SUCCESS (7.711s)
[770.168749] Starting dynamic subtest: D-HDMI-A1
[777.893590] Dynamic subtest D-HDMI-A1: SUCCESS (7.713s)
[777.894651] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (30.963s)
[778.032912] [127/133] (270s left) gem_basic (multigpu-create-close)
[778.068310] Starting subtest: multigpu-create-close
[778.069654] Subtest multigpu-create-close: SKIP (0.000s)
[778.129087] [128/133] (270s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[778.220613] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[778.222001] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[778.311456] [129/133] (270s left) gem_mmap (bad-size)
[778.346120] Starting subtest: bad-size
[778.346870] Subtest bad-size: SUCCESS (0.001s)
[778.436244] [130/133] (270s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[778.525090] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[778.526521] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[778.634539] [131/133] (270s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[778.726088] Starting subtest: fbcpsr-rgb565-draw-pwrite
[778.727574] Subtest fbcpsr-rgb565-draw-pwrite: SKIP (0.000s)
[778.824426] [132/133] (270s left) kms_draw_crc (draw-method-render)
[778.910802] Starting subtest: draw-method-render
[778.911572] Starting dynamic subtest: xrgb8888-untiled
[779.082754] Dynamic subtest xrgb8888-untiled: SUCCESS (0.171s)
[779.103783] Starting dynamic subtest: rgb565-untiled
[779.257789] Dynamic subtest rgb565-untiled: SUCCESS (0.172s)
[779.277169] Starting dynamic subtest: xrgb2101010-untiled
[779.416204] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.156s)
[779.432678] Starting dynamic subtest: xbgr16161616f-untiled
[779.574588] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.156s)
[779.591599] Starting dynamic subtest: xrgb8888-xtiled
[779.666443] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.089s)
[779.683959] Starting dynamic subtest: rgb565-xtiled
[779.749719] Dynamic subtest rgb565-xtiled: SUCCESS (0.081s)
[779.769798] Starting dynamic subtest: xrgb2101010-xtiled
[779.833245] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.081s)
[779.850793] Starting dynamic subtest: xbgr16161616f-xtiled
[779.916597] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.081s)
[779.939823] Starting dynamic subtest: xrgb8888-ytiled
[780.016681] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.097s)
[780.037534] Starting dynamic subtest: rgb565-ytiled
[780.108272] Dynamic subtest rgb565-ytiled: SUCCESS (0.089s)
[780.127815] Starting dynamic subtest: xrgb2101010-ytiled
[780.191912] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.081s)
[780.212085] Starting dynamic subtest: xbgr16161616f-ytiled
[780.283413] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.089s)
[780.286329] Subtest draw-method-render: SUCCESS (1.373s)
[780.398427] [133/133] (268s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[780.490549] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[780.491925] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[780.580355] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_render_copy
results: parsing output: 2/ for test: perf
results: parsing output: 3/ for test: kms_psr
results: parsing output: 4/ for test: kms_hdmi_inject
results: parsing output: 5/ for test: gem_mmap
results: parsing output: 6/ for test: kms_plane
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_ctx_persistence
results: parsing output: 10/ for test: kms_ccs
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: i915_selftest
results: parsing output: 14/ for test: gem_softpin
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 17/ for test: kms_getfb
results: parsing output: 18/ for test: kms_plane_scaling
results: parsing output: 19/ for test: gem_exec_whisper
results: parsing output: 20/ for test: i915_hangman
results: parsing output: 21/ for test: i915_pm_rpm
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: kms_cursor_crc
results: parsing output: 24/ for test: kms_rotation_crc
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: core_getversion
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: kms_cursor_edge_walk
results: parsing output: 32/ for test: gem_exec_reloc
results: parsing output: 33/ for test: kms_psr2_sf
results: parsing output: 34/ for test: gem_mmap_wc
results: parsing output: 35/ for test: kms_pm_backlight
results: parsing output: 36/ for test: core_getstats
results: parsing output: 37/ for test: kms_atomic
results: parsing output: 38/ for test: kms_flip
results: parsing output: 39/ for test: kms_addfb_basic
results: parsing output: 40/ for test: gem_eio
results: parsing output: 41/ for test: gem_ctx_persistence
results: parsing output: 42/ for test: gem_exec_reloc
results: parsing output: 43/ for test: kms_psr2_sf
results: parsing output: 44/ for test: kms_plane_cursor
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: kms_chamelium_frames
results: parsing output: 47/ for test: gem_spin_batch
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: kms_vblank
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: perf
results: parsing output: 52/ for test: sw_sync
results: parsing output: 53/ for test: kms_plane
results: parsing output: 54/ for test: prime_busy
results: parsing output: 55/ for test: template
results: parsing output: 56/ for test: gem_exec_schedule
results: parsing output: 57/ for test: kms_chamelium_hpd
results: parsing output: 58/ for test: kms_flip_scaled_crc
results: parsing output: 59/ for test: gem_mmap_wc
results: parsing output: 60/ for test: api_intel_allocator
results: parsing output: 61/ for test: gem_cs_tlb
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_content_protection
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: gem_pxp
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: gen7_exec_parse
results: parsing output: 70/ for test: gem_exec_flush
results: parsing output: 71/ for test: gem_exec_fence
results: parsing output: 72/ for test: kms_cursor_crc
results: parsing output: 73/ for test: gen3_render_tiledy_blits
results: parsing output: 74/ for test: gem_exec_schedule
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_wait
results: parsing output: 78/ for test: gem_ctx_shared
results: parsing output: 79/ for test: kms_flip_scaled_crc
results: parsing output: 80/ for test: gem_pxp
results: parsing output: 81/ for test: kms_color
results: parsing output: 82/ for test: kms_addfb_basic
results: parsing output: 83/ for test: syncobj_basic
results: parsing output: 84/ for test: gem_exec_balancer
results: parsing output: 85/ for test: kms_flip
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_chamelium_audio
results: parsing output: 88/ for test: kms_addfb_basic
results: parsing output: 89/ for test: kms_flip
results: parsing output: 90/ for test: kms_psr
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_lease
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_caching
results: parsing output: 95/ for test: kms_ccs
results: parsing output: 96/ for test: kms_cursor_legacy
results: parsing output: 97/ for test: gem_mmap_gtt
results: parsing output: 98/ for test: gem_mmap_offset
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_pm_rpm
results: parsing output: 101/ for test: kms_flip
results: parsing output: 102/ for test: perf
results: parsing output: 103/ for test: gem_mmap_gtt
results: parsing output: 104/ for test: kms_cursor_legacy
results: parsing output: 105/ for test: prime_udl
results: parsing output: 106/ for test: kms_cursor_legacy
results: parsing output: 107/ for test: kms_cursor_legacy
results: parsing output: 108/ for test: gem_tiled_wb
results: parsing output: 109/ for test: kms_pipe_crc_basic
results: parsing output: 110/ for test: gem_exec_balancer
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: i915_drm_fdinfo
results: parsing output: 113/ for test: kms_psr
results: parsing output: 114/ for test: kms_hdr
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: gem_exec_whisper
results: parsing output: 117/ for test: syncobj_eventfd
results: parsing output: 118/ for test: prime_self_import
results: parsing output: 119/ for test: syncobj_wait
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: perf_pmu
results: parsing output: 122/ for test: perf
results: parsing output: 123/ for test: perf_pmu
results: parsing output: 124/ for test: kms_selftest
results: parsing output: 125/ for test: kms_flip
results: parsing output: 126/ for test: gem_basic
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: gem_mmap
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_draw_crc
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.