[57.929968] Initializing watchdogs
[57.930022]   /dev/watchdog0
[57.945210] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.949673] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.952082] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.955360] [001/133] (960s left) kms_flip (2x-blocking-absolute-wf_vblank)
[58.086780] Starting subtest: 2x-blocking-absolute-wf_vblank
[58.095792] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.011s)
[58.184723] [002/133] (960s left) kms_pm_backlight (fade)
[58.287686] Starting subtest: fade
[58.383567] Starting dynamic subtest: eDP-1
[62.114840] Dynamic subtest eDP-1: SUCCESS (3.776s)
[62.116900] Subtest fade: SUCCESS (3.877s)
[62.471471] [003/133] (956s left) kms_psr (pr-cursor-blt)
[62.578296] Starting subtest: pr-cursor-blt
[62.582829] Subtest pr-cursor-blt: SKIP (0.000s)
[62.647365] [004/133] (955s left) gem_ctx_exec (basic-close-race)
[62.698053] Starting subtest: basic-close-race
[68.827146] Subtest basic-close-race: SUCCESS (6.118s)
[68.906684] [005/133] (949s left) gem_tiled_blits (basic)
[68.964440] Subtest basic: SKIP (0.000s)
[69.029970] [006/133] (949s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[69.150287] Starting subtest: y-tiled-64bpp-rotate-0
[69.154490] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[69.268237] [007/133] (949s left) gem_ctx_param (basic)
[69.313601] Starting subtest: basic
[69.315991] Subtest basic: SUCCESS (0.001s)
[69.414662] [008/133] (949s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[69.463605] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[69.467578] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[69.576899] [009/133] (949s left) kms_chamelium_hpd (hdmi-hpd-fast)
[69.958057] Subtest hdmi-hpd-fast: SKIP (0.000s)
[70.729284] [010/133] (948s left) gem_spin_batch (legacy-resubmit)
[70.794794] Starting subtest: legacy-resubmit
[70.797401] Starting dynamic subtest: default
[70.802066] Dynamic subtest default: SUCCESS (0.005s)
[70.810261] Starting dynamic subtest: render
[70.812667] Dynamic subtest render: SUCCESS (0.001s)
[70.822155] Starting dynamic subtest: bsd
[70.824291] Dynamic subtest bsd: SUCCESS (0.002s)
[70.831837] Starting dynamic subtest: bsd1
[70.834024] Dynamic subtest bsd1: SUCCESS (0.001s)
[70.841586] Starting dynamic subtest: bsd2
[70.843735] Dynamic subtest bsd2: SUCCESS (0.002s)
[70.851296] Starting dynamic subtest: blt
[70.853462] Dynamic subtest blt: SUCCESS (0.002s)
[70.861072] Starting dynamic subtest: vebox
[70.863304] Dynamic subtest vebox: SUCCESS (0.003s)
[70.865538] Subtest legacy-resubmit: SUCCESS (0.019s)
[71.038420] [011/133] (947s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[71.101399] Starting subtest: multi-wait-all-for-submit-unsubmitted
[71.203664] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.102s)
[71.290914] [012/133] (947s left) kms_async_flips (async-flip-dpms)
[71.379095] Starting subtest: async-flip-dpms
[71.750765] Starting dynamic subtest: pipe-A-eDP-1
[75.662107] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.919s)
[76.044867] Starting dynamic subtest: pipe-B-eDP-1
[78.830784] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.798s)
[79.220616] Starting dynamic subtest: pipe-C-eDP-1
[81.999272] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.786s)
[82.385735] Starting dynamic subtest: pipe-D-eDP-1
[85.174635] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.796s)
[85.176950] Subtest async-flip-dpms: SUCCESS (13.815s)
[86.367199] [013/133] (932s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[86.464361] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[86.468744] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[87.586187] [014/133] (931s left) kms_psr (fbc-psr2-primary-blt)
[87.687295] Starting subtest: fbc-psr2-primary-blt
[87.689627] Starting dynamic subtest: eDP-1
[87.694260] Dynamic subtest eDP-1: SKIP (0.000s)
[87.698944] Subtest fbc-psr2-primary-blt: SKIP (0.000s)
[87.755720] [015/133] (931s left) gem_exec_flush (basic-wb-prw-default)
[87.821875] Starting subtest: basic-wb-prw-default
[93.309192] Subtest basic-wb-prw-default: SUCCESS (5.462s)
[93.473413] [016/133] (925s left) i915_pm_rps (min-max-config-loaded)
[93.545757] Starting subtest: min-max-config-loaded
[93.550410] Subtest min-max-config-loaded: SKIP (0.001s)
[93.655691] [017/133] (925s left) kms_psr2_su (page_flip-xrgb8888)
[93.705090] Subtest page_flip-XRGB8888: SKIP (0.000s)
[93.758367] [018/133] (925s left) kms_addfb_basic (tile-pitch-mismatch)
[93.810740] Starting subtest: tile-pitch-mismatch
[93.816134] Subtest tile-pitch-mismatch: SKIP (0.000s)
[93.937527] [019/133] (925s left) prime_self_import (basic-with_two_bos)
[93.972444] Starting subtest: basic-with_two_bos
[93.991737] Subtest basic-with_two_bos: SUCCESS (0.021s)
[94.102026] [020/133] (925s left) gem_pipe_control_store_loop (reused-buffer)
[94.160178] Starting subtest: reused-buffer
[96.312233] Subtest reused-buffer: SUCCESS (2.153s)
[96.448971] [021/133] (922s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[96.498573] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[96.602826] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.102s)
[96.696101] [022/133] (922s left) i915_hangman (gt-engine-hang)
[96.759815] Starting subtest: gt-engine-hang
[96.761986] Starting dynamic subtest: rcs0
[98.278672] Dynamic subtest rcs0: SUCCESS (1.517s)
[98.291038] Starting dynamic subtest: bcs0
[100.263880] Dynamic subtest bcs0: SUCCESS (1.984s)
[100.275100] Starting dynamic subtest: vcs0
[102.245039] Dynamic subtest vcs0: SUCCESS (1.980s)
[102.259165] Starting dynamic subtest: vcs1
[104.292990] Dynamic subtest vcs1: SUCCESS (2.047s)
[104.304168] Starting dynamic subtest: vecs0
[106.277857] Dynamic subtest vecs0: SUCCESS (1.983s)
[106.288163] Starting dynamic subtest: ccs0
[108.261060] Dynamic subtest ccs0: SUCCESS (1.982s)
[108.264203] Subtest gt-engine-hang: SUCCESS (11.500s)
[108.346494] [023/133] (910s left) syncobj_wait (reset-multiple-signaled)
[108.402184] Starting subtest: reset-multiple-signaled
[108.404328] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[108.498257] [024/133] (910s left) kms_cursor_edge_walk (256x256-right-edge)
[108.591723] Starting subtest: 256x256-right-edge
[108.593926] Starting dynamic subtest: pipe-A-eDP-1
[112.041556] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.451s)
[112.051496] Starting dynamic subtest: pipe-D-eDP-1
[115.173156] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.130s)
[115.175561] Subtest 256x256-right-edge: SUCCESS (6.583s)
[115.993792] [025/133] (903s left) api_intel_bb (full-batch)
[116.058985] Starting subtest: full-batch
[116.064087] Subtest full-batch: SUCCESS (0.005s)
[116.206734] [026/133] (903s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[116.319296] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[116.323626] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[116.409305] [027/133] (903s left) gem_exec_flush (basic-wb-ro-default)
[116.463979] Starting subtest: basic-wb-ro-default
[121.950600] Subtest basic-wb-ro-default: SUCCESS (5.457s)
[122.126861] [028/133] (897s left) kms_getfb (getfb-reject-nv12)
[122.221921] Starting subtest: getfb-reject-nv12
[122.224248] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[122.322602] [029/133] (897s left) kms_rotation_crc (exhaust-fences)
[122.402068] Starting subtest: exhaust-fences
[122.406409] Subtest exhaust-fences: SKIP (0.000s)
[122.486037] [030/133] (897s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[122.578784] Starting subtest: flip-primary-invalidate-overlay
[134.168429] Subtest flip-primary-invalidate-overlay: SUCCESS (11.590s)
[134.295243] [031/133] (885s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[134.402845] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[134.444798] [032/133] (885s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[134.534117] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[134.537574] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[134.601247] [033/133] (885s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[134.704590] Starting subtest: pr-overlay-primary-update-sf-dmg-area
[134.708171] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[134.783723] [034/133] (884s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[134.874349] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[141.834179] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.962s)
[141.970646] [035/133] (877s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[142.069120] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[142.073702] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[143.180928] [036/133] (876s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[143.279314] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[143.281752] Starting dynamic subtest: pipe-A
[144.326325] Dynamic subtest pipe-A: SUCCESS (1.049s)
[144.335738] Starting dynamic subtest: pipe-B
[146.482812] Dynamic subtest pipe-B: SUCCESS (2.156s)
[146.491399] Starting dynamic subtest: pipe-C
[147.688464] Dynamic subtest pipe-C: SUCCESS (1.204s)
[147.698202] Starting dynamic subtest: pipe-D
[148.913715] Dynamic subtest pipe-D: SUCCESS (1.225s)
[148.916076] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.637s)
[150.104292] [037/133] (869s left) kms_plane_multiple (tiling-4)
[150.194477] Starting subtest: tiling-4
[150.196390] Starting dynamic subtest: pipe-A-eDP-1
[154.041903] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.846s)
[154.052232] Starting dynamic subtest: pipe-B-eDP-1
[158.529254] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.487s)
[158.539658] Starting dynamic subtest: pipe-C-eDP-1
[162.929673] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.400s)
[162.938653] Starting dynamic subtest: pipe-D-eDP-1
[167.285962] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.354s)
[167.288302] Subtest tiling-4: SUCCESS (17.092s)
[168.085178] [038/133] (851s left) kms_cursor_crc (cursor-sliding-256x256)
[168.318838] Starting subtest: cursor-sliding-256x256
[168.321184] Starting dynamic subtest: pipe-A-eDP-1
[171.544914] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.223s)
[171.574944] Starting dynamic subtest: pipe-D-eDP-1
[175.482157] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.915s)
[175.484524] Subtest cursor-sliding-256x256: SUCCESS (7.164s)
[176.366260] [039/133] (843s left) kms_atomic (plane-invalid-params)
[176.459106] Starting subtest: plane-invalid-params
[176.461422] Starting dynamic subtest: pipe-A-eDP-1
[176.849467] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.388s)
[176.851401] Subtest plane-invalid-params: SUCCESS (0.390s)
[177.701547] [040/133] (842s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[177.785461] Starting subtest: fbc-psr-sprite-mmap-gtt
[177.787674] Starting dynamic subtest: eDP-1
[177.791677] Dynamic subtest eDP-1: SKIP (0.000s)
[177.795725] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[177.859720] [041/133] (842s left) gem_exec_whisper (basic-queues-forked-all)
[177.919894] Starting subtest: basic-queues-forked-all
[197.485208] Subtest basic-queues-forked-all: SUCCESS (19.559s)
[197.682353] [042/133] (822s left) gem_exec_balancer (invalid-bonds)
[197.751690] Starting subtest: invalid-bonds
[197.756073] Subtest invalid-bonds: SKIP (0.000s)
[198.072870] [043/133] (822s left) dumb_buffer (create-clear)
[198.121767] Starting subtest: create-clear
[232.210648] Subtest create-clear: SUCCESS (34.034s)
[232.252138] [044/133] (787s left) api_intel_allocator (alloc-simple)
[232.298490] Starting subtest: alloc-simple
[232.303394] Subtest alloc-simple: SUCCESS (0.006s)
[232.429867] [045/133] (787s left) gem_exec_params (invalid-fence-in)
[232.474400] Starting subtest: invalid-fence-in
[232.476664] Subtest invalid-fence-in: SUCCESS (0.000s)
[232.579107] [046/133] (787s left) kms_big_fb (linear-addfb)
[232.677679] Starting subtest: linear-addfb
[232.679986] Subtest linear-addfb: SUCCESS (0.000s)
[232.786035] [047/133] (787s left) gem_exec_parallel (userptr)
[232.850390] Starting subtest: userptr
[232.852637] Starting dynamic subtest: rcs0
[234.296069] Dynamic subtest rcs0: SUCCESS (1.448s)
[234.307859] Starting dynamic subtest: bcs0
[235.765029] Dynamic subtest bcs0: SUCCESS (1.467s)
[235.776668] Starting dynamic subtest: vcs0
[237.356217] Dynamic subtest vcs0: SUCCESS (1.587s)
[237.368773] Starting dynamic subtest: vcs1
[239.302083] Dynamic subtest vcs1: SUCCESS (1.945s)
[239.311946] Starting dynamic subtest: vecs0
[241.288078] Dynamic subtest vecs0: SUCCESS (1.984s)
[241.300849] Starting dynamic subtest: ccs0
[242.778831] Dynamic subtest ccs0: SUCCESS (1.490s)
[242.781203] Subtest userptr: SUCCESS (9.932s)
[242.971788] [048/133] (777s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[243.084041] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[243.088369] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[243.187038] [049/133] (777s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[243.281093] Starting subtest: primary-y-tiled-reflect-x-180
[243.351675] Subtest primary-y-tiled-reflect-x-180: SKIP (0.071s)
[243.452546] [050/133] (776s left) kms_vblank (wait-forked-busy)
[243.545094] Starting subtest: wait-forked-busy
[243.547379] Starting dynamic subtest: pipe-A-eDP-1
[245.433471] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.888s)
[245.448210] Starting dynamic subtest: pipe-D-eDP-1
[247.959934] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.523s)
[247.962339] Subtest wait-forked-busy: SUCCESS (4.415s)
[248.773571] [051/133] (771s left) gem_mmap_offset (blt-coherency)
[248.825173] Starting subtest: blt-coherency
[248.830758] Subtest blt-coherency: SUCCESS (0.008s)
[248.948993] [052/133] (771s left) gem_exec_fence (expired-history)
[249.419340] Starting subtest: expired-history
[257.029439] Subtest expired-history: SUCCESS (7.611s)
[257.585406] [FACT gem_exec_fence (expired-history)] new: kernel.kmod_is_loaded.vgem: true
[257.588388] [053/133] (762s left) gem_render_copy (yf-tiled-to-vebox-linear)
[257.648725] Starting subtest: yf-tiled-to-vebox-linear
[257.653264] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[257.832907] [054/133] (762s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[257.938077] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[257.942727] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[258.043287] [055/133] (762s left) gem_lmem_swapping (verify-random)
[258.084782] Subtest verify-random: SKIP (0.000s)
[258.127646] [056/133] (762s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[258.233825] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[265.648062] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.417s)
[265.776521] [057/133] (754s left) perf_pmu (module-unload)