[60.002898] Initializing watchdogs
[60.002951]   /dev/watchdog0
[60.018149] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[60.022490] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.024811] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.028192] [001/131] (960s left) api_intel_allocator (gem-pool)
[60.116762] Starting subtest: gem-pool
[60.131043] Subtest gem-pool: SUCCESS (0.016s)
[60.288880] [002/131] (960s left) gem_bad_reloc (negative-reloc)
[60.359075] Subtest negative-reloc: SKIP (0.000s)
[60.432052] [003/131] (960s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[65.509992] Starting subtest: fbc-pr-overlay-plane-move-continuous-sf
[65.514450] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.003s)
[66.381856] [004/131] (954s left) kms_vblank (wait-forked-busy-hang)
[66.478918] Starting subtest: wait-forked-busy-hang
[66.480766] Starting dynamic subtest: pipe-A-eDP-1
[92.693174] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.214s)
[92.706798] Starting dynamic subtest: pipe-D-eDP-1
[117.666799] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.971s)
[117.669246] Subtest wait-forked-busy-hang: SUCCESS (51.189s)
[118.541106] [005/131] (902s left) kms_fence_pin_leak
[118.716357] [006/131] (901s left) gem_exec_schedule (implicit-boths)
[118.796254] Starting subtest: implicit-boths
[118.798605] Starting dynamic subtest: rcs0
[118.899360] Dynamic subtest rcs0: SUCCESS (0.112s)
[118.911846] Starting dynamic subtest: vcs0
[118.980997] Dynamic subtest vcs0: SUCCESS (0.081s)
[118.991717] Starting dynamic subtest: vcs1
[119.055729] Dynamic subtest vcs1: SUCCESS (0.075s)
[119.066136] Starting dynamic subtest: vecs0
[119.129838] Dynamic subtest vecs0: SUCCESS (0.074s)
[119.139905] Starting dynamic subtest: ccs0
[119.217597] Dynamic subtest ccs0: SUCCESS (0.087s)
[119.220216] Subtest implicit-boths: SUCCESS (0.431s)
[120.039419] [007/131] (900s left) gem_render_copy_redux (flink)
[120.107734] Starting subtest: flink
[120.804626] Subtest flink: SUCCESS (0.697s)
[120.969210] [008/131] (899s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[121.055126] Starting subtest: pipe-fbc-rte
[121.060660] Starting dynamic subtest: pipe-B-eDP-1
[126.513238] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.461s)
[126.520467] Subtest pipe-fbc-rte: SUCCESS (5.462s)
[128.871690] [009/131] (891s left) kms_cursor_crc (cursor-offscreen-512x512)
[129.126801] Starting subtest: cursor-offscreen-512x512
[129.131651] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[129.327701] [010/131] (891s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[129.426589] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[130.260727] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.837s)
[130.471343] [011/131] (890s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[130.541720] Starting subtest: framebuffer-vs-set-tiling
[130.545972] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[130.721227] [012/131] (890s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[130.818583] Starting subtest: addfb25-y-tiled-legacy
[130.820635] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[130.956915] [013/131] (890s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[131.047680] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[131.049889] Starting dynamic subtest: pipe-A
[131.110805] Dynamic subtest pipe-A: SUCCESS (0.065s)
[131.120357] Starting dynamic subtest: pipe-B
[132.278447] Dynamic subtest pipe-B: SUCCESS (1.167s)
[132.287923] Starting dynamic subtest: pipe-C
[133.388751] Dynamic subtest pipe-C: SUCCESS (1.109s)
[133.398672] Starting dynamic subtest: pipe-D
[134.515750] Dynamic subtest pipe-D: SUCCESS (1.126s)
[134.518426] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.470s)
[135.705318] [014/131] (885s left) perf (gen12-oa-tlb-invalidate)
[135.853136] Starting subtest: gen12-oa-tlb-invalidate
[135.855387] Starting dynamic subtest: 0-rcs0
[145.911162] Dynamic subtest 0-rcs0: SUCCESS (10.057s)
[145.918552] Starting dynamic subtest: 1-vcs0
[155.956712] Dynamic subtest 1-vcs0: SUCCESS (10.044s)
[155.958974] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.101s)
[155.999563] [015/131] (865s left) perf (stress-open-close)
[156.105077] Starting subtest: stress-open-close
[156.107547] Starting dynamic subtest: 0-rcs0
[158.274887] Dynamic subtest 0-rcs0: SUCCESS (2.170s)
[158.284413] Starting dynamic subtest: 1-vcs0
[160.438902] Dynamic subtest 1-vcs0: SUCCESS (2.163s)
[160.440909] Subtest stress-open-close: SUCCESS (4.334s)
[160.477225] [016/131] (860s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[160.585893] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[160.589398] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[160.725330] [017/131] (860s left) kms_pm_rpm (universal-planes)
[162.248557] Starting subtest: universal-planes
[162.250810] Starting dynamic subtest: plane-33
[170.817526] Dynamic subtest plane-33: SUCCESS (8.571s)
[170.828308] Starting dynamic subtest: plane-63
[179.144365] Dynamic subtest plane-63: SUCCESS (8.325s)
[179.155176] Starting dynamic subtest: plane-93
[187.435393] Dynamic subtest plane-93: SUCCESS (8.291s)
[187.446268] Starting dynamic subtest: plane-123
[195.720096] Dynamic subtest plane-123: SUCCESS (8.282s)
[195.731093] Starting dynamic subtest: plane-133
[204.032046] Dynamic subtest plane-133: SUCCESS (8.311s)
[204.042729] Starting dynamic subtest: plane-143
[212.671066] Dynamic subtest plane-143: SUCCESS (8.637s)
[212.673832] Subtest universal-planes: SUCCESS (50.425s)
[213.059639] [018/131] (808s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[213.166124] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[213.170611] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[213.293243] [019/131] (807s left) gem_exec_params (readonly)
[213.360983] Starting subtest: readonly
[213.365565] Subtest readonly: SUCCESS (0.003s)
[213.537862] [020/131] (807s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[213.609967] Starting subtest: legacy-engines-hostile-preempt
[213.612253] Starting dynamic subtest: render
[213.728890] Dynamic subtest render: SUCCESS (0.121s)
[213.739701] Starting dynamic subtest: bsd1
[214.908373] Dynamic subtest bsd1: SUCCESS (1.176s)
[214.917499] Starting dynamic subtest: bsd2
[216.938280] Dynamic subtest bsd2: SUCCESS (2.027s)
[216.947767] Starting dynamic subtest: blt
[216.964223] Dynamic subtest blt: SUCCESS (0.026s)
[216.971637] Starting dynamic subtest: vebox
[218.885599] Dynamic subtest vebox: SUCCESS (1.919s)
[218.888113] Subtest legacy-engines-hostile-preempt: SUCCESS (5.277s)
[219.056152] [021/131] (802s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[219.122685] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[219.226494] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.102s)
[219.327869] [022/131] (801s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[219.393196] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[219.498965] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.105s)
[219.600756] [023/131] (801s left) core_setmaster (master-drop-set-root)
[219.691872] Starting subtest: master-drop-set-root
[219.703346] Subtest master-drop-set-root: SUCCESS (0.015s)
[219.748192] [024/131] (801s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[219.841358] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[226.894170] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.055s)
[227.052946] [025/131] (794s left) gem_pwrite (basic-self)
[227.104984] Subtest basic-self: SKIP (0.000s)
[227.160604] [026/131] (794s left) kms_joiner (invalid-modeset-big-joiner)
[227.273357] Starting subtest: invalid-modeset-big-joiner
[227.278094] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[227.354621] [027/131] (794s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[227.444306] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[232.721594] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.280s)
[233.853306] [028/131] (787s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[233.948215] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[238.435543] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.491s)
[239.660306] [029/131] (781s left) perf_pmu (render-node-busy-idle)
[239.736101] Starting subtest: render-node-busy-idle
[239.738460] Starting dynamic subtest: rcs0
[240.403898] Dynamic subtest rcs0: SUCCESS (0.667s)
[240.414956] Starting dynamic subtest: bcs0
[241.075959] Dynamic subtest bcs0: SUCCESS (0.670s)
[241.087552] Starting dynamic subtest: vcs0
[242.902719] Dynamic subtest vcs0: SUCCESS (1.825s)
[242.913721] Starting dynamic subtest: vcs1
[244.889794] Dynamic subtest vcs1: SUCCESS (1.985s)
[244.901324] Starting dynamic subtest: vecs0
[246.934312] Dynamic subtest vecs0: SUCCESS (2.043s)
[246.944065] Starting dynamic subtest: ccs0
[247.606331] Dynamic subtest ccs0: SUCCESS (0.671s)
[247.608857] Subtest render-node-busy-idle: SUCCESS (7.871s)
[247.704681] [030/131] (773s left) i915_hangman (detector)
[247.795375] Starting subtest: detector
[247.797372] Starting dynamic subtest: rcs0
[257.844458] Dynamic subtest rcs0: SUCCESS (10.047s)
[257.856242] Starting dynamic subtest: bcs0
[269.877424] Dynamic subtest bcs0: SUCCESS (12.031s)
[269.889195] Starting dynamic subtest: vcs0
[280.884453] Dynamic subtest vcs0: SUCCESS (11.004s)
[280.896802] Starting dynamic subtest: vcs1
[292.853616] Dynamic subtest vcs1: SUCCESS (11.966s)
[292.864720] Starting dynamic subtest: vecs0
[304.885628] Dynamic subtest vecs0: SUCCESS (12.028s)
[304.900339] Starting dynamic subtest: ccs0
[316.917049] Dynamic subtest ccs0: SUCCESS (12.029s)
[316.919878] Subtest detector: SUCCESS (69.118s)
[317.024302] [031/131] (704s left) gem_ctx_engines (execute-allforone)
[317.087904] Starting subtest: execute-allforone
[317.114086] Subtest execute-allforone: SUCCESS (0.026s)
[319.057481] [032/131] (702s left) gem_ctx_param (non-root-set)
[319.116092] Starting subtest: non-root-set
[319.136091] Subtest non-root-set: SUCCESS (0.020s)
[319.253907] [033/131] (702s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[319.366378] Starting subtest: 4-tiled-8bpp-rotate-0
[320.626743] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.259s)
[320.783872] [034/131] (700s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[320.883143] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[320.884971] Starting dynamic subtest: pipe-A-eDP-1
[354.414486] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.338s)
[354.424259] Starting dynamic subtest: pipe-B-eDP-1
[389.344751] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.479s)
[389.358207] Starting dynamic subtest: pipe-C-eDP-1
[424.347706] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.492s)
[424.357392] Starting dynamic subtest: pipe-D-eDP-1
[459.350000] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.429s)
[459.352300] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (20.743s)
[469.597251] [035/131] (561s left) i915_suspend (basic-s3-without-i915)
[469.649617] Starting subtest: basic-s3-without-i915
[473.205250] Subtest basic-s3-without-i915: SKIP (3.547s)
[474.813232] [036/131] (556s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[474.922535] Starting subtest: fbcpsr-1p-rte
[482.028376] Subtest fbcpsr-1p-rte: SUCCESS (7.107s)
[482.197450] [037/131] (548s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[482.295147] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[482.297416] Starting dynamic subtest: pipe-A-eDP-1
[482.317540] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[482.327034] Starting dynamic subtest: pipe-B-eDP-1
[482.346546] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[482.354681] Starting dynamic subtest: pipe-C-eDP-1
[482.373772] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[482.382520] Starting dynamic subtest: pipe-D-eDP-1
[482.401682] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[482.403571] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[484.513442] [038/131] (546s left) gem_ctx_isolation (preservation-s3)
[484.583180] Starting subtest: preservation-S3
[484.585483] Starting dynamic subtest: rcs0
[501.197068] Dynamic subtest rcs0: SUCCESS (1.729s)
[501.207044] Starting dynamic subtest: bcs0
[518.200158] Dynamic subtest bcs0: SUCCESS (1.737s)
[518.210898] Starting dynamic subtest: vcs0
[535.198035] Dynamic subtest vcs0: SUCCESS (3.091s)
[535.207473] Starting dynamic subtest: vcs1
[553.198391] Dynamic subtest vcs1: SUCCESS (4.964s)
[553.207751] Starting dynamic subtest: vecs0
[571.195573] Dynamic subtest vecs0: SUCCESS (5.012s)
[571.205038] Starting dynamic subtest: ccs0
[589.202745] Dynamic subtest ccs0: SUCCESS (3.227s)
[589.204914] Subtest preservation-S3: SUCCESS (19.767s)
[601.498623] [039/131] (441s left) gem_exec_schedule (promotion)
[601.594661] Starting subtest: promotion
[601.596638] Starting dynamic subtest: rcs0
[601.782790] Dynamic subtest rcs0: SUCCESS (0.189s)
[601.795728] Starting dynamic subtest: vcs0
[601.940093] Dynamic subtest vcs0: SUCCESS (0.157s)
[601.950968] Starting dynamic subtest: vcs1
[602.078496] Dynamic subtest vcs1: SUCCESS (0.136s)
[602.091600] Starting dynamic subtest: vecs0
[602.207906] Dynamic subtest vecs0: SUCCESS (0.128s)
[602.220251] Starting dynamic subtest: ccs0
[602.335183] Dynamic subtest ccs0: SUCCESS (0.126s)
[602.338102] Subtest promotion: SUCCESS (0.742s)
[603.631540] [040/131] (439s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[603.753344] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[603.757316] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[603.897678] [041/131] (439s left) kms_draw_crc (draw-method-blt)
[604.008298] Starting subtest: draw-method-blt
[604.010099] Starting dynamic subtest: xrgb8888-untiled
[604.228726] Dynamic subtest xrgb8888-untiled: SUCCESS (0.222s)
[604.242569] Starting dynamic subtest: rgb565-untiled
[604.462330] Dynamic subtest rgb565-untiled: SUCCESS (0.232s)
[604.471320] Starting dynamic subtest: xrgb2101010-untiled
[604.684573] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[604.693800] Starting dynamic subtest: xbgr16161616f-untiled
[604.896039] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.210s)
[604.907160] Starting dynamic subtest: xrgb8888-xtiled
[605.018253] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.120s)
[605.027258] Starting dynamic subtest: rgb565-xtiled
[605.140915] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s)
[605.152104] Starting dynamic subtest: xrgb2101010-xtiled
[605.251766] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s)
[605.260506] Starting dynamic subtest: xbgr16161616f-xtiled
[605.363138] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.110s)
[605.371652] Starting dynamic subtest: xrgb8888-4tiled
[605.485399] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.121s)
[605.496812] Starting dynamic subtest: rgb565-4tiled
[605.607597] Dynamic subtest rgb565-4tiled: SUCCESS (0.121s)
[605.615918] Starting dynamic subtest: xrgb2101010-4tiled
[605.718936] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.110s)
[605.727474] Starting dynamic subtest: xbgr16161616f-4tiled
[605.830326] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.110s)
[605.832284] Subtest draw-method-blt: SUCCESS (1.823s)
[605.990695] [042/131] (437s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[606.102576] Starting subtest: psr-indfb-scaledprimary
[611.923696] Subtest psr-indfb-scaledprimary: SUCCESS (5.817s)
[612.099450] [043/131] (431s left) gem_eio (in-flight-1us)