[60.813967] Initializing watchdogs
[60.814090]   /dev/watchdog0
[60.828144] [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.832422] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.834531] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.837753] [001/134] (960s left) kms_atomic_transition (plane-toggle-modeset-transition)
[60.956747] Starting subtest: plane-toggle-modeset-transition
[60.958947] Starting dynamic subtest: pipe-A-eDP-1
[73.691571] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.733s)
[73.699917] Starting dynamic subtest: pipe-B-eDP-1
[86.114174] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.422s)
[86.116663] Subtest plane-toggle-modeset-transition: SUCCESS (25.160s)
[86.946508] [002/134] (934s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[87.052269] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[87.054596] Starting dynamic subtest: pipe-A-eDP-1
[87.078316] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[87.087242] Starting dynamic subtest: pipe-B-eDP-1
[87.108945] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[87.115440] Starting dynamic subtest: pipe-C-eDP-1
[87.137349] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[87.143935] Starting dynamic subtest: pipe-D-eDP-1
[87.166707] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[87.170751] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.004s)
[89.218907] [003/134] (932s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[89.313252] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[89.317369] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[89.423407] [004/134] (932s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[89.520298] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[89.522606] Starting dynamic subtest: pipe-A-eDP-1
[89.547847] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[89.557117] Starting dynamic subtest: pipe-B-eDP-1
[89.580515] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[89.587907] Starting dynamic subtest: pipe-C-eDP-1
[89.611944] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[89.620105] Starting dynamic subtest: pipe-D-eDP-1
[89.643709] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[89.647635] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.003s)
[91.801598] [005/134] (929s left) kms_cursor_crc (cursor-size-change)
[91.889890] Starting subtest: cursor-size-change
[91.891833] Starting dynamic subtest: pipe-A-eDP-1
[92.708075] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.818s)
[92.717324] Starting dynamic subtest: pipe-D-eDP-1
[94.122135] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.413s)
[94.124659] Subtest cursor-size-change: SUCCESS (2.233s)
[94.956183] [006/134] (926s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[95.015744] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[95.018159] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[95.149179] [007/134] (926s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[95.208811] Starting subtest: invalid-single-wait-all-unsubmitted
[95.210993] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[95.350273] [008/134] (926s left) kms_flip_event_leak (basic)
[95.457977] Starting subtest: basic
[95.460161] Starting dynamic subtest: pipe-A-eDP-1
[95.884919] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.427s)
[95.893519] Starting dynamic subtest: pipe-B-eDP-1
[96.980789] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.093s)
[96.988767] Starting dynamic subtest: pipe-C-eDP-1
[98.090142] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.111s)
[98.099055] Starting dynamic subtest: pipe-D-eDP-1
[99.220949] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.128s)
[99.223391] Subtest basic: SUCCESS (3.763s)
[100.100771] [009/134] (921s left) syncobj_wait (single-wait-submitted)
[100.163959] Starting subtest: single-wait-submitted
[100.273196] Subtest single-wait-submitted: SUCCESS (0.107s)
[100.373102] [010/134] (921s left) gem_render_copy (yf-tiled-to-vebox-linear)
[100.440820] Starting subtest: yf-tiled-to-vebox-linear
[100.445334] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[100.645193] [011/134] (921s left) gem_exec_reloc (basic-write-cpu-active)
[100.721380] Subtest basic-write-cpu-active: SKIP (0.000s)
[100.777313] [012/134] (920s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[100.885796] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[100.890325] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[101.032811] [013/134] (920s left) core_auth (basic-auth)
[101.101446] Starting subtest: basic-auth
[101.103765] Subtest basic-auth: SUCCESS (0.001s)
[101.247153] [014/134] (920s left) gem_lmem_swapping (verify-ccs)
[101.286610] Subtest verify-ccs: SKIP (0.000s)
[101.323414] [015/134] (920s left) kms_flip (wf_vblank-ts-check)
[101.411449] Starting subtest: wf_vblank-ts-check
[101.413828] Starting dynamic subtest: A-eDP1
[110.322522] Dynamic subtest A-eDP1: SUCCESS (8.910s)
[110.329844] Starting dynamic subtest: B-eDP1
[119.259163] Dynamic subtest B-eDP1: SUCCESS (8.936s)
[119.276800] Starting dynamic subtest: C-eDP1
[128.182693] Dynamic subtest C-eDP1: SUCCESS (8.922s)
[128.191661] Starting dynamic subtest: D-eDP1
[137.118236] Dynamic subtest D-eDP1: SUCCESS (8.935s)
[137.120684] Subtest wf_vblank-ts-check: SUCCESS (35.710s)
[138.362179] [016/134] (883s left) fbdev (eof)
[138.403941] Starting subtest: eof
[138.406375] Subtest eof: SUCCESS (0.000s)
[138.493847] [017/134] (883s left) gem_tiled_wc
[138.619628] [018/134] (883s left) api_intel_bb (bb-with-allocator)
[138.676842] Starting subtest: bb-with-allocator
[138.681624] Subtest bb-with-allocator: SUCCESS (0.005s)
[138.853391] [019/134] (883s left) kms_frontbuffer_tracking (fbcpsr-abgr161616f-draw-mmap-wc)
[138.952654] Starting subtest: fbcpsr-abgr161616f-draw-mmap-wc
[138.956854] Subtest fbcpsr-abgr161616f-draw-mmap-wc: SKIP (0.000s)
[139.095153] [020/134] (882s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[139.194273] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[145.905925] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.716s)
[146.051637] [021/134] (876s left) kms_vblank (query-forked)
[146.161055] Starting subtest: query-forked
[146.163269] Starting dynamic subtest: pipe-A-eDP-1
[147.991931] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.828s)
[148.005396] Starting dynamic subtest: pipe-D-eDP-1
[150.484120] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.489s)
[150.486082] Subtest query-forked: SUCCESS (4.321s)
[151.361220] [022/134] (870s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[151.458991] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[151.461264] Starting dynamic subtest: pipe-A
[151.795728] Dynamic subtest pipe-A: SUCCESS (0.339s)
[151.804263] Starting dynamic subtest: pipe-B
[153.276115] Dynamic subtest pipe-B: SUCCESS (1.480s)
[153.284169] Starting dynamic subtest: pipe-C
[154.678574] Dynamic subtest pipe-C: SUCCESS (1.402s)
[154.685893] Starting dynamic subtest: pipe-D
[156.092181] Dynamic subtest pipe-D: SUCCESS (1.413s)
[156.094585] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.636s)
[157.272735] [023/134] (864s left) kms_psr (psr-basic)
[157.375419] Starting subtest: psr-basic
[157.377829] Starting dynamic subtest: eDP-1
[159.045933] Dynamic subtest eDP-1: SUCCESS (1.670s)
[159.048313] Subtest psr-basic: SUCCESS (1.671s)
[159.937510] [024/134] (862s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[160.048115] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[160.050466] Starting dynamic subtest: pipe-A-default-mode
[160.336850] Dynamic subtest pipe-A-default-mode: SKIP (0.288s)
[160.341572] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.289s)
[161.185573] [025/134] (861s left) kms_plane_multiple (tiling-y)
[161.295377] Starting subtest: tiling-y
[161.299598] Subtest tiling-y: SKIP (0.000s)
[161.388574] [026/134] (860s left) drm_read (empty-block)
[161.535203] Starting subtest: empty-block
[162.533753] Subtest empty-block: SUCCESS (1.000s)
[162.712320] [027/134] (859s left) kms_psr (fbc-psr-primary-blt)
[162.825351] Starting subtest: fbc-psr-primary-blt
[162.827420] Starting dynamic subtest: eDP-1
[162.831719] Dynamic subtest eDP-1: SKIP (0.000s)
[162.835847] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[162.915763] [028/134] (859s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[163.037783] Starting subtest: flip-vs-cursor-crc-atomic
[163.736068] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.697s)
[164.604777] [029/134] (857s left) vgem_basic (bad-handle)
[164.691082] Starting subtest: bad-handle
[164.693261] Subtest bad-handle: SUCCESS (0.000s)
[164.767371] [FACT vgem_basic (bad-handle)] new: kernel.kmod_is_loaded.vgem: true
[164.770541] [030/134] (857s left) kms_async_flips (async-flip-suspend-resume)
[164.867977] Starting subtest: async-flip-suspend-resume
[165.252483] Starting dynamic subtest: pipe-A-eDP-1
[183.402125] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.048s)
[183.768785] Starting dynamic subtest: pipe-B-eDP-1
[201.371316] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.878s)
[201.749315] Starting dynamic subtest: pipe-C-eDP-1
[219.409143] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.898s)
[219.778571] Starting dynamic subtest: pipe-D-eDP-1
[237.404077] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.891s)
[237.406991] Subtest async-flip-suspend-resume: SUCCESS (13.192s)
[238.621095] [031/134] (783s left) gem_exec_fence (syncobj-unused-fence)
[239.055938] Starting subtest: syncobj-unused-fence
[239.062352] Subtest syncobj-unused-fence: SUCCESS (0.005s)
[240.289103] [032/134] (782s left) gem_exec_fence (expired-history)
[240.706559] Starting subtest: expired-history
[247.955611] Subtest expired-history: SUCCESS (7.238s)
[248.550065] [033/134] (774s left) perf (oa-formats)
[248.709973] Starting subtest: oa-formats
[248.712687] Starting dynamic subtest: 0-rcs0
[248.724791] Dynamic subtest 0-rcs0: SUCCESS (0.016s)
[248.733748] Starting dynamic subtest: 1-vecs0
[248.750116] Dynamic subtest 1-vecs0: SUCCESS (0.025s)
[248.753092] Subtest oa-formats: SUCCESS (0.043s)
[248.801565] [034/134] (773s left) gem_exec_schedule (thriceslice)
[248.876568] Starting subtest: thriceslice
[248.878963] Starting dynamic subtest: rcs0
[248.893602] Dynamic subtest rcs0: SUCCESS (0.030s)
[248.904242] Starting dynamic subtest: bcs0
[248.931252] Dynamic subtest bcs0: SUCCESS (0.037s)
[248.940564] Starting dynamic subtest: vcs0
[248.964312] Dynamic subtest vcs0: SUCCESS (0.032s)
[248.975247] Starting dynamic subtest: vcs1
[248.998218] Dynamic subtest vcs1: SUCCESS (0.033s)
[249.009485] Starting dynamic subtest: vecs0
[249.025877] Dynamic subtest vecs0: SUCCESS (0.028s)
[249.033717] Starting dynamic subtest: ccs0
[249.081690] Dynamic subtest ccs0: SUCCESS (0.055s)
[249.084214] Subtest thriceslice: SUCCESS (0.218s)
[250.315510] [035/134] (772s left) gem_mmap_wc (pf-nonblock)
[250.387972] Subtest pf-nonblock: SKIP (0.000s)
[250.454352] [036/134] (772s left) kms_addfb_basic (too-high)
[250.553815] Starting subtest: too-high
[250.556433] Subtest too-high: SUCCESS (0.001s)
[250.670547] [037/134] (772s left) gem_ctx_isolation (nonpriv)
[250.741910] Starting subtest: nonpriv
[250.744716] Starting dynamic subtest: rcs0
[250.998877] Dynamic subtest rcs0: SUCCESS (0.256s)
[251.007245] Starting dynamic subtest: bcs0
[251.248473] Dynamic subtest bcs0: SUCCESS (0.249s)
[251.256604] Starting dynamic subtest: vcs0
[251.532044] Dynamic subtest vcs0: SUCCESS (0.282s)
[251.540244] Starting dynamic subtest: vcs1
[253.538483] Dynamic subtest vcs1: SUCCESS (2.004s)
[253.549240] Starting dynamic subtest: vecs0
[255.530988] Dynamic subtest vecs0: SUCCESS (1.990s)
[255.543458] Starting dynamic subtest: ccs0
[257.536215] Dynamic subtest ccs0: SUCCESS (2.003s)
[257.538986] Subtest nonpriv: SUCCESS (6.789s)
[257.813579] [038/134] (764s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[257.880205] Subtest no-spare-fences-busy: SKIP (0.000s)
[257.961619] [039/134] (764s left) gem_softpin (32b-excludes-last-page)
[258.035066] Starting subtest: 32b-excludes-last-page
[258.040370] Subtest 32b-excludes-last-page: SUCCESS (0.006s)
[258.211294] [040/134] (764s left) kms_vrr (lobf)
[258.312023] Starting subtest: lobf
[258.317224] Subtest lobf: SKIP (0.000s)
[258.414829] [041/134] (764s left) kms_prop_blob (invalid-get-prop-any)
[258.468498] Starting subtest: invalid-get-prop-any
[258.470618] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[258.584491] [042/134] (764s left) gem_exec_fence (basic-busy)
[258.761931] Starting subtest: basic-busy
[258.765083] Starting dynamic subtest: rcs0
[258.852144] Dynamic subtest rcs0: SUCCESS (0.090s)
[258.863248] Starting dynamic subtest: bcs0
[258.906220] Dynamic subtest bcs0: SUCCESS (0.052s)
[258.916411] Starting dynamic subtest: vcs0
[258.970698] Dynamic subtest vcs0: SUCCESS (0.062s)
[258.983234] Starting dynamic subtest: vcs1
[259.028192] Dynamic subtest vcs1: SUCCESS (0.056s)
[259.038411] Starting dynamic subtest: vecs0
[259.082712] Dynamic subtest vecs0: SUCCESS (0.053s)
[259.094135] Starting dynamic subtest: ccs0
[259.142805] Dynamic subtest ccs0: SUCCESS (0.058s)
[259.145711] Subtest basic-busy: SUCCESS (0.382s)
[261.315724] [043/134] (761s left) gem_userptr_blits (probe)
[261.390514] Starting subtest: probe
[261.461040] Subtest probe: SUCCESS (0.070s)
[261.632877] [044/134] (761s left) syncobj_wait (multi-wait-all-submitted-signaled)
[261.696251] Starting subtest: multi-wait-all-submitted-signaled
[261.795798] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.101s)
[261.901570] [045/134] (761s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[262.012915] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[266.519111] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.508s)
[267.671607] [046/134] (755s left) kms_dsc (dsc-with-bpc)
[267.776987] Starting subtest: dsc-with-bpc
[267.813278] Subtest dsc-with-bpc: SKIP (0.001s)
[267.871480] [047/134] (755s left) gem_exec_flush (basic-wb-ro-default)
[267.944973] Starting subtest: basic-wb-ro-default
[273.417024] Subtest basic-wb-ro-default: SUCCESS (5.469s)
[273.630239] [048/134] (749s left) gem_exec_whisper (basic-queues-forked-all)
[273.707746] Starting subtest: basic-queues-forked-all
[295.679105] Subtest basic-queues-forked-all: SUCCESS (21.957s)
[295.883778] [049/134] (727s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[295.986249] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[295.988619] Starting dynamic subtest: pipe-A-eDP-1
[296.012199] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[296.021217] Starting dynamic subtest: pipe-B-eDP-1
[296.047313] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[296.056900] Starting dynamic subtest: pipe-C-eDP-1
[296.079707] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[296.088046] Starting dynamic subtest: pipe-D-eDP-1
[296.113444] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[296.118103] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[298.325085] [050/134] (724s left) kms_atomic (crtc-invalid-params-fence)
[298.424090] Starting subtest: crtc-invalid-params-fence
[298.426828] Starting dynamic subtest: pipe-A-eDP-1
[298.821425] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.395s)
[298.823908] Subtest crtc-invalid-params-fence: SUCCESS (0.397s)
[299.642307] [051/134] (723s left) kms_chamelium_hpd (hdmi-hpd)
[300.031017] Subtest hdmi-hpd: SKIP (0.000s)
[300.830871] [052/134] (722s left) kms_psr (psr-cursor-blt)
[300.928109] Starting subtest: psr-cursor-blt
[300.931032] Starting dynamic subtest: eDP-1
[302.651222] Dynamic subtest eDP-1: SUCCESS (1.722s)
[302.654247] Subtest psr-cursor-blt: SUCCESS (1.723s)
[303.548064] [053/134] (719s left) gem_tiled_partial_pwrite_pread (writes)
[303.605861] Subtest writes: SKIP (0.000s)
[303.688256] [054/134] (719s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[303.749190] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[303.853231] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.104s)
[303.954840] [055/134] (719s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[304.011267] Starting subtest: single-wait-for-submit-unsubmitted
[304.117758] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.106s)
[304.220867] [056/134] (719s left) kms_frontbuffer_tracking (fbc-argb161616f-draw-blt)
[304.326084] Starting subtest: fbc-argb161616f-draw-blt
[304.331598] Subtest fbc-argb161616f-draw-blt: SKIP (0.000s)
[304.455509] [057/134] (719s left) kms_cursor_crc (cursor-size-hints)
[304.601239] Starting subtest: cursor-size-hints
[304.604012] Starting dynamic subtest: pipe-A-eDP-1
[305.219039] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.617s)
[305.227686] Starting dynamic subtest: pipe-D-eDP-1
[306.489699] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.271s)
[306.492202] Subtest cursor-size-hints: SUCCESS (1.891s)
[307.314496] [058/134] (716s left) gem_exec_balancer (parallel)
[307.573004] Starting subtest: parallel
[308.465874] Subtest parallel: SUCCESS (0.892s)
[309.256630] [059/134] (714s left) gem_exec_store (dword)
[309.326207] Starting subtest: dword
[309.328489] Starting dynamic subtest: rcs0
[309.416789] Dynamic subtest rcs0: SUCCESS (0.092s)
[309.429022] Starting dynamic subtest: bcs0
[309.459892] Dynamic subtest bcs0: SUCCESS (0.041s)
[309.470744] Starting dynamic subtest: vcs0
[309.502660] Dynamic subtest vcs0: SUCCESS (0.041s)
[309.512564] Starting dynamic subtest: vcs1
[309.547183] Dynamic subtest vcs1: SUCCESS (0.043s)
[309.557720] Starting dynamic subtest: vecs0
[309.588964] Dynamic subtest vecs0: SUCCESS (0.040s)
[309.600237] Starting dynamic subtest: ccs0
[309.633226] Dynamic subtest ccs0: SUCCESS (0.042s)
[309.636078] Subtest dword: SUCCESS (0.310s)
[309.839840] [060/134] (713s left) kms_lease (atomic-implicit-crtc)
[309.942295] Starting subtest: atomic-implicit-crtc
[309.944694] Starting dynamic subtest: pipe-A-eDP-1
[309.957084] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[309.968230] Starting dynamic subtest: pipe-B-eDP-1
[309.982760] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[309.992028] Starting dynamic subtest: pipe-C-eDP-1
[310.005107] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s)
[310.014204] Starting dynamic subtest: pipe-D-eDP-1
[310.028701] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.009s)
[310.031199] Subtest atomic-implicit-crtc: SUCCESS (0.035s)
[310.104519] [061/134] (713s left) perf_pmu (multi-client)
[310.150103] Starting subtest: multi-client
[310.152894] Starting dynamic subtest: rcs0
[311.230532] Dynamic subtest rcs0: SUCCESS (1.080s)
[311.243605] Starting dynamic subtest: bcs0
[312.283754] Dynamic subtest bcs0: SUCCESS (1.049s)
[312.296242] Starting dynamic subtest: vcs0
[313.335860] Dynamic subtest vcs0: SUCCESS (1.048s)
[313.347017] Starting dynamic subtest: vcs1
[315.262146] Dynamic subtest vcs1: SUCCESS (1.924s)
[315.274260] Starting dynamic subtest: vecs0
[317.247589] Dynamic subtest vecs0: SUCCESS (1.982s)
[317.260409] Starting dynamic subtest: ccs0
[319.234881] Dynamic subtest ccs0: SUCCESS (1.983s)
[319.238128] Subtest multi-client: SUCCESS (9.083s)
[319.375498] [062/134] (704s left) gem_exec_schedule (lateslice)
[319.458947] Starting subtest: lateslice
[319.461805] Starting dynamic subtest: rcs0
[319.479156] Dynamic subtest rcs0: SUCCESS (0.033s)
[319.490014] Starting dynamic subtest: bcs0
[319.506732] Dynamic subtest bcs0: SUCCESS (0.026s)
[319.515330] Starting dynamic subtest: vcs0
[319.533577] Dynamic subtest vcs0: SUCCESS (0.026s)
[319.541906] Starting dynamic subtest: vcs1
[319.555193] Dynamic subtest vcs1: SUCCESS (0.022s)
[319.565196] Starting dynamic subtest: vecs0
[319.578832] Dynamic subtest vecs0: SUCCESS (0.022s)
[319.587727] Starting dynamic subtest: ccs0
[319.600676] Dynamic subtest ccs0: SUCCESS (0.021s)
[319.603246] Subtest lateslice: SUCCESS (0.155s)
[321.335890] [063/134] (702s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[321.442972] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[321.448213] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[321.573909] [064/134] (702s left) i915_pm_sseu (full-enable)
[321.639976] Subtest full-enable: SKIP (0.000s)
[321.781128] [065/134] (702s left) syncobj_wait (reset-multiple-signaled)
[321.841241] Starting subtest: reset-multiple-signaled
[321.843739] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[321.959402] [066/134] (701s left) api_intel_bb (reset-flags)
[322.009630] Starting subtest: reset-flags
[322.015530] Subtest reset-flags: SUCCESS (0.008s)
[322.167586] [067/134] (701s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[322.230874] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[322.309111] [068/134] (701s left) gem_ctx_shared (exec-shared-gtt)
[322.378621] Starting subtest: exec-shared-gtt
[322.380482] Starting dynamic subtest: rcs0
[322.387113] Dynamic subtest rcs0: SUCCESS (0.011s)
[322.397574] Starting dynamic subtest: bcs0
[322.399650] Dynamic subtest bcs0: SUCCESS (0.006s)
[322.408853] Starting dynamic subtest: vcs0
[322.411085] Dynamic subtest vcs0: SUCCESS (0.007s)
[322.420494] Starting dynamic subtest: vcs1
[322.422457] Dynamic subtest vcs1: SUCCESS (0.007s)
[322.432053] Starting dynamic subtest: vecs0
[322.434616] Dynamic subtest vecs0: SUCCESS (0.006s)
[322.443453] Starting dynamic subtest: ccs0
[322.445673] Dynamic subtest ccs0: SUCCESS (0.007s)
[322.447963] Subtest exec-shared-gtt: SUCCESS (0.049s)
[322.640426] [069/134] (701s left) gem_linear_blits (basic)
[322.971978] Starting subtest: basic
[322.978842] Subtest basic: SUCCESS (0.011s)
[323.160823] [070/134] (700s left) perf_pmu (render-node-busy)
[323.308873] Starting subtest: render-node-busy
[323.311110] Starting dynamic subtest: rcs0
[323.883435] Dynamic subtest rcs0: SUCCESS (0.577s)
[323.895899] Starting dynamic subtest: bcs0
[324.442234] Dynamic subtest bcs0: SUCCESS (0.556s)
[324.454610] Starting dynamic subtest: vcs0
[326.217530] Dynamic subtest vcs0: SUCCESS (1.771s)
[326.228242] Starting dynamic subtest: vcs1
[328.201195] Dynamic subtest vcs1: SUCCESS (1.980s)
[328.214352] Starting dynamic subtest: vecs0
[330.248879] Dynamic subtest vecs0: SUCCESS (2.044s)
[330.261570] Starting dynamic subtest: ccs0
[330.824336] Dynamic subtest ccs0: SUCCESS (0.574s)
[330.827378] Subtest render-node-busy: SUCCESS (7.516s)
[330.928050] [071/134] (693s left) kms_chamelium_edid (dp-edid-resolution-list)
[331.340768] Subtest dp-edid-resolution-list: SKIP (0.000s)
[332.118454] [072/134] (692s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[332.211881] Starting subtest: fbc-pr-cursor-mmap-cpu
[332.217034] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[332.307700] [073/134] (691s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[332.413960] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[336.440847] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (4.045s)
[337.651998] [074/134] (686s left) gem_exec_params (invalid-fence-in)
[337.716869] Starting subtest: invalid-fence-in
[337.719821] Subtest invalid-fence-in: SUCCESS (0.000s)
[337.890514] [075/134] (686s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[337.989041] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[344.952026] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (6.981s)
[345.100645] [076/134] (679s left) kms_big_fb (yf-tiled-addfb)
[345.199002] Starting subtest: yf-tiled-addfb
[345.204261] Subtest yf-tiled-addfb: SKIP (0.000s)
[345.310809] [077/134] (679s left) kms_vblank (crtc-id)
[345.403972] Starting subtest: crtc-id
[345.406720] Starting dynamic subtest: pipe-A-eDP-1
[345.850909] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.444s)
[345.865864] Starting dynamic subtest: pipe-D-eDP-1
[346.992040] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.141s)
[346.995056] Subtest crtc-id: SUCCESS (1.589s)
[347.833649] [078/134] (676s left) kms_cursor_crc (cursor-onscreen-512x512)
[348.100741] Starting subtest: cursor-onscreen-512x512
[348.106019] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[348.293797] [079/134] (676s left) kms_psr (pr-sprite-plane-move)
[348.384294] Starting subtest: pr-sprite-plane-move
[348.389040] Subtest pr-sprite-plane-move: SKIP (0.000s)
[348.479887] [080/134] (676s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[348.580263] Starting subtest: y-tiled-64bpp-rotate-180
[348.585776] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[348.712510] [081/134] (675s left) i915_drm_fdinfo (memory-info-resident)
[348.754695] Starting subtest: memory-info-resident
[348.756501] Starting dynamic subtest: smem0
[351.560701] Dynamic subtest smem0: SUCCESS (2.811s)
[351.562979] Subtest memory-info-resident: SUCCESS (2.813s)
[351.667635] [082/134] (672s left) kms_pm_rpm (basic-pci-d3-state)
[353.410182] Starting subtest: basic-pci-d3-state
[354.881468] Subtest basic-pci-d3-state: SUCCESS (1.474s)
[355.003516] [083/134] (669s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[355.094950] Starting subtest: fbc-shrfb-scaledprimary
[358.161547] Subtest fbc-shrfb-scaledprimary: SUCCESS (3.073s)
[359.385736] [084/134] (665s left) sriov_basic (enable-vfs-autoprobe-off)
[359.451617] Starting subtest: enable-vfs-autoprobe-off
[359.454458] Starting dynamic subtest: numvfs-1
[359.557200] Dynamic subtest numvfs-1: FAIL (0.034s)
[359.567892] Starting dynamic subtest: numvfs-2
[359.643787] Dynamic subtest numvfs-2: FAIL (0.004s)
[359.652572] Starting dynamic subtest: numvfs-3
[359.734000] Dynamic subtest numvfs-3: FAIL (0.004s)
[359.744225] Starting dynamic subtest: numvfs-4
[359.823837] Dynamic subtest numvfs-4: FAIL (0.003s)
[359.832951] Starting dynamic subtest: numvfs-5
[359.920214] Dynamic subtest numvfs-5: FAIL (0.003s)
[359.930037] Starting dynamic subtest: numvfs-6
[360.015568] Dynamic subtest numvfs-6: FAIL (0.003s)
[360.025462] Starting dynamic subtest: numvfs-7
[360.110015] Dynamic subtest numvfs-7: FAIL (0.003s)
[360.120196] Starting dynamic subtest: numvfs-random
[360.203106] Dynamic subtest numvfs-random: FAIL (0.003s)
[360.211903] Starting dynamic subtest: numvfs-all
[360.286837] Dynamic subtest numvfs-all: FAIL (0.573s)
[360.288799] Subtest enable-vfs-autoprobe-off: FAIL (0.638s)
[360.324378] [085/134] (664s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[360.411880] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[360.413992] Starting dynamic subtest: pipe-A-eDP-1
[360.433626] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[360.443407] Starting dynamic subtest: pipe-B-eDP-1
[360.464014] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[360.472512] Starting dynamic subtest: pipe-C-eDP-1
[360.494409] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[360.502942] Starting dynamic subtest: pipe-D-eDP-1
[360.524923] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[360.528939] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[362.643078] [086/134] (662s left) gem_ctx_persistence (processes)
[362.709805] Starting subtest: processes
[364.191481] Subtest processes: SUCCESS (1.482s)
[364.292647] [087/134] (660s left) prime_mmap (test_errors)
[364.355916] Starting subtest: test_errors
[364.358777] Starting dynamic subtest: test_errors-smem
[364.497316] Dynamic subtest test_errors-smem: SUCCESS (0.141s)
[364.500318] Subtest test_errors: SUCCESS (0.143s)
[364.620005] [088/134] (660s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[364.751342] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[364.755946] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.001s)
[364.923428] [089/134] (659s left) gem_userptr_blits (unsync-unmap)
[364.998209] Subtest unsync-unmap: SKIP (0.000s)
[365.161608] [090/134] (659s left) gem_mmap (big-bo)
[365.226066] Subtest big-bo: SKIP (0.000s)
[365.301178] [091/134] (659s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[367.424539] Starting subtest: dpms-mode-unset-non-lpsp
[368.572034] Subtest dpms-mode-unset-non-lpsp: SKIP (1.145s)
[368.961278] [092/134] (656s left) kms_lease (lessee-list)
[369.068075] Starting subtest: lessee-list
[369.070876] Starting dynamic subtest: pipe-A-eDP-1
[369.073514] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[369.083789] Starting dynamic subtest: pipe-B-eDP-1
[369.086261] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[369.096093] Starting dynamic subtest: pipe-C-eDP-1
[369.098890] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[369.115033] Starting dynamic subtest: pipe-D-eDP-1
[369.118079] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[369.121073] Subtest lessee-list: SUCCESS (0.015s)
[369.213033] [093/134] (655s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[369.345568] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[370.329789] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.986s)
[371.210517] [094/134] (653s left) i915_pm_rpm (gem-execbuf)
[373.443390] Starting subtest: gem-execbuf
[373.446251] Starting dynamic subtest: smem0
[375.200942] Dynamic subtest smem0: SUCCESS (1.756s)
[375.203469] Subtest gem-execbuf: SUCCESS (1.759s)
[375.347119] [095/134] (649s left) kms_cursor_crc (cursor-sliding-512x170)
[375.646988] Starting subtest: cursor-sliding-512x170
[375.652051] Subtest cursor-sliding-512x170: SKIP (0.001s)
[375.815722] [096/134] (649s left) kms_plane_lowres (tiling-x)
[375.912905] Starting subtest: tiling-x
[375.915321] Starting dynamic subtest: pipe-A-eDP-1
[375.920433] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[376.225194] Starting dynamic subtest: pipe-B-eDP-1
[376.230619] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[376.240155] Starting dynamic subtest: pipe-C-eDP-1
[376.245770] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[376.255189] Starting dynamic subtest: pipe-D-eDP-1
[376.260870] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[376.266113] Subtest tiling-x: SKIP (0.312s)
[377.111991] [097/134] (648s left) kms_color (deep-color)
[377.210370] Starting subtest: deep-color
[378.266241] Starting dynamic subtest: pipe-A-eDP-1-gamma
[378.965663] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.702s)
[378.976491] Starting dynamic subtest: pipe-A-eDP-1-degamma
[380.483341] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.514s)
[380.493862] Starting dynamic subtest: pipe-A-eDP-1-ctm
[381.874537] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.393s)
[382.655935] Starting dynamic subtest: pipe-B-eDP-1-gamma
[383.394093] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.744s)
[383.405032] Starting dynamic subtest: pipe-B-eDP-1-degamma
[384.837004] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.444s)
[384.848999] Starting dynamic subtest: pipe-B-eDP-1-ctm
[386.255975] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.419s)
[387.044149] Starting dynamic subtest: pipe-C-eDP-1-gamma
[387.727449] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.693s)
[387.742199] Starting dynamic subtest: pipe-C-eDP-1-degamma
[389.097146] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.365s)
[389.113238] Starting dynamic subtest: pipe-C-eDP-1-ctm
[390.517066] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.423s)
[391.352428] Starting dynamic subtest: pipe-D-eDP-1-gamma
[392.046124] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.702s)
[392.057247] Starting dynamic subtest: pipe-D-eDP-1-degamma
[393.499145] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.452s)
[393.510128] Starting dynamic subtest: pipe-D-eDP-1-ctm
[394.922929] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.424s)
[394.925957] Subtest deep-color: SUCCESS (17.717s)
[395.806241] [098/134] (629s left) gem_mmap (basic)
[395.883059] Subtest basic: SKIP (0.000s)
[395.946171] [099/134] (629s left) gem_softpin (noreloc-interruptible)
[396.009592] Starting subtest: noreloc-interruptible
[401.411592] Subtest noreloc-interruptible: SUCCESS (5.401s)
[401.653265] [100/134] (623s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[401.767925] Starting subtest: fbc-pr-sprite-mmap-cpu
[401.772785] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[401.864230] [101/134] (623s left) syncobj_wait (multi-wait-signaled)
[401.937199] Starting subtest: multi-wait-signaled
[401.940040] Subtest multi-wait-signaled: SUCCESS (0.000s)
[402.072603] [102/134] (623s left) gem_busy (close-race)
[402.137099] Starting subtest: close-race
[426.249234] Subtest close-race: SUCCESS (24.110s)
[426.647808] [103/134] (598s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[426.795902] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[426.800903] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[426.930309] [104/134] (598s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[427.027024] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[427.032889] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[427.161484] [105/134] (598s left) gem_render_copy (linear-to-vebox-yf-tiled)
[427.215910] Starting subtest: linear-to-vebox-yf-tiled
[427.220978] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[427.423714] [106/134] (598s left) gem_mmap_wc (write-read-distinct)
[427.480188] Subtest write-read-distinct: SKIP (0.000s)
[427.538086] [107/134] (598s left) kms_frontbuffer_tracking (psr-abgr161616f-draw-mmap-wc)
[427.636982] Starting subtest: psr-abgr161616f-draw-mmap-wc
[427.642228] Subtest psr-abgr161616f-draw-mmap-wc: SKIP (0.000s)
[427.772522] [108/134] (597s left) gem_tiled_pread_basic
[427.914431] [109/134] (597s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[427.980014] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[428.046554] [110/134] (597s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[428.158234] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[428.859618] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.703s)
[429.039124] [111/134] (596s left) kms_atomic_transition (plane-all-transition-nonblocking)
[429.132856] Starting subtest: plane-all-transition-nonblocking
[429.135457] Starting dynamic subtest: pipe-A-eDP-1
[431.625804] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[431.933228] Starting dynamic subtest: pipe-B-eDP-1
[435.117149] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.192s)
[435.414214] Subtest plane-all-transition-nonblocking: SUCCESS (6.283s)
[436.271117] [112/134] (589s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[436.349085] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[436.428973] [113/134] (589s left) kms_getfb (getfb2-into-addfb2)
[436.531086] Starting subtest: getfb2-into-addfb2
[436.534043] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[436.652381] [114/134] (589s left) gem_eio (throttle)
[436.898133] Starting subtest: throttle
[437.231823] Subtest throttle: SUCCESS (0.332s)
[437.399512] [115/134] (588s left) gem_create (create-ext-placement-each)
[437.581117] Starting subtest: create-ext-placement-each
[437.584428] Subtest create-ext-placement-each: SUCCESS (0.000s)
[437.720783] [116/134] (588s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[442.723930] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[442.727013] Starting dynamic subtest: pipe-A-eDP-1
[443.515876] Dynamic subtest pipe-A-eDP-1: SKIP (0.788s)
[443.526386] Starting dynamic subtest: pipe-B-eDP-1
[444.653560] Dynamic subtest pipe-B-eDP-1: SKIP (1.136s)
[444.658349] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.929s)
[445.869627] [117/134] (580s left) gem_partial_pwrite_pread (writes-after-reads)
[445.932216] Subtest writes-after-reads: SKIP (0.000s)
[446.027664] [118/134] (580s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[446.124483] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[446.127152] Starting dynamic subtest: pipe-A-eDP-1
[447.330093] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.208s)
[447.340582] Starting dynamic subtest: pipe-B-eDP-1
[449.679040] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.347s)
[449.689788] Starting dynamic subtest: pipe-C-eDP-1
[451.960373] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.280s)
[451.971323] Starting dynamic subtest: pipe-D-eDP-1
[454.198337] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.237s)
[454.201388] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.078s)
[455.374620] [119/134] (570s left) kms_big_fb (linear-8bpp-rotate-90)
[455.493896] Starting subtest: linear-8bpp-rotate-90
[455.520236] Subtest linear-8bpp-rotate-90: SKIP (0.024s)
[455.664393] [120/134] (570s left) kms_busy (extended-modeset-hang-newfb)
[455.755645] Starting subtest: extended-modeset-hang-newfb
[455.757670] Starting dynamic subtest: pipe-A
[490.118942] Dynamic subtest pipe-A: SUCCESS (34.363s)
[490.131085] Starting dynamic subtest: pipe-D
[513.176244] Dynamic subtest pipe-D: SUCCESS (23.053s)
[513.179206] Subtest extended-modeset-hang-newfb: SUCCESS (57.421s)
[514.007341] [121/134] (512s left) dmabuf_sync_file (export-before-signal)
[514.054548] Starting subtest: export-before-signal
[514.057067] Subtest export-before-signal: SUCCESS (0.001s)
[514.137716] [122/134] (512s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[514.238208] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[521.663909] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.429s)
[521.827417] [123/134] (504s left) kms_tiled_display (basic-test-pattern)
[521.952455] Subtest basic-test-pattern: SKIP (0.000s)
[522.001721] [124/134] (504s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[522.114766] Starting subtest: x-tiled-64bpp-rotate-0
[523.828936] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.715s)
[524.021553] [125/134] (502s left) gem_mmap_gtt (hang-busy)
[524.076953] Subtest hang-busy: SKIP (0.000s)
[524.144181] [126/134] (502s left) gen9_exec_parse (batch-zero-length)
[524.205023] Subtest batch-zero-length: SKIP (0.000s)
[524.295790] [127/134] (502s left) sysfs_heartbeat_interval (nopreempt)
[524.353019] Starting subtest: nopreempt
[524.355756] Starting dynamic subtest: vecs0
[534.234233] Dynamic subtest vecs0: SUCCESS (9.876s)
[534.249879] Starting dynamic subtest: ccs0
[538.378569] Dynamic subtest ccs0: SUCCESS (4.145s)
[538.393717] Starting dynamic subtest: vcs0
[548.246019] Dynamic subtest vcs0: SUCCESS (9.864s)
[548.258884] Starting dynamic subtest: bcs0
[552.226812] Dynamic subtest bcs0: SUCCESS (3.980s)
[552.238957] Starting dynamic subtest: rcs0
[556.296727] Dynamic subtest rcs0: SUCCESS (4.068s)
[556.306975] Starting dynamic subtest: vcs1
[566.242346] Dynamic subtest vcs1: SUCCESS (9.941s)
[566.245121] Subtest nopreempt: SUCCESS (41.885s)
[566.362242] [128/134] (460s left) i915_hangman (gt-engine-hang)
[566.458245] Starting subtest: gt-engine-hang
[566.460948] Starting dynamic subtest: rcs0
[568.166988] Dynamic subtest rcs0: SUCCESS (1.709s)
[568.182982] Starting dynamic subtest: bcs0
[570.151196] Dynamic subtest bcs0: SUCCESS (1.981s)
[570.163971] Starting dynamic subtest: vcs0
[572.198203] Dynamic subtest vcs0: SUCCESS (2.044s)
[572.210225] Starting dynamic subtest: vcs1
[574.183532] Dynamic subtest vcs1: SUCCESS (1.982s)
[574.197249] Starting dynamic subtest: vecs0
[576.167394] Dynamic subtest vecs0: SUCCESS (1.981s)
[576.181684] Starting dynamic subtest: ccs0
[578.215481] Dynamic subtest ccs0: SUCCESS (2.045s)
[578.218154] Subtest gt-engine-hang: SUCCESS (11.760s)
[578.330429] [129/134] (448s left) syncobj_timeline (transfer-timeline-point)
[578.395627] Starting subtest: transfer-timeline-point
[578.398018] Subtest transfer-timeline-point: SUCCESS (0.000s)
[578.534346] [130/134] (448s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[578.657945] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[585.940207] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.286s)
[586.102092] [131/134] (440s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[586.202084] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[586.207787] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[586.334100] [132/134] (440s left) kms_content_protection (atomic-dpms-hdcp14)
[586.480072] Starting subtest: atomic-dpms-hdcp14
[586.485456] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[586.642189] [133/134] (440s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[586.747229] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[587.593458] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.848s)
[587.770939] [134/134] (439s left) kms_dirtyfb (drrs-dirtyfb-ioctl)
[587.869004] Starting subtest: drrs-dirtyfb-ioctl
[587.884622] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s)
[588.002948] Closing watchdogs
results: parsing output: 0/ for test: kms_atomic_transition
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: kms_cursor_crc
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: kms_flip_event_leak
results: parsing output: 8/ for test: syncobj_wait
results: parsing output: 9/ for test: gem_render_copy
results: parsing output: 10/ for test: gem_exec_reloc
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: core_auth
results: parsing output: 13/ for test: gem_lmem_swapping
results: parsing output: 14/ for test: kms_flip
results: parsing output: 15/ for test: fbdev
results: parsing output: 16/ for test: gem_tiled_wc
results: parsing output: 17/ for test: api_intel_bb
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_vblank
results: parsing output: 21/ for test: kms_plane_scaling
results: parsing output: 22/ for test: kms_psr
results: parsing output: 23/ for test: kms_flip_scaled_crc
results: parsing output: 24/ for test: kms_plane_multiple
results: parsing output: 25/ for test: drm_read
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: kms_cursor_legacy
results: parsing output: 28/ for test: vgem_basic
results: parsing output: 29/ for test: kms_async_flips
results: parsing output: 30/ for test: gem_exec_fence
results: parsing output: 31/ for test: gem_exec_fence
results: parsing output: 32/ for test: perf
results: parsing output: 33/ for test: gem_exec_schedule
results: parsing output: 34/ for test: gem_mmap_wc
results: parsing output: 35/ for test: kms_addfb_basic
results: parsing output: 36/ for test: gem_ctx_isolation
results: parsing output: 37/ for test: gem_fenced_exec_thrash
results: parsing output: 38/ for test: gem_softpin
results: parsing output: 39/ for test: kms_vrr
results: parsing output: 40/ for test: kms_prop_blob
results: parsing output: 41/ for test: gem_exec_fence
results: parsing output: 42/ for test: gem_userptr_blits
results: parsing output: 43/ for test: syncobj_wait
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_dsc
results: parsing output: 46/ for test: gem_exec_flush
results: parsing output: 47/ for test: gem_exec_whisper
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: kms_atomic
results: parsing output: 50/ for test: kms_chamelium_hpd
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 53/ for test: syncobj_timeline
results: parsing output: 54/ for test: syncobj_wait
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_cursor_crc
results: parsing output: 57/ for test: gem_exec_balancer
results: parsing output: 58/ for test: gem_exec_store
results: parsing output: 59/ for test: kms_lease
results: parsing output: 60/ for test: perf_pmu
results: parsing output: 61/ for test: gem_exec_schedule
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: i915_pm_sseu
results: parsing output: 64/ for test: syncobj_wait
results: parsing output: 65/ for test: api_intel_bb
results: parsing output: 66/ for test: gem_exec_reloc
results: parsing output: 67/ for test: gem_ctx_shared
results: parsing output: 68/ for test: gem_linear_blits
results: parsing output: 69/ for test: perf_pmu
results: parsing output: 70/ for test: kms_chamelium_edid
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: gem_exec_params
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: kms_vblank
results: parsing output: 77/ for test: kms_cursor_crc
results: parsing output: 78/ for test: kms_psr
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: i915_drm_fdinfo
results: parsing output: 81/ for test: kms_pm_rpm
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: sriov_basic
results: parsing output: 84/ for test: kms_ccs
results: parsing output: 85/ for test: gem_ctx_persistence
results: parsing output: 86/ for test: prime_mmap
results: parsing output: 87/ for test: kms_cursor_legacy
results: parsing output: 88/ for test: gem_userptr_blits
results: parsing output: 89/ for test: gem_mmap
results: parsing output: 90/ for test: kms_pm_rpm
results: parsing output: 91/ for test: kms_lease
results: parsing output: 92/ for test: kms_cursor_legacy
results: parsing output: 93/ for test: i915_pm_rpm
results: parsing output: 94/ for test: kms_cursor_crc
results: parsing output: 95/ for test: kms_plane_lowres
results: parsing output: 96/ for test: kms_color
results: parsing output: 97/ for test: gem_mmap
results: parsing output: 98/ for test: gem_softpin
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: syncobj_wait
results: parsing output: 101/ for test: gem_busy
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_render_copy
results: parsing output: 105/ for test: gem_mmap_wc
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_tiled_pread_basic
results: parsing output: 108/ for test: kms_pipe_b_c_ivb
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: kms_atomic_transition
results: parsing output: 111/ for test: gem_fenced_exec_thrash
results: parsing output: 112/ for test: kms_getfb
results: parsing output: 113/ for test: gem_eio
results: parsing output: 114/ for test: gem_create
results: parsing output: 115/ for test: kms_psr2_sf
results: parsing output: 116/ for test: gem_partial_pwrite_pread
results: parsing output: 117/ for test: kms_ccs
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: kms_busy
results: parsing output: 120/ for test: dmabuf_sync_file
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_tiled_display
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: gem_mmap_gtt
results: parsing output: 125/ for test: gen9_exec_parse
results: parsing output: 126/ for test: sysfs_heartbeat_interval
results: parsing output: 127/ for test: i915_hangman
results: parsing output: 128/ for test: syncobj_timeline
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_content_protection
results: parsing output: 132/ for test: kms_big_fb
results: parsing output: 133/ for test: kms_dirtyfb
Done.