[40.136388] Initializing watchdogs [40.136424] /dev/watchdog0 [40.142280] [001/129] (960s left) kms_big_fb (4-tiled-32bpp-rotate-270) [40.250813] Starting subtest: 4-tiled-32bpp-rotate-270 [40.279371] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.029s) [40.386117] [002/129] (960s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180) [40.475570] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180 [40.479154] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s) [40.537754] [003/129] (960s left) kms_panel_fitting (legacy) [40.620268] Starting subtest: legacy [40.622221] Starting dynamic subtest: pipe-A-eDP-1 [41.148633] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.528s) [41.172653] Starting dynamic subtest: pipe-B-eDP-1 [42.786858] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.619s) [42.812489] Starting dynamic subtest: pipe-C-eDP-1 [44.354701] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.546s) [44.377314] Starting dynamic subtest: pipe-D-eDP-1 [45.967055] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.591s) [45.969446] Subtest legacy: SUCCESS (5.343s) [47.246707] [004/129] (953s left) api_intel_allocator (fork-simple-once) [47.304154] Starting subtest: fork-simple-once [47.317083] Subtest fork-simple-once: SUCCESS (0.015s) [47.415545] [005/129] (953s left) gem_lmem_swapping (verify-ccs) [47.452869] Subtest verify-ccs: SKIP (0.000s) [47.481155] [006/129] (953s left) sw_sync (sync_multi_timeline_wait) [47.505406] Starting subtest: sync_multi_timeline_wait [47.507871] Subtest sync_multi_timeline_wait: SUCCESS (0.000s) [47.534834] [007/129] (953s left) gem_exec_reloc (basic-write-wc-active) [47.595692] Subtest basic-write-wc-active: SKIP (0.000s) [47.638085] [008/129] (953s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render) [47.733272] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render [47.737467] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [47.805944] [009/129] (952s left) gem_userptr_blits (nohangcheck) [47.862745] Starting subtest: nohangcheck [48.093965] Subtest nohangcheck: SUCCESS (0.233s) [48.181259] [010/129] (952s left) gem_exec_schedule (in-order) [48.246731] Starting subtest: in-order [48.248597] Starting dynamic subtest: rcs0 [48.324998] Dynamic subtest rcs0: SUCCESS (0.088s) [48.331194] Starting dynamic subtest: vcs0 [48.396730] Dynamic subtest vcs0: SUCCESS (0.072s) [48.404876] Starting dynamic subtest: vcs1 [48.465314] Dynamic subtest vcs1: SUCCESS (0.069s) [48.473986] Starting dynamic subtest: vecs0 [48.533511] Dynamic subtest vecs0: SUCCESS (0.070s) [48.541784] Starting dynamic subtest: ccs0 [48.607105] Dynamic subtest ccs0: SUCCESS (0.074s) [48.609655] Subtest in-order: SUCCESS (0.373s) [50.487332] [011/129] (950s left) gem_render_copy (yf-tiled) [50.537919] Starting subtest: yf-tiled [50.542899] Subtest yf-tiled: SKIP (0.000s) [50.694342] [012/129] (950s left) i915_pm_rc6_residency (rc6-accuracy) [50.747041] Starting subtest: rc6-accuracy [50.749585] Starting dynamic subtest: gt0 [53.919063] Dynamic subtest gt0: SUCCESS (3.192s) [53.927793] Starting dynamic subtest: gt1 [57.087411] Dynamic subtest gt1: SUCCESS (3.183s) [57.090479] Subtest rc6-accuracy: SUCCESS (6.376s) [57.136945] [013/129] (943s left) gem_userptr_blits (map-fixed-invalidate) [57.198607] Starting subtest: map-fixed-invalidate [57.203327] Subtest map-fixed-invalidate: SKIP (0.000s) [57.297136] [014/129] (943s left) gem_mmap_wc (write-wc-read-gtt) [57.339554] Subtest write-wc-read-gtt: SKIP (0.000s) [57.381037] [015/129] (943s left) gem_exec_reloc (basic-cpu-read) [57.429073] Subtest basic-cpu-read: SKIP (0.000s) [57.470853] [016/129] (943s left) kms_flip (2x-plain-flip-ts-check) [57.564154] Starting subtest: 2x-plain-flip-ts-check [57.578234] Subtest 2x-plain-flip-ts-check: SKIP (0.014s) [57.626783] [017/129] (943s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling) [57.716843] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling [57.719274] Starting dynamic subtest: pipe-A-default-mode [58.894875] Dynamic subtest pipe-A-default-mode: SKIP (1.175s) [58.901525] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.176s) [59.034662] [018/129] (941s left) kms_big_fb (y-tiled-8bpp-rotate-90) [59.128153] Starting subtest: y-tiled-8bpp-rotate-90 [59.132377] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s) [59.201453] [019/129] (941s left) kms_plane_scaling (planes-downscale-factor-0-75) [59.296865] Starting subtest: planes-downscale-factor-0-75 [59.299269] Starting dynamic subtest: pipe-A [59.317452] Dynamic subtest pipe-A: SKIP (0.015s) [59.323587] Starting dynamic subtest: pipe-B [59.340838] Dynamic subtest pipe-B: SKIP (0.024s) [59.347535] Starting dynamic subtest: pipe-C [59.363936] Dynamic subtest pipe-C: SKIP (0.022s) [59.369110] Starting dynamic subtest: pipe-D [59.386269] Dynamic subtest pipe-D: SKIP (0.022s) [59.390910] Subtest planes-downscale-factor-0-75: SKIP (0.083s) [59.438399] [020/129] (941s left) kms_flip (bo-too-big-interruptible) [59.530530] Starting subtest: bo-too-big-interruptible [59.532702] Starting dynamic subtest: A-eDP1 [60.870351] Dynamic subtest A-eDP1: SUCCESS (1.341s) [60.879646] Starting dynamic subtest: B-eDP1 [62.225935] Dynamic subtest B-eDP1: SUCCESS (1.358s) [62.234321] Starting dynamic subtest: C-eDP1 [63.568569] Dynamic subtest C-eDP1: SUCCESS (1.344s) [63.577287] Starting dynamic subtest: D-eDP1 [64.907509] Dynamic subtest D-eDP1: SUCCESS (1.341s) [64.913559] Subtest bo-too-big-interruptible: SUCCESS (5.392s) [66.189110] [021/129] (934s left) kms_big_fb (linear-addfb) [66.285961] Starting subtest: linear-addfb [66.288052] Subtest linear-addfb: SUCCESS (0.000s) [66.351713] [022/129] (934s left) syncobj_timeline (invalid-transfer-non-existent-point) [66.397423] Starting subtest: invalid-transfer-non-existent-point [66.399613] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s) [66.463631] [023/129] (934s left) gem_fenced_exec_thrash (no-spare-fences) [66.515150] Subtest no-spare-fences: SKIP (0.000s) [66.563062] [024/129] (934s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip) [66.659408] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip [66.663769] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [66.720873] [025/129] (934s left) gen7_exec_parse (basic-allocation) [66.776591] Subtest basic-allocation: SKIP (0.000s) [66.812250] [026/129] (934s left) kms_flip (modeset-vs-vblank-race) [66.906809] Starting subtest: modeset-vs-vblank-race [66.909587] Starting dynamic subtest: A-eDP1 [71.839471] Dynamic subtest A-eDP1: SUCCESS (4.937s) [71.847751] Starting dynamic subtest: B-eDP1 [76.766196] Dynamic subtest B-eDP1: SUCCESS (4.928s) [76.774883] Starting dynamic subtest: C-eDP1 [81.672718] Dynamic subtest C-eDP1: SUCCESS (4.907s) [81.679397] Starting dynamic subtest: D-eDP1 [86.536740] Dynamic subtest D-eDP1: SUCCESS (4.864s) [86.539785] Subtest modeset-vs-vblank-race: SUCCESS (19.642s) [87.819181] [027/129] (913s left) core_hotunplug (unbind-rebind) [87.883753] Starting subtest: unbind-rebind [92.168766] Subtest unbind-rebind: SUCCESS (4.285s) [92.183982] [028/129] (908s left) i915_module_load (reload-no-display) [92.217933] Starting subtest: reload-no-display [96.145857] Subtest reload-no-display: SUCCESS (3.929s) [96.161065] [029/129] (904s left) gem_exec_reloc (basic-cpu-gtt-noreloc) [97.121790] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s) [97.163239] [030/129] (903s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render) [97.256729] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render [97.261187] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [97.344825] [031/129] (903s left) kms_ccs (bad-pixel-format-y-tiled-ccs) [97.432747] Starting subtest: bad-pixel-format-y-tiled-ccs [97.435023] Starting dynamic subtest: pipe-A-eDP-1 [97.456875] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [97.462610] Starting dynamic subtest: pipe-B-eDP-1 [97.483692] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [97.488418] Starting dynamic subtest: pipe-C-eDP-1 [97.509099] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [97.513748] Starting dynamic subtest: pipe-D-eDP-1 [97.534547] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [97.538506] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.002s) [97.550543] [032/129] (903s left) kms_pipe_crc_basic (hang-read-crc) [97.643448] Starting subtest: hang-read-crc [97.645751] Starting dynamic subtest: pipe-A-eDP-1 [99.692581] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.045s) [99.699938] Starting dynamic subtest: pipe-B-eDP-1 [102.481643] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.788s) [102.489934] Starting dynamic subtest: pipe-C-eDP-1 [105.211730] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.729s) [105.219642] Starting dynamic subtest: pipe-D-eDP-1 [107.949211] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.737s) [107.951441] Subtest hang-read-crc: SUCCESS (10.302s) [108.814809] [033/129] (892s left) prime_vgem (basic-write) [108.928345] Starting subtest: basic-write [108.932752] Subtest basic-write: SKIP (0.004s) [109.020961] [034/129] (891s left) kms_psr_stress_test (invalidate-primary-flip-overlay) [109.107612] Starting subtest: invalidate-primary-flip-overlay [119.745638] Subtest invalidate-primary-flip-overlay: SUCCESS (10.638s) [119.863356] [035/129] (881s left) gem_exec_reloc (basic-gtt-wc-active) [119.916328] Subtest basic-gtt-wc-active: SKIP (0.000s) [119.977866] [036/129] (881s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-cpu) [120.071031] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-cpu [124.407658] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (4.337s) [124.509522] [037/129] (876s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf) [129.625450] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf [129.628923] Starting dynamic subtest: pipe-A-eDP-1 [130.479226] Dynamic subtest pipe-A-eDP-1: SKIP (0.850s) [130.486744] Starting dynamic subtest: pipe-B-eDP-1 [131.696113] Dynamic subtest pipe-B-eDP-1: SKIP (1.216s) [131.700793] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (2.069s) [132.951573] [038/129] (868s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu) [133.039388] Starting subtest: fbc-rgb101010-draw-mmap-cpu [136.616381] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (3.580s) [136.682420] [039/129] (864s left) gem_userptr_blits (dmabuf-sync) [136.734748] Starting subtest: dmabuf-sync [136.739833] Subtest dmabuf-sync: SKIP (0.002s) [136.835653] [040/129] (864s left) gem_exec_whisper (basic-normal-all) [136.894439] Starting subtest: basic-normal-all [139.103286] Subtest basic-normal-all: SUCCESS (2.209s) [139.261175] [041/129] (861s left) perf (enable-disable) [139.356793] Starting subtest: enable-disable [139.359041] Starting dynamic subtest: 0-rcs0 [141.484814] Dynamic subtest 0-rcs0: SUCCESS (2.127s) [141.492526] Starting dynamic subtest: 1-vcs1 [145.682191] Dynamic subtest 1-vcs1: SUCCESS (4.197s) [145.684463] Subtest enable-disable: SUCCESS (6.325s) [145.706816] [042/129] (855s left) syncobj_eventfd (timeline-wait-signaled) [145.747055] Starting subtest: timeline-wait-signaled [145.749267] Subtest timeline-wait-signaled: SUCCESS (0.000s) [145.806500] [043/129] (855s left) kms_cursor_crc (cursor-rapid-movement-512x170) [146.045543] Starting subtest: cursor-rapid-movement-512x170 [146.050071] Subtest cursor-rapid-movement-512x170: SKIP (0.001s) [146.169103] [044/129] (854s left) kms_chamelium_frames (hdmi-crc-fast) [146.538171] Subtest hdmi-crc-fast: SKIP (0.000s) [147.386817] [045/129] (853s left) gem_softpin (allocator-nopin-reserve) [147.442876] Starting subtest: allocator-nopin-reserve [147.512856] Subtest allocator-nopin-reserve: SUCCESS (0.070s) [147.625552] [046/129] (853s left) gem_exec_fair (basic-throttle) [147.694240] Subtest basic-throttle: SKIP (0.000s) [147.725224] [047/129] (853s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot) [147.830657] Starting subtest: modeset-atomic-cursor-hotspot [147.835839] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s) [147.918340] [048/129] (853s left) kms_cursor_crc (cursor-random-32x10) [148.050309] Starting subtest: cursor-random-32x10 [148.083957] Subtest cursor-random-32x10: SKIP (0.029s) [148.306482] [049/129] (852s left) perf (gen12-group-exclusive-stream-ctx-handle) [148.385127] Starting subtest: gen12-group-exclusive-stream-ctx-handle [148.405645] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.020s) [148.424451] [050/129] (852s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs) [150.391942] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs [150.394333] Starting dynamic subtest: pipe-A-eDP-1 [151.965502] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.573s) [151.971819] Starting dynamic subtest: pipe-B-eDP-1 [154.657813] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.691s) [154.666250] Starting dynamic subtest: pipe-C-eDP-1 [157.301087] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.642s) [157.308161] Starting dynamic subtest: pipe-D-eDP-1 [159.969395] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.666s) [159.972084] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (9.577s) [161.232490] [051/129] (840s left) gem_exec_reloc (basic-cpu) [161.284122] Subtest basic-cpu: SKIP (0.000s) [161.354132] [052/129] (839s left) kms_frontbuffer_tracking (psr-slowdraw) [161.448135] Starting subtest: psr-slowdraw [184.141697] Subtest psr-slowdraw: SUCCESS (22.696s) [184.240906] [053/129] (817s left) drm_fdinfo (most-busy-idle-check-all) [184.271325] Starting subtest: most-busy-idle-check-all [184.273696] Starting dynamic subtest: rcs0 [184.278949] Dynamic subtest rcs0: SKIP (0.005s) [184.287638] Starting dynamic subtest: bcs0 [184.292146] Dynamic subtest bcs0: SKIP (0.000s) [184.298574] Starting dynamic subtest: vcs0 [184.303482] Dynamic subtest vcs0: SKIP (0.000s) [184.309888] Starting dynamic subtest: vcs1 [184.314486] Dynamic subtest vcs1: SKIP (0.000s) [184.320283] Starting dynamic subtest: vecs0 [184.324914] Dynamic subtest vecs0: SKIP (0.000s) [184.330872] Starting dynamic subtest: ccs0 [184.335432] Dynamic subtest ccs0: SKIP (0.000s) [184.339889] Subtest most-busy-idle-check-all: SKIP (0.007s) [184.353925] [054/129] (816s left) kms_cursor_crc (cursor-offscreen-64x21) [184.513601] Starting subtest: cursor-offscreen-64x21 [184.552032] Subtest cursor-offscreen-64x21: SKIP (0.033s) [184.742393] [055/129] (816s left) core_getstats [184.869837] [056/129] (816s left) syncobj_timeline (wait-all-snapshot) [184.914659] Starting subtest: wait-all-snapshot [184.993614] Subtest wait-all-snapshot: SUCCESS (0.082s) [185.043312] [057/129] (816s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs) [185.127480] Starting subtest: missing-ccs-buffer-y-tiled-ccs [185.129316] Starting dynamic subtest: pipe-A-eDP-1 [185.146952] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [185.155464] Starting dynamic subtest: pipe-B-eDP-1 [185.174469] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [185.188851] Starting dynamic subtest: pipe-C-eDP-1 [185.210876] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [185.222799] Starting dynamic subtest: pipe-D-eDP-1 [185.245413] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [185.249656] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.003s) [185.271744] [058/129] (816s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc) [185.361112] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc [185.363551] Starting dynamic subtest: pipe-A-eDP-1 [185.385383] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [185.395402] Starting dynamic subtest: pipe-B-eDP-1 [185.417323] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [185.424740] Starting dynamic subtest: pipe-C-eDP-1 [185.444469] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [185.450592] Starting dynamic subtest: pipe-D-eDP-1 [185.471063] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [185.474443] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s) [185.486815] [059/129] (815s left) gem_render_copy (yf-tiled-ccs-to-y-tiled) [185.532479] Starting subtest: yf-tiled-ccs-to-y-tiled [185.536643] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s) [185.691488] [060/129] (815s left) kms_plane_lowres (tiling-y) [185.773225] Starting subtest: tiling-y [185.778431] Subtest tiling-y: SKIP (0.000s) [185.823434] [061/129] (815s left) gem_exec_create (legacy) [185.867280] Starting subtest: legacy [185.869652] Starting dynamic subtest: smem [188.395200] Dynamic subtest smem: SUCCESS (2.525s) [188.397921] Subtest legacy: SUCCESS (2.526s) [188.552774] [062/129] (812s left) gem_exec_fence (syncobj-unused-fence) [188.978194] Starting subtest: syncobj-unused-fence [188.983456] Subtest syncobj-unused-fence: SUCCESS (0.006s) [190.432324] [063/129] (811s left) gem_ctx_persistence (engines-hang) [190.475823] Starting subtest: engines-hang [190.478318] Starting dynamic subtest: rcs0 [190.528457] Dynamic subtest rcs0: SUCCESS (0.052s) [190.537516] Starting dynamic subtest: bcs0 [190.642082] Dynamic subtest bcs0: SUCCESS (0.114s) [190.650701] Starting dynamic subtest: vcs0 [190.753752] Dynamic subtest vcs0: SUCCESS (0.111s) [190.762502] Starting dynamic subtest: vcs1 [190.859928] Dynamic subtest vcs1: SUCCESS (0.105s) [190.869186] Starting dynamic subtest: vecs0 [190.964060] Dynamic subtest vecs0: SUCCESS (0.103s) [190.972300] Starting dynamic subtest: ccs0 [190.999625] Dynamic subtest ccs0: SUCCESS (0.035s) [191.002468] Subtest engines-hang: SUCCESS (0.524s) [191.097184] [064/129] (810s left) kms_psr (pr-sprite-render) [191.190866] Starting subtest: pr-sprite-render [191.195302] Subtest pr-sprite-render: SKIP (0.000s) [191.239078] [065/129] (810s left) fbdev (unaligned-write) [191.282371] Starting subtest: unaligned-write [191.374166] Subtest unaligned-write: SUCCESS (0.091s) [191.415195] [066/129] (810s left) gen3_mixed_blits [191.509384] [067/129] (810s left) gem_ctx_shared (q-out-order) [191.555442] Starting subtest: Q-out-order [191.557635] Starting dynamic subtest: rcs0 [191.640945] Dynamic subtest rcs0: SUCCESS (0.085s) [191.653569] Starting dynamic subtest: vcs0 [191.709324] Dynamic subtest vcs0: SUCCESS (0.068s) [191.724740] Starting dynamic subtest: vcs1 [191.775341] Dynamic subtest vcs1: SUCCESS (0.066s) [191.789798] Starting dynamic subtest: vecs0 [191.841520] Dynamic subtest vecs0: SUCCESS (0.065s) [191.855742] Starting dynamic subtest: ccs0 [191.927088] Dynamic subtest ccs0: SUCCESS (0.085s) [191.929281] Subtest Q-out-order: SUCCESS (0.371s) [193.476955] [068/129] (808s left) kms_big_fb (yf-tiled-64bpp-rotate-90) [193.568737] Starting subtest: yf-tiled-64bpp-rotate-90 [193.573217] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s) [193.638393] [069/129] (807s left) kms_big_fb (4-tiled-addfb-size-overflow) [193.729980] Starting subtest: 4-tiled-addfb-size-overflow [193.732455] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s) [193.812934] [070/129] (807s left) kms_flip (nonexisting-fb-interruptible) [193.902827] Starting subtest: nonexisting-fb-interruptible [193.907927] Starting dynamic subtest: A-eDP1 [195.133396] Dynamic subtest A-eDP1: SUCCESS (1.228s) [195.140816] Starting dynamic subtest: B-eDP1 [196.348463] Dynamic subtest B-eDP1: SUCCESS (1.214s) [196.356162] Starting dynamic subtest: C-eDP1 [197.564813] Dynamic subtest C-eDP1: SUCCESS (1.216s) [197.572751] Starting dynamic subtest: D-eDP1 [198.780952] Dynamic subtest D-eDP1: SUCCESS (1.214s) [198.786882] Subtest nonexisting-fb-interruptible: SUCCESS (4.883s) [200.014329] [071/129] (801s left) kms_cursor_legacy (flip-vs-cursor-atomic) [200.130552] Starting subtest: flip-vs-cursor-atomic [206.648086] Subtest flip-vs-cursor-atomic: SUCCESS (6.515s) [207.563924] [072/129] (794s left) gem_mmap_gtt (basic-small-bo-tiledx) [207.618298] Subtest basic-small-bo-tiledX: SKIP (0.000s) [207.648211] [073/129] (793s left) gem_exec_create (basic) [207.693966] Starting subtest: basic [207.696293] Starting dynamic subtest: smem [210.346352] Dynamic subtest smem: SUCCESS (2.650s) [210.349056] Subtest basic: SUCCESS (2.651s) [210.505139] [074/129] (791s left) gem_eio (wait-wedge-immediate) [210.760761] Starting subtest: wait-wedge-immediate [212.483929] Subtest wait-wedge-immediate: SUCCESS (1.724s) [212.585329] [075/129] (789s left) perf_pmu (semaphore-wait-idle) [212.616864] Starting subtest: semaphore-wait-idle [212.618778] Starting dynamic subtest: rcs0 [213.128501] Dynamic subtest rcs0: SUCCESS (0.511s) [213.136614] Starting dynamic subtest: bcs0 [213.639380] Dynamic subtest bcs0: SUCCESS (0.511s) [213.649235] Starting dynamic subtest: vcs0 [214.152439] Dynamic subtest vcs0: SUCCESS (0.511s) [214.161420] Starting dynamic subtest: vcs1 [214.664191] Dynamic subtest vcs1: SUCCESS (0.510s) [214.673989] Starting dynamic subtest: vecs0 [215.175448] Dynamic subtest vecs0: SUCCESS (0.510s) [215.185208] Starting dynamic subtest: ccs0 [215.688417] Dynamic subtest ccs0: SUCCESS (0.511s) [215.691272] Subtest semaphore-wait-idle: SUCCESS (3.072s) [216.412624] [076/129] (785s left) kms_big_fb (x-tiled-32bpp-rotate-90) [216.518208] Starting subtest: x-tiled-32bpp-rotate-90 [216.537250] Subtest x-tiled-32bpp-rotate-90: SKIP (0.018s) [216.640347] [077/129] (785s left) kms_color (gamma) [216.741740] Starting subtest: gamma [216.743939] Starting dynamic subtest: pipe-A-eDP-1 [217.416716] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.672s) [217.424409] Starting dynamic subtest: pipe-B-eDP-1 [218.886649] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.469s) [218.894735] Starting dynamic subtest: pipe-C-eDP-1 [220.303572] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.415s) [220.310828] Starting dynamic subtest: pipe-D-eDP-1 [221.702787] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.398s) [221.705302] Subtest gamma: SUCCESS (4.958s) [222.605988] [078/129] (779s left) gem_ctx_persistence (hostile) [222.664801] Starting subtest: hostile [224.202675] Subtest hostile: FAIL (1.488s) [224.272391] [079/129] (777s left) gem_readwrite (read-write) [224.330920] Subtest read-write: SKIP (0.000s) [224.358910] [080/129] (777s left) gem_exec_params (secure-non-master) [224.410169] Starting subtest: secure-non-master [224.414759] Subtest secure-non-master: SKIP (0.000s) [224.468702] [081/129] (777s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf) [229.592454] Starting subtest: psr2-overlay-plane-update-continuous-sf [229.594823] Starting dynamic subtest: pipe-A-eDP-1 [231.406504] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.811s) [231.413729] Starting dynamic subtest: pipe-B-eDP-1 [233.213777] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.807s) [233.216280] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (3.621s) [234.126103] [082/129] (767s left) kms_cursor_legacy (cursorb-vs-flipa-toggle) [234.242419] Starting subtest: cursorB-vs-flipA-toggle [234.246861] Subtest cursorB-vs-flipA-toggle: SKIP (0.002s) [234.340762] [083/129] (767s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling) [234.417816] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling [234.420075] Starting dynamic subtest: pipe-A-default-mode [237.258211] Dynamic subtest pipe-A-default-mode: SUCCESS (2.838s) [237.260926] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.839s) [238.155988] [084/129] (763s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc) [238.258474] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc [238.262874] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [238.331567] [085/129] (763s left) kms_vblank (accuracy-idle) [238.420863] Starting subtest: accuracy-idle [238.423177] Starting dynamic subtest: pipe-A-eDP-1 [240.174379] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.750s) [240.186334] Starting dynamic subtest: pipe-D-eDP-1 [242.664354] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.487s) [242.667327] Subtest accuracy-idle: SUCCESS (4.241s) [243.533989] [086/129] (758s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt) [243.636756] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt [248.570483] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (4.938s) [248.693580] [087/129] (753s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled) [248.742407] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [248.744648] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s) [248.811959] [088/129] (753s left) drm_fdinfo (busy) [248.846059] Starting subtest: busy [248.848167] Starting dynamic subtest: rcs0 [248.852359] Dynamic subtest rcs0: SKIP (0.000s) [248.860285] Starting dynamic subtest: bcs0 [248.864142] Dynamic subtest bcs0: SKIP (0.000s) [248.870462] Starting dynamic subtest: vcs0 [248.874762] Dynamic subtest vcs0: SKIP (0.000s) [248.881592] Starting dynamic subtest: vcs1 [248.885770] Dynamic subtest vcs1: SKIP (0.000s) [248.891709] Starting dynamic subtest: vecs0 [248.895910] Dynamic subtest vecs0: SKIP (0.000s) [248.901897] Starting dynamic subtest: ccs0 [248.906151] Dynamic subtest ccs0: SKIP (0.000s) [248.910327] Subtest busy: SKIP (0.002s) [248.922675] [089/129] (752s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted) [248.958019] Starting subtest: etime-single-wait-for-submit-available-unsubmitted [249.062038] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.102s) [249.115323] [090/129] (752s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-25) [249.206923] Starting subtest: planes-unity-scaling-downscale-factor-0-25 [249.209277] Starting dynamic subtest: pipe-A [249.224299] Dynamic subtest pipe-A: SKIP (0.010s) [249.231964] Starting dynamic subtest: pipe-B [249.243782] Dynamic subtest pipe-B: SKIP (0.019s) [249.250502] Starting dynamic subtest: pipe-C [249.262400] Dynamic subtest pipe-C: SKIP (0.019s) [249.269312] Starting dynamic subtest: pipe-D [249.283228] Dynamic subtest pipe-D: SKIP (0.021s) [249.286962] Subtest planes-unity-scaling-downscale-factor-0-25: SKIP (0.071s) [249.339813] [091/129] (752s left) i915_pm_rps (thresholds) [249.385912] Starting subtest: thresholds [249.391057] Subtest thresholds: SKIP (0.000s) [249.444640] [092/129] (752s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render) [249.529447] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render [249.533596] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [249.599058] [093/129] (752s left) kms_chamelium_frames (hdmi-crc-single) [249.969859] Subtest hdmi-crc-single: SKIP (0.000s) [250.810759] [094/129] (751s left) kms_draw_crc (draw-method-mmap-wc) [250.896536] Starting subtest: draw-method-mmap-wc [250.898542] Starting dynamic subtest: xrgb8888-untiled [251.092529] Dynamic subtest xrgb8888-untiled: SUCCESS (0.198s) [251.099195] Starting dynamic subtest: rgb565-untiled [251.269890] Dynamic subtest rgb565-untiled: SUCCESS (0.177s) [251.278592] Starting dynamic subtest: xrgb2101010-untiled [251.449051] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.177s) [251.458239] Starting dynamic subtest: xrgb8888-xtiled [251.547953] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.099s) [251.554956] Starting dynamic subtest: rgb565-xtiled [251.647365] Dynamic subtest rgb565-xtiled: SUCCESS (0.100s) [251.654076] Starting dynamic subtest: xrgb2101010-xtiled [251.736583] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.089s) [251.743487] Starting dynamic subtest: xrgb8888-4tiled [251.859185] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.121s) [251.867051] Starting dynamic subtest: rgb565-4tiled [251.969611] Dynamic subtest rgb565-4tiled: SUCCESS (0.110s) [251.978099] Starting dynamic subtest: xrgb2101010-4tiled [252.080768] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.111s) [252.082706] Subtest draw-method-mmap-wc: SUCCESS (1.188s) [252.139045] [095/129] (749s left) gem_workarounds (reset-context) [252.189964] Starting subtest: reset-context [252.348716] Subtest reset-context: SUCCESS (0.159s) [252.445673] [096/129] (749s left) syncobj_wait (wait-any-snapshot) [252.501838] Starting subtest: wait-any-snapshot [252.582527] Subtest wait-any-snapshot: SUCCESS (0.082s) [252.636087] [097/129] (749s left) kms_psr (fbc-psr2-primary-blt) [252.713582] Starting subtest: fbc-psr2-primary-blt [252.715576] Starting dynamic subtest: eDP-1 [252.719067] Dynamic subtest eDP-1: SKIP (0.000s) [252.722478] Subtest fbc-psr2-primary-blt: SKIP (0.001s) [252.765418] [098/129] (749s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu) [252.852484] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu [252.856270] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [252.920588] [099/129] (749s left) gem_mmap_offset (mmap-unmap) [252.971848] Starting subtest: mmap-unmap [252.973821] Starting dynamic subtest: smem0 [267.244370] Dynamic subtest smem0: SUCCESS (14.272s) [267.246863] Subtest mmap-unmap: SUCCESS (14.273s) [267.357404] [100/129] (734s left) kms_addfb_basic (bo-too-small) [267.440179] Starting subtest: bo-too-small [267.442551] Subtest bo-too-small: SUCCESS (0.000s) [267.528121] [101/129] (734s left) kms_vblank (ts-continuation-suspend) [267.615845] Starting subtest: ts-continuation-suspend [267.618093] Starting dynamic subtest: pipe-A-eDP-1 [284.419468] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.443s) [284.434614] Starting dynamic subtest: pipe-D-eDP-1 [301.372978] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.155s) [301.375167] Subtest ts-continuation-suspend: SUCCESS (3.601s) [302.252841] [102/129] (729s left) kms_psr (pr-cursor-mmap-gtt) [302.337566] Starting subtest: pr-cursor-mmap-gtt [302.342082] Subtest pr-cursor-mmap-gtt: SKIP (0.000s) [302.387998] [103/129] (729s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move) [302.479250] Starting subtest: fbc-2p-primscrn-spr-indfb-move [302.484047] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s) [302.537599] [104/129] (729s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf) [307.630815] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf [307.635839] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.002s) [308.522686] [105/129] (723s left) gem_exec_whisper (basic-fds-all) [308.562905] Starting subtest: basic-fds-all [318.509147] Subtest basic-fds-all: SUCCESS (9.971s) [318.669945] [106/129] (713s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite) [318.761307] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite [323.572608] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (4.821s) [323.652132] [107/129] (708s left) kms_properties (invalid-properties-atomic) [323.745459] Starting subtest: invalid-properties-atomic [323.974864] Subtest invalid-properties-atomic: SUCCESS (0.227s) [324.020934] [108/129] (708s left) perf (stress-open-close) [324.088078] Starting subtest: stress-open-close [324.090626] Starting dynamic subtest: 0-rcs0 [326.254122] Dynamic subtest 0-rcs0: SUCCESS (2.168s) [326.266109] Starting dynamic subtest: 1-vecs0 [328.412863] Dynamic subtest 1-vecs0: SUCCESS (2.161s) [328.414771] Subtest stress-open-close: SUCCESS (4.329s) [328.436969] [109/129] (703s left) kms_pm_rpm (cursor) [330.753909] Starting subtest: cursor [362.778090] Subtest cursor: SUCCESS (32.016s) [363.546630] [110/129] (668s left) kms_flip (2x-flip-vs-expired-vblank) [363.632465] Starting subtest: 2x-flip-vs-expired-vblank [363.646848] Subtest 2x-flip-vs-expired-vblank: SKIP (0.014s) [363.699181] [111/129] (668s left) perf_pmu (invalid-init) [363.731912] Starting subtest: invalid-init [363.734317] Subtest invalid-init: SUCCESS (0.000s) [363.823693] [112/129] (668s left) kms_lease (lease-invalid-plane) [363.913410] Starting subtest: lease-invalid-plane [363.915603] Starting dynamic subtest: pipe-A-eDP-1 [363.917853] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [363.925022] Starting dynamic subtest: pipe-B-eDP-1 [363.927217] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [363.934317] Starting dynamic subtest: pipe-C-eDP-1 [363.936207] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [363.943339] Starting dynamic subtest: pipe-D-eDP-1 [363.945543] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [363.947760] Subtest lease-invalid-plane: SUCCESS (0.003s) [363.966985] [113/129] (668s left) gem_exec_balancer (nop) [364.011019] Starting subtest: nop [410.241191] Subtest nop: SUCCESS (46.233s) [410.482347] [114/129] (621s left) kms_psr (fbc-pr-sprite-blt) [410.565560] Starting subtest: fbc-pr-sprite-blt [410.569849] Subtest fbc-pr-sprite-blt: SKIP (0.000s) [410.615667] [115/129] (621s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render) [410.705042] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render [410.709142] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [410.779288] [116/129] (621s left) syncobj_wait (wait-all-delayed-signal) [410.840459] Starting subtest: wait-all-delayed-signal [410.941526] Subtest wait-all-delayed-signal: SUCCESS (0.102s) [411.003514] [117/129] (621s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc) [411.101151] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc [415.674194] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.574s) [415.764134] [118/129] (616s left) gem_softpin (noreloc-interruptible) [415.825163] Starting subtest: noreloc-interruptible [421.235125] Subtest noreloc-interruptible: SUCCESS (5.407s) [421.381005] [119/129] (610s left) kms_psr (psr-cursor-blt) [421.474251] Starting subtest: psr-cursor-blt [421.476472] Starting dynamic subtest: eDP-1 [423.253932] Dynamic subtest eDP-1: SUCCESS (1.777s) [423.256543] Subtest psr-cursor-blt: SUCCESS (1.777s) [424.173996] [120/129] (608s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu) [424.276237] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu [428.535283] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (4.263s) [428.637594] [121/129] (603s left) kms_async_flips (crc) [428.732711] Starting subtest: crc [429.082659] Starting dynamic subtest: pipe-A-eDP-1 [431.986058] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.904s) [432.359129] Starting dynamic subtest: pipe-B-eDP-1 [435.295349] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.941s) [435.642463] Starting dynamic subtest: pipe-C-eDP-1 [438.546857] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.910s) [438.896538] Starting dynamic subtest: pipe-D-eDP-1 [441.819709] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.933s) [441.822040] Subtest crc: SUCCESS (13.087s) [443.056364] [122/129] (589s left) kms_rotation_crc (exhaust-fences) [443.142586] Starting subtest: exhaust-fences [443.147238] Subtest exhaust-fences: SKIP (0.000s) [443.195300] [123/129] (589s left) gem_exec_schedule (submit-golden-slice) [443.260584] Starting subtest: submit-golden-slice [443.263394] Starting dynamic subtest: rcs0 [443.276943] Dynamic subtest rcs0: SUCCESS (0.027s) [443.285966] Starting dynamic subtest: bcs0 [443.299785] Dynamic subtest bcs0: SUCCESS (0.023s) [443.307658] Starting dynamic subtest: vcs0 [443.332144] Dynamic subtest vcs0: SUCCESS (0.032s) [443.342317] Starting dynamic subtest: vcs1 [443.357414] Dynamic subtest vcs1: SUCCESS (0.025s) [443.365290] Starting dynamic subtest: vecs0 [443.382402] Dynamic subtest vecs0: SUCCESS (0.025s) [443.390315] Starting dynamic subtest: ccs0 [443.409195] Dynamic subtest ccs0: SUCCESS (0.026s) [443.411755] Subtest submit-golden-slice: SUCCESS (0.159s) [444.630228] [124/129] (587s left) gem_ctx_isolation (dirty-switch) [444.673276] Starting subtest: dirty-switch [444.675900] Starting dynamic subtest: rcs0 [444.830631] Dynamic subtest rcs0: SUCCESS (0.157s) [444.839032] Starting dynamic subtest: bcs0 [445.019888] Dynamic subtest bcs0: SUCCESS (0.189s) [445.030578] Starting dynamic subtest: vcs0 [445.220443] Dynamic subtest vcs0: SUCCESS (0.200s) [445.229999] Starting dynamic subtest: vcs1 [446.729642] Dynamic subtest vcs1: SUCCESS (1.509s) [446.738189] Starting dynamic subtest: vecs0 [448.774592] Dynamic subtest vecs0: SUCCESS (2.046s) [448.784079] Starting dynamic subtest: ccs0 [450.773121] Dynamic subtest ccs0: SUCCESS (1.998s) [450.775546] Subtest dirty-switch: SUCCESS (6.101s) [450.980640] [125/129] (581s left) kms_hdr (bpc-switch) [451.079754] Starting subtest: bpc-switch [452.240027] Starting dynamic subtest: pipe-A-eDP-1 [455.882937] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.644s) [455.885406] Subtest bpc-switch: SUCCESS (4.803s) [455.984914] [126/129] (576s left) kms_flip (2x-flip-vs-modeset) [456.085027] Starting subtest: 2x-flip-vs-modeset [456.103510] Subtest 2x-flip-vs-modeset: SKIP (0.017s) [456.158716] [127/129] (576s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render) [456.250918] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render [456.254944] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [456.318365] [128/129] (576s left) gem_pipe_control_store_loop (reused-buffer) [456.373789] Starting subtest: reused-buffer [458.524773] Subtest reused-buffer: SUCCESS (2.151s) [458.630295] [129/129] (573s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt) [458.727906] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt [458.732010] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [458.800839] Closing watchdogs Done.