[57.037871] Initializing watchdogs
[57.037921]   /dev/watchdog0
[57.051137] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.055460] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.058142] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.061651] [001/131] (960s left) kms_pm_rpm (pm-caching)
[59.106698] Starting subtest: pm-caching
[59.112864] Subtest pm-caching: SKIP (0.000s)
[59.482156] [002/131] (958s left) fbdev (read)
[59.530342] Starting subtest: read
[60.072254] Subtest read: SUCCESS (0.531s)
[60.124199] [003/131] (957s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[60.232871] Starting subtest: fbcpsr-rgb565-draw-blt
[65.187611] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (4.900s)
[65.317556] [004/131] (952s left) i915_pm_rc6_residency (rc6-idle)
[65.389600] Starting subtest: rc6-idle
[65.413853] Starting dynamic subtest: gt0-rcs0
[77.732964] Dynamic subtest gt0-rcs0: SUCCESS (12.224s)
[77.742464] Starting dynamic subtest: gt0-bcs0
[89.951092] Dynamic subtest gt0-bcs0: SUCCESS (12.251s)
[89.958605] Starting dynamic subtest: gt0-ccs0
[102.256831] Dynamic subtest gt0-ccs0: SUCCESS (12.251s)
[102.264337] Starting dynamic subtest: gt1-vcs0
[114.479088] Dynamic subtest gt1-vcs0: SUCCESS (12.263s)
[114.486167] Starting dynamic subtest: gt1-vecs0
[127.162982] Dynamic subtest gt1-vecs0: SUCCESS (12.652s)
[127.165176] Subtest rc6-idle: SUCCESS (61.668s)
[127.953211] [005/131] (889s left) kms_force_connector_basic (force-connector-state)
[128.031499] Starting subtest: force-connector-state
[128.631403] Subtest force-connector-state: SUCCESS (0.600s)
[129.602771] [006/131] (888s left) kms_psr (psr-primary-mmap-cpu)
[129.708097] Starting subtest: psr-primary-mmap-cpu
[129.710420] Starting dynamic subtest: eDP-1
[131.455292] Dynamic subtest eDP-1: SUCCESS (1.745s)
[131.457635] Subtest psr-primary-mmap-cpu: SUCCESS (1.745s)
[132.309776] [007/131] (885s left) gem_mmap_wc (read-write)
[132.368668] Subtest read-write: SKIP (0.000s)
[132.423322] [008/131] (885s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[132.531068] Starting subtest: invalidate-primary-flip-overlay
[143.253963] Subtest invalidate-primary-flip-overlay: SUCCESS (10.724s)
[143.417996] [009/131] (874s left) gem_exec_schedule (u-semaphore-resolve)
[143.491055] Starting subtest: u-semaphore-resolve
[143.526509] Subtest u-semaphore-resolve: SUCCESS (0.041s)
[143.880897] [010/131] (874s left) gem_mmap_gtt (basic-copy)
[143.940168] Subtest basic-copy: SKIP (0.000s)
[143.995467] [011/131] (874s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[144.109374] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[145.368375] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (1.259s)
[145.661900] [012/131] (872s left) gem_exec_reloc (basic-gtt-read)
[145.742470] Subtest basic-gtt-read: SKIP (0.000s)
[145.813868] [013/131] (872s left) gem_mmap_gtt (cpuset-big-copy)
[145.870401] Subtest cpuset-big-copy: SKIP (0.000s)
[145.929282] [014/131] (872s left) kms_flip (2x-dpms-vs-vblank-race-interruptible)
[146.015872] Starting subtest: 2x-dpms-vs-vblank-race-interruptible
[146.029117] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.011s)
[146.120797] [015/131] (872s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[146.222766] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[149.288407] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (3.069s)
[149.441818] [016/131] (868s left) gem_workarounds (reset-context)
[149.512611] Starting subtest: reset-context
[149.696452] Subtest reset-context: SUCCESS (0.184s)
[149.838962] [017/131] (868s left) kms_plane_multiple (tiling-x)
[149.942513] Starting subtest: tiling-x
[149.944461] Starting dynamic subtest: pipe-A-eDP-1
[153.550414] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.605s)
[153.559051] Starting dynamic subtest: pipe-B-eDP-1
[157.948119] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.399s)
[157.956825] Starting dynamic subtest: pipe-C-eDP-1
[162.238840] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.287s)
[162.248013] Starting dynamic subtest: pipe-D-eDP-1
[166.642802] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.403s)
[166.644826] Subtest tiling-x: SUCCESS (16.696s)
[167.443469] [018/131] (850s left) kms_cursor_crc (cursor-offscreen-128x42)
[167.648764] Starting subtest: cursor-offscreen-128x42
[167.688835] Subtest cursor-offscreen-128x42: SKIP (0.034s)
[167.895122] [019/131] (850s left) i915_suspend (forcewake)
[167.955066] Starting subtest: forcewake
[200.043736] Subtest forcewake: SUCCESS (2.502s)
[201.136777] [020/131] (847s left) perf_pmu (init-busy)
[201.183562] Starting subtest: init-busy
[201.186203] Starting dynamic subtest: rcs0
[201.188738] Dynamic subtest rcs0: SUCCESS (0.001s)
[201.199120] Starting dynamic subtest: bcs0
[201.201530] Dynamic subtest bcs0: SUCCESS (0.000s)
[201.209965] Starting dynamic subtest: vcs0
[201.212353] Dynamic subtest vcs0: SUCCESS (0.001s)
[201.220499] Starting dynamic subtest: vcs1
[201.222935] Dynamic subtest vcs1: SUCCESS (0.001s)
[201.231784] Starting dynamic subtest: vecs0
[201.234060] Dynamic subtest vecs0: SUCCESS (0.001s)
[201.244885] Starting dynamic subtest: ccs0
[201.247251] Dynamic subtest ccs0: SUCCESS (0.000s)
[201.249694] Subtest init-busy: SUCCESS (0.006s)
[201.283218] [021/131] (847s left) device_reset (unbind-cold-reset-rebind)
[201.332724] Starting subtest: unbind-cold-reset-rebind
[201.337685] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[201.400840] [022/131] (847s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[206.628236] Starting subtest: pr-overlay-primary-update-sf-dmg-area
[206.633220] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.003s)
[207.496146] [023/131] (841s left) kms_tiled_display (basic-test-pattern)
[207.617886] Subtest basic-test-pattern: SKIP (0.000s)
[207.656016] [024/131] (841s left) gem_eio (wait-1us)
[207.896687] Starting subtest: wait-1us
[208.271149] Subtest wait-1us: SUCCESS (0.367s)
[208.431349] [025/131] (840s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[208.546295] Starting subtest: y-tiled-16bpp-rotate-180
[208.549977] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[208.653699] [026/131] (840s left) syncobj_wait (wait-zero-handles)
[208.713571] Starting subtest: wait-zero-handles
[208.715289] Subtest wait-zero-handles: SUCCESS (0.000s)
[208.804212] [027/131] (840s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[208.906812] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[208.908852] Starting dynamic subtest: pipe-A-eDP-1
[208.929725] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[208.939880] Starting dynamic subtest: pipe-B-eDP-1
[208.958245] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[208.966750] Starting dynamic subtest: pipe-C-eDP-1
[208.984573] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[208.993489] Starting dynamic subtest: pipe-D-eDP-1
[209.011814] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[209.015245] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.003s)
[211.106046] [028/131] (838s left) kms_cursor_crc (cursor-random-128x42)
[211.319871] Starting subtest: cursor-random-128x42
[211.363160] Subtest cursor-random-128x42: SKIP (0.037s)
[211.581176] [029/131] (837s left) kms_dp_link_training (uhbr-mst)
[211.672223] Starting subtest: uhbr-mst
[211.681258] Subtest uhbr-mst: SKIP (0.000s)
[211.742549] [030/131] (837s left) vgem_basic (unload)
[211.783378] Starting subtest: unload
[241.070648] Subtest unload: SUCCESS (29.148s)
[241.108155] [FACT vgem_basic (unload)] new: kernel.kmod_is_loaded.vgem: true
[241.111422] [031/131] (808s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[241.218376] Starting subtest: fbc-psr2-cursor-plane-onoff
[241.220761] Starting dynamic subtest: eDP-1
[241.225178] Dynamic subtest eDP-1: SKIP (0.000s)
[241.229518] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s)
[241.287691] [032/131] (808s left) gem_exec_basic (basic)
[241.349705] Starting subtest: basic
[241.352172] Starting dynamic subtest: rcs0-smem
[241.354579] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[241.365114] Starting dynamic subtest: bcs0-smem
[241.367083] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[241.374972] Starting dynamic subtest: vcs0-smem
[241.376900] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[241.384649] Starting dynamic subtest: vcs1-smem
[241.386571] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[241.394366] Starting dynamic subtest: vecs0-smem
[241.396248] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[241.404191] Starting dynamic subtest: ccs0-smem
[241.406200] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[241.408187] Subtest basic: SUCCESS (0.012s)
[242.526027] [033/131] (807s left) gem_exec_whisper (basic-sync)
[242.588472] Starting subtest: basic-sync
[251.957304] Subtest basic-sync: SUCCESS (9.355s)
[252.129567] [034/131] (797s left) gem_exec_reloc (basic-write-gtt-noreloc)
[252.185854] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[252.249843] [035/131] (797s left) kms_pm_backlight (fade-with-dpms)
[252.348123] Starting subtest: fade-with-dpms
[254.492246] Starting dynamic subtest: eDP-1
[257.184995] Dynamic subtest eDP-1: SUCCESS (2.694s)
[257.187512] Subtest fade-with-dpms: SUCCESS (4.836s)
[257.979821] [036/131] (791s left) syncobj_timeline (invalid-query-bad-pad)
[258.044638] Starting subtest: invalid-query-bad-pad
[258.047136] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[258.160895] [037/131] (791s left) gem_mmap_wc (write)
[258.219259] Subtest write: SKIP (0.000s)
[258.276738] [038/131] (791s left) gem_userptr_blits (coherency-unsync)
[258.351085] Subtest coherency-unsync: SKIP (0.000s)
[258.491645] [039/131] (791s left) gem_ctx_param (basic)
[258.545639] Starting subtest: basic
[258.547977] Subtest basic: SUCCESS (0.001s)
[258.638876] [040/131] (791s left) kms_psr (pr-cursor-blt)
[258.739044] Starting subtest: pr-cursor-blt
[258.743518] Subtest pr-cursor-blt: SKIP (0.000s)
[258.803799] [041/131] (791s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[258.901135] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[258.903568] Starting dynamic subtest: pipe-A-eDP-1
[259.418101] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.515s)
[259.429180] Starting dynamic subtest: pipe-B-eDP-1
[259.450158] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[259.459125] Starting dynamic subtest: pipe-C-eDP-1
[259.482108] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.003s)
[259.490189] Starting dynamic subtest: pipe-D-eDP-1
[259.510086] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[259.512088] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.529s)
[261.634507] [042/131] (788s left) kms_pm_rpm (modeset-lpsp-stress)
[263.677662] Starting subtest: modeset-lpsp-stress
[279.967763] Subtest modeset-lpsp-stress: SUCCESS (16.281s)
[280.051644] [043/131] (770s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[280.187187] Starting subtest: modeset-atomic-cursor-hotspot
[280.191528] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[280.280024] [044/131] (769s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[280.377045] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[280.390411] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.011s)
[280.461681] [045/131] (769s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[280.582840] Starting subtest: yf-tiled-64bpp-rotate-180
[280.587197] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[280.698956] [046/131] (769s left) gem_softpin (allocator-basic)
[280.756618] Starting subtest: allocator-basic
[280.823078] Subtest allocator-basic: SUCCESS (0.066s)
[280.959990] [047/131] (769s left) i915_pm_rpm (gem-mmap-type)
[282.594546] Starting subtest: gem-mmap-type
[282.597319] Starting dynamic subtest: wb-smem0
[286.615890] Dynamic subtest wb-smem0: SUCCESS (4.016s)
[286.626456] Starting dynamic subtest: wc-smem0
[289.823909] Dynamic subtest wc-smem0: SUCCESS (3.207s)
[289.832720] Starting dynamic subtest: uc-smem0
[292.642966] Dynamic subtest uc-smem0: SUCCESS (2.816s)
[292.645267] Subtest gem-mmap-type: SUCCESS (10.042s)
[292.727258] [048/131] (757s left) gem_exec_reloc (basic-write-read-active)
[292.790700] Subtest basic-write-read-active: SKIP (0.000s)
[292.853592] [049/131] (757s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[292.963166] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[292.965458] Starting dynamic subtest: pipe-A-eDP-1
[292.987924] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[292.997673] Starting dynamic subtest: pipe-B-eDP-1
[293.018736] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[293.026847] Starting dynamic subtest: pipe-C-eDP-1
[293.047777] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[293.055629] Starting dynamic subtest: pipe-D-eDP-1
[293.076706] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[293.080887] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[295.157422] [050/131] (755s left) kms_pipe_crc_basic (nonblocking-crc)
[295.243887] Starting subtest: nonblocking-crc
[295.246304] Starting dynamic subtest: pipe-A-eDP-1
[295.979811] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.734s)
[295.989019] Starting dynamic subtest: pipe-B-eDP-1
[297.357717] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.377s)
[297.366873] Starting dynamic subtest: pipe-C-eDP-1
[298.747678] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.388s)
[298.756092] Starting dynamic subtest: pipe-D-eDP-1
[300.082167] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.334s)
[300.084516] Subtest nonblocking-crc: SUCCESS (4.838s)
[300.943488] [051/131] (749s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[301.023071] Starting subtest: basic-batch-kernel-default-cmd
[301.027513] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[301.207034] [052/131] (749s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[301.308920] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[301.321937] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[301.391844] [053/131] (749s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[301.498633] Starting subtest: psr-farfromfence-mmap-gtt
[301.503031] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[301.599700] [054/131] (748s left) kms_vrr (lobf)
[301.693179] Starting subtest: lobf
[301.697084] Subtest lobf: SKIP (0.000s)
[301.761229] [055/131] (748s left) syncobj_timeline (device-signal-unordered)
[301.823905] Starting subtest: device-signal-unordered
[301.826289] Subtest device-signal-unordered: SUCCESS (0.001s)
[301.919306] [056/131] (748s left) gem_exec_reloc (basic-write-read-noreloc)
[301.972885] Subtest basic-write-read-noreloc: SKIP (0.000s)
[302.048756] [057/131] (748s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[302.151271] Starting subtest: fbc-pr-sprite-mmap-cpu
[302.154972] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[302.216120] [058/131] (748s left) kms_lease (lease-invalid-plane)
[302.310608] Starting subtest: lease-invalid-plane
[302.312631] Starting dynamic subtest: pipe-A-eDP-1
[302.314615] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[302.322911] Starting dynamic subtest: pipe-B-eDP-1
[302.324836] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[302.332822] Starting dynamic subtest: pipe-C-eDP-1
[302.334443] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[302.342780] Starting dynamic subtest: pipe-D-eDP-1
[302.344703] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[302.346563] Subtest lease-invalid-plane: SUCCESS (0.004s)
[302.381014] [059/131] (748s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[302.472783] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[302.474837] Starting dynamic subtest: pipe-A-default-mode
[302.764099] Dynamic subtest pipe-A-default-mode: SKIP (0.286s)
[302.768492] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.288s)
[303.571949] [060/131] (747s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[303.638537] Starting subtest: multi-wait-available-unsubmitted-signaled
[303.640992] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.001s)
[303.745818] [061/131] (747s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[303.845253] Starting subtest: 4-tiled-16bpp-rotate-180
[305.187835] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.345s)
[305.340544] [062/131] (745s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[305.397752] Starting subtest: saturated-hostile-nopreempt
[305.400196] Starting dynamic subtest: rcs0
[305.466312] Dynamic subtest rcs0: SKIP (0.067s)
[305.477015] Starting dynamic subtest: bcs0
[305.489258] Dynamic subtest bcs0: SKIP (0.021s)
[305.499639] Starting dynamic subtest: vcs0
[305.505951] Dynamic subtest vcs0: SKIP (0.015s)
[305.513981] Starting dynamic subtest: vcs1
[305.531013] Dynamic subtest vcs1: SKIP (0.024s)
[305.539272] Starting dynamic subtest: vecs0
[305.555172] Dynamic subtest vecs0: SKIP (0.022s)
[305.563329] Starting dynamic subtest: ccs0
[305.579112] Dynamic subtest ccs0: SKIP (0.023s)
[305.582959] Subtest saturated-hostile-nopreempt: SKIP (0.180s)
[305.652469] [063/131] (745s left) gem_ctx_exec (basic-close-race)
[305.719746] Starting subtest: basic-close-race
[311.755533] Subtest basic-close-race: SUCCESS (5.983s)
[311.850883] [064/131] (739s left) gem_close_race (basic-threads)
[311.925764] Starting subtest: basic-threads
[313.388278] Subtest basic-threads: SUCCESS (1.463s)
[313.568698] [065/131] (737s left) api_intel_allocator (default-alignment)
[313.623799] Starting subtest: default-alignment
[313.626169] Subtest default-alignment: SUCCESS (0.005s)
[313.765194] [066/131] (737s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[313.881684] Starting subtest: psr-rgb565-draw-mmap-wc
[318.554793] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (4.676s)
[318.660649] [067/131] (732s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[318.770465] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[318.774502] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[318.881495] [068/131] (732s left) gem_blits (basic)
[318.945281] Starting subtest: basic
[320.302670] Subtest basic: SUCCESS (1.357s)
[320.427572] [069/131] (730s left) syncobj_timeline (single-wait-available-signaled)
[320.487150] Starting subtest: single-wait-available-signaled
[320.489333] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[320.587325] [070/131] (730s left) gem_partial_pwrite_pread (write)
[320.650873] Subtest write: SKIP (0.000s)
[320.709806] [071/131] (730s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[320.813802] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[320.818235] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[320.926632] [072/131] (730s left) kms_async_flips (async-flip-suspend-resume)
[321.021324] Starting subtest: async-flip-suspend-resume
[321.388554] Starting dynamic subtest: pipe-A-eDP-1
[339.120376] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.930s)
[339.496905] Starting dynamic subtest: pipe-B-eDP-1
[342.250859] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.688s)
[342.631277] Starting dynamic subtest: pipe-C-eDP-1
[345.395366] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.685s)
[345.767758] Starting dynamic subtest: pipe-D-eDP-1
[348.510909] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.694s)
[348.513294] Subtest async-flip-suspend-resume: SUCCESS (12.452s)
[349.750243] [073/131] (716s left) kms_color (legacy-gamma)
[349.845928] Starting subtest: legacy-gamma
[349.848134] Starting dynamic subtest: pipe-A-eDP-1
[350.588584] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.729s)
[350.602805] Starting dynamic subtest: pipe-B-eDP-1
[351.972896] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.368s)
[351.982641] Starting dynamic subtest: pipe-C-eDP-1
[353.359983] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.371s)
[353.370646] Starting dynamic subtest: pipe-D-eDP-1
[354.709952] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.339s)
[354.712361] Subtest legacy-gamma: SUCCESS (4.809s)
[355.527489] [074/131] (710s left) gem_wait (write-busy)
[355.601640] Starting subtest: write-busy
[355.604104] Starting dynamic subtest: all-engines
[356.231419] Dynamic subtest all-engines: SUCCESS (0.624s)
[356.248066] Starting dynamic subtest: rcs0
[356.785970] Dynamic subtest rcs0: SUCCESS (0.550s)
[356.802331] Starting dynamic subtest: bcs0
[357.336213] Dynamic subtest bcs0: SUCCESS (0.546s)
[357.352102] Starting dynamic subtest: vcs0
[359.305649] Dynamic subtest vcs0: SUCCESS (1.957s)
[359.323164] Starting dynamic subtest: vcs1
[361.290285] Dynamic subtest vcs1: SUCCESS (1.974s)
[361.305743] Starting dynamic subtest: vecs0
[363.337554] Dynamic subtest vecs0: SUCCESS (2.039s)
[363.352976] Starting dynamic subtest: ccs0
[363.887148] Dynamic subtest ccs0: SUCCESS (0.548s)
[363.889604] Subtest write-busy: SUCCESS (8.249s)
[364.082127] [075/131] (702s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[364.184888] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[368.759550] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (4.568s)
[368.890598] [076/131] (697s left) gem_pxp (fail-invalid-protected-context)
[369.015924] Starting subtest: fail-invalid-protected-context
[369.018376] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[369.118235] [077/131] (697s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[369.228376] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[373.615763] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (4.385s)
[373.701186] [078/131] (692s left) gem_ctx_persistence (hang)
[373.753219] Starting subtest: hang
[373.757936] Subtest hang: SKIP (0.000s)
[373.846787] [079/131] (692s left) gem_softpin (reverse)
[373.909464] Starting subtest: reverse
[373.916901] Subtest reverse: SUCCESS (0.007s)
[374.031556] [080/131] (692s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[374.152690] Starting subtest: cursorA-vs-flipB-varying-size
[374.156995] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[374.280881] [081/131] (692s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[374.392702] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[374.397166] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[374.479262] [082/131] (692s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[379.561565] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[379.566542] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.003s)
[380.393207] [083/131] (686s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[380.507445] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[380.511946] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[380.608430] [084/131] (686s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[380.716350] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[381.851088] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.133s)
[381.988968] [085/131] (684s left) gem_mmap (basic-small-bo)
[382.055282] Subtest basic-small-bo: SKIP (0.000s)
[382.121519] [086/131] (684s left) gem_exec_schedule (manyslice)
[382.194572] Starting subtest: manyslice
[382.196548] Starting dynamic subtest: rcs0
[386.869943] Dynamic subtest rcs0: SUCCESS (4.628s)
[386.882705] Starting dynamic subtest: bcs0
[392.988357] Dynamic subtest bcs0: SUCCESS (6.114s)
[392.997263] Starting dynamic subtest: vcs0
[399.058467] Dynamic subtest vcs0: SUCCESS (6.066s)
[399.070586] Starting dynamic subtest: vcs1
[405.126228] Dynamic subtest vcs1: SUCCESS (6.062s)
[405.140642] Starting dynamic subtest: vecs0
[411.189044] Dynamic subtest vecs0: SUCCESS (6.058s)
[411.201766] Starting dynamic subtest: ccs0
[416.843635] Dynamic subtest ccs0: SUCCESS (5.647s)
[416.845803] Subtest manyslice: SUCCESS (34.585s)
[417.096386] [087/131] (649s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[417.490883] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[418.308259] [088/131] (648s left) perf (polling-small-buf)
[418.423712] Starting subtest: polling-small-buf
[418.520701] Subtest polling-small-buf: SUCCESS (0.096s)
[418.564272] [089/131] (648s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[418.669421] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[418.673522] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[418.774710] [090/131] (648s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[418.878317] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[424.052751] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (5.175s)
[424.176765] [091/131] (642s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[424.279016] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[424.281447] Starting dynamic subtest: pipe-A-default-mode
[426.897417] Dynamic subtest pipe-A-default-mode: SUCCESS (2.617s)
[426.900071] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.619s)
[427.772742] [092/131] (639s left) prime_self_import (export-vs-gem_close-race)
[427.814488] Starting subtest: export-vs-gem_close-race
[432.923366] Subtest export-vs-gem_close-race: SUCCESS (5.087s)
[432.976690] [093/131] (634s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[433.085408] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[433.089468] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[433.183549] [094/131] (634s left) api_intel_bb (lot-of-buffers)
[433.238031] Starting subtest: lot-of-buffers
[434.241866] Subtest lot-of-buffers: SUCCESS (1.004s)
[434.412855] [095/131] (632s left) gem_exec_fence (syncobj-timeline-chain-engines)
[434.980830] Starting subtest: syncobj-timeline-chain-engines
[435.069107] Subtest syncobj-timeline-chain-engines: SUCCESS (0.090s)
[436.407055] [096/131] (630s left) kms_invalid_mode (bad-hsync-start)
[436.510879] Starting subtest: bad-hsync-start
[436.513191] Starting dynamic subtest: pipe-A-eDP-1
[436.793351] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.282s)
[436.803565] Starting dynamic subtest: pipe-B-eDP-1
[436.805534] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[436.813680] Starting dynamic subtest: pipe-C-eDP-1
[436.816091] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[436.824667] Starting dynamic subtest: pipe-D-eDP-1
[436.826989] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[436.829236] Subtest bad-hsync-start: SUCCESS (0.287s)
[437.596403] [097/131] (629s left) gem_mmap_offset (open-flood)
[437.656216] Starting subtest: open-flood
[459.141712] Subtest open-flood: SUCCESS (21.494s)
[459.265907] [098/131] (608s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[459.387465] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[460.645173] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (1.259s)
[460.878143] [099/131] (606s left) gem_create (create-invalid-size)
[460.932109] Starting subtest: create-invalid-size
[460.934333] Subtest create-invalid-size: SUCCESS (0.000s)
[461.113389] [100/131] (606s left) prime_self_import (reimport-vs-gem_close-race)
[461.148669] Starting subtest: reimport-vs-gem_close-race
[466.264125] Subtest reimport-vs-gem_close-race: SUCCESS (5.105s)
[466.328037] [101/131] (601s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[466.482819] Starting subtest: cursor-rapid-movement-32x10
[466.523225] Subtest cursor-rapid-movement-32x10: SKIP (0.036s)
[466.777622] [102/131] (600s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[466.833450] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[466.897674] [103/131] (600s left) gem_eio (in-flight-contexts-10ms)
[467.126746] Starting subtest: in-flight-contexts-10ms
[478.304044] Subtest in-flight-contexts-10ms: SUCCESS (11.175s)
[478.492325] [104/131] (589s left) kms_atomic_transition (plane-all-transition-nonblocking)
[478.595182] Starting subtest: plane-all-transition-nonblocking
[478.597565] Starting dynamic subtest: pipe-A-eDP-1
[481.155886] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.506s)
[481.402512] Starting dynamic subtest: pipe-B-eDP-1
[484.676393] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.230s)
[484.903953] Subtest plane-all-transition-nonblocking: SUCCESS (6.304s)
[485.732154] [105/131] (581s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[485.797480] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[485.799630] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[485.892766] [106/131] (581s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[486.001201] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[489.396908] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (3.400s)
[489.495390] [107/131] (578s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[489.592083] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[489.594375] Starting dynamic subtest: pipe-A
[489.665792] Dynamic subtest pipe-A: SUCCESS (0.074s)
[489.676416] Starting dynamic subtest: pipe-B
[490.771895] Dynamic subtest pipe-B: SUCCESS (1.105s)
[490.780992] Starting dynamic subtest: pipe-C
[491.886581] Dynamic subtest pipe-C: SUCCESS (1.114s)
[491.897739] Starting dynamic subtest: pipe-D
[493.001919] Dynamic subtest pipe-D: SUCCESS (1.115s)
[493.004259] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.409s)
[494.155854] [108/131] (573s left) kms_flip (2x-flip-vs-rmfb)
[494.267542] Starting subtest: 2x-flip-vs-rmfb
[494.277910] Subtest 2x-flip-vs-rmfb: SKIP (0.011s)
[494.356196] [109/131] (573s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[494.421525] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[494.424034] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[494.506152] [110/131] (573s left) i915_getparams_basic (basic-eu-total)
[494.569355] Starting subtest: basic-eu-total
[494.574202] Subtest basic-eu-total: SUCCESS (0.000s)
[494.657608] [111/131] (573s left) gem_lmem_swapping (random)
[494.701064] Subtest random: SKIP (0.000s)
[494.744593] [112/131] (573s left) sw_sync (alloc_timeline)
[494.782670] Starting subtest: alloc_timeline
[494.784911] Subtest alloc_timeline: SUCCESS (0.000s)
[494.833559] [113/131] (573s left) kms_frontbuffer_tracking (psr-1p-rte)
[494.946877] Starting subtest: psr-1p-rte
[498.129127] Subtest psr-1p-rte: SUCCESS (3.186s)
[498.291431] [114/131] (569s left) api_intel_bb (render)
[498.338904] Starting subtest: render
[498.341199] Starting dynamic subtest: render-none-512
[498.441748] Dynamic subtest render-none-512: SUCCESS (0.104s)
[498.450366] Starting dynamic subtest: render-none-1024
[498.833464] Dynamic subtest render-none-1024: SUCCESS (0.389s)
[498.845190] Starting dynamic subtest: render-x-512
[498.920590] Dynamic subtest render-x-512: SUCCESS (0.087s)
[498.932492] Starting dynamic subtest: render-x-1024
[499.267483] Dynamic subtest render-x-1024: SUCCESS (0.345s)
[499.277730] Starting dynamic subtest: render-y-512
[499.353397] Dynamic subtest render-y-512: SUCCESS (0.086s)
[499.363872] Starting dynamic subtest: render-y-1024
[499.699393] Dynamic subtest render-y-1024: SUCCESS (0.344s)
[499.701882] Subtest render: SUCCESS (1.361s)
[499.802674] [115/131] (568s left) gem_userptr_blits (unsync-unmap)
[499.874487] Subtest unsync-unmap: SKIP (0.000s)
[500.004908] [116/131] (567s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[500.106276] Starting subtest: crc-primary-basic-y-tiled-ccs
[500.108645] Starting dynamic subtest: pipe-A-eDP-1
[500.131607] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[500.141629] Starting dynamic subtest: pipe-B-eDP-1
[500.163984] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[500.172958] Starting dynamic subtest: pipe-C-eDP-1
[500.195200] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[500.204022] Starting dynamic subtest: pipe-D-eDP-1
[500.226846] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[500.231021] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.005s)
[502.271322] [117/131] (565s left) kms_chamelium_color (ctm-red-to-blue)
[502.374090] Subtest ctm-red-to-blue: SKIP (0.000s)
[502.419213] [118/131] (565s left) gem_mmap_gtt (medium-copy-xy)
[502.472852] Subtest medium-copy-XY: SKIP (0.000s)
[502.533531] [119/131] (565s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[502.588724] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[502.591118] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[502.699821] [120/131] (565s left) prime_mmap (test_errors)
[502.754587] Starting subtest: test_errors
[502.756951] Starting dynamic subtest: test_errors-smem
[502.867089] Dynamic subtest test_errors-smem: SUCCESS (0.114s)
[502.869685] Subtest test_errors: SUCCESS (0.114s)
[502.963598] [121/131] (565s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[503.053902] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[503.056329] Starting dynamic subtest: pipe-A-eDP-1
[503.082217] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[503.092040] Starting dynamic subtest: pipe-B-eDP-1
[503.115990] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[503.124906] Starting dynamic subtest: pipe-C-eDP-1
[503.149616] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[503.158615] Starting dynamic subtest: pipe-D-eDP-1
[503.183489] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[503.187667] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[505.320761] [122/131] (562s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[505.435363] Starting subtest: psr-2p-primscrn-spr-indfb-move
[505.439642] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[505.526789] [123/131] (562s left) gem_ctx_sseu (invalid-args)
[505.583597] Subtest invalid-args: SKIP (0.000s)
[505.651414] [124/131] (562s left) perf_pmu (busy-accuracy-50)
[505.691674] Starting subtest: busy-accuracy-50
[505.694476] Starting dynamic subtest: rcs0
[507.230322] Dynamic subtest rcs0: SUCCESS (1.535s)
[507.241453] Starting dynamic subtest: bcs0
[508.777730] Dynamic subtest bcs0: SUCCESS (1.545s)
[508.788905] Starting dynamic subtest: vcs0
[510.320046] Dynamic subtest vcs0: SUCCESS (1.540s)
[510.337023] Starting dynamic subtest: vcs1
[511.866489] Dynamic subtest vcs1: SUCCESS (1.544s)
[511.877121] Starting dynamic subtest: vecs0
[513.408293] Dynamic subtest vecs0: SUCCESS (1.540s)
[513.419139] Starting dynamic subtest: ccs0
[514.959226] Dynamic subtest ccs0: SUCCESS (1.548s)
[514.961607] Subtest busy-accuracy-50: SUCCESS (9.263s)
[515.092711] [125/131] (553s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[515.155188] Starting subtest: yf-tiled-ccs-to-x-tiled
[515.159831] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[515.335198] [126/131] (553s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[515.446763] Starting subtest: fbc-shrfb-scaledprimary
[519.518803] Subtest fbc-shrfb-scaledprimary: SUCCESS (4.074s)
[519.674933] [127/131] (548s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[519.787104] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[519.789424] Starting dynamic subtest: pipe-A-default-mode
[520.096772] Dynamic subtest pipe-A-default-mode: SKIP (0.309s)
[520.101278] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.310s)
[520.886810] [128/131] (547s left) kms_psr (psr2-dpms)
[520.998937] Starting subtest: psr2-dpms
[521.001077] Starting dynamic subtest: eDP-1
[523.899986] Dynamic subtest eDP-1: SUCCESS (2.901s)
[523.902327] Subtest psr2-dpms: SUCCESS (2.902s)
[524.758206] [129/131] (543s left) gem_exec_schedule (preempt-self)
[524.834739] Starting subtest: preempt-self
[524.836636] Starting dynamic subtest: rcs0
[524.846527] Dynamic subtest rcs0: SUCCESS (0.019s)
[524.856482] Starting dynamic subtest: bcs0
[524.865714] Dynamic subtest bcs0: SUCCESS (0.018s)
[524.874911] Starting dynamic subtest: vcs0
[524.882902] Dynamic subtest vcs0: SUCCESS (0.017s)
[524.891665] Starting dynamic subtest: vcs1
[524.899190] Dynamic subtest vcs1: SUCCESS (0.016s)
[524.910273] Starting dynamic subtest: vecs0
[524.917455] Dynamic subtest vecs0: SUCCESS (0.018s)
[524.926629] Starting dynamic subtest: ccs0
[524.936853] Dynamic subtest ccs0: SUCCESS (0.018s)
[524.939569] Subtest preempt-self: SUCCESS (0.110s)
[526.357697] [130/131] (542s left) gem_exec_balancer (persistence)
[526.615486] Starting subtest: persistence
[527.390511] Subtest persistence: SUCCESS (0.775s)
[527.526523] [131/131] (541s left) kms_flip (2x-plain-flip-fb-recreate)
[527.634116] Starting subtest: 2x-plain-flip-fb-recreate
[527.646104] Subtest 2x-plain-flip-fb-recreate: SKIP (0.012s)
[527.753318] Closing watchdogs
Done.