[57.371233] Initializing watchdogs
[57.371279]   /dev/watchdog0
[57.385195] [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.389509] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.391716] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.395036] [001/133] (960s left) gem_mmap_wc (copy)
[57.468304] Subtest copy: SKIP (0.000s)
[57.529724] [002/133] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[57.630186] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[57.634875] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[57.740818] [003/133] (960s left) kms_psr (psr-suspend)
[57.835358] Starting subtest: psr-suspend
[57.837621] Starting dynamic subtest: eDP-1
[75.706794] Dynamic subtest eDP-1: SUCCESS (3.004s)
[75.710060] Subtest psr-suspend: SUCCESS (3.004s)
[76.591934] [004/133] (941s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[76.710414] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[76.715922] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[76.804918] [005/133] (941s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[76.892796] Starting subtest: fbc-pr-cursor-mmap-cpu
[76.897928] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[76.991773] [006/133] (941s left) template (b)
[77.043934] Starting subtest: B
[77.046515] Subtest B: SUCCESS (0.000s)
[77.136811] [007/133] (940s left) kms_lease (lease-unleased-connector)
[77.224039] Starting subtest: lease-unleased-connector
[77.226814] Starting dynamic subtest: pipe-A-eDP-1
[77.229655] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[77.238060] Starting dynamic subtest: pipe-B-eDP-1
[77.240805] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.006s)
[77.248508] Starting dynamic subtest: pipe-C-eDP-1
[77.251073] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.006s)
[77.258709] Starting dynamic subtest: pipe-D-eDP-1
[77.261085] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.006s)
[77.263332] Subtest lease-unleased-connector: SUCCESS (0.029s)
[77.359537] [008/133] (940s left) kms_addfb_basic (invalid-set-prop)
[77.420785] Starting subtest: invalid-set-prop
[77.423554] Subtest invalid-set-prop: SUCCESS (0.000s)
[77.570400] [009/133] (940s left) kms_cursor_crc (cursor-onscreen-32x32)
[77.714360] Starting subtest: cursor-onscreen-32x32
[77.764401] Subtest cursor-onscreen-32x32: SKIP (0.046s)
[78.039032] [010/133] (940s left) gem_vm_create (create-ext)
[78.100324] Starting subtest: create-ext
[78.106447] Subtest create-ext: SUCCESS (0.006s)
[78.222244] [011/133] (940s left) kms_plane_lowres (tiling-yf)
[78.309696] Starting subtest: tiling-yf
[78.314561] Subtest tiling-yf: SKIP (0.000s)
[78.379557] [012/133] (939s left) kms_sequence (get-busy)
[78.469267] Starting subtest: get-busy
[78.471461] Starting dynamic subtest: pipe-A-eDP-1
[80.446682] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.939s)
[80.456854] Starting dynamic subtest: pipe-B-eDP-1
[83.118629] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.632s)
[83.133751] Starting dynamic subtest: pipe-C-eDP-1
[85.751528] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.605s)
[85.760758] Starting dynamic subtest: pipe-D-eDP-1
[88.404641] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.634s)
[88.407321] Subtest get-busy: SUCCESS (9.813s)
[89.209996] [013/133] (929s left) gem_ctx_param (invalid-set-ringsize)
[89.267544] Starting subtest: invalid-set-ringsize
[89.270526] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[89.343674] [014/133] (929s left) syncobj_wait (invalid-signal-one-illegal-handle)
[89.390773] Starting subtest: invalid-signal-one-illegal-handle
[89.393261] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[89.490137] [015/133] (928s left) kms_chamelium_frames (dp-frame-dump)
[89.881763] Subtest dp-frame-dump: SKIP (0.000s)
[90.736091] [016/133] (927s left) kms_content_protection (dp-mst-type-0-hdcp14)
[90.869248] Starting subtest: dp-mst-type-0-hdcp14
[90.875520] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[90.990577] [017/133] (927s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[91.094752] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[91.099672] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[91.183737] [018/133] (927s left) gem_pxp (create-valid-protected-context)
[91.311027] Starting subtest: create-valid-protected-context
[91.314035] Subtest create-valid-protected-context: SUCCESS (0.003s)
[91.442878] [019/133] (927s left) syncobj_timeline (single-wait-for-submit-signaled)
[91.501829] Starting subtest: single-wait-for-submit-signaled
[91.504646] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[91.588671] [020/133] (927s left) gem_exec_fence (syncobj-channel)
[92.024357] Starting subtest: syncobj-channel
[93.043852] Subtest syncobj-channel: SUCCESS (1.011s)
[93.861555] [FACT gem_exec_fence (syncobj-channel)] new: kernel.kmod_is_loaded.vgem: true
[93.865181] [021/133] (924s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[93.976543] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[93.982015] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[94.066091] [022/133] (924s left) perf_pmu (busy-check-all)
[94.104390] Starting subtest: busy-check-all
[94.106915] Starting dynamic subtest: rcs0
[94.655049] Dynamic subtest rcs0: SUCCESS (0.551s)
[94.666903] Starting dynamic subtest: bcs0
[95.208631] Dynamic subtest bcs0: SUCCESS (0.551s)
[95.223781] Starting dynamic subtest: vcs0
[96.730482] Dynamic subtest vcs0: SUCCESS (1.515s)
[96.742457] Starting dynamic subtest: vcs1
[98.777063] Dynamic subtest vcs1: SUCCESS (2.041s)
[98.788347] Starting dynamic subtest: vecs0
[100.761188] Dynamic subtest vecs0: SUCCESS (1.979s)
[100.772753] Starting dynamic subtest: ccs0
[101.318259] Dynamic subtest ccs0: SUCCESS (0.556s)
[101.321403] Subtest busy-check-all: SUCCESS (7.201s)
[101.432892] [023/133] (917s left) api_intel_bb (blit-reloc-keep-cache)
[101.491913] Starting subtest: blit-reloc-keep-cache
[101.497569] Subtest blit-reloc-keep-cache: SKIP (0.000s)
[101.603322] [024/133] (917s left) gen9_exec_parse (unaligned-access)
[101.672549] Subtest unaligned-access: SKIP (0.000s)
[101.739784] [025/133] (917s left) gem_exec_flush (basic-wb-ro-default)
[101.804977] Starting subtest: basic-wb-ro-default
[107.274774] Subtest basic-wb-ro-default: SUCCESS (5.463s)
[107.465636] [026/133] (911s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted)
[107.525567] Starting subtest: etime-single-wait-all-available-unsubmitted
[107.628208] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.103s)
[107.706596] [027/133] (911s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[107.805541] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[116.445647] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.643s)
[116.556653] [028/133] (902s left) kms_cursor_legacy (torture-move)
[116.684624] Starting subtest: torture-move
[116.687340] Starting dynamic subtest: pipe-A
[122.436272] Dynamic subtest pipe-A: SUCCESS (5.744s)
[122.452365] Starting dynamic subtest: pipe-B
[128.776724] Dynamic subtest pipe-B: SUCCESS (6.342s)
[128.787726] Starting dynamic subtest: pipe-C
[136.036291] Dynamic subtest pipe-C: SUCCESS (7.254s)
[136.046325] Starting dynamic subtest: pipe-D
[144.349830] Dynamic subtest pipe-D: SUCCESS (8.310s)
[144.359533] Starting dynamic subtest: all-pipes
[151.846151] Dynamic subtest all-pipes: SUCCESS (7.491s)
[151.849029] Subtest torture-move: SUCCESS (35.147s)
[152.003551] [029/133] (867s left) syncobj_wait (invalid-wait-illegal-handle)
[152.064804] Starting subtest: invalid-wait-illegal-handle
[152.067756] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[152.158152] [030/133] (866s left) syncobj_timeline (wait-any-snapshot)
[152.217791] Starting subtest: wait-any-snapshot
[152.299274] Subtest wait-any-snapshot: SUCCESS (0.083s)
[152.376570] [031/133] (866s left) gem_mmap_gtt (basic-small-bo)
[152.435343] Subtest basic-small-bo: SKIP (0.000s)
[152.501106] [032/133] (866s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[152.602473] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[152.605130] Starting dynamic subtest: pipe-A-eDP-1
[152.628058] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[152.643228] Starting dynamic subtest: pipe-B-eDP-1
[152.666050] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[152.674365] Starting dynamic subtest: pipe-C-eDP-1
[152.696574] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[152.704537] Starting dynamic subtest: pipe-D-eDP-1
[152.727048] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[152.729249] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[154.795643] [033/133] (864s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[154.895164] Starting subtest: psr-rgb565-draw-render
[162.010634] Subtest psr-rgb565-draw-render: SUCCESS (7.115s)
[162.137181] [034/133] (857s left) kms_vblank (wait-busy)
[162.232327] Starting subtest: wait-busy
[162.234526] Starting dynamic subtest: pipe-A-eDP-1
[164.124325] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.891s)
[164.139311] Starting dynamic subtest: pipe-D-eDP-1
[166.711241] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.585s)
[166.713793] Subtest wait-busy: SUCCESS (4.479s)
[167.515772] [035/133] (851s left) kms_psr (fbc-psr-primary-mmap-gtt)
[167.610752] Starting subtest: fbc-psr-primary-mmap-gtt
[167.613517] Starting dynamic subtest: eDP-1
[167.618818] Dynamic subtest eDP-1: SKIP (0.000s)
[167.624645] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[167.685072] [036/133] (851s left) kms_getfb (getfb2-handle-zero)
[167.783486] Starting subtest: getfb2-handle-zero
[167.785680] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[167.889581] [037/133] (851s left) gem_exec_params (rs-invalid)
[167.944591] Starting subtest: rs-invalid
[167.949333] Subtest rs-invalid: SUCCESS (0.005s)
[168.064412] [038/133] (851s left) i915_module_load (resize-bar)
[168.106546] Starting subtest: resize-bar
[168.114140] Subtest resize-bar: SKIP (0.005s)
[168.164893] [039/133] (851s left) gem_exec_params (secure-non-root)
[168.229249] Starting subtest: secure-non-root
[168.234324] Subtest secure-non-root: SKIP (0.000s)
[168.328213] [040/133] (851s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[168.435157] Starting subtest: fbc-modesetfrombusy
[172.164043] Subtest fbc-modesetfrombusy: SUCCESS (3.733s)
[173.335379] [041/133] (846s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[173.431776] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[173.434238] Starting dynamic subtest: pipe-A-eDP-1
[173.457649] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[173.467769] Starting dynamic subtest: pipe-B-eDP-1
[173.492835] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[173.501738] Starting dynamic subtest: pipe-C-eDP-1
[173.526755] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[173.535537] Starting dynamic subtest: pipe-D-eDP-1
[173.561538] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[173.566404] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[175.677298] [042/133] (843s left) gem_ctx_engines (invalid-engines)
[175.743345] Starting subtest: invalid-engines
[175.753521] Subtest invalid-engines: SUCCESS (0.010s)
[175.982287] [043/133] (843s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[176.046552] Starting subtest: mixed-tiled-to-y-tiled-ccs
[176.050874] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[176.232479] [044/133] (843s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[176.342397] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[177.420956] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.079s)
[177.543460] [045/133] (842s left) gem_exec_whisper (basic-queues-forked)
[177.599904] Starting subtest: basic-queues-forked
[201.931120] Subtest basic-queues-forked: SUCCESS (24.330s)
[202.115483] [046/133] (817s left) kms_chamelium_color (ctm-0-75)
[202.205654] Subtest ctm-0-75: SKIP (0.000s)
[202.252946] [047/133] (817s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[202.346785] Starting subtest: y-tiled-32bpp-rotate-90
[202.352294] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[202.443599] [048/133] (817s left) gem_exec_schedule (preempt-contexts)
[202.534272] Starting subtest: preempt-contexts
[202.536453] Starting dynamic subtest: rcs0
[202.582427] Dynamic subtest rcs0: SUCCESS (0.060s)
[202.592738] Starting dynamic subtest: bcs0
[202.654536] Dynamic subtest bcs0: SUCCESS (0.072s)
[202.664931] Starting dynamic subtest: vcs0
[202.704841] Dynamic subtest vcs0: SUCCESS (0.049s)
[202.719450] Starting dynamic subtest: vcs1
[202.749594] Dynamic subtest vcs1: SUCCESS (0.046s)
[202.759738] Starting dynamic subtest: vecs0
[202.809444] Dynamic subtest vecs0: SUCCESS (0.057s)
[202.821383] Starting dynamic subtest: ccs0
[202.868748] Dynamic subtest ccs0: SUCCESS (0.060s)
[202.871744] Subtest preempt-contexts: SUCCESS (0.346s)
[203.823264] [049/133] (816s left) syncobj_timeline (invalid-signal-illegal-handle)
[203.890656] Starting subtest: invalid-signal-illegal-handle
[203.893337] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[203.992615] [050/133] (815s left) kms_psr (pr-sprite-mmap-gtt)
[204.081002] Starting subtest: pr-sprite-mmap-gtt
[204.086013] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[204.177117] [051/133] (815s left) kms_psr (psr2-primary-blt)
[204.270728] Starting subtest: psr2-primary-blt
[204.273154] Starting dynamic subtest: eDP-1
[205.971750] Dynamic subtest eDP-1: SUCCESS (1.699s)
[205.974742] Subtest psr2-primary-blt: SUCCESS (1.700s)
[206.840209] [052/133] (813s left) kms_rotation_crc (primary-rotation-180)
[206.939081] Starting subtest: primary-rotation-180
[213.952375] Subtest primary-rotation-180: SUCCESS (7.013s)
[215.190580] [053/133] (804s left) gem_exec_parallel (contexts)
[215.267325] Starting subtest: contexts
[215.270023] Starting dynamic subtest: rcs0
[218.651947] Dynamic subtest rcs0: SUCCESS (3.383s)
[218.661150] Starting dynamic subtest: bcs0
[222.843020] Dynamic subtest bcs0: SUCCESS (4.188s)
[222.854809] Starting dynamic subtest: vcs0
[227.272193] Dynamic subtest vcs0: SUCCESS (4.426s)
[227.282099] Starting dynamic subtest: vcs1
[233.056294] Dynamic subtest vcs1: SUCCESS (5.782s)
[233.068786] Starting dynamic subtest: vecs0
[237.331789] Dynamic subtest vecs0: SUCCESS (4.273s)
[237.342762] Starting dynamic subtest: ccs0
[241.899012] Dynamic subtest ccs0: SUCCESS (4.566s)
[241.901592] Subtest contexts: SUCCESS (26.627s)
[242.089983] [054/133] (778s left) gen9_exec_parse (cmd-crossing-page)
[242.146611] Subtest cmd-crossing-page: SKIP (0.000s)
[242.211103] [055/133] (777s left) i915_query (engine-info-invalid)
[242.271182] Starting subtest: engine-info-invalid
[242.273651] Subtest engine-info-invalid: SUCCESS (0.000s)
[242.365760] [056/133] (777s left) kms_chamelium_hpd (vga-hpd-fast)
[242.759988] Subtest vga-hpd-fast: SKIP (0.000s)
[243.603371] [057/133] (776s left) kms_addfb_basic (small-bo)
[243.693518] Starting subtest: small-bo
[243.696084] Subtest small-bo: SUCCESS (0.000s)
[243.782170] [058/133] (776s left) gem_userptr_blits (relocations)
[243.860513] Starting subtest: relocations
[243.865459] Subtest relocations: SKIP (0.000s)
[243.975153] [059/133] (776s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[244.031617] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[244.132142] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.101s)
[244.208936] [060/133] (776s left) gem_ctx_persistence (saturated-hostile)
[244.273671] Starting subtest: saturated-hostile
[244.276483] Starting dynamic subtest: rcs0
[245.093964] Dynamic subtest rcs0: SUCCESS (0.822s)
[245.109298] Starting dynamic subtest: bcs0
[245.884453] Dynamic subtest bcs0: SUCCESS (0.789s)
[245.895725] Starting dynamic subtest: vcs0
[246.661079] Dynamic subtest vcs0: SUCCESS (0.775s)
[246.672013] Starting dynamic subtest: vcs1
[247.463206] Dynamic subtest vcs1: SUCCESS (0.800s)
[247.475764] Starting dynamic subtest: vecs0
[248.269164] Dynamic subtest vecs0: SUCCESS (0.804s)
[248.281581] Starting dynamic subtest: ccs0
[249.099936] Dynamic subtest ccs0: SUCCESS (0.829s)
[249.102779] Subtest saturated-hostile: SUCCESS (4.829s)
[249.180202] [061/133] (771s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[249.295562] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[249.300529] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[249.392333] [062/133] (771s left) kms_async_flips (crc)
[249.478365] Starting subtest: crc
[249.849584] Starting dynamic subtest: pipe-A-eDP-1
[252.752572] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.903s)
[253.131668] Starting dynamic subtest: pipe-B-eDP-1
[256.079408] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.956s)
[256.473638] Starting dynamic subtest: pipe-C-eDP-1
[259.398588] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.934s)
[259.782620] Starting dynamic subtest: pipe-D-eDP-1
[262.617279] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.849s)
[262.619961] Subtest crc: SUCCESS (13.137s)
[263.778193] [063/133] (756s left) gem_exec_reloc (basic-wc-gtt)
[263.839542] Subtest basic-wc-gtt: SKIP (0.000s)
[263.901424] [064/133] (756s left) gem_exec_reloc (basic-cpu-gtt)
[263.962534] Subtest basic-cpu-gtt: SKIP (0.000s)
[264.032743] [065/133] (756s left) kms_hdr (static-swap)
[264.129266] Starting subtest: static-swap
[264.136351] Subtest static-swap: SKIP (0.000s)
[264.217866] [066/133] (756s left) gem_lmem_swapping (smem-oom)
[264.263190] Subtest smem-oom: SKIP (0.000s)
[264.311489] [067/133] (756s left) kms_async_flips (test-cursor)
[264.409369] Starting subtest: test-cursor
[264.795062] Starting dynamic subtest: pipe-A-eDP-1
[265.573691] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.780s)
[265.952427] Starting dynamic subtest: pipe-B-eDP-1
[266.708619] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.763s)
[267.075405] Starting dynamic subtest: pipe-C-eDP-1
[267.829485] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.761s)
[268.197774] Starting dynamic subtest: pipe-D-eDP-1
[268.948595] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.759s)
[268.951203] Subtest test-cursor: SUCCESS (4.541s)
[270.118246] [068/133] (750s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[270.217525] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[277.580758] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.366s)
[277.703712] [069/133] (743s left) gem_softpin (allocator-basic-reserve)
[277.766495] Starting subtest: allocator-basic-reserve
[277.841569] Subtest allocator-basic-reserve: SUCCESS (0.075s)
[277.958549] [070/133] (742s left) prime_vgem (sync)
[278.028613] Starting subtest: sync
[278.031194] Starting dynamic subtest: rcs0
[278.087773] Dynamic subtest rcs0: SUCCESS (0.062s)
[278.097501] Starting dynamic subtest: bcs0
[278.161987] Dynamic subtest bcs0: SUCCESS (0.073s)
[278.173849] Starting dynamic subtest: vcs0
[278.209265] Dynamic subtest vcs0: SUCCESS (0.046s)
[278.218689] Starting dynamic subtest: vcs1
[278.258792] Dynamic subtest vcs1: SUCCESS (0.047s)
[278.268525] Starting dynamic subtest: vecs0
[278.304803] Dynamic subtest vecs0: SUCCESS (0.045s)
[278.314570] Starting dynamic subtest: ccs0
[278.355009] Dynamic subtest ccs0: SUCCESS (0.049s)
[278.357432] Subtest sync: SUCCESS (0.330s)
[278.466770] [071/133] (742s left) gem_userptr_blits (sync-unmap-cycles)
[278.540551] Starting subtest: sync-unmap-cycles
[283.927385] Subtest sync-unmap-cycles: SUCCESS (5.386s)
[284.058122] [072/133] (736s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[284.177974] Starting subtest: basic-busy-flip-before-cursor-atomic
[284.181896] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[284.324887] [073/133] (736s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[284.433294] Starting subtest: short-flip-before-cursor-atomic-transitions
[285.396757] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.960s)
[286.276308] [074/133] (734s left) kms_feature_discovery (display)
[286.368674] Starting subtest: display
[286.371427] Subtest display: SUCCESS (0.000s)
[286.442055] [075/133] (734s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[286.537940] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[286.540399] Starting dynamic subtest: pipe-A-default-mode
[289.320658] Dynamic subtest pipe-A-default-mode: SUCCESS (2.782s)
[289.323679] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.784s)
[290.184940] [076/133] (730s left) gem_ctx_shared (q-smoketest-all)
[290.265451] Starting subtest: Q-smoketest-all
[322.690864] Subtest Q-smoketest-all: SUCCESS (32.365s)
[323.842394] [077/133] (697s left) gem_mmap_gtt (basic-wc)
[323.894664] Subtest basic-wc: SKIP (0.000s)
[323.973212] [078/133] (697s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[324.075737] Starting subtest: yf-tiled-8bpp-rotate-180
[324.081059] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[324.173243] [079/133] (697s left) gem_exec_suspend (basic-s4-devices)
[324.224544] Starting subtest: basic-S4-devices
[324.227231] Starting dynamic subtest: smem
[335.705007] Dynamic subtest smem: SUCCESS (11.480s)
[335.707792] Subtest basic-S4-devices: SUCCESS (11.483s)
[342.906797] [080/133] (685s left) kms_plane (plane-position-hole)
[343.020681] Starting subtest: plane-position-hole
[343.556236] Starting dynamic subtest: pipe-A-plane-1
[344.845995] Dynamic subtest pipe-A-plane-1: SUCCESS (1.290s)
[344.856965] Starting dynamic subtest: pipe-A-plane-2
[346.072675] Dynamic subtest pipe-A-plane-2: SUCCESS (1.225s)
[346.084308] Starting dynamic subtest: pipe-A-plane-3
[347.333624] Dynamic subtest pipe-A-plane-3: SUCCESS (1.260s)
[347.343984] Starting dynamic subtest: pipe-A-plane-4
[348.716584] Dynamic subtest pipe-A-plane-4: SUCCESS (1.382s)
[348.730113] Starting dynamic subtest: pipe-A-plane-5
[348.746772] Dynamic subtest pipe-A-plane-5: SUCCESS (0.026s)
[349.915531] Starting dynamic subtest: pipe-B-plane-1
[351.255725] Dynamic subtest pipe-B-plane-1: SUCCESS (1.351s)
[351.266076] Starting dynamic subtest: pipe-B-plane-2
[352.594456] Dynamic subtest pipe-B-plane-2: SUCCESS (1.338s)
[352.604746] Starting dynamic subtest: pipe-B-plane-3
[353.919331] Dynamic subtest pipe-B-plane-3: SUCCESS (1.325s)
[353.929735] Starting dynamic subtest: pipe-B-plane-4
[355.229795] Dynamic subtest pipe-B-plane-4: SUCCESS (1.308s)
[355.240460] Starting dynamic subtest: pipe-B-plane-5
[355.259579] Dynamic subtest pipe-B-plane-5: SUCCESS (0.026s)
[355.262398] Subtest plane-position-hole: SUCCESS (12.234s)
[356.027129] [081/133] (672s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[356.140781] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[363.042447] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.904s)
[363.183092] [082/133] (665s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[363.289323] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[363.292095] Starting dynamic subtest: pipe-A-eDP-1
[363.318733] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[363.332040] Starting dynamic subtest: pipe-B-eDP-1
[363.356660] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[363.365744] Starting dynamic subtest: pipe-C-eDP-1
[363.391752] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[363.401041] Starting dynamic subtest: pipe-D-eDP-1
[363.426515] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[363.431745] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[365.525167] [083/133] (662s left) kms_cursor_crc (cursor-sliding-128x128)
[365.742711] Starting subtest: cursor-sliding-128x128
[365.748436] Starting dynamic subtest: pipe-A-eDP-1
[368.956532] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.207s)
[368.984384] Starting dynamic subtest: pipe-D-eDP-1
[372.851743] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.875s)
[372.854597] Subtest cursor-sliding-128x128: SUCCESS (7.108s)
[373.701817] [084/133] (654s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[373.803348] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[373.806019] Starting dynamic subtest: pipe-A-eDP-1
[373.898597] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s)
[373.910013] Starting dynamic subtest: pipe-B-eDP-1
[375.067353] Dynamic subtest pipe-B-eDP-1: SKIP (1.166s)
[375.072632] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.267s)
[376.250883] [085/133] (652s left) kms_addfb_basic (no-handle)
[376.311297] Starting subtest: no-handle
[376.314363] Subtest no-handle: SUCCESS (0.000s)
[376.455080] [086/133] (652s left) gem_mmap_gtt (big-copy)
[376.510649] Subtest big-copy: SKIP (0.000s)
[376.565790] [087/133] (651s left) kms_color (ctm-max)
[376.654810] Starting subtest: ctm-max
[376.657549] Starting dynamic subtest: pipe-A-eDP-1
[377.371040] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.715s)
[377.381531] Starting dynamic subtest: pipe-B-eDP-1
[378.776750] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.404s)
[378.786771] Starting dynamic subtest: pipe-C-eDP-1
[380.156730] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.379s)
[380.167303] Starting dynamic subtest: pipe-D-eDP-1
[381.482312] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s)
[381.484593] Subtest ctm-max: SUCCESS (4.829s)
[382.278541] [088/133] (646s left) gem_workarounds (reset-context)
[382.355440] Starting subtest: reset-context
[382.536288] Subtest reset-context: SUCCESS (0.183s)
[382.653067] [089/133] (645s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[382.745172] Starting subtest: 4-tiled-32bpp-rotate-270
[382.769554] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.021s)
[382.875997] [090/133] (645s left) i915_pm_rps (engine-order)
[382.936345] Starting subtest: engine-order
[387.933387] Subtest engine-order: SUCCESS (4.995s)
[388.099613] [091/133] (640s left) gem_exec_whisper (basic-contexts-all)
[388.165950] Starting subtest: basic-contexts-all
[397.540985] Subtest basic-contexts-all: SUCCESS (9.373s)
[397.733302] [092/133] (631s left) i915_query (query-topology-unsupported)
[397.798529] Starting subtest: query-topology-unsupported
[397.803404] Subtest query-topology-unsupported: SKIP (0.000s)
[397.889910] [093/133] (630s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[397.952483] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[397.957553] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[398.138938] [094/133] (630s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[398.230582] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[398.235905] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[398.314554] [095/133] (630s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[398.403141] Starting subtest: read-crc-frame-sequence
[398.405489] Starting dynamic subtest: pipe-A-eDP-1
[399.097466] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.694s)
[399.108346] Starting dynamic subtest: pipe-B-eDP-1
[400.467584] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.368s)
[400.477734] Starting dynamic subtest: pipe-C-eDP-1
[401.833635] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.365s)
[401.844506] Starting dynamic subtest: pipe-D-eDP-1
[403.184764] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.349s)
[403.187288] Subtest read-crc-frame-sequence: SUCCESS (4.782s)
[404.007861] [096/133] (624s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[404.105011] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[411.411926] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.310s)
[411.525801] [097/133] (617s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[411.618456] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[411.623375] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[411.690568] [098/133] (617s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[411.780150] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[411.782438] Starting dynamic subtest: pipe-A
[411.800782] Dynamic subtest pipe-A: SKIP (0.017s)
[411.810308] Starting dynamic subtest: pipe-B
[411.835201] Dynamic subtest pipe-B: SKIP (0.032s)
[411.845359] Starting dynamic subtest: pipe-C
[411.865558] Dynamic subtest pipe-C: SKIP (0.032s)
[411.874999] Starting dynamic subtest: pipe-D
[411.899793] Dynamic subtest pipe-D: SKIP (0.031s)
[411.904490] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.116s)
[411.989652] [099/133] (617s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[412.082664] Starting subtest: fbc-rgb565-draw-pwrite
[416.606656] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.528s)
[417.752114] [100/133] (611s left) kms_psr (fbc-psr2-cursor-plane-move)
[417.846497] Starting subtest: fbc-psr2-cursor-plane-move
[417.849262] Starting dynamic subtest: eDP-1
[417.854249] Dynamic subtest eDP-1: SKIP (0.000s)
[417.859508] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[417.920406] [101/133] (611s left) perf (non-system-wide-paranoid)
[418.054497] Starting subtest: non-system-wide-paranoid
[418.082662] Subtest non-system-wide-paranoid: SUCCESS (0.030s)
[418.135167] [102/133] (611s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[419.899190] Starting subtest: modeset-lpsp-stress-no-wait
[429.898491] Subtest modeset-lpsp-stress-no-wait: SUCCESS (9.999s)
[429.987704] [103/133] (599s left) fbdev (write)
[430.041490] Starting subtest: write
[430.429346] Subtest write: SUCCESS (0.361s)
[430.511107] [104/133] (598s left) gem_exec_create (basic)
[430.569501] Starting subtest: basic
[430.572520] Starting dynamic subtest: smem
[433.689061] Dynamic subtest smem: SUCCESS (3.117s)
[433.692218] Subtest basic: SUCCESS (3.119s)
[433.896392] [105/133] (595s left) gem_mmap_offset (bad-flags)
[433.956922] Starting subtest: bad-flags
[433.959522] Subtest bad-flags: SUCCESS (0.000s)
[434.052166] [106/133] (595s left) api_intel_bb (simple-bb)
[434.109600] Starting subtest: simple-bb
[434.118741] Subtest simple-bb: SUCCESS (0.011s)
[434.213881] [107/133] (595s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[434.312775] Starting subtest: flip-vs-dpms-on-nop-interruptible
[434.315457] Starting dynamic subtest: A-eDP1
[436.138766] Dynamic subtest A-eDP1: SUCCESS (1.825s)
[436.151754] Starting dynamic subtest: B-eDP1
[437.973527] Dynamic subtest B-eDP1: SUCCESS (1.832s)
[437.986081] Starting dynamic subtest: C-eDP1
[439.797631] Dynamic subtest C-eDP1: SUCCESS (1.822s)
[439.809737] Starting dynamic subtest: D-eDP1
[441.630358] Dynamic subtest D-eDP1: SUCCESS (1.830s)
[441.632761] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.320s)
[442.818634] [108/133] (586s left) gem_exec_reloc (basic-cpu)
[442.885752] Subtest basic-cpu: SKIP (0.000s)
[442.957988] [109/133] (586s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[443.065020] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[443.978776] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.914s)
[444.143939] [110/133] (585s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[444.198672] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[444.201397] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[444.301346] [111/133] (585s left) gem_mmap_gtt (basic-read-write)
[444.361347] Subtest basic-read-write: SKIP (0.000s)
[444.416946] [112/133] (585s left) kms_pm_dc (dc3co-vpb-simulation)
[445.513485] Starting subtest: dc3co-vpb-simulation
[454.003691] Subtest dc3co-vpb-simulation: SKIP (8.488s)
[454.126011] [113/133] (575s left) kms_cursor_crc (cursor-sliding-32x32)
[454.289171] Starting subtest: cursor-sliding-32x32
[454.333320] Subtest cursor-sliding-32x32: SKIP (0.039s)
[454.626552] [114/133] (575s left) kms_flip (plain-flip-ts-check-interruptible)
[454.727511] Starting subtest: plain-flip-ts-check-interruptible
[454.730494] Starting dynamic subtest: A-eDP1
[463.614042] Dynamic subtest A-eDP1: SUCCESS (8.886s)
[463.625609] Starting dynamic subtest: B-eDP1
[472.450917] Dynamic subtest B-eDP1: SUCCESS (8.834s)
[472.462900] Starting dynamic subtest: C-eDP1
[481.271513] Dynamic subtest C-eDP1: SUCCESS (8.816s)
[481.289750] Starting dynamic subtest: D-eDP1
[490.107305] Dynamic subtest D-eDP1: SUCCESS (8.833s)
[490.113027] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.381s)
[491.290786] [115/133] (538s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[491.381740] Starting subtest: x-tiled-64bpp-rotate-270
[491.400797] Subtest x-tiled-64bpp-rotate-270: SKIP (0.019s)
[491.504396] [116/133] (538s left) gem_sync (basic-store-each)
[491.583534] Starting subtest: basic-store-each
[493.931723] Subtest basic-store-each: SUCCESS (2.362s)
[494.135814] [117/133] (535s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[494.234267] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[494.239279] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[494.326746] [118/133] (535s left) device_reset (unbind-cold-reset-rebind)
[494.368619] Starting subtest: unbind-cold-reset-rebind
[494.374001] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[494.430556] [119/133] (535s left) gem_exec_schedule (semaphore-user)
[494.504141] Starting subtest: semaphore-user
[494.554584] Subtest semaphore-user: SUCCESS (0.059s)
[495.830892] [120/133] (534s left) perf_pmu (idle)
[495.874642] Starting subtest: idle
[495.877784] Starting dynamic subtest: rcs0
[496.420984] Dynamic subtest rcs0: SUCCESS (0.544s)
[496.433034] Starting dynamic subtest: bcs0
[496.938410] Dynamic subtest bcs0: SUCCESS (0.515s)
[496.949771] Starting dynamic subtest: vcs0
[497.454893] Dynamic subtest vcs0: SUCCESS (0.514s)
[497.466034] Starting dynamic subtest: vcs1
[497.978249] Dynamic subtest vcs1: SUCCESS (0.520s)
[497.991683] Starting dynamic subtest: vecs0
[498.494389] Dynamic subtest vecs0: SUCCESS (0.514s)
[498.507784] Starting dynamic subtest: ccs0
[499.014232] Dynamic subtest ccs0: SUCCESS (0.517s)
[499.017234] Subtest idle: SUCCESS (3.140s)
[499.134406] [121/133] (530s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[499.238235] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[505.753194] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.517s)
[505.880350] [122/133] (524s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[505.970798] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[505.973655] Starting dynamic subtest: pipe-A-eDP-1
[506.000311] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[506.012006] Starting dynamic subtest: pipe-B-eDP-1
[506.036984] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[506.047567] Starting dynamic subtest: pipe-C-eDP-1
[506.069901] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[506.078760] Starting dynamic subtest: pipe-D-eDP-1
[506.101903] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[506.106544] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[508.169689] [123/133] (522s left) kms_plane (pixel-format-linear-modifier)
[508.277637] Starting subtest: pixel-format-linear-modifier
[508.304516] Starting dynamic subtest: pipe-A-plane-0
[512.104467] Dynamic subtest pipe-A-plane-0: SUCCESS (3.800s)
[512.116017] Starting dynamic subtest: pipe-A-plane-3
[513.815752] Dynamic subtest pipe-A-plane-3: SUCCESS (1.710s)
[513.827912] Starting dynamic subtest: pipe-A-plane-5
[514.038436] Dynamic subtest pipe-A-plane-5: SUCCESS (0.222s)
[515.161382] Starting dynamic subtest: pipe-B-plane-0
[519.021453] Dynamic subtest pipe-B-plane-0: SUCCESS (3.866s)
[519.031536] Starting dynamic subtest: pipe-B-plane-3
[520.754493] Dynamic subtest pipe-B-plane-3: SUCCESS (1.732s)
[520.765030] Starting dynamic subtest: pipe-B-plane-5
[520.966158] Dynamic subtest pipe-B-plane-5: SUCCESS (0.211s)
[521.275544] Subtest pixel-format-linear-modifier: SUCCESS (12.995s)
[522.131521] [124/133] (508s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[522.233426] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[522.238638] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[522.339304] [125/133] (507s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[522.440370] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[522.445133] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[522.528300] [126/133] (507s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[522.622509] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[522.627674] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[523.751556] [127/133] (506s left) syncobj_wait (wait-all-complex)
[523.806519] Starting subtest: wait-all-complex
[524.022329] Subtest wait-all-complex: SUCCESS (0.217s)
[524.104720] [128/133] (506s left) gem_exec_balancer (bonded-chain)
[524.169462] Starting subtest: bonded-chain
[531.200925] Subtest bonded-chain: SUCCESS (7.028s)
[531.512409] [129/133] (498s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[531.635232] Starting subtest: cursorB-vs-flipB-atomic
[531.639880] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[531.780919] [130/133] (498s left) kms_properties (colorop-properties-legacy)
[531.867575] Starting subtest: colorop-properties-legacy
[531.870389] Starting dynamic subtest: pipe-A-eDP-1
[532.199966] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.334s)
[532.210718] Starting dynamic subtest: pipe-B-eDP-1
[533.327270] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.126s)
[533.338685] Starting dynamic subtest: pipe-C-eDP-1
[534.368546] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.038s)
[534.380004] Starting dynamic subtest: pipe-D-eDP-1
[535.398580] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.028s)
[535.400797] Subtest colorop-properties-legacy: SUCCESS (3.531s)
[536.201438] [131/133] (494s left) gem_exec_fence (basic-busy)
[536.373047] Starting subtest: basic-busy
[536.375984] Starting dynamic subtest: rcs0
[536.449334] Dynamic subtest rcs0: SUCCESS (0.076s)
[536.463040] Starting dynamic subtest: bcs0
[536.503783] Dynamic subtest bcs0: SUCCESS (0.053s)
[536.516760] Starting dynamic subtest: vcs0
[536.556357] Dynamic subtest vcs0: SUCCESS (0.050s)
[536.568359] Starting dynamic subtest: vcs1
[536.619285] Dynamic subtest vcs1: SUCCESS (0.061s)
[536.632369] Starting dynamic subtest: vecs0
[536.683589] Dynamic subtest vecs0: SUCCESS (0.062s)
[536.697560] Starting dynamic subtest: ccs0
[536.745465] Dynamic subtest ccs0: SUCCESS (0.060s)
[536.748269] Subtest basic-busy: SUCCESS (0.374s)
[538.865493] [132/133] (491s left) gem_eio (wait-10ms)
[539.086141] Starting subtest: wait-10ms
[539.440781] Subtest wait-10ms: SUCCESS (0.356s)
[539.579421] [133/133] (491s left) kms_atomic_transition (plane-all-transition-fencing)
[539.669081] Starting subtest: plane-all-transition-fencing
[539.671372] Starting dynamic subtest: pipe-A-eDP-1
[542.164385] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[542.483123] Starting dynamic subtest: pipe-B-eDP-1
[545.733717] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.257s)
[546.030178] Subtest plane-all-transition-fencing: SUCCESS (6.360s)
[546.854077] Closing watchdogs
results: parsing output: 0/ for test: gem_mmap_wc
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_psr
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_psr
results: parsing output: 5/ for test: template
results: parsing output: 6/ for test: kms_lease
results: parsing output: 7/ for test: kms_addfb_basic
results: parsing output: 8/ for test: kms_cursor_crc
results: parsing output: 9/ for test: gem_vm_create
results: parsing output: 10/ for test: kms_plane_lowres
results: parsing output: 11/ for test: kms_sequence
results: parsing output: 12/ for test: gem_ctx_param
results: parsing output: 13/ for test: syncobj_wait
results: parsing output: 14/ for test: kms_chamelium_frames
results: parsing output: 15/ for test: kms_content_protection
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: gem_pxp
results: parsing output: 18/ for test: syncobj_timeline
results: parsing output: 19/ for test: gem_exec_fence
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: perf_pmu
results: parsing output: 22/ for test: api_intel_bb
results: parsing output: 23/ for test: gen9_exec_parse
results: parsing output: 24/ for test: gem_exec_flush
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_cursor_legacy
results: parsing output: 28/ for test: syncobj_wait
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: gem_mmap_gtt
results: parsing output: 31/ for test: kms_ccs
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_vblank
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: kms_getfb
results: parsing output: 36/ for test: gem_exec_params
results: parsing output: 37/ for test: i915_module_load
results: parsing output: 38/ for test: gem_exec_params
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_ccs
results: parsing output: 41/ for test: gem_ctx_engines
results: parsing output: 42/ for test: gem_render_copy
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: gem_exec_whisper
results: parsing output: 45/ for test: kms_chamelium_color
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: gem_exec_schedule
results: parsing output: 48/ for test: syncobj_timeline
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: kms_psr
results: parsing output: 51/ for test: kms_rotation_crc
results: parsing output: 52/ for test: gem_exec_parallel
results: parsing output: 53/ for test: gen9_exec_parse
results: parsing output: 54/ for test: i915_query
results: parsing output: 55/ for test: kms_chamelium_hpd
results: parsing output: 56/ for test: kms_addfb_basic
results: parsing output: 57/ for test: gem_userptr_blits
results: parsing output: 58/ for test: syncobj_timeline
results: parsing output: 59/ for test: gem_ctx_persistence
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_async_flips
results: parsing output: 62/ for test: gem_exec_reloc
results: parsing output: 63/ for test: gem_exec_reloc
results: parsing output: 64/ for test: kms_hdr
results: parsing output: 65/ for test: gem_lmem_swapping
results: parsing output: 66/ for test: kms_async_flips
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_softpin
results: parsing output: 69/ for test: prime_vgem
results: parsing output: 70/ for test: gem_userptr_blits
results: parsing output: 71/ for test: kms_cursor_legacy
results: parsing output: 72/ for test: kms_cursor_legacy
results: parsing output: 73/ for test: kms_feature_discovery
results: parsing output: 74/ for test: kms_flip_scaled_crc
results: parsing output: 75/ for test: gem_ctx_shared
results: parsing output: 76/ for test: gem_mmap_gtt
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: gem_exec_suspend
results: parsing output: 79/ for test: kms_plane
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_ccs
results: parsing output: 82/ for test: kms_cursor_crc
results: parsing output: 83/ for test: kms_psr2_sf
results: parsing output: 84/ for test: kms_addfb_basic
results: parsing output: 85/ for test: gem_mmap_gtt
results: parsing output: 86/ for test: kms_color
results: parsing output: 87/ for test: gem_workarounds
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: i915_pm_rps
results: parsing output: 90/ for test: gem_exec_whisper
results: parsing output: 91/ for test: i915_query
results: parsing output: 92/ for test: gem_render_copy
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_pipe_crc_basic
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_flip_scaled_crc
results: parsing output: 97/ for test: kms_plane_scaling
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: perf
results: parsing output: 101/ for test: kms_pm_rpm
results: parsing output: 102/ for test: fbdev
results: parsing output: 103/ for test: gem_exec_create
results: parsing output: 104/ for test: gem_mmap_offset
results: parsing output: 105/ for test: api_intel_bb
results: parsing output: 106/ for test: kms_flip
results: parsing output: 107/ for test: gem_exec_reloc
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: syncobj_timeline
results: parsing output: 110/ for test: gem_mmap_gtt
results: parsing output: 111/ for test: kms_pm_dc
results: parsing output: 112/ for test: kms_cursor_crc
results: parsing output: 113/ for test: kms_flip
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: gem_sync
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: device_reset
results: parsing output: 118/ for test: gem_exec_schedule
results: parsing output: 119/ for test: perf_pmu
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_ccs
results: parsing output: 122/ for test: kms_plane
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_ccs
results: parsing output: 126/ for test: syncobj_wait
results: parsing output: 127/ for test: gem_exec_balancer
results: parsing output: 128/ for test: kms_cursor_legacy
results: parsing output: 129/ for test: kms_properties
results: parsing output: 130/ for test: gem_exec_fence
results: parsing output: 131/ for test: gem_eio
results: parsing output: 132/ for test: kms_atomic_transition
Done.