[40.323348] Initializing watchdogs [40.323402] /dev/watchdog0 [40.327723] [001/141] (960s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt) [40.418826] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt [40.420220] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [40.517445] [002/141] (960s left) syncobj_timeline (etime-multi-wait-submitted) [40.582523] Starting subtest: etime-multi-wait-submitted [40.685460] Subtest etime-multi-wait-submitted: SUCCESS (0.103s) [40.761445] [003/141] (960s left) kms_addfb_basic (invalid-set-prop) [40.823484] Starting subtest: invalid-set-prop [40.824210] Subtest invalid-set-prop: SUCCESS (0.000s) [40.951926] [004/141] (959s left) kms_ccs (pipe-c-bad-aux-stride-yf_tiled_ccs) [41.183409] Subtest pipe-C-bad-aux-stride-yf_tiled_ccs: SKIP (0.000s) [41.268638] [005/141] (959s left) gem_exec_schedule (deep) [41.441986] Starting subtest: deep [41.442776] Starting dynamic subtest: rcs0 [48.255218] Dynamic subtest rcs0: SUCCESS (6.813s) [48.258577] Starting dynamic subtest: bcs0 [54.972508] Dynamic subtest bcs0: SUCCESS (6.717s) [54.976728] Starting dynamic subtest: vcs0 [61.569575] Dynamic subtest vcs0: SUCCESS (6.597s) [61.573013] Starting dynamic subtest: vecs0 [68.307536] Dynamic subtest vecs0: SUCCESS (6.738s) [68.308329] Subtest deep: SUCCESS (26.865s) [68.648095] [006/141] (932s left) perf_pmu (init-sema) [68.707937] Starting subtest: init-sema [68.708640] Starting dynamic subtest: rcs0 [68.709363] Dynamic subtest rcs0: SUCCESS (0.001s) [68.713440] Starting dynamic subtest: bcs0 [68.714204] Dynamic subtest bcs0: SUCCESS (0.000s) [68.717372] Starting dynamic subtest: vcs0 [68.718037] Dynamic subtest vcs0: SUCCESS (0.000s) [68.721131] Starting dynamic subtest: vecs0 [68.721796] Dynamic subtest vecs0: SUCCESS (0.000s) [68.722443] Subtest init-sema: SUCCESS (0.001s) [68.772893] [007/141] (932s left) gem_eio (in-flight-1us) [68.837578] Starting subtest: in-flight-1us [70.677409] Subtest in-flight-1us: SUCCESS (1.839s) [70.835637] [008/141] (930s left) gem_ctx_persistence (engines-hang) [70.893695] Starting subtest: engines-hang [70.894394] Starting dynamic subtest: rcs0 [70.936369] Dynamic subtest rcs0: SUCCESS (0.042s) [70.949180] Starting dynamic subtest: bcs0 [70.980360] Dynamic subtest bcs0: SUCCESS (0.044s) [70.987284] Starting dynamic subtest: vcs0 [71.022430] Dynamic subtest vcs0: SUCCESS (0.042s) [71.035374] Starting dynamic subtest: vecs0 [71.066346] Dynamic subtest vecs0: SUCCESS (0.044s) [71.067675] Subtest engines-hang: SUCCESS (0.172s) [71.152602] [009/141] (929s left) gen9_exec_parse (batch-zero-length) [71.216517] Subtest batch-zero-length: SKIP (0.000s) [71.242450] [010/141] (929s left) api_intel_bb (blit-noreloc-purge-cache) [71.302199] Starting subtest: blit-noreloc-purge-cache [71.306769] Subtest blit-noreloc-purge-cache: SUCCESS (0.005s) [71.418466] [011/141] (929s left) api_intel_bb (simple-bb) [71.479031] Starting subtest: simple-bb [71.480451] Subtest simple-bb: SUCCESS (0.002s) [71.588923] [012/141] (929s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy) [71.658455] Starting subtest: map-fixed-invalidate-overlap-busy [71.659166] Starting dynamic subtest: gtt [72.500252] Dynamic subtest gtt: SUCCESS (0.842s) [72.503805] Starting dynamic subtest: wb [73.298222] Dynamic subtest wb: SUCCESS (0.798s) [73.301843] Starting dynamic subtest: wc [74.108570] Dynamic subtest wc: SUCCESS (0.810s) [74.112209] Starting dynamic subtest: uc [74.939156] Dynamic subtest uc: SUCCESS (0.831s) [74.939918] Subtest map-fixed-invalidate-overlap-busy: SUCCESS (3.281s) [75.061849] [013/141] (925s left) kms_chamelium_audio (dp-audio) [75.189833] Subtest dp-audio: SKIP (0.000s) [75.240473] [014/141] (925s left) gem_exec_balancer (parallel-ordering) [76.213568] Subtest parallel-ordering: SKIP (0.000s) [76.276199] [015/141] (924s left) gem_ctx_persistence (saturated-hostile) [76.338454] Starting subtest: saturated-hostile [76.339179] Starting dynamic subtest: rcs0 [76.461951] Dynamic subtest rcs0: SUCCESS (0.123s) [76.470419] Starting dynamic subtest: bcs0 [76.591731] Dynamic subtest bcs0: SUCCESS (0.130s) [76.604973] Starting dynamic subtest: vcs0 [76.726695] Dynamic subtest vcs0: SUCCESS (0.135s) [76.740330] Starting dynamic subtest: vecs0 [76.850876] Dynamic subtest vecs0: SUCCESS (0.124s) [76.852653] Subtest saturated-hostile: SUCCESS (0.512s) [76.958994] [016/141] (924s left) prime_self_import (basic-with_one_bo_two_files) [77.017006] Starting subtest: basic-with_one_bo_two_files [77.018369] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s) [77.121278] [017/141] (923s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite) [77.208520] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite [77.209835] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [77.311997] [018/141] (923s left) gem_mmap_wc (write-cpu-read-wc) [77.373596] Starting subtest: write-cpu-read-wc [77.451413] Subtest write-cpu-read-wc: SUCCESS (0.078s) [77.538780] [019/141] (923s left) kms_flip (flip-vs-rmfb-interruptible) [77.630396] Starting subtest: flip-vs-rmfb-interruptible [77.631912] Starting dynamic subtest: A-HDMI-A2 [92.852116] Dynamic subtest A-HDMI-A2: SUCCESS (15.220s) [92.859105] Starting dynamic subtest: B-HDMI-A2 [107.982592] Dynamic subtest B-HDMI-A2: SUCCESS (15.130s) [107.986259] Subtest flip-vs-rmfb-interruptible: SUCCESS (30.354s) [108.131121] [020/141] (893s left) gem_lmem_swapping (parallel-random) [108.178959] Subtest parallel-random: SKIP (0.000s) [108.199944] [021/141] (892s left) kms_ccs (pipe-a-crc-primary-basic-4_tiled_dg2_mc_ccs) [108.339903] Starting subtest: pipe-A-crc-primary-basic-4_tiled_dg2_mc_ccs [108.341229] Subtest pipe-A-crc-primary-basic-4_tiled_dg2_mc_ccs: SKIP (0.000s) [108.519626] [022/141] (892s left) kms_addfb_basic (bad-pitch-32) [108.562102] Starting subtest: bad-pitch-32 [108.562807] Subtest bad-pitch-32: SUCCESS (0.000s) [108.670732] [023/141] (892s left) kms_flip (blocking-absolute-wf_vblank) [108.744477] Starting subtest: blocking-absolute-wf_vblank [108.745190] Starting dynamic subtest: A-HDMI-A2 [124.115400] Dynamic subtest A-HDMI-A2: SUCCESS (15.370s) [124.122102] Starting dynamic subtest: B-HDMI-A2 [139.434207] Dynamic subtest B-HDMI-A2: SUCCESS (15.318s) [139.435128] Subtest blocking-absolute-wf_vblank: SUCCESS (30.692s) [139.562594] [024/141] (861s left) kms_big_fb (y-tiled-64bpp-rotate-270) [139.644665] Starting subtest: y-tiled-64bpp-rotate-270 [139.697695] Subtest y-tiled-64bpp-rotate-270: SKIP (0.053s) [139.788651] [025/141] (861s left) kms_getfb (getfb-handle-closed) [139.840015] Starting subtest: getfb-handle-closed [139.840746] Subtest getfb-handle-closed: SUCCESS (0.000s) [139.941046] [026/141] (861s left) kms_plane_scaling (planes-downscale-factor-0-25-upscale-20x20) [140.032788] Starting subtest: planes-downscale-factor-0-25-upscale-20x20 [140.033490] Starting dynamic subtest: pipe-A-HDMI-A-2 [140.041819] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.007s) [140.045823] Starting dynamic subtest: pipe-B-HDMI-A-2 [140.057344] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.016s) [140.058742] Subtest planes-downscale-factor-0-25-upscale-20x20: SKIP (0.025s) [140.149866] [027/141] (861s left) gem_partial_pwrite_pread (write) [140.194984] Subtest write: SKIP (0.000s) [140.239911] [028/141] (861s left) kms_content_protection (dp-mst-lic-type-1) [140.334045] Starting subtest: dp-mst-lic-type-1 [140.335403] Subtest dp-mst-lic-type-1: SKIP (0.000s) [140.430757] [029/141] (860s left) kms_cursor_legacy (single-bo) [140.520757] Starting subtest: single-bo [140.521468] Starting dynamic subtest: pipe-A [145.898732] Dynamic subtest pipe-A: SUCCESS (5.378s) [145.902351] Starting dynamic subtest: pipe-B [151.276384] Dynamic subtest pipe-B: SUCCESS (5.377s) [151.280040] Starting dynamic subtest: all-pipes [156.654088] Dynamic subtest all-pipes: SUCCESS (5.377s) [156.654812] Subtest single-bo: SUCCESS (16.133s) [156.725519] [030/141] (844s left) testdisplay [160.313072] [031/141] (841s left) kms_vblank (pipe-d-wait-forked) [160.392064] Subtest pipe-D-wait-forked: SKIP (0.000s) [160.449081] [032/141] (840s left) gem_create (create-ext-placement-each) [160.625941] Starting subtest: create-ext-placement-each [160.627292] Subtest create-ext-placement-each: SUCCESS (0.000s) [160.706958] [033/141] (840s left) kms_ccs (pipe-a-ccs-on-another-bo-yf_tiled_ccs) [160.868928] Starting subtest: pipe-A-ccs-on-another-bo-yf_tiled_ccs [160.870273] Subtest pipe-A-ccs-on-another-bo-yf_tiled_ccs: SKIP (0.000s) [161.026439] [034/141] (840s left) api_intel_allocator (alloc-simple) [161.069382] Starting subtest: alloc-simple [161.071052] Subtest alloc-simple: SUCCESS (0.001s) [161.193621] [035/141] (840s left) perf (gen12-invalid-class-instance) [161.328291] Starting subtest: gen12-invalid-class-instance [161.333795] Subtest gen12-invalid-class-instance: SUCCESS (0.007s) [161.347322] [036/141] (840s left) gem_wait (write-busy) [161.403814] Starting subtest: write-busy [161.404512] Starting dynamic subtest: all-engines [161.939105] Dynamic subtest all-engines: SUCCESS (0.535s) [161.946212] Starting dynamic subtest: rcs0 [162.449740] Dynamic subtest rcs0: SUCCESS (0.510s) [162.453397] Starting dynamic subtest: bcs0 [162.960737] Dynamic subtest bcs0: SUCCESS (0.511s) [162.964336] Starting dynamic subtest: vcs0 [163.468731] Dynamic subtest vcs0: SUCCESS (0.508s) [163.472336] Starting dynamic subtest: vecs0 [163.976738] Dynamic subtest vecs0: SUCCESS (0.508s) [163.977479] Subtest write-busy: SUCCESS (2.573s) [164.192765] [037/141] (837s left) gem_exec_flush (basic-wb-set-default) [164.258349] Starting subtest: basic-wb-set-default [169.680621] Subtest basic-wb-set-default: SUCCESS (5.422s) [169.875765] [038/141] (831s left) gem_mmap_wc (write-read-distinct) [169.950899] Starting subtest: write-read-distinct [169.952590] Subtest write-read-distinct: SUCCESS (0.002s) [170.059667] [039/141] (831s left) kms_addfb_basic (addfb25-bad-modifier) [170.117640] Starting subtest: addfb25-bad-modifier [170.118354] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [170.250223] [040/141] (831s left) kms_plane_scaling (plane-upscale-with-pixel-format-20x20) [170.334578] Starting subtest: plane-upscale-with-pixel-format-20x20 [170.335299] Starting dynamic subtest: pipe-A-HDMI-A-2 [172.210494] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (1.875s) [172.216451] Starting dynamic subtest: pipe-B-HDMI-A-2 [174.112508] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.901s) [174.113286] Subtest plane-upscale-with-pixel-format-20x20: SUCCESS (3.778s) [174.241592] [041/141] (827s left) gem_tiled_blits (basic) [174.634352] Starting subtest: basic [174.643996] Subtest basic: SUCCESS (0.010s) [174.763190] [042/141] (826s left) gem_exec_reloc (basic-write-read-noreloc) [174.856718] Subtest basic-write-read-noreloc: SKIP (0.000s) [174.908999] [043/141] (826s left) kms_cursor_legacy (cursora-vs-flipa-atomic) [175.044937] Starting subtest: cursorA-vs-flipA-atomic [185.943025] Subtest cursorA-vs-flipA-atomic: SUCCESS (10.899s) [186.049404] [044/141] (815s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu) [186.128974] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu [186.130346] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SKIP (0.000s) [186.233291] [045/141] (815s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render) [186.317024] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render [186.318390] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [186.429221] [046/141] (815s left) gem_mmap_offset (blt-coherency) [186.484214] Starting subtest: blt-coherency [186.487591] Subtest blt-coherency: SUCCESS (0.003s) [186.596995] [047/141] (815s left) kms_flip (2x-flip-vs-expired-vblank-interruptible) [186.676967] Starting subtest: 2x-flip-vs-expired-vblank-interruptible [186.679151] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.001s) [186.789595] [048/141] (814s left) kms_big_fb (yf-tiled-32bpp-rotate-0) [186.886839] Starting subtest: yf-tiled-32bpp-rotate-0 [186.888170] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s) [186.999023] [049/141] (814s left) perf (invalid-open-flags) [187.122988] Starting subtest: invalid-open-flags [187.123722] Subtest invalid-open-flags: SUCCESS (0.000s) [187.151631] [050/141] (814s left) kms_dsc (dsc-with-output-formats-with-bpc) [187.243760] Starting subtest: dsc-with-output-formats-with-bpc [187.245133] Subtest dsc-with-output-formats-with-bpc: SKIP (0.000s) [187.304540] [051/141] (814s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt) [187.399899] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt [187.401275] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s) [187.504959] [052/141] (814s left) gem_exec_fair (basic-none-solo) [187.568134] Starting subtest: basic-none-solo [187.568877] Starting dynamic subtest: rcs0 [193.463879] Dynamic subtest rcs0: FAIL (5.877s) [193.465141] Subtest basic-none-solo: FAIL (5.877s) [193.641597] [053/141] (808s left) gem_exec_schedule (preempt-queue-contexts) [193.707964] Starting subtest: preempt-queue-contexts [193.708797] Starting dynamic subtest: rcs0 [193.860049] Dynamic subtest rcs0: SUCCESS (0.152s) [193.864318] Starting dynamic subtest: bcs0 [194.012789] Dynamic subtest bcs0: SUCCESS (0.152s) [194.017372] Starting dynamic subtest: vcs0 [194.183921] Dynamic subtest vcs0: SUCCESS (0.170s) [194.188636] Starting dynamic subtest: vecs0 [194.331478] Dynamic subtest vecs0: SUCCESS (0.147s) [194.332329] Subtest preempt-queue-contexts: SUCCESS (0.624s) [194.639840] [054/141] (807s left) prime_busy (hang-wait) [194.695171] Starting subtest: hang-wait [194.695969] Starting dynamic subtest: rcs0 [208.833430] Dynamic subtest rcs0: SUCCESS (14.136s) [208.840040] Starting dynamic subtest: bcs0 [215.873218] Dynamic subtest bcs0: SUCCESS (7.036s) [215.879339] Starting dynamic subtest: vcs0 [222.912762] Dynamic subtest vcs0: SUCCESS (7.038s) [222.918245] Starting dynamic subtest: vecs0 [229.889018] Dynamic subtest vecs0: SUCCESS (6.974s) [229.890346] Subtest hang-wait: SUCCESS (35.192s) [229.988393] [055/141] (771s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite) [230.073579] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite [230.074929] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [230.178825] [056/141] (771s left) gem_barrier_race (remote-request) [230.230374] Starting subtest: remote-request [230.231089] Starting dynamic subtest: rcs0 [235.323555] Dynamic subtest rcs0: SUCCESS (5.093s) [235.324303] Subtest remote-request: SUCCESS (5.093s) [235.449973] [057/141] (766s left) syncobj_timeline (single-wait-all-available-submitted) [235.541374] Starting subtest: single-wait-all-available-submitted [235.542095] Subtest single-wait-all-available-submitted: SUCCESS (0.000s) [235.631417] [058/141] (766s left) v3d/v3d_perfmon (create-perfmon-exceed) [235.711424] Subtest create-perfmon-exceed: SKIP (0.000s) [235.776884] [059/141] (766s left) kms_ccs (pipe-c-bad-rotation-90-4_tiled_dg2_rc_ccs) [236.012560] Subtest pipe-C-bad-rotation-90-4_tiled_dg2_rc_ccs: SKIP (0.000s) [236.099749] [060/141] (765s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt) [236.178983] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt [236.180318] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [236.272820] [061/141] (765s left) i915_selftest (live) [237.306179] Starting subtest: live [237.307865] Starting dynamic subtest: sanitycheck [239.134213] Dynamic subtest sanitycheck: SUCCESS (1.819s) [239.140903] Starting dynamic subtest: uncore [240.773272] Dynamic subtest uncore: SUCCESS (1.645s) [240.784943] Starting dynamic subtest: workarounds [242.617050] Dynamic subtest workarounds: SUCCESS (1.842s) [242.626584] Starting dynamic subtest: gt_engines [244.691079] Dynamic subtest gt_engines: SUCCESS (2.072s) [244.702940] Starting dynamic subtest: gt_timelines [251.460761] Dynamic subtest gt_timelines: SUCCESS (6.768s) [251.470497] Starting dynamic subtest: gt_contexts [253.211176] Dynamic subtest gt_contexts: SUCCESS (1.748s) [253.220440] Starting dynamic subtest: gt_lrc [257.238084] Dynamic subtest gt_lrc: SUCCESS (4.025s) [257.247701] Starting dynamic subtest: gt_mocs [258.932208] Dynamic subtest gt_mocs: SUCCESS (1.692s) [258.944455] Starting dynamic subtest: gt_pm [271.557090] Dynamic subtest gt_pm: SUCCESS (12.622s) [271.564839] Starting dynamic subtest: gt_heartbeat [273.292071] Dynamic subtest gt_heartbeat: SUCCESS (1.733s) [273.303745] Starting dynamic subtest: gt_tlb [276.055142] Dynamic subtest gt_tlb: SUCCESS (2.761s) [276.067249] Starting dynamic subtest: requests [283.937124] Dynamic subtest requests: SUCCESS (7.879s) [283.944689] Starting dynamic subtest: migrate [288.373287] Dynamic subtest migrate: SUCCESS (4.435s) [288.377478] Starting dynamic subtest: active [290.003123] Dynamic subtest active: SUCCESS (1.628s) [290.015371] Starting dynamic subtest: objects [292.172159] Dynamic subtest objects: SUCCESS (2.166s) [292.183096] Starting dynamic subtest: mman [297.275784] Dynamic subtest mman: SUCCESS (5.101s) [297.286508] Starting dynamic subtest: dmabuf [298.965938] Dynamic subtest dmabuf: SUCCESS (1.688s) [298.980246] Starting dynamic subtest: vma [300.600999] Dynamic subtest vma: SUCCESS (1.633s) [300.611205] Starting dynamic subtest: coherency [302.866913] Dynamic subtest coherency: SUCCESS (2.264s) [302.878505] Starting dynamic subtest: gtt [311.907846] Dynamic subtest gtt: SUCCESS (9.039s) [311.917600] Starting dynamic subtest: gem [313.675840] Dynamic subtest gem: SUCCESS (1.766s) [313.685950] Starting dynamic subtest: evict [315.884819] Dynamic subtest evict: SUCCESS (2.207s) [315.896176] Starting dynamic subtest: hugepages [324.109962] Dynamic subtest hugepages: SUCCESS (8.223s) [324.124329] Starting dynamic subtest: gem_contexts [336.663474] Dynamic subtest gem_contexts: SUCCESS (12.551s) [336.673447] Starting dynamic subtest: client [338.309711] Dynamic subtest client: SUCCESS (1.641s) [338.317785] Starting dynamic subtest: gem_migrate [339.937356] Dynamic subtest gem_migrate: SUCCESS (1.628s) [339.949382] Starting dynamic subtest: reset [345.519885] Dynamic subtest reset: SUCCESS (5.581s) [345.528802] Starting dynamic subtest: memory_region [347.143492] Dynamic subtest memory_region: SUCCESS (1.622s) [347.147057] Starting dynamic subtest: hangcheck [371.833077] Dynamic subtest hangcheck: SUCCESS (24.688s) [371.843098] Starting dynamic subtest: execlists [380.956212] Dynamic subtest execlists: SUCCESS (9.121s) [380.968444] Starting dynamic subtest: ring_submission [382.587106] Dynamic subtest ring_submission: SUCCESS (1.628s) [382.598061] Starting dynamic subtest: perf [384.315963] Dynamic subtest perf: SUCCESS (1.727s) [384.326497] Starting dynamic subtest: slpc [385.950065] Dynamic subtest slpc: SUCCESS (1.632s) [385.960115] Starting dynamic subtest: guc [387.569078] Dynamic subtest guc: SUCCESS (1.617s) [387.580357] Starting dynamic subtest: guc_multi_lrc [389.205959] Dynamic subtest guc_multi_lrc: SUCCESS (1.635s) [389.215596] Starting dynamic subtest: guc_hang [390.843965] Dynamic subtest guc_hang: SUCCESS (1.636s) [390.856702] Starting dynamic subtest: late_gt_pm [392.539084] Dynamic subtest late_gt_pm: SUCCESS (1.693s) [392.540699] Subtest live: SUCCESS (155.234s) [392.754533] [062/141] (609s left) gem_spin_batch (engines) [394.312418] Starting subtest: engines [394.313204] Starting dynamic subtest: rcs0 [397.631378] Dynamic subtest rcs0: SUCCESS (3.316s) [397.638449] Starting dynamic subtest: bcs0 [400.945724] Dynamic subtest bcs0: SUCCESS (3.313s) [400.952885] Starting dynamic subtest: vcs0 [404.260974] Dynamic subtest vcs0: SUCCESS (3.313s) [404.267945] Starting dynamic subtest: vecs0 [407.574517] Dynamic subtest vecs0: SUCCESS (3.312s) [407.575889] Subtest engines: SUCCESS (13.261s) [407.719089] [063/141] (594s left) gem_softpin (evict-snoop-interruptible) [407.781426] Starting subtest: evict-snoop-interruptible [407.782830] Subtest evict-snoop-interruptible: SKIP (0.000s) [407.864365] [064/141] (594s left) syncobj_timeline (reset-multiple-signaled) [407.922782] Starting subtest: reset-multiple-signaled [407.923496] Subtest reset-multiple-signaled: SUCCESS (0.000s) [407.995586] [065/141] (593s left) kms_big_fb (x-tiled-64bpp-rotate-0) [408.092123] Starting subtest: x-tiled-64bpp-rotate-0 [409.922808] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.830s) [410.048099] [066/141] (591s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt) [410.129725] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt [413.470478] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SUCCESS (3.343s) [413.610362] [067/141] (588s left) kms_frontbuffer_tracking (psr-suspend) [413.697178] Starting subtest: psr-suspend [413.698546] Subtest psr-suspend: SKIP (0.000s) [413.807930] [068/141] (588s left) prime_mmap (test_invalid_sync_flags) [413.861127] Starting subtest: test_invalid_sync_flags [413.861853] Starting dynamic subtest: test_invalid_sync_flags-smem [413.862541] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s) [413.863232] Subtest test_invalid_sync_flags: SUCCESS (0.000s) [413.957080] [069/141] (588s left) gem_tiled_partial_pwrite_pread (reads) [414.016981] Subtest reads: SKIP (0.000s) [414.072505] [070/141] (587s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite) [414.164986] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite [414.166327] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [414.281492] [071/141] (587s left) i915_pm_rpm (basic-rte) [414.337254] Starting subtest: basic-rte [416.021643] Subtest basic-rte: SUCCESS (1.684s) [416.529604] [072/141] (585s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted) [416.574181] Starting subtest: multi-wait-for-submit-unsubmitted-submitted [416.677407] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.103s) [416.759775] [073/141] (585s left) kms_ccs (pipe-b-bad-aux-stride-4_tiled_mtl_rc_ccs_cc) [416.971753] Starting subtest: pipe-B-bad-aux-stride-4_tiled_mtl_rc_ccs_cc [416.973144] Subtest pipe-B-bad-aux-stride-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s) [417.077196] [074/141] (585s left) kms_ccs (pipe-d-ccs-on-another-bo-4_tiled_mtl_mc_ccs) [417.304184] Subtest pipe-D-ccs-on-another-bo-4_tiled_mtl_mc_ccs: SKIP (0.000s) [417.390154] [075/141] (584s left) gem_media_vme [417.460361] [076/141] (584s left) kms_ccs (pipe-a-missing-ccs-buffer-y_tiled_gen12_rc_ccs) [417.600942] Starting subtest: pipe-A-missing-ccs-buffer-y_tiled_gen12_rc_ccs [417.602059] Subtest pipe-A-missing-ccs-buffer-y_tiled_gen12_rc_ccs: SUCCESS (0.000s) [417.764544] [077/141] (584s left) kms_vblank (pipe-c-wait-forked-busy) [417.841536] Subtest pipe-C-wait-forked-busy: SKIP (0.000s) [417.897339] [078/141] (584s left) perf (sysctl-defaults) [417.999555] Starting subtest: sysctl-defaults [418.000310] Subtest sysctl-defaults: SUCCESS (0.000s) [418.028414] [079/141] (584s left) syncobj_wait (wait-any-complex) [418.075806] Starting subtest: wait-any-complex [418.137707] Subtest wait-any-complex: SUCCESS (0.062s) [418.213887] [080/141] (583s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt) [418.305027] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt [418.306384] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [418.412814] [081/141] (583s left) v3d/v3d_submit_csd (bad-bo) [418.493584] Subtest bad-bo: SKIP (0.000s) [418.561802] [082/141] (583s left) kms_atomic (plane-cursor-legacy) [418.685389] Starting subtest: plane-cursor-legacy [418.764682] Subtest plane-cursor-legacy: SUCCESS (0.079s) [418.916569] [083/141] (583s left) gem_softpin (allocator-nopin) [418.961149] Starting subtest: allocator-nopin [419.015666] Subtest allocator-nopin: SUCCESS (0.054s) [419.120666] [084/141] (583s left) gem_render_copy (linear-to-vebox-yf-tiled) [419.177917] Starting subtest: linear-to-vebox-yf-tiled [419.178643] Starting dynamic subtest: smem [419.245598] Dynamic subtest smem: SUCCESS (0.067s) [419.246315] Subtest linear-to-vebox-yf-tiled: SUCCESS (0.068s) [419.431038] [085/141] (582s left) kms_cursor_crc (cursor-random-32x10) [419.523027] Starting subtest: cursor-random-32x10 [419.549222] Subtest cursor-random-32x10: SKIP (0.026s) [419.637103] [086/141] (582s left) kms_ccs (pipe-d-bad-pixel-format-4_tiled_dg2_rc_ccs_cc) [419.866082] Subtest pipe-D-bad-pixel-format-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s) [419.952612] [087/141] (582s left) kms_big_fb (4-tiled-8bpp-rotate-0) [420.034267] Starting subtest: 4-tiled-8bpp-rotate-0 [420.035707] Subtest 4-tiled-8bpp-rotate-0: SKIP (0.000s) [420.127620] [088/141] (582s left) kms_ccs (pipe-c-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc) [420.370873] Subtest pipe-C-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s) [420.458972] [089/141] (581s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0) [420.540777] Starting subtest: linear-max-hw-stride-64bpp-rotate-0 [421.685967] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.139s) [421.802208] [090/141] (580s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt) [421.894632] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt [421.896012] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [422.017873] [091/141] (580s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc) [422.109989] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc [422.111347] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [422.226452] [092/141] (580s left) kms_lease (master-vs-lease) [422.308180] Starting subtest: master-vs-lease [422.308926] Subtest master-vs-lease: SUCCESS (0.001s) [422.384634] [093/141] (580s left) gem_mmap_gtt (basic-small-copy-odd) [422.438964] Starting subtest: basic-small-copy-odd [425.192023] Subtest basic-small-copy-odd: SUCCESS (2.753s) [425.272325] [094/141] (577s left) kms_cursor_crc (cursor-offscreen-256x256) [425.395630] Starting subtest: cursor-offscreen-256x256 [425.398257] Starting dynamic subtest: pipe-A-HDMI-A-2 [428.155169] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.757s) [428.174586] Starting dynamic subtest: pipe-B-HDMI-A-2 [430.971090] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.801s) [430.971828] Subtest cursor-offscreen-256x256: SUCCESS (5.576s) [431.086456] [095/141] (571s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move) [431.167100] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move [431.168494] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SKIP (0.000s) [431.255750] [096/141] (571s left) gem_exec_schedule (u-semaphore-resolve) [431.323385] Starting subtest: u-semaphore-resolve [431.334135] Subtest u-semaphore-resolve: SUCCESS (0.011s) [431.631950] [097/141] (570s left) vc4/vc4_label_bo (set-label) [431.719909] Subtest set-label: SKIP (0.000s) [431.788306] [098/141] (570s left) kms_vblank (pipe-b-ts-continuation-modeset-rpm) [431.876015] Starting subtest: pipe-B-ts-continuation-modeset-rpm [433.595830] Subtest pipe-B-ts-continuation-modeset-rpm: SUCCESS (1.720s) [433.777754] [099/141] (568s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite) [433.859769] Starting subtest: fbc-rgb565-draw-pwrite [436.422568] Subtest fbc-rgb565-draw-pwrite: SUCCESS (2.564s) [436.563284] [100/141] (566s left) kms_ccs (pipe-c-crc-primary-rotation-180-4_tiled_dg2_mc_ccs) [436.794531] Subtest pipe-C-crc-primary-rotation-180-4_tiled_dg2_mc_ccs: SKIP (0.000s) [436.881516] [101/141] (565s left) syncobj_timeline (invalid-wait-bad-flags) [436.926128] Starting subtest: invalid-wait-bad-flags [436.926903] Subtest invalid-wait-bad-flags: SUCCESS (0.000s) [436.994457] [102/141] (565s left) kms_ccs (pipe-a-bad-aux-stride-4_tiled_mtl_rc_ccs_cc) [437.157338] Starting subtest: pipe-A-bad-aux-stride-4_tiled_mtl_rc_ccs_cc [437.158682] Subtest pipe-A-bad-aux-stride-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s) [437.309272] [103/141] (565s left) kms_ccs (pipe-d-missing-ccs-buffer-y_tiled_gen12_mc_ccs) [437.537475] Subtest pipe-D-missing-ccs-buffer-y_tiled_gen12_mc_ccs: SKIP (0.000s) [437.623553] [104/141] (564s left) gem_exec_reloc (basic-wc-noreloc) [437.668283] Subtest basic-wc-noreloc: SKIP (0.000s) [437.712732] [105/141] (564s left) kms_flip (flip-vs-suspend-interruptible) [437.786526] Starting subtest: flip-vs-suspend-interruptible [437.788467] Starting dynamic subtest: A-HDMI-A2 [472.277215] Dynamic subtest A-HDMI-A2: SUCCESS (34.489s) [472.283304] Starting dynamic subtest: B-HDMI-A2 [490.273098] Dynamic subtest B-HDMI-A2: SUCCESS (17.995s) [490.273816] Subtest flip-vs-suspend-interruptible: SUCCESS (52.487s) [494.411965] [106/141] (512s left) syncobj_wait (multi-wait-submitted-signaled) [494.466575] Starting subtest: multi-wait-submitted-signaled [494.467282] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s) [494.538561] [107/141] (512s left) kms_psr (psr2_primary_render) [494.591725] Subtest psr2_primary_render: SKIP (0.000s) [494.610736] [108/141] (512s left) kms_ccs (pipe-b-bad-rotation-90-y_tiled_gen12_rc_ccs_cc) [494.795517] Starting subtest: pipe-B-bad-rotation-90-y_tiled_gen12_rc_ccs_cc [494.847698] Subtest pipe-B-bad-rotation-90-y_tiled_gen12_rc_ccs_cc: SUCCESS (0.052s) [495.004812] [109/141] (511s left) i915_pm_rpm (gem-execbuf-stress-pc8) [496.380531] Starting subtest: gem-execbuf-stress-pc8 [496.423316] Subtest gem-execbuf-stress-pc8: SKIP (0.043s) [496.599277] [110/141] (510s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary) [496.680995] Starting subtest: fbcpsr-shrfb-scaledprimary [496.682394] Subtest fbcpsr-shrfb-scaledprimary: SKIP (0.000s) [496.769893] [111/141] (509s left) gem_exec_balancer (bonded-true-hang) [497.739062] Starting subtest: bonded-true-hang [498.532914] Subtest bonded-true-hang: SUCCESS (0.794s) [498.601966] [112/141] (508s left) i915_pm_rpm (system-suspend-execbuf) [499.986873] Starting subtest: system-suspend-execbuf [519.975019] Subtest system-suspend-execbuf: SUCCESS (19.988s) [521.176526] [113/141] (486s left) sysfs_timeslice_duration (timeout) [521.234399] Starting subtest: timeout [521.235121] Starting dynamic subtest: vecs0 [522.070675] Dynamic subtest vecs0: SUCCESS (0.835s) [522.077765] Starting dynamic subtest: vcs0 [522.930103] Dynamic subtest vcs0: SUCCESS (0.858s) [522.938662] Starting dynamic subtest: bcs0 [523.785931] Dynamic subtest bcs0: SUCCESS (0.854s) [523.792941] Starting dynamic subtest: rcs0 [524.655669] Dynamic subtest rcs0: SUCCESS (0.869s) [524.656634] Subtest timeout: SUCCESS (3.421s) [524.733472] [114/141] (483s left) gem_pxp (fail-invalid-protected-context) [527.295220] Subtest fail-invalid-protected-context: SKIP (0.000s) [527.368314] [115/141] (480s left) kms_chamelium_edid (vga-edid-read) [527.490388] Subtest vga-edid-read: SKIP (0.000s) [527.541673] [116/141] (480s left) gem_mmap_gtt (big-bo-tiledy) [527.586118] Starting subtest: big-bo-tiledY [527.683708] Subtest big-bo-tiledY: SUCCESS (0.098s) [527.804683] [117/141] (480s left) vc4/vc4_create_bo (create-bo-zeroed) [527.932129] Subtest create-bo-zeroed: SKIP (0.000s) [528.001958] [118/141] (479s left) kms_lease (empty_lease) [528.093018] Starting subtest: empty_lease [528.093918] Starting dynamic subtest: pipe-A-HDMI-A-2 [528.094626] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.000s) [528.100218] Starting dynamic subtest: pipe-B-HDMI-A-2 [528.100928] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.000s) [528.101619] Subtest empty_lease: SUCCESS (0.002s) [528.160467] [119/141] (479s left) kms_vblank (pipe-a-ts-continuation-idle-hang) [528.246071] Starting subtest: pipe-A-ts-continuation-idle-hang [542.186710] Subtest pipe-A-ts-continuation-idle-hang: SUCCESS (13.941s) [542.310126] [120/141] (465s left) kms_vblank (pipe-c-ts-continuation-dpms-rpm) [542.387363] Subtest pipe-C-ts-continuation-dpms-rpm: SKIP (0.000s) [542.446319] [121/141] (465s left) gem_cs_tlb (engines) [542.497307] Starting subtest: engines [542.498077] Starting dynamic subtest: rcs0 [544.649269] Dynamic subtest rcs0: SUCCESS (2.151s) [544.654884] Starting dynamic subtest: bcs0 [546.801314] Dynamic subtest bcs0: SUCCESS (2.150s) [546.806633] Starting dynamic subtest: vcs0 [548.950964] Dynamic subtest vcs0: SUCCESS (2.150s) [548.956159] Starting dynamic subtest: vecs0 [551.102620] Dynamic subtest vecs0: SUCCESS (2.150s) [551.103362] Subtest engines: SUCCESS (8.604s) [551.206676] [122/141] (456s left) i915_pm_dc (dc6-psr) [552.310488] Starting subtest: dc6-psr [552.312079] Subtest dc6-psr: SKIP (0.000s) [552.457141] [123/141] (455s left) kms_ccs (pipe-b-crc-primary-rotation-180-4_tiled_dg2_mc_ccs) [552.652331] Starting subtest: pipe-B-crc-primary-rotation-180-4_tiled_dg2_mc_ccs [552.653734] Subtest pipe-B-crc-primary-rotation-180-4_tiled_dg2_mc_ccs: SKIP (0.000s) [552.775847] [124/141] (455s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c) [552.819180] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s) [552.846224] [125/141] (455s left) gem_render_copy (linear) [552.893548] Starting subtest: linear [552.895194] Starting dynamic subtest: smem [552.958874] Dynamic subtest smem: SUCCESS (0.064s) [552.959596] Subtest linear: SUCCESS (0.065s) [553.151968] [126/141] (454s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow) [553.244840] Starting subtest: yf-tiled-addfb-size-offset-overflow [553.246222] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s) [553.349294] [127/141] (454s left) gem_mmap_wc (copy) [553.404249] Starting subtest: copy [553.508817] Subtest copy: SUCCESS (0.105s) [553.592360] [128/141] (454s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt) [553.683174] Starting subtest: fbc-rgb101010-draw-blt [556.406705] Subtest fbc-rgb101010-draw-blt: SUCCESS (2.725s) [556.528941] [129/141] (451s left) kms_rotation_crc (primary-rotation-180) [556.612945] Starting subtest: primary-rotation-180 [564.494032] Subtest primary-rotation-180: SUCCESS (7.881s) [564.642478] [130/141] (443s left) kms_vblank (pipe-a-wait-forked-busy-hang) [564.723104] Starting subtest: pipe-A-wait-forked-busy-hang [579.054647] Subtest pipe-A-wait-forked-busy-hang: SUCCESS (14.332s) [579.179833] [131/141] (428s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation) [579.257050] Starting subtest: plane-scaler-with-clipping-clamping-rotation [579.257767] Starting dynamic subtest: pipe-A-HDMI-A-2 [579.328399] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.070s) [579.333608] Starting dynamic subtest: pipe-B-HDMI-A-2 [579.405693] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.076s) [579.407121] Subtest plane-scaler-with-clipping-clamping-rotation: SKIP (0.149s) [579.528353] [132/141] (428s left) gem_exec_whisper (basic-queues-forked-all) [579.578567] Starting subtest: basic-queues-forked-all [592.646182] Subtest basic-queues-forked-all: SUCCESS (13.067s) [592.850225] [133/141] (415s left) gem_exec_fence (syncobj-repeat) [593.179573] Starting subtest: syncobj-repeat [593.334693] Subtest syncobj-repeat: SUCCESS (0.155s) [593.644105] [134/141] (414s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt) [593.730067] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt [596.212392] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (2.484s) [596.354435] [135/141] (411s left) kms_pipe_crc_basic (read-crc-frame-sequence) [596.444541] Starting subtest: read-crc-frame-sequence [596.445344] Starting dynamic subtest: pipe-A-HDMI-A-2 [596.994785] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.550s) [597.001217] Starting dynamic subtest: pipe-B-HDMI-A-2 [597.690675] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.695s) [597.691375] Subtest read-crc-frame-sequence: SUCCESS (1.248s) [597.779764] [136/141] (410s left) kms_selftest (drm_dp_mst) [597.823175] Starting subtest: drm_dp_mst [597.825476] Subtest drm_dp_mst: SKIP (0.001s) [597.890828] [137/141] (410s left) kms_vblank (pipe-d-query-forked-busy-hang) [597.979600] Subtest pipe-D-query-forked-busy-hang: SKIP (0.000s) [598.065206] [138/141] (410s left) kms_chamelium_hpd (vga-hpd-fast) [598.190436] Subtest vga-hpd-fast: SKIP (0.000s) [598.241976] [139/141] (409s left) kms_ccs (pipe-d-crc-primary-basic-4_tiled_mtl_rc_ccs_cc) [598.454022] Subtest pipe-D-crc-primary-basic-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s) [598.541272] [140/141] (409s left) drm_fdinfo (busy) [598.585471] Starting subtest: busy [598.586165] Starting dynamic subtest: rcs0 [599.100419] Dynamic subtest rcs0: SUCCESS (0.514s) [599.109672] Starting dynamic subtest: bcs0 [599.618336] Dynamic subtest bcs0: SUCCESS (0.516s) [599.628254] Starting dynamic subtest: vcs0 [600.137494] Dynamic subtest vcs0: SUCCESS (0.517s) [600.147431] Starting dynamic subtest: vecs0 [600.655367] Dynamic subtest vecs0: SUCCESS (0.516s) [600.656549] Subtest busy: SUCCESS (2.070s) [600.730024] [141/141] (407s left) gem_create (create-valid-nonaligned) [600.784670] Starting subtest: create-valid-nonaligned [600.785351] Subtest create-valid-nonaligned: SUCCESS (0.000s) [600.973547] Closing watchdogs Done.