[41.453801] Initializing watchdogs [41.453854] /dev/watchdog0 [41.461587] [001/133] (960s left) syncobj_timeline (single-wait-for-submit-available-submitted) [41.534672] Starting subtest: single-wait-for-submit-available-submitted [41.537115] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s) [41.622063] [002/133] (960s left) kms_hdmi_inject (inject-audio) [41.986814] Starting subtest: inject-audio [42.245291] Subtest inject-audio: SUCCESS (0.258s) [42.883838] [003/133] (959s left) kms_big_fb (y-tiled-addfb-size-offset-overflow) [42.989058] Starting subtest: y-tiled-addfb-size-offset-overflow [42.993650] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s) [43.059171] [004/133] (958s left) gem_create (create-invalid-size) [43.111546] Starting subtest: create-invalid-size [43.113920] Subtest create-invalid-size: SUCCESS (0.000s) [43.286090] [005/133] (958s left) perf_pmu (init-sema) [43.362285] Starting subtest: init-sema [43.364850] Starting dynamic subtest: rcs0 [43.367343] Dynamic subtest rcs0: SUCCESS (0.003s) [43.377751] Starting dynamic subtest: bcs0 [43.380184] Dynamic subtest bcs0: SUCCESS (0.000s) [43.391398] Starting dynamic subtest: vcs0 [43.393798] Dynamic subtest vcs0: SUCCESS (0.001s) [43.404037] Starting dynamic subtest: vcs1 [43.406352] Dynamic subtest vcs1: SUCCESS (0.001s) [43.415084] Starting dynamic subtest: vecs0 [43.417672] Dynamic subtest vecs0: SUCCESS (0.000s) [43.425887] Starting dynamic subtest: ccs0 [43.428049] Dynamic subtest ccs0: SUCCESS (0.000s) [43.430337] Subtest init-sema: SUCCESS (0.006s) [43.457505] [006/133] (958s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu) [43.553653] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu [48.345065] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (4.792s) [48.423742] [007/133] (953s left) gem_mmap_gtt (cpuset-medium-copy) [48.512281] Subtest cpuset-medium-copy: SKIP (0.000s) [48.558478] [008/133] (953s left) kms_psr (fbc-psr2-suspend) [48.646042] Starting subtest: fbc-psr2-suspend [48.648574] Starting dynamic subtest: eDP-1 [48.652544] Dynamic subtest eDP-1: SKIP (0.000s) [48.656850] Subtest fbc-psr2-suspend: SKIP (0.001s) [48.708534] [009/133] (953s left) gem_ctx_persistence (idempotent) [48.794711] Starting subtest: idempotent [48.797839] Subtest idempotent: SUCCESS (0.000s) [48.880136] [010/133] (953s left) kms_frontbuffer_tracking (psr-rgb565-draw-render) [48.958427] Starting subtest: psr-rgb565-draw-render [53.964043] Subtest psr-rgb565-draw-render: SUCCESS (5.010s) [54.086473] [011/133] (948s left) gem_softpin (overlap) [54.169717] Starting subtest: overlap [54.935384] Subtest overlap: SUCCESS (0.764s) [55.034123] [012/133] (947s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180) [55.130683] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180 [56.384923] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.258s) [56.482483] [013/133] (945s left) syncobj_wait (wait-all-delayed-signal) [56.546138] Starting subtest: wait-all-delayed-signal [56.650164] Subtest wait-all-delayed-signal: SUCCESS (0.102s) [56.716781] [014/133] (945s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite) [56.804706] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite [56.808880] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [56.884223] [015/133] (945s left) kms_cursor_legacy (cursorb-vs-flipb-toggle) [56.990498] Starting subtest: cursorB-vs-flipB-toggle [56.995333] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s) [57.078924] [016/133] (945s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size) [57.200758] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size [57.205181] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s) [57.289342] [017/133] (945s left) kms_atomic (plane-invalid-params-fence) [57.369830] Starting subtest: plane-invalid-params-fence [57.372051] Starting dynamic subtest: pipe-A-eDP-1 [57.748269] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.378s) [57.750748] Subtest plane-invalid-params-fence: SUCCESS (0.379s) [58.682931] [018/133] (943s left) gem_sync (basic-each) [58.778563] Starting subtest: basic-each [61.059155] Subtest basic-each: SUCCESS (2.287s) [61.232640] [019/133] (941s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu) [61.330028] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu [61.334670] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [61.416745] [020/133] (940s left) kms_pm_rpm (basic-rte) [61.469503] Starting subtest: basic-rte [67.692851] Subtest basic-rte: SUCCESS (6.224s) [68.913125] [021/133] (933s left) kms_cursor_crc (cursor-offscreen-32x10) [69.043435] Starting subtest: cursor-offscreen-32x10 [69.074454] Subtest cursor-offscreen-32x10: SKIP (0.026s) [69.303789] [022/133] (933s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff) [69.428486] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff [69.432775] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [69.495557] [023/133] (932s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt) [69.587730] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt [69.591804] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [69.664268] [024/133] (932s left) gem_watchdog (default-physical) [69.732680] Starting subtest: default-physical [71.016618] Subtest default-physical: SUCCESS (1.289s) [71.088346] [025/133] (931s left) syncobj_timeline (invalid-signal-bad-pad) [71.167054] Starting subtest: invalid-signal-bad-pad [71.169527] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [71.243915] [026/133] (931s left) gem_userptr_blits (create-destroy-unsync) [71.315061] Subtest create-destroy-unsync: SKIP (0.000s) [71.409625] [027/133] (931s left) kms_draw_crc (draw-method-mmap-gtt) [71.492512] Starting subtest: draw-method-mmap-gtt [71.496955] Subtest draw-method-mmap-gtt: SKIP (0.000s) [71.579290] [028/133] (931s left) gem_exec_whisper (basic-contexts-forked) [71.668215] Starting subtest: basic-contexts-forked [97.480150] Subtest basic-contexts-forked: SUCCESS (25.758s) [97.590130] [029/133] (905s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt) [97.707878] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt [102.619591] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (4.917s) [102.737501] [030/133] (899s left) kms_legacy_colorkey (basic) [102.823158] Starting subtest: basic [102.825128] Starting dynamic subtest: pipe-A [102.867808] Dynamic subtest pipe-A: SUCCESS (0.045s) [102.878815] Starting dynamic subtest: pipe-B [102.881502] Dynamic subtest pipe-B: SUCCESS (0.001s) [102.890327] Starting dynamic subtest: pipe-C [102.893152] Dynamic subtest pipe-C: SUCCESS (0.001s) [102.901595] Starting dynamic subtest: pipe-D [102.904488] Dynamic subtest pipe-D: SUCCESS (0.001s) [102.907118] Subtest basic: SUCCESS (0.048s) [102.927591] [031/133] (899s left) drm_fdinfo (virtual-busy-idle-all) [102.981258] Starting subtest: virtual-busy-idle-all [102.985547] Subtest virtual-busy-idle-all: SKIP (0.000s) [103.036176] [032/133] (899s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite) [103.139205] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite [103.143170] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [103.215837] [033/133] (899s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite) [103.323423] Starting subtest: fbcpsr-rgb101010-draw-pwrite [108.166175] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (4.844s) [108.265125] [034/133] (894s left) kms_chamelium_audio (hdmi-audio-edid) [108.617824] Subtest hdmi-audio-edid: SKIP (0.000s) [109.467321] [035/133] (893s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs) [109.574164] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs [109.576683] Starting dynamic subtest: pipe-A-eDP-1 [109.581415] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [109.590389] Starting dynamic subtest: pipe-B-eDP-1 [109.595351] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [109.608677] Starting dynamic subtest: pipe-C-eDP-1 [109.613193] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [109.624089] Starting dynamic subtest: pipe-D-eDP-1 [109.628863] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [109.633542] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.002s) [109.653524] [036/133] (893s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render) [109.767549] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render [113.038232] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (3.277s) [113.156275] [037/133] (889s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation) [113.238302] Starting subtest: plane-downscale-factor-0-5-with-rotation [113.240549] Starting dynamic subtest: pipe-A-eDP-1 [113.271044] Dynamic subtest pipe-A-eDP-1: SKIP (0.028s) [113.279230] Starting dynamic subtest: pipe-B-eDP-1 [113.304050] Dynamic subtest pipe-B-eDP-1: SKIP (0.034s) [113.310322] Starting dynamic subtest: pipe-C-eDP-1 [113.335992] Dynamic subtest pipe-C-eDP-1: SKIP (0.032s) [113.343410] Starting dynamic subtest: pipe-D-eDP-1 [113.371532] Dynamic subtest pipe-D-eDP-1: SKIP (0.032s) [113.374896] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.130s) [113.464036] [038/133] (889s left) v3d/v3d_submit_csd (bad-multisync-extension) [113.556169] Subtest bad-multisync-extension: SKIP (0.000s) [113.605332] [039/133] (889s left) kms_vblank (ts-continuation-dpms-rpm) [113.699712] Starting subtest: ts-continuation-dpms-rpm [113.701940] Starting dynamic subtest: pipe-A-eDP-1 [116.309610] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.607s) [116.322468] Starting dynamic subtest: pipe-D-eDP-1 [118.659960] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.345s) [118.663160] Subtest ts-continuation-dpms-rpm: SUCCESS (4.959s) [119.547784] [040/133] (883s left) v3d/v3d_get_param (get-bad-flags) [119.634625] Subtest get-bad-flags: SKIP (0.000s) [119.679330] [041/133] (883s left) kms_psr2_sf (fbc-overlay-plane-update-sf-dmg-area) [124.982458] Starting subtest: fbc-overlay-plane-update-sf-dmg-area [124.985031] Starting dynamic subtest: psr2-pipe-A-eDP-1 [125.816708] Dynamic subtest psr2-pipe-A-eDP-1: SKIP (0.831s) [125.824275] Starting dynamic subtest: psr2-pipe-B-eDP-1 [127.056087] Dynamic subtest psr2-pipe-B-eDP-1: SKIP (1.237s) [127.060940] Subtest fbc-overlay-plane-update-sf-dmg-area: SKIP (2.073s) [128.378572] [042/133] (874s left) i915_pm_rpm (debugfs-read) [130.609241] Starting subtest: debugfs-read [133.983345] Subtest debugfs-read: SUCCESS (3.372s) [134.825615] [043/133] (868s left) gem_softpin (allocator-basic-reserve) [134.894487] Starting subtest: allocator-basic-reserve [134.984353] Subtest allocator-basic-reserve: SUCCESS (0.090s) [135.098368] [044/133] (867s left) perf (short-reads) [135.224508] Starting subtest: short-reads [135.240073] Subtest short-reads: SUCCESS (0.016s) [135.269386] [045/133] (867s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip) [135.356272] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip [136.425471] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.069s) [136.537606] [046/133] (866s left) kms_psr2_sf (overlay-plane-update-sf-dmg-area) [141.836315] Starting subtest: overlay-plane-update-sf-dmg-area [141.838804] Starting dynamic subtest: psr2-pipe-A-eDP-1 [148.650954] Dynamic subtest psr2-pipe-A-eDP-1: SUCCESS (6.810s) [148.664037] Starting dynamic subtest: psr2-pipe-B-eDP-1 [155.470046] Dynamic subtest psr2-pipe-B-eDP-1: SUCCESS (6.816s) [155.473181] Subtest overlay-plane-update-sf-dmg-area: SUCCESS (13.632s) [156.342440] [047/133] (846s left) gem_eio (in-flight-external) [156.612187] Starting subtest: in-flight-external [158.587446] Subtest in-flight-external: SUCCESS (1.977s) [158.697934] [048/133] (844s left) sw_sync (alloc_fence_invalid_timeline) [158.765286] Starting subtest: alloc_fence_invalid_timeline [158.767903] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s) [158.822550] [049/133] (844s left) prime_mmap_kms (buffer-sharing) [158.928823] Starting subtest: buffer-sharing [159.425693] Subtest buffer-sharing: SUCCESS (0.498s) [160.316557] [050/133] (842s left) syncobj_timeline (multi-wait-for-submit-signaled) [160.376066] Starting subtest: multi-wait-for-submit-signaled [160.379159] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s) [160.455076] [051/133] (842s left) kms_writeback (writeback-pixel-formats) [160.564296] Subtest writeback-pixel-formats: SKIP (0.000s) [160.592157] [052/133] (842s left) gem_mmap_gtt (big-bo-tiledx) [160.683237] Subtest big-bo-tiledX: SKIP (0.000s) [160.732782] [053/133] (842s left) gem_mmap_wc (fault-concurrent) [160.815208] Subtest fault-concurrent: SKIP (0.000s) [160.863574] [054/133] (842s left) gem_ctx_engines (execute-oneforall) [160.950576] Starting subtest: execute-oneforall [162.251068] Subtest execute-oneforall: SUCCESS (1.299s) [162.654663] [055/133] (840s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines) [163.254990] Starting subtest: syncobj-stationary-timeline-chain-engines [163.435522] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.181s) [164.573757] [056/133] (838s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs) [164.674677] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs [164.677187] Starting dynamic subtest: pipe-A-eDP-1 [164.681226] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [164.695342] Starting dynamic subtest: pipe-B-eDP-1 [164.700171] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [164.714501] Starting dynamic subtest: pipe-C-eDP-1 [164.719284] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [164.727475] Starting dynamic subtest: pipe-D-eDP-1 [164.732422] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [164.737375] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.003s) [164.758395] [057/133] (838s left) kms_big_fb (linear-64bpp-rotate-90) [164.850918] Starting subtest: linear-64bpp-rotate-90 [164.868190] Subtest linear-64bpp-rotate-90: SKIP (0.019s) [164.966220] [058/133] (838s left) kms_flip (basic-flip-vs-wf_vblank) [165.044452] Starting subtest: basic-flip-vs-wf_vblank [165.046671] Starting dynamic subtest: A-eDP1 [167.057926] Dynamic subtest A-eDP1: SUCCESS (2.014s) [167.075352] Starting dynamic subtest: B-eDP1 [169.104383] Dynamic subtest B-eDP1: SUCCESS (2.045s) [169.119391] Starting dynamic subtest: C-eDP1 [171.143166] Dynamic subtest C-eDP1: SUCCESS (2.035s) [171.159160] Starting dynamic subtest: D-eDP1 [173.125231] Dynamic subtest D-eDP1: SUCCESS (1.984s) [173.133057] Subtest basic-flip-vs-wf_vblank: SUCCESS (8.093s) [174.400861] [059/133] (829s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs) [174.487537] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs [174.489912] Starting dynamic subtest: pipe-A-eDP-1 [174.494682] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [174.503788] Starting dynamic subtest: pipe-B-eDP-1 [174.508393] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [174.517548] Starting dynamic subtest: pipe-C-eDP-1 [174.522806] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [174.531519] Starting dynamic subtest: pipe-D-eDP-1 [174.536103] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [174.540565] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.010s) [174.564535] [060/133] (828s left) kms_psr (pr-sprite-render) [174.662313] Starting subtest: pr-sprite-render [174.666740] Subtest pr-sprite-render: SKIP (0.000s) [174.726082] [061/133] (828s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling) [174.784321] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling [174.786842] Starting dynamic subtest: pipe-A-default-mode [175.074853] Dynamic subtest pipe-A-default-mode: SKIP (0.287s) [175.079786] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.289s) [176.001773] [062/133] (827s left) gem_ctx_param (root-set) [176.067271] Starting subtest: root-set [176.070186] Subtest root-set: SUCCESS (0.001s) [176.159865] [063/133] (827s left) kms_flip (2x-blocking-wf_vblank) [176.255470] Starting subtest: 2x-blocking-wf_vblank [176.270668] Subtest 2x-blocking-wf_vblank: SKIP (0.015s) [176.345862] [064/133] (827s left) gem_exec_reloc (basic-write-gtt) [176.418522] Subtest basic-write-gtt: SKIP (0.000s) [176.455715] [065/133] (827s left) gem_eio (context-create) [176.733569] Starting subtest: context-create [177.121750] Subtest context-create: SUCCESS (0.387s) [177.222200] [066/133] (826s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling) [177.313988] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling [177.316517] Starting dynamic subtest: pipe-A-default-mode [177.606837] Dynamic subtest pipe-A-default-mode: SKIP (0.288s) [177.612739] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.289s) [178.495302] [067/133] (825s left) prime_vgem (fence-wait) [178.585435] Starting subtest: fence-wait [178.587928] Starting dynamic subtest: rcs0 [179.627761] Dynamic subtest rcs0: SUCCESS (1.040s) [179.643424] Starting dynamic subtest: bcs0 [180.678640] Dynamic subtest bcs0: SUCCESS (1.049s) [180.694236] Starting dynamic subtest: vcs0 [181.726622] Dynamic subtest vcs0: SUCCESS (1.047s) [181.742149] Starting dynamic subtest: vcs1 [182.771644] Dynamic subtest vcs1: SUCCESS (1.042s) [182.786905] Starting dynamic subtest: vecs0 [183.818544] Dynamic subtest vecs0: SUCCESS (1.045s) [183.834455] Starting dynamic subtest: ccs0 [184.867667] Dynamic subtest ccs0: SUCCESS (1.047s) [184.870353] Subtest fence-wait: SUCCESS (6.281s) [184.969589] [068/133] (818s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc) [185.072039] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc [188.235433] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (3.167s) [188.354841] [069/133] (815s left) syncobj_timeline (host-signal-ordered) [188.413252] Starting subtest: host-signal-ordered [188.415225] Subtest host-signal-ordered: SUCCESS (0.000s) [188.492179] [070/133] (815s left) kms_cursor_crc (cursor-rapid-movement-256x256) [188.776281] Starting subtest: cursor-rapid-movement-256x256 [188.787248] Starting dynamic subtest: pipe-A-eDP-1 [189.358085] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.569s) [189.396285] Starting dynamic subtest: pipe-D-eDP-1 [190.681671] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.301s) [190.684368] Subtest cursor-rapid-movement-256x256: SUCCESS (1.904s) [191.571747] [071/133] (812s left) kms_tv_load_detect (load-detect) [191.654245] Subtest load-detect: SKIP (0.000s) [191.701163] [072/133] (812s left) gem_ctx_persistence (engines-hang) [191.782895] Starting subtest: engines-hang [191.785395] Starting dynamic subtest: rcs0 [191.846095] Dynamic subtest rcs0: SUCCESS (0.062s) [191.861462] Starting dynamic subtest: bcs0 [191.932999] Dynamic subtest bcs0: SUCCESS (0.085s) [191.948271] Starting dynamic subtest: vcs0 [192.007893] Dynamic subtest vcs0: SUCCESS (0.074s) [192.023394] Starting dynamic subtest: vcs1 [192.115285] Dynamic subtest vcs1: SUCCESS (0.106s) [192.131042] Starting dynamic subtest: vecs0 [192.201076] Dynamic subtest vecs0: SUCCESS (0.085s) [192.218362] Starting dynamic subtest: ccs0 [192.285304] Dynamic subtest ccs0: SUCCESS (0.083s) [192.288258] Subtest engines-hang: SUCCESS (0.502s) [192.360456] [073/133] (811s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic) [192.462863] Starting subtest: flip-vs-cursor-crc-atomic [193.181131] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.718s) [194.110131] [074/133] (809s left) kms_content_protection (content-type-change) [194.264502] Starting subtest: content-type-change [197.913789] Subtest content-type-change: SKIP (3.645s) [199.166118] [075/133] (804s left) kms_flip (2x-flip-vs-absolute-wf_vblank) [199.235130] Starting subtest: 2x-flip-vs-absolute-wf_vblank [199.261745] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.023s) [199.337664] [076/133] (804s left) gem_eio (in-flight-internal-immediate) [199.612613] Starting subtest: in-flight-internal-immediate [201.568536] Subtest in-flight-internal-immediate: SUCCESS (1.955s) [201.684892] [077/133] (802s left) api_intel_bb (add-remove-objects) [201.753977] Starting subtest: add-remove-objects [201.762972] Subtest add-remove-objects: SUCCESS (0.012s) [201.844036] [078/133] (802s left) kms_cursor_edge_walk (256x256-right-edge) [201.944658] Starting subtest: 256x256-right-edge [201.947584] Starting dynamic subtest: pipe-A-eDP-1 [205.510921] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.565s) [205.524419] Starting dynamic subtest: pipe-D-eDP-1 [208.735177] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.220s) [208.738180] Subtest 256x256-right-edge: SUCCESS (6.791s) [209.662344] [079/133] (794s left) syncobj_eventfd (invalid-bad-flags) [209.718966] Starting subtest: invalid-bad-flags [209.721960] Subtest invalid-bad-flags: SUCCESS (0.000s) [209.792497] [080/133] (794s left) gem_mmap_gtt (big-copy) [209.873231] Subtest big-copy: SKIP (0.000s) [209.920145] [081/133] (794s left) kms_plane_lowres (tiling-4) [210.034580] Starting subtest: tiling-4 [210.036992] Starting dynamic subtest: pipe-A-eDP-1 [210.041851] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [210.334505] Starting dynamic subtest: pipe-B-eDP-1 [210.340212] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [210.348304] Starting dynamic subtest: pipe-C-eDP-1 [210.354054] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [210.369582] Starting dynamic subtest: pipe-D-eDP-1 [210.374680] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [210.379388] Subtest tiling-4: SKIP (0.301s) [211.198119] [082/133] (792s left) gem_exec_suspend (basic-s3) [211.278475] Starting subtest: basic-S3 [211.281065] Starting dynamic subtest: smem [230.677986] Dynamic subtest smem: SUCCESS (7.153s) [230.681177] Subtest basic-S3: SUCCESS (7.154s) [230.858946] [083/133] (785s left) dmabuf (all-tests) [230.914126] Starting subtest: all-tests [230.916680] Starting dynamic subtest: sanitycheck [230.986573] Dynamic subtest sanitycheck: SUCCESS (0.069s) [231.004872] Starting dynamic subtest: dma_fence [231.162149] Dynamic subtest dma_fence: SUCCESS (0.176s) [231.179777] Starting dynamic subtest: dma_fence_chain [240.525524] Dynamic subtest dma_fence_chain: SUCCESS (9.362s) [240.543694] Starting dynamic subtest: dma_fence_unwrap [240.607070] Dynamic subtest dma_fence_unwrap: SUCCESS (0.081s) [240.625303] Starting dynamic subtest: dma_resv [240.675753] Dynamic subtest dma_resv: SUCCESS (0.068s) [240.678487] Subtest all-tests: SUCCESS (9.762s) [240.742427] [084/133] (775s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render) [240.844414] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render [240.848842] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [240.916198] [085/133] (775s left) kms_chamelium_frames (hdmi-crc-single) [241.325745] Subtest hdmi-crc-single: SKIP (0.000s) [242.232360] [086/133] (774s left) gem_exec_balancer (parallel-contexts) [242.473005] Starting subtest: parallel-contexts [245.616117] Subtest parallel-contexts: SUCCESS (3.143s) [246.005823] [087/133] (770s left) i915_suspend (fence-restore-untiled) [246.058609] Starting subtest: fence-restore-untiled [246.064082] Subtest fence-restore-untiled: SKIP (0.000s) [246.145741] [088/133] (770s left) kms_cursor_legacy (cursor-vs-flip-atomic) [246.259078] Starting subtest: cursor-vs-flip-atomic [275.311862] Subtest cursor-vs-flip-atomic: SUCCESS (29.049s) [276.237051] [089/133] (740s left) gem_pwrite (basic-self) [276.302572] Subtest basic-self: SKIP (0.000s) [276.361931] [090/133] (740s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy) [276.478427] Starting subtest: 2x-long-flip-vs-cursor-legacy [276.483041] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s) [276.608627] [091/133] (739s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt) [276.709163] Starting subtest: fbcpsr-farfromfence-mmap-gtt [276.713458] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s) [276.794648] [092/133] (739s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite) [276.897578] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite [281.484244] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.590s) [281.617564] [093/133] (735s left) gem_tiled_partial_pwrite_pread (reads) [281.695770] Subtest reads: SKIP (0.000s) [281.756010] [094/133] (734s left) gem_mmap (short-mmap) [281.843757] Subtest short-mmap: SKIP (0.000s) [281.901308] [095/133] (734s left) kms_properties (connector-properties-legacy) [282.001738] Starting subtest: connector-properties-legacy [290.616233] Subtest connector-properties-legacy: SUCCESS (8.609s) [291.540096] [096/133] (725s left) api_intel_bb (purge-bb) [291.602968] Starting subtest: purge-bb [291.608509] Subtest purge-bb: SUCCESS (0.006s) [291.702939] [097/133] (725s left) i915_query (query-topology-known-pci-ids) [291.779201] Starting subtest: query-topology-known-pci-ids [291.783820] Subtest query-topology-known-pci-ids: SKIP (0.000s) [291.861073] [098/133] (724s left) gem_exec_fair (basic-pace) [291.950531] Subtest basic-pace: SKIP (0.000s) [292.017622] [099/133] (724s left) gem_ppgtt (flink-and-close-vma-leak) [292.115179] Starting subtest: flink-and-close-vma-leak [292.159755] Subtest flink-and-close-vma-leak: SUCCESS (0.044s) [292.261547] [100/133] (724s left) kms_psr (psr2-sprite-plane-move) [292.335640] Starting subtest: psr2-sprite-plane-move [292.338426] Starting dynamic subtest: eDP-1 [294.157481] Dynamic subtest eDP-1: SUCCESS (1.822s) [294.159931] Subtest psr2-sprite-plane-move: SUCCESS (1.824s) [295.060907] [101/133] (721s left) gem_eio (in-flight-1us) [295.299568] Starting subtest: in-flight-1us [303.749618] Subtest in-flight-1us: SUCCESS (8.448s) [303.863857] [102/133] (713s left) gem_ccs (block-multicopy-compressed) [303.949639] Starting subtest: block-multicopy-compressed [303.955437] Subtest block-multicopy-compressed: SKIP (0.000s) [304.036417] [103/133] (712s left) vc4/vc4_wait_bo (bad-pad) [304.128178] Subtest bad-pad: SKIP (0.000s) [304.186214] [104/133] (712s left) kms_psr (psr-cursor-render) [304.274928] Starting subtest: psr-cursor-render [304.277724] Starting dynamic subtest: eDP-1 [306.106816] Dynamic subtest eDP-1: SUCCESS (1.832s) [306.109568] Subtest psr-cursor-render: SUCCESS (1.834s) [307.028410] [105/133] (709s left) kms_flip (2x-busy-flip) [307.134076] Starting subtest: 2x-busy-flip [307.156360] Subtest 2x-busy-flip: SKIP (0.023s) [307.236905] [106/133] (709s left) kms_addfb_basic (addfb25-x-tiled-legacy) [307.302826] Subtest addfb25-x-tiled-legacy: SKIP (0.000s) [307.413385] [107/133] (709s left) gem_userptr_blits (sync-overlap) [307.498628] Starting subtest: sync-overlap [307.501395] Subtest sync-overlap: SUCCESS (0.000s) [307.607815] [108/133] (709s left) gem_exec_whisper (basic-queues-priority) [307.697195] Starting subtest: basic-queues-priority [332.530588] Subtest basic-queues-priority: SUCCESS (24.780s) [332.664234] [109/133] (684s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled) [332.752064] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled [332.757111] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s) [332.934276] [110/133] (684s left) gem_exec_schedule (implicit-write-read) [332.997774] Starting subtest: implicit-write-read [333.000599] Starting dynamic subtest: rcs0 [333.213462] Dynamic subtest rcs0: SUCCESS (0.222s) [333.233345] Starting dynamic subtest: vcs0 [333.413922] Dynamic subtest vcs0: SUCCESS (0.198s) [333.430775] Starting dynamic subtest: vcs1 [333.538440] Dynamic subtest vcs1: SUCCESS (0.125s) [333.556356] Starting dynamic subtest: vecs0 [333.657881] Dynamic subtest vecs0: SUCCESS (0.118s) [333.675025] Starting dynamic subtest: ccs0 [333.815546] Dynamic subtest ccs0: SUCCESS (0.156s) [333.819174] Subtest implicit-write-read: SUCCESS (0.827s) [334.766180] [111/133] (682s left) sysfs_timeslice_duration (duration) [334.839950] Starting subtest: duration [334.842394] Starting dynamic subtest: vecs0 [348.658996] Dynamic subtest vecs0: SUCCESS (13.819s) [348.677504] Starting dynamic subtest: ccs0 [361.833989] Dynamic subtest ccs0: SUCCESS (13.174s) [361.852645] Starting dynamic subtest: vcs0 [375.667274] Dynamic subtest vcs0: SUCCESS (13.830s) [375.685418] Starting dynamic subtest: bcs0 [390.810800] Dynamic subtest bcs0: SUCCESS (15.112s) [390.829060] Starting dynamic subtest: rcs0 [403.966980] Dynamic subtest rcs0: SUCCESS (13.159s) [403.984520] Starting dynamic subtest: vcs1 [417.651161] Dynamic subtest vcs1: SUCCESS (13.707s) [417.654272] Subtest duration: SUCCESS (82.812s) [417.726638] [112/133] (599s left) kms_pm_rpm (dpms-mode-unset-non-lpsp) [419.852597] Starting subtest: dpms-mode-unset-non-lpsp [423.225097] Subtest dpms-mode-unset-non-lpsp: SKIP (3.370s) [424.062336] [113/133] (593s left) gem_exec_reloc (basic-write-cpu) [424.137748] Subtest basic-write-cpu: SKIP (0.000s) [424.192284] [114/133] (593s left) kms_big_fb (y-tiled-64bpp-rotate-90) [424.261116] Starting subtest: y-tiled-64bpp-rotate-90 [424.265104] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s) [424.338333] [115/133] (592s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode) [424.724531] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s) [425.595816] [116/133] (591s left) v3d/v3d_submit_csd (single-in-sync) [425.702563] Subtest single-in-sync: SKIP (0.000s) [425.756003] [117/133] (591s left) gem_render_copy (linear-to-vebox-yf-tiled) [425.844401] Starting subtest: linear-to-vebox-yf-tiled [425.849272] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s) [426.028116] [118/133] (591s left) kms_psr (fbc-psr2-primary-render) [426.125793] Starting subtest: fbc-psr2-primary-render [426.128344] Starting dynamic subtest: eDP-1 [426.132340] Dynamic subtest eDP-1: SKIP (0.000s) [426.136345] Subtest fbc-psr2-primary-render: SKIP (0.001s) [426.194369] [119/133] (591s left) i915_hangman (hangcheck-unterminated) [426.280853] Starting subtest: hangcheck-unterminated [437.684352] Subtest hangcheck-unterminated: SUCCESS (11.403s) [437.793187] [120/133] (579s left) gen7_exec_parse (chained-batch) [437.859480] Subtest chained-batch: SKIP (0.000s) [437.902144] [121/133] (579s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite) [438.008777] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite [443.266582] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.264s) [443.374837] [122/133] (574s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs) [443.469336] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs [443.472190] Starting dynamic subtest: pipe-A-eDP-1 [443.477324] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [443.490891] Starting dynamic subtest: pipe-B-eDP-1 [443.495806] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [443.515279] Starting dynamic subtest: pipe-C-eDP-1 [443.519873] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [443.537144] Starting dynamic subtest: pipe-D-eDP-1 [443.542317] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [443.547270] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.004s) [443.572895] [123/133] (573s left) kms_invalid_mode (bad-vsync-start) [443.693101] Starting subtest: bad-vsync-start [443.695458] Starting dynamic subtest: pipe-A-eDP-1 [443.980071] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s) [443.997622] Starting dynamic subtest: pipe-B-eDP-1 [443.999910] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [444.012837] Starting dynamic subtest: pipe-C-eDP-1 [444.015663] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [444.025049] Starting dynamic subtest: pipe-D-eDP-1 [444.027541] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [444.030157] Subtest bad-vsync-start: SUCCESS (0.300s) [444.884775] [124/133] (572s left) gem_exec_schedule (smoketest) [445.087477] Starting subtest: smoketest [445.090585] Starting dynamic subtest: rcs0 [450.651318] Dynamic subtest rcs0: SUCCESS (5.511s) [450.664250] Starting dynamic subtest: bcs0 [456.284526] Dynamic subtest bcs0: SUCCESS (5.629s) [456.300901] Starting dynamic subtest: vcs0 [461.838742] Dynamic subtest vcs0: SUCCESS (5.554s) [461.853872] Starting dynamic subtest: vcs1 [467.397636] Dynamic subtest vcs1: SUCCESS (5.554s) [467.411775] Starting dynamic subtest: vecs0 [472.970432] Dynamic subtest vecs0: SUCCESS (5.571s) [472.981381] Starting dynamic subtest: ccs0 [478.604760] Dynamic subtest ccs0: SUCCESS (5.580s) [478.607445] Subtest smoketest: SUCCESS (33.405s) [478.675052] [125/133] (538s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20) [478.771117] Starting subtest: planes-downscale-factor-0-5-upscale-20x20 [478.773599] Starting dynamic subtest: pipe-A-eDP-1 [478.778353] Dynamic subtest pipe-A-eDP-1: SKIP (0.003s) [478.796041] Starting dynamic subtest: pipe-B-eDP-1 [478.802151] Dynamic subtest pipe-B-eDP-1: SKIP (0.012s) [478.822467] Starting dynamic subtest: pipe-C-eDP-1 [478.828650] Dynamic subtest pipe-C-eDP-1: SKIP (0.012s) [478.840754] Starting dynamic subtest: pipe-D-eDP-1 [478.846235] Dynamic subtest pipe-D-eDP-1: SKIP (0.012s) [478.851112] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.044s) [478.885734] [126/133] (538s left) vc4/vc4_tiling (get-after-free) [478.995932] Subtest get-after-free: SKIP (0.000s) [479.048419] [127/133] (538s left) kms_feature_discovery (display-1x) [479.152047] Starting subtest: display-1x [479.156388] Subtest display-1x: SUCCESS (0.000s) [479.204951] [128/133] (538s left) gem_exec_fair (basic-sync) [479.279515] Subtest basic-sync: SKIP (0.000s) [479.299380] [129/133] (538s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu) [479.391241] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu [483.959434] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (4.573s) [484.057766] [130/133] (533s left) kms_big_fb (yf-tiled-32bpp-rotate-180) [484.168359] Starting subtest: yf-tiled-32bpp-rotate-180 [484.172681] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s) [484.253832] [131/133] (533s left) gem_mmap (bad-offset) [484.318066] Subtest bad-offset: SKIP (0.000s) [484.358062] [132/133] (533s left) gem_madvise (dontneed-after-mmap) [484.419758] Starting subtest: dontneed-after-mmap [484.443035] Subtest dontneed-after-mmap: SUCCESS (0.025s) [484.534034] [133/133] (533s left) kms_sequence (get-forked) [484.611594] Starting subtest: get-forked [484.614060] Starting dynamic subtest: pipe-A-eDP-1 [486.468981] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.856s) [486.485867] Starting dynamic subtest: pipe-B-eDP-1 [489.088764] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.617s) [489.099954] Starting dynamic subtest: pipe-C-eDP-1 [491.728560] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.638s) [491.743980] Starting dynamic subtest: pipe-D-eDP-1 [494.324605] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.595s) [494.327170] Subtest get-forked: SUCCESS (9.716s) [495.209297] Closing watchdogs Done.