[65.763334] Initializing watchdogs
[65.763417]   /dev/watchdog0
[65.792509] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[65.807053] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[65.811884] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[65.815091] [001/132] (960s left) gem_exec_params (rsvd2-dirt)
[65.876766] Starting subtest: rsvd2-dirt
[65.879730] Subtest rsvd2-dirt: SKIP (0.000s)
[66.033640] [002/132] (960s left) kms_color (invalid-ctm-matrix-sizes)
[68.017382] Starting subtest: invalid-ctm-matrix-sizes
[68.018752] Starting dynamic subtest: pipe-A
[68.022299] Dynamic subtest pipe-A: SUCCESS (0.006s)
[68.030098] Starting dynamic subtest: pipe-B
[68.031515] Dynamic subtest pipe-B: SUCCESS (0.008s)
[68.039414] Starting dynamic subtest: pipe-C
[68.040807] Dynamic subtest pipe-C: SUCCESS (0.008s)
[68.048549] Starting dynamic subtest: pipe-D
[68.049939] Dynamic subtest pipe-D: SUCCESS (0.010s)
[68.051603] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.033s)
[68.192567] [003/132] (958s left) kms_addfb_basic (addfb25-4-tiled)
[70.195911] Starting subtest: addfb25-4-tiled
[70.197636] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[70.416875] [004/132] (956s left) kms_prop_blob (invalid-set-prop)
[70.462164] Starting subtest: invalid-set-prop
[70.463644] Subtest invalid-set-prop: SUCCESS (0.000s)
[70.643061] [005/132] (956s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[72.625869] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[72.627274] Starting dynamic subtest: pipe-A
[73.392547] Dynamic subtest pipe-A: SUCCESS (0.769s)
[73.402045] Starting dynamic subtest: pipe-B
[74.148031] Dynamic subtest pipe-B: SUCCESS (0.756s)
[74.158273] Starting dynamic subtest: pipe-C
[74.902871] Dynamic subtest pipe-C: SUCCESS (0.756s)
[74.912551] Starting dynamic subtest: pipe-D
[75.659024] Dynamic subtest pipe-D: SUCCESS (0.757s)
[75.660673] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (3.039s)
[75.892732] [006/132] (950s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[75.940489] Starting subtest: single-wait-for-submit-available-signaled
[75.942123] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[76.093796] [007/132] (950s left) kms_flip (2x-wf_vblank-ts-check)
[78.078786] Starting subtest: 2x-wf_vblank-ts-check
[78.096920] Subtest 2x-wf_vblank-ts-check: SKIP (0.018s)
[78.319176] [008/132] (948s left) kms_hdr (static-toggle)
[80.303135] Starting subtest: static-toggle
[80.307573] Subtest static-toggle: SKIP (0.001s)
[80.484162] [009/132] (946s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[82.478288] Starting subtest: primary-yf-tiled-reflect-x-270
[82.578126] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.100s)
[82.802167] [010/132] (944s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[84.789045] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[84.790466] Starting dynamic subtest: pipe-A-HDMI-A-4
[84.805658] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[84.813947] Starting dynamic subtest: pipe-B-HDMI-A-4
[84.829531] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[84.837540] Starting dynamic subtest: pipe-C-HDMI-A-4
[84.853423] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[84.861449] Starting dynamic subtest: pipe-D-HDMI-A-4
[84.877992] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[84.880997] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[85.029664] [011/132] (942s left) gem_exec_params (invalid-fence-in-submit)
[85.100945] Starting subtest: invalid-fence-in-submit
[85.105930] Subtest invalid-fence-in-submit: SUCCESS (0.004s)
[85.303936] [012/132] (942s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[87.330896] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[87.431800] [013/132] (940s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[89.425100] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[89.428592] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[89.633402] [014/132] (937s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[91.619721] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[91.621388] Starting dynamic subtest: pipe-A-HDMI-A-4
[91.638121] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.001s)
[91.646818] Starting dynamic subtest: pipe-B-HDMI-A-4
[91.664200] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.001s)
[91.672176] Starting dynamic subtest: pipe-C-HDMI-A-4
[91.685121] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.001s)
[91.693034] Starting dynamic subtest: pipe-D-HDMI-A-4
[91.706710] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.001s)
[91.709518] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[91.885059] [015/132] (935s left) perf (create-destroy-userspace-config)
[92.067115] Starting subtest: create-destroy-userspace-config
[92.099301] Subtest create-destroy-userspace-config: SUCCESS (0.033s)
[92.206148] [016/132] (935s left) kms_vblank (query-idle-hang)
[94.190389] Starting subtest: query-idle-hang
[94.191903] Starting dynamic subtest: pipe-A-HDMI-A-4
[120.492336] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (26.299s)
[120.504138] Starting dynamic subtest: pipe-D-HDMI-A-4
[145.495590] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (25.000s)
[145.496881] Subtest query-idle-hang: SUCCESS (51.305s)
[145.682164] [017/132] (882s left) kms_lease (page-flip-implicit-plane)
[147.664569] Starting subtest: page-flip-implicit-plane
[147.666283] Starting dynamic subtest: pipe-A-HDMI-A-4
[148.096160] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.430s)
[148.105178] Starting dynamic subtest: pipe-B-HDMI-A-4
[148.339831] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.242s)
[148.350625] Starting dynamic subtest: pipe-C-HDMI-A-4
[148.583598] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.241s)
[148.593682] Starting dynamic subtest: pipe-D-HDMI-A-4
[148.832343] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.247s)
[148.833924] Subtest page-flip-implicit-plane: SUCCESS (1.167s)
[149.020101] [018/132] (878s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[151.008531] Starting subtest: nonblocking-crc-frame-sequence
[151.010050] Starting dynamic subtest: pipe-A-HDMI-A-4
[151.759563] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.750s)
[151.768278] Starting dynamic subtest: pipe-B-HDMI-A-4
[152.349575] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.589s)
[152.358290] Starting dynamic subtest: pipe-C-HDMI-A-4
[152.870150] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.520s)
[152.881055] Starting dynamic subtest: pipe-D-HDMI-A-4
[153.426440] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.554s)
[153.428124] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.420s)
[153.617019] [019/132] (874s left) i915_pm_rpm (gem-idle)
[157.998379] Starting subtest: gem-idle
[164.257171] Subtest gem-idle: SUCCESS (6.259s)
[165.390772] [020/132] (862s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[167.389056] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[167.392198] Subtest fbcpsr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[167.619696] [021/132] (860s left) gem_userptr_blits (mmap-offset-banned)
[167.679815] Starting subtest: mmap-offset-banned
[167.681491] Starting dynamic subtest: fixed
[167.683149] Dynamic subtest fixed: SUCCESS (0.000s)
[167.684829] Subtest mmap-offset-banned: SUCCESS (0.001s)
[167.891871] [022/132] (860s left) gem_ctx_isolation (clean)
[167.947817] Starting subtest: clean
[167.949612] Starting dynamic subtest: rcs0
[168.053856] Dynamic subtest rcs0: SUCCESS (0.106s)
[168.062808] Starting dynamic subtest: bcs0
[168.189893] Dynamic subtest bcs0: SUCCESS (0.136s)
[168.198666] Starting dynamic subtest: vcs0
[168.311106] Dynamic subtest vcs0: SUCCESS (0.121s)
[168.319847] Starting dynamic subtest: vcs1
[168.423280] Dynamic subtest vcs1: SUCCESS (0.111s)
[168.432251] Starting dynamic subtest: vecs0
[168.554117] Dynamic subtest vecs0: SUCCESS (0.131s)
[168.555654] Subtest clean: SUCCESS (0.607s)
[168.939414] [023/132] (859s left) gem_userptr_blits (sync-overlap)
[168.998691] Starting subtest: sync-overlap
[169.000230] Subtest sync-overlap: SUCCESS (0.000s)
[169.196497] [024/132] (859s left) perf_pmu (module-unload)
[169.264580] Starting subtest: module-unload
[178.324034] Subtest module-unload: FAIL (8.989s)
[178.401838] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[178.404504] [025/132] (850s left) kms_psr (psr2-sprite-plane-onoff)
[184.248631] Subtest psr2-sprite-plane-onoff: SKIP (0.000s)
[184.343526] [FACT kms_psr (psr2-sprite-plane-onoff)] new: kernel.kmod_is_loaded.i915: true
[184.349209] [026/132] (844s left) kms_cursor_crc (cursor-onscreen-32x32)
[186.435738] Starting subtest: cursor-onscreen-32x32
[186.488245] Subtest cursor-onscreen-32x32: SKIP (0.048s)
[186.963592] [027/132] (841s left) gem_caching (writes)
[187.017978] Starting subtest: writes
[192.097038] Subtest writes: SUCCESS (5.079s)
[192.301819] [028/132] (836s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[194.293678] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[194.296594] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[194.538540] [029/132] (834s left) gem_create (create-ext-placement-all)
[194.700828] Starting subtest: create-ext-placement-all
[194.702550] Subtest create-ext-placement-all: SUCCESS (0.000s)
[194.853297] [030/132] (834s left) i915_module_load (reload-no-display)
[194.897115] Starting subtest: reload-no-display
[200.754699] Subtest reload-no-display: SUCCESS (5.857s)
[200.793347] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[200.797047] [031/132] (828s left) kms_dp_linktrain_fallback (dsc-fallback)
[206.723721] Starting subtest: dsc-fallback
[206.728363] Subtest dsc-fallback: SKIP (0.000s)
[206.886151] [FACT kms_dp_linktrain_fallback (dsc-fallback)] new: kernel.kmod_is_loaded.i915: true
[206.890117] [032/132] (822s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[208.880490] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[208.899780] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.018s)
[209.113874] [033/132] (820s left) gem_exec_balancer (full-late)
[209.173161] Starting subtest: full-late
[211.627367] Subtest full-late: SUCCESS (2.454s)
[212.118134] [034/132] (817s left) kms_psr (psr2-basic)
[214.108229] Subtest psr2-basic: SKIP (0.000s)
[214.175497] [035/132] (815s left) syncobj_timeline (wait-zero-handles)
[214.222324] Starting subtest: wait-zero-handles
[214.224032] Subtest wait-zero-handles: SUCCESS (0.000s)
[214.416610] [036/132] (815s left) gem_mmap_wc (write-cpu-read-wc)
[214.465454] Subtest write-cpu-read-wc: SKIP (0.000s)
[214.541391] [037/132] (815s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[216.534730] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[216.537863] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[216.781598] [038/132] (812s left) syncobj_wait (multi-wait-for-submit-submitted)
[216.829237] Starting subtest: multi-wait-for-submit-submitted
[216.935875] Subtest multi-wait-for-submit-submitted: SUCCESS (0.104s)
[217.118613] [039/132] (812s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[219.109868] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[219.113444] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[219.353402] [040/132] (810s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[221.337974] Starting subtest: 2x-cursor-vs-flip-legacy
[221.341166] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.003s)
[221.535957] [041/132] (808s left) gem_exec_fence (syncobj-timeline-export)
[222.078832] Starting subtest: syncobj-timeline-export
[222.097814] Subtest syncobj-timeline-export: SUCCESS (0.022s)
[222.438799] [FACT gem_exec_fence (syncobj-timeline-export)] new: kernel.kmod_is_loaded.vgem: true
[222.441974] [042/132] (807s left) syncobj_wait (wait-any-complex)
[222.498849] Starting subtest: wait-any-complex
[222.551736] Subtest wait-any-complex: SUCCESS (0.062s)
[222.741093] [043/132] (807s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[224.722557] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[224.723898] Starting dynamic subtest: pipe-A
[224.851365] Dynamic subtest pipe-A: SUCCESS (0.129s)
[224.861697] Starting dynamic subtest: pipe-B
[224.992967] Dynamic subtest pipe-B: SUCCESS (0.141s)
[225.003088] Starting dynamic subtest: pipe-C
[225.134048] Dynamic subtest pipe-C: SUCCESS (0.140s)
[225.144263] Starting dynamic subtest: pipe-D
[225.275273] Dynamic subtest pipe-D: SUCCESS (0.140s)
[225.276969] Subtest planes-upscale-20x20-downscale-factor-0-75: SUCCESS (0.553s)
[225.516273] [044/132] (804s left) api_intel_allocator (execbuf-with-allocator)
[225.562174] Starting subtest: execbuf-with-allocator
[225.581636] Subtest execbuf-with-allocator: SUCCESS (0.020s)
[225.767241] [045/132] (804s left) gem_exec_whisper (basic-queues-priority)
[225.824513] Starting subtest: basic-queues-priority
[239.199659] Subtest basic-queues-priority: SUCCESS (13.370s)
[239.454554] [046/132] (791s left) gem_eio (unwedge-stress)
[239.656851] Starting subtest: unwedge-stress
[306.884476] Subtest unwedge-stress: SUCCESS (67.227s)
[309.043497] [047/132] (721s left) syncobj_wait (wait-all-interrupted)
[309.109307] Starting subtest: wait-all-interrupted
[309.215702] Subtest wait-all-interrupted: SUCCESS (0.102s)
[309.387609] [048/132] (721s left) gem_mmap_offset (bad-extensions)
[309.432585] Starting subtest: bad-extensions
[309.434169] Subtest bad-extensions: SUCCESS (0.000s)
[309.655993] [049/132] (721s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[311.648877] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[311.651834] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[311.907145] [050/132] (719s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[313.899995] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[313.902993] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[314.156949] [051/132] (717s left) kms_plane_alpha_blend (coverage-7efc)
[316.146467] Starting subtest: coverage-7efc
[316.416346] Starting dynamic subtest: pipe-A-HDMI-A-4
[316.904690] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.487s)
[316.935576] Starting dynamic subtest: pipe-D-HDMI-A-4
[317.449074] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.524s)
[317.450978] Subtest coverage-7efc: SUCCESS (1.304s)
[317.666109] [052/132] (713s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[319.662539] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[319.665826] Subtest psr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[319.915911] [053/132] (711s left) gem_pxp (reject-modify-context-protection-off-1)
[322.520172] Starting subtest: reject-modify-context-protection-off-1
[322.523402] Subtest reject-modify-context-protection-off-1: SKIP (0.000s)
[322.650501] [054/132] (708s left) kms_chamelium_frames (hdmi-frame-dump)
[324.673804] Subtest hdmi-frame-dump: SKIP (0.000s)
[324.786268] [055/132] (706s left) gem_mmap_gtt (basic-write-read)
[324.833518] Subtest basic-write-read: SKIP (0.000s)
[324.921762] [056/132] (706s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[326.923159] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[326.926299] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[327.176165] [057/132] (704s left) gem_mmap_gtt (bad-object)
[327.224108] Subtest bad-object: SKIP (0.000s)
[327.300121] [058/132] (704s left) kms_async_flips (invalid-async-flip-atomic)
[329.316662] Starting subtest: invalid-async-flip-atomic
[329.543753] Starting dynamic subtest: pipe-A-HDMI-A-4
[329.963611] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.420s)
[330.144160] Starting dynamic subtest: pipe-B-HDMI-A-4
[330.229797] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.096s)
[330.392493] Starting dynamic subtest: pipe-C-HDMI-A-4
[330.480921] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.099s)
[330.649249] Starting dynamic subtest: pipe-D-HDMI-A-4
[330.744921] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.106s)
[330.746487] Subtest invalid-async-flip-atomic: SUCCESS (1.431s)
[331.125994] [059/132] (700s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[333.175940] Starting subtest: y-tiled-8bpp-rotate-90
[333.280091] Subtest y-tiled-8bpp-rotate-90: SKIP (0.103s)
[333.481301] [060/132] (698s left) kms_flip (nonexisting-fb)
[335.466346] Starting subtest: nonexisting-fb
[335.473471] Starting dynamic subtest: A-HDMI-A4
[335.715121] Dynamic subtest A-HDMI-A4: SUCCESS (0.242s)
[335.727050] Starting dynamic subtest: B-HDMI-A4
[335.892735] Dynamic subtest B-HDMI-A4: SUCCESS (0.177s)
[335.904341] Starting dynamic subtest: C-HDMI-A4
[336.052181] Dynamic subtest C-HDMI-A4: SUCCESS (0.158s)
[336.063970] Starting dynamic subtest: D-HDMI-A4
[336.229884] Dynamic subtest D-HDMI-A4: SUCCESS (0.176s)
[336.231479] Subtest nonexisting-fb: SUCCESS (0.765s)
[336.521854] [061/132] (695s left) kms_pm_rpm (dpms-lpsp)
[341.004080] Starting subtest: dpms-lpsp
[341.009134] Subtest dpms-lpsp: SKIP (0.002s)
[342.269425] [062/132] (689s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[344.270944] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[344.272690] Starting dynamic subtest: pipe-A-HDMI-A-4
[344.287200] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.001s)
[344.299128] Starting dynamic subtest: pipe-B-HDMI-A-4
[344.314407] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.001s)
[344.325875] Starting dynamic subtest: pipe-C-HDMI-A-4
[344.341113] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.001s)
[344.352668] Starting dynamic subtest: pipe-D-HDMI-A-4
[344.366836] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.001s)
[344.368183] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SUCCESS (0.013s)
[344.561826] [063/132] (687s left) gem_spin_batch (legacy-resubmit)
[344.617688] Starting subtest: legacy-resubmit
[344.619127] Starting dynamic subtest: default
[344.639356] Dynamic subtest default: SUCCESS (0.021s)
[344.651491] Starting dynamic subtest: render
[344.652913] Dynamic subtest render: SUCCESS (0.002s)
[344.664817] Starting dynamic subtest: bsd
[344.666482] Dynamic subtest bsd: SUCCESS (0.002s)
[344.677780] Starting dynamic subtest: bsd1
[344.679337] Dynamic subtest bsd1: SUCCESS (0.002s)
[344.690341] Starting dynamic subtest: bsd2
[344.691871] Dynamic subtest bsd2: SUCCESS (0.002s)
[344.702855] Starting dynamic subtest: blt
[344.704510] Dynamic subtest blt: SUCCESS (0.002s)
[344.715582] Starting dynamic subtest: vebox
[344.717190] Dynamic subtest vebox: SUCCESS (0.003s)
[344.718845] Subtest legacy-resubmit: SUCCESS (0.043s)
[345.027151] [064/132] (687s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[347.028787] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[347.031657] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[347.286945] [065/132] (685s left) kms_getfb (getfb2-handle-not-fb)
[349.290809] Starting subtest: getfb2-handle-not-fb
[349.292201] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[349.529624] [066/132] (683s left) gem_exec_reloc (basic-gtt-read-noreloc)
[349.580627] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[349.680536] [067/132] (683s left) syncobj_timeline (invalid-transfer-non-existent-point)
[349.727846] Starting subtest: invalid-transfer-non-existent-point
[349.729310] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[349.943660] [068/132] (682s left) kms_sharpness_filter (filter-scaler-downscale)
[351.919710] Starting subtest: filter-scaler-downscale
[351.928243] Subtest filter-scaler-downscale: SKIP (0.002s)
[352.129910] [069/132] (680s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[352.177844] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[352.288118] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.108s)
[352.491864] [070/132] (680s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[354.479896] Starting subtest: flip-vs-cursor-crc-atomic
[355.005841] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.527s)
[355.232181] [071/132] (677s left) i915_drm_fdinfo (memory-info-active)
[355.282134] Starting subtest: memory-info-active
[355.283749] Starting dynamic subtest: lmem0
[358.887988] Dynamic subtest lmem0: SUCCESS (3.604s)
[358.908219] Starting dynamic subtest: smem0
[363.212335] Dynamic subtest smem0: SUCCESS (4.317s)
[363.214215] Subtest memory-info-active: SUCCESS (7.928s)
[363.348709] [072/132] (669s left) api_intel_bb (object-reloc-purge-cache)
[363.395902] Starting subtest: object-reloc-purge-cache
[363.400502] Subtest object-reloc-purge-cache: SKIP (0.003s)
[363.614893] [073/132] (669s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[365.617640] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[366.179182] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.561s)
[366.481231] [074/132] (666s left) kms_flip (bo-too-big)
[368.468903] Starting subtest: bo-too-big
[368.475831] Starting dynamic subtest: A-HDMI-A4
[368.706384] Dynamic subtest A-HDMI-A4: SUCCESS (0.231s)
[368.720558] Starting dynamic subtest: B-HDMI-A4
[368.851313] Dynamic subtest B-HDMI-A4: SUCCESS (0.143s)
[368.865377] Starting dynamic subtest: C-HDMI-A4
[368.994965] Dynamic subtest C-HDMI-A4: SUCCESS (0.142s)
[369.007026] Starting dynamic subtest: D-HDMI-A4
[369.141304] Dynamic subtest D-HDMI-A4: SUCCESS (0.145s)
[369.142946] Subtest bo-too-big: SUCCESS (0.675s)
[369.463742] [075/132] (664s left) gem_mmap_gtt (big-bo-tiledx)
[369.520374] Subtest big-bo-tiledX: SKIP (0.000s)
[369.594065] [076/132] (664s left) kms_flip (flip-vs-modeset-vs-hang)
[371.578936] Starting subtest: flip-vs-modeset-vs-hang
[371.583542] Starting dynamic subtest: A-HDMI-A4
[422.489462] Dynamic subtest A-HDMI-A4: SUCCESS (50.903s)
[422.502650] Starting dynamic subtest: D-HDMI-A4
[472.470180] Dynamic subtest D-HDMI-A4: SUCCESS (49.979s)
[472.472163] Subtest flip-vs-modeset-vs-hang: SUCCESS (100.889s)
[472.691911] [077/132] (561s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[474.685188] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[474.688671] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[474.880848] [078/132] (558s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[476.865029] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[476.866668] Starting dynamic subtest: pipe-A-HDMI-A-4
[476.882817] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.001s)
[476.895207] Starting dynamic subtest: pipe-B-HDMI-A-4
[476.912277] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.001s)
[476.924178] Starting dynamic subtest: pipe-C-HDMI-A-4
[476.941043] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.001s)
[476.953114] Starting dynamic subtest: pipe-D-HDMI-A-4
[476.977770] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.001s)
[476.980569] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.014s)
[477.123326] [079/132] (556s left) kms_cursor_crc (cursor-sliding-256x85)
[479.344491] Starting subtest: cursor-sliding-256x85
[479.352575] Starting dynamic subtest: pipe-A-HDMI-A-4
[483.760522] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (4.409s)
[483.794871] Starting dynamic subtest: pipe-D-HDMI-A-4
[488.088900] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (4.304s)
[488.090693] Subtest cursor-sliding-256x85: SUCCESS (8.743s)
[488.442334] [080/132] (545s left) kms_cursor_legacy (forked-move)
[490.440706] Starting subtest: forked-move
[490.442254] Starting dynamic subtest: pipe-A
[495.862224] Dynamic subtest pipe-A: SUCCESS (5.418s)
[495.878490] Starting dynamic subtest: pipe-B
[501.304376] Dynamic subtest pipe-B: SUCCESS (5.439s)
[501.334107] Starting dynamic subtest: pipe-C
[506.753891] Dynamic subtest pipe-C: SUCCESS (5.447s)
[506.779512] Starting dynamic subtest: pipe-D
[512.212078] Dynamic subtest pipe-D: SUCCESS (5.455s)
[512.238045] Starting dynamic subtest: all-pipes
[517.658763] Dynamic subtest all-pipes: SUCCESS (5.444s)
[517.660525] Subtest forked-move: SUCCESS (27.217s)
[517.829147] [081/132] (516s left) kms_selftest (drm_format_helper)
[517.877318] Starting subtest: drm_format_helper
[517.952646] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[518.027544] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.103s)
[518.075769] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[518.117547] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.083s)
[518.142589] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[518.208043] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.087s)
[518.251062] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[518.298108] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.082s)
[518.326968] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[518.401616] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.100s)
[518.447085] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[518.494749] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.085s)
[518.519286] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[518.595593] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.098s)
[518.639031] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[518.688594] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.083s)
[518.722421] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[518.762147] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.071s)
[518.791882] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[518.859385] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.092s)
[518.906973] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[518.948833] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.083s)
[518.970750] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[519.042335] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.089s)
[519.087814] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[519.136301] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.088s)
[519.164983] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[519.242903] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.102s)
[519.287807] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[519.332374] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.086s)
[519.364509] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[519.443073] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.105s)
[519.480972] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[519.540826] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.092s)
[519.542895] Subtest drm_format_helper: SUCCESS (1.662s)
[519.812549] [082/132] (514s left) gem_eio (in-flight-internal-10ms)
[520.005344] Starting subtest: in-flight-internal-10ms
[521.825423] Subtest in-flight-internal-10ms: SUCCESS (1.821s)
[523.966741] [083/132] (510s left) gen9_exec_parse (basic-rejected)
[524.020662] Subtest basic-rejected: SKIP (0.000s)
[524.100385] [084/132] (510s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[526.102095] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[526.105547] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[526.358598] [085/132] (508s left) perf_pmu (busy)
[526.411317] Starting subtest: busy
[526.412615] Starting dynamic subtest: rcs0
[527.037343] Dynamic subtest rcs0: SUCCESS (0.627s)
[527.053917] Starting dynamic subtest: bcs0
[527.598370] Dynamic subtest bcs0: SUCCESS (0.559s)
[527.615516] Starting dynamic subtest: vcs0
[528.162972] Dynamic subtest vcs0: SUCCESS (0.561s)
[528.179621] Starting dynamic subtest: vcs1
[528.726940] Dynamic subtest vcs1: SUCCESS (0.558s)
[528.743797] Starting dynamic subtest: vecs0
[529.290080] Dynamic subtest vecs0: SUCCESS (0.557s)
[529.296052] Subtest busy: SUCCESS (2.884s)
[529.454590] [086/132] (505s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[531.696100] Starting subtest: cursor-rapid-movement-512x512
[531.699164] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[531.995019] [087/132] (502s left) kms_fbcon_fbt (fbc-suspend)
[532.045962] Starting subtest: fbc-suspend
[587.056867] Subtest fbc-suspend: SUCCESS (32.762s)
[588.164742] [088/132] (447s left) syncobj_timeline (invalid-query-illegal-handle)
[588.214215] Starting subtest: invalid-query-illegal-handle
[588.216018] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[588.401822] [089/132] (447s left) gem_bad_reloc (negative-reloc-lut)
[588.457726] Subtest negative-reloc-lut: SKIP (0.000s)
[588.575066] [090/132] (447s left) kms_chamelium_color (ctm-limited-range)
[590.325568] Subtest ctm-limited-range: SKIP (0.000s)
[590.408124] [091/132] (445s left) syncobj_timeline (device-submit-unordered)
[590.456853] Starting subtest: device-submit-unordered
[590.458557] Subtest device-submit-unordered: SUCCESS (0.000s)
[590.643333] [092/132] (445s left) gem_exec_capture (capture)
[590.699040] Starting subtest: capture
[590.700771] Starting dynamic subtest: rcs0-smem
[591.601004] Dynamic subtest rcs0-smem: SUCCESS (0.878s)
[591.616141] Starting dynamic subtest: rcs0-lmem0
[592.984072] Dynamic subtest rcs0-lmem0: SUCCESS (1.350s)
[592.998283] Starting dynamic subtest: bcs0-smem
[593.861495] Dynamic subtest bcs0-smem: SUCCESS (0.859s)
[593.875774] Starting dynamic subtest: bcs0-lmem0
[594.735110] Dynamic subtest bcs0-lmem0: SUCCESS (0.857s)
[594.749578] Starting dynamic subtest: vcs0-smem
[595.599319] Dynamic subtest vcs0-smem: SUCCESS (0.851s)
[595.613265] Starting dynamic subtest: vcs0-lmem0
[596.967325] Dynamic subtest vcs0-lmem0: SUCCESS (1.347s)
[596.981105] Starting dynamic subtest: vcs1-smem
[597.830627] Dynamic subtest vcs1-smem: SUCCESS (0.851s)
[597.844872] Starting dynamic subtest: vcs1-lmem0
[598.693387] Dynamic subtest vcs1-lmem0: SUCCESS (0.853s)
[598.707515] Starting dynamic subtest: vecs0-smem
[599.601694] Dynamic subtest vecs0-smem: FAIL (0.862s)
[599.615158] Starting dynamic subtest: vecs0-lmem0
[600.618565] Dynamic subtest vecs0-lmem0: FAIL (0.996s)
[600.620588] Subtest capture: FAIL (9.718s)
[600.806459] [093/132] (435s left) vgem_basic (busy-fence)
[600.862329] Starting subtest: busy-fence
[600.864106] Subtest busy-fence: SUCCESS (0.000s)
[601.040146] [094/132] (435s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[603.033736] Starting subtest: psr-rgb101010-draw-render
[603.037243] Subtest psr-rgb101010-draw-render: SKIP (0.000s)
[603.301327] [095/132] (433s left) kms_psr (fbc-pr-sprite-render)
[605.289251] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[605.368124] [096/132] (431s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[605.421462] Subtest no-spare-fences-busy: SKIP (0.000s)
[605.503557] [097/132] (431s left) device_reset (cold-reset-bound)
[605.580869] Starting subtest: cold-reset-bound
[605.584881] Subtest cold-reset-bound: SKIP (0.000s)
[605.724698] [098/132] (431s left) kms_force_connector_basic (force-edid)
[605.856066] Starting subtest: force-edid
[605.877027] Subtest force-edid: SUCCESS (0.021s)
[608.130468] [099/132] (428s left) gem_flink_basic (bad-flink)
[608.192430] Starting subtest: bad-flink
[608.193806] Subtest bad-flink: SUCCESS (0.000s)
[608.375590] [100/132] (428s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[608.458509] Starting subtest: y-tiled-to-vebox-x-tiled
[608.460312] Starting dynamic subtest: smem
[608.547370] Dynamic subtest smem: SUCCESS (0.088s)
[608.561853] Starting dynamic subtest: lmem0
[609.309054] Dynamic subtest lmem0: SUCCESS (0.755s)
[609.310762] Subtest y-tiled-to-vebox-x-tiled: SUCCESS (0.846s)
[609.625661] [101/132] (427s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[611.617489] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[611.620438] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[611.881475] [102/132] (425s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[611.933232] Subtest writes-after-reads: SKIP (0.000s)
[612.067873] [103/132] (425s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[614.063115] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[614.066240] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[614.313588] [104/132] (423s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[616.317572] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[616.383687] [105/132] (421s left) i915_suspend (fence-restore-tiled2untiled)
[616.429274] Starting subtest: fence-restore-tiled2untiled
[616.432123] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[616.564202] [106/132] (421s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[618.552501] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[618.555212] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[618.806783] [107/132] (419s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[620.792867] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[620.794525] Starting dynamic subtest: pipe-A-valid-mode
[621.577474] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.782s)
[621.579045] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (0.785s)
[621.845769] [108/132] (416s left) gem_exec_store (pages)
[621.905595] Starting subtest: pages
[621.907126] Starting dynamic subtest: rcs0
[622.064676] Dynamic subtest rcs0: SUCCESS (0.161s)
[622.087974] Starting dynamic subtest: bcs0
[622.180259] Dynamic subtest bcs0: SUCCESS (0.114s)
[622.194304] Starting dynamic subtest: vcs0
[622.294335] Dynamic subtest vcs0: SUCCESS (0.113s)
[622.308447] Starting dynamic subtest: vcs1
[622.408346] Dynamic subtest vcs1: SUCCESS (0.113s)
[622.422799] Starting dynamic subtest: vecs0
[622.525539] Dynamic subtest vecs0: SUCCESS (0.116s)
[622.527118] Subtest pages: SUCCESS (0.623s)
[622.802291] [109/132] (415s left) kms_busy (extended-modeset-hang-newfb)
[624.795122] Starting subtest: extended-modeset-hang-newfb
[624.796800] Starting dynamic subtest: pipe-A
[640.338202] Dynamic subtest pipe-A: SUCCESS (15.540s)
[640.356068] Starting dynamic subtest: pipe-D
[655.851128] Dynamic subtest pipe-D: SUCCESS (15.503s)
[655.852587] Subtest extended-modeset-hang-newfb: SUCCESS (31.052s)
[656.135088] [110/132] (381s left) sw_sync (sync_multi_consumer_producer)
[656.197848] Starting subtest: sync_multi_consumer_producer
[656.478240] Subtest sync_multi_consumer_producer: SUCCESS (0.277s)
[656.635577] [111/132] (381s left) kms_psr (fbc-psr2-primary-blt)
[658.640258] Subtest fbc-psr2-primary-blt: SKIP (0.000s)
[658.716528] [112/132] (379s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[660.722179] Starting subtest: x-tiled-64bpp-rotate-270
[660.791395] Subtest x-tiled-64bpp-rotate-270: SKIP (0.066s)
[661.054286] [113/132] (377s left) gem_pread (self)
[661.101948] Subtest self: SKIP (0.000s)
[661.229437] [114/132] (377s left) kms_vrr (flipline)
[663.213579] Starting subtest: flipline
[663.217762] Subtest flipline: SKIP (0.000s)
[663.411565] [115/132] (375s left) gem_softpin (evict-active)
[663.463873] Starting subtest: evict-active
[663.475859] Subtest evict-active: SUCCESS (0.012s)
[663.705714] [116/132] (375s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[665.696684] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[665.699373] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[665.963281] [117/132] (372s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[667.948643] Starting subtest: cursorA-vs-flipA-atomic-transitions
[678.865637] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (10.914s)
[679.081374] [118/132] (359s left) gem_ctx_persistence (legacy-engines-mixed)
[679.141248] Starting subtest: legacy-engines-mixed
[679.142805] Starting dynamic subtest: render
[679.208753] Dynamic subtest render: SUCCESS (0.066s)
[679.228521] Starting dynamic subtest: bsd1
[679.259927] Dynamic subtest bsd1: SUCCESS (0.049s)
[679.292543] Starting dynamic subtest: bsd2
[679.317825] Dynamic subtest bsd2: SUCCESS (0.055s)
[679.341778] Starting dynamic subtest: blt
[679.373913] Dynamic subtest blt: SUCCESS (0.053s)
[679.403958] Starting dynamic subtest: vebox
[679.428913] Dynamic subtest vebox: SUCCESS (0.052s)
[679.430765] Subtest legacy-engines-mixed: SUCCESS (0.289s)
[679.642209] [119/132] (359s left) gem_exec_params (dr4-dirt)
[679.694628] Starting subtest: DR4-dirt
[679.696333] Subtest DR4-dirt: SUCCESS (0.000s)
[679.851234] [120/132] (359s left) gem_exec_parallel (basic)
[679.906697] Starting subtest: basic
[679.908472] Starting dynamic subtest: rcs0
[681.502495] Dynamic subtest rcs0: SUCCESS (1.595s)
[681.518796] Starting dynamic subtest: bcs0
[683.003507] Dynamic subtest bcs0: SUCCESS (1.499s)
[683.017810] Starting dynamic subtest: vcs0
[684.546564] Dynamic subtest vcs0: SUCCESS (1.541s)
[684.564034] Starting dynamic subtest: vcs1
[686.097527] Dynamic subtest vcs1: SUCCESS (1.550s)
[686.112098] Starting dynamic subtest: vecs0
[687.634919] Dynamic subtest vecs0: SUCCESS (1.536s)
[687.636809] Subtest basic: SUCCESS (7.729s)
[688.000986] [121/132] (351s left) gem_render_copy_redux (interruptible)
[688.057006] Starting subtest: interruptible
[688.941345] Subtest interruptible: SUCCESS (0.887s)
[689.153308] [122/132] (350s left) gem_mmap_wc (close)
[689.203059] Subtest close: SKIP (0.000s)
[689.277008] [123/132] (350s left) gem_exec_schedule (lateslice)
[689.345162] Starting subtest: lateslice
[689.346603] Starting dynamic subtest: rcs0
[689.369462] Dynamic subtest rcs0: SUCCESS (0.035s)
[689.383574] Starting dynamic subtest: bcs0
[689.390783] Dynamic subtest bcs0: SUCCESS (0.020s)
[689.404893] Starting dynamic subtest: vcs0
[689.412574] Dynamic subtest vcs0: SUCCESS (0.020s)
[689.426860] Starting dynamic subtest: vcs1
[689.436324] Dynamic subtest vcs1: SUCCESS (0.022s)
[689.452624] Starting dynamic subtest: vecs0
[689.457617] Dynamic subtest vecs0: SUCCESS (0.020s)
[689.459194] Subtest lateslice: SUCCESS (0.125s)
[689.957646] [124/132] (349s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[691.953594] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[692.025467] [125/132] (347s left) kms_flip_event_leak (basic)
[694.012109] Starting subtest: basic
[694.013857] Starting dynamic subtest: pipe-A-HDMI-A-4
[694.385713] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.371s)
[694.400279] Starting dynamic subtest: pipe-B-HDMI-A-4
[694.591635] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.204s)
[694.608529] Starting dynamic subtest: pipe-C-HDMI-A-4
[694.780567] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.184s)
[694.797144] Starting dynamic subtest: pipe-D-HDMI-A-4
[694.955325] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.173s)
[694.956940] Subtest basic: SUCCESS (0.944s)
[695.228335] [126/132] (344s left) gem_exec_schedule (u-semaphore-noskip)
[695.416433] Starting subtest: u-semaphore-noskip
[695.857216] Subtest u-semaphore-noskip: SUCCESS (0.442s)
[696.400843] [127/132] (343s left) gem_ctx_param (set-priority-not-supported)
[696.466493] Starting subtest: set-priority-not-supported
[696.469265] Subtest set-priority-not-supported: SKIP (0.000s)
[696.619709] [128/132] (343s left) gem_ctx_shared (q-out-order)
[696.676810] Starting subtest: Q-out-order
[696.678462] Starting dynamic subtest: rcs0
[696.866479] Dynamic subtest rcs0: SUCCESS (0.186s)
[696.880729] Starting dynamic subtest: bcs0
[697.001608] Dynamic subtest bcs0: SUCCESS (0.133s)
[697.015866] Starting dynamic subtest: vcs0
[697.127977] Dynamic subtest vcs0: SUCCESS (0.125s)
[697.141870] Starting dynamic subtest: vcs1
[697.262450] Dynamic subtest vcs1: SUCCESS (0.133s)
[697.276797] Starting dynamic subtest: vecs0
[697.398174] Dynamic subtest vecs0: SUCCESS (0.134s)
[697.399768] Subtest Q-out-order: SUCCESS (0.719s)
[697.755025] [129/132] (342s left) kms_big_fb (linear-64bpp-rotate-180)
[699.758277] Starting subtest: linear-64bpp-rotate-180
[702.032305] Subtest linear-64bpp-rotate-180: SUCCESS (2.271s)
[702.291988] [130/132] (337s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[702.340410] Starting subtest: multi-wait-all-for-submit-unsubmitted
[702.444781] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.103s)
[702.601921] [131/132] (337s left) prime_mmap (test_correct_cpu_write)
[702.648867] Starting subtest: test_correct_cpu_write
[702.650630] Starting dynamic subtest: test_correct_cpu_write-smem
[702.652360] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[702.666859] Starting dynamic subtest: test_correct_cpu_write-lmem0
[702.668736] Dynamic subtest test_correct_cpu_write-lmem0: SUCCESS (0.000s)
[702.670490] Subtest test_correct_cpu_write: SUCCESS (0.004s)
[702.879561] [132/132] (337s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[704.865480] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.000s)
[704.940217] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_params
results: parsing output: 1/ for test: kms_color
results: parsing output: 2/ for test: kms_addfb_basic
results: parsing output: 3/ for test: kms_prop_blob
results: parsing output: 4/ for test: kms_plane_scaling
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: kms_flip
results: parsing output: 7/ for test: kms_hdr
results: parsing output: 8/ for test: kms_rotation_crc
results: parsing output: 9/ for test: kms_ccs
results: parsing output: 10/ for test: gem_exec_params
results: parsing output: 11/ for test: kms_chamelium_hpd
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: perf
results: parsing output: 15/ for test: kms_vblank
results: parsing output: 16/ for test: kms_lease
results: parsing output: 17/ for test: kms_pipe_crc_basic
results: parsing output: 18/ for test: i915_pm_rpm
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: gem_userptr_blits
results: parsing output: 21/ for test: gem_ctx_isolation
results: parsing output: 22/ for test: gem_userptr_blits
results: parsing output: 23/ for test: perf_pmu
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: kms_cursor_crc
results: parsing output: 26/ for test: gem_caching
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gem_create
results: parsing output: 29/ for test: i915_module_load
results: parsing output: 30/ for test: kms_dp_linktrain_fallback
results: parsing output: 31/ for test: kms_flip
results: parsing output: 32/ for test: gem_exec_balancer
results: parsing output: 33/ for test: kms_psr
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: gem_mmap_wc
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: syncobj_wait
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_cursor_legacy
results: parsing output: 40/ for test: gem_exec_fence
results: parsing output: 41/ for test: syncobj_wait
results: parsing output: 42/ for test: kms_plane_scaling
results: parsing output: 43/ for test: api_intel_allocator
results: parsing output: 44/ for test: gem_exec_whisper
results: parsing output: 45/ for test: gem_eio
results: parsing output: 46/ for test: syncobj_wait
results: parsing output: 47/ for test: gem_mmap_offset
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_plane_alpha_blend
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: gem_pxp
results: parsing output: 53/ for test: kms_chamelium_frames
results: parsing output: 54/ for test: gem_mmap_gtt
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_mmap_gtt
results: parsing output: 57/ for test: kms_async_flips
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: kms_flip
results: parsing output: 60/ for test: kms_pm_rpm
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: gem_spin_batch
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: kms_getfb
results: parsing output: 65/ for test: gem_exec_reloc
results: parsing output: 66/ for test: syncobj_timeline
results: parsing output: 67/ for test: kms_sharpness_filter
results: parsing output: 68/ for test: syncobj_timeline
results: parsing output: 69/ for test: kms_cursor_legacy
results: parsing output: 70/ for test: i915_drm_fdinfo
results: parsing output: 71/ for test: api_intel_bb
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: kms_flip
results: parsing output: 74/ for test: gem_mmap_gtt
results: parsing output: 75/ for test: kms_flip
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: kms_cursor_crc
results: parsing output: 79/ for test: kms_cursor_legacy
results: parsing output: 80/ for test: kms_selftest
results: parsing output: 81/ for test: gem_eio
results: parsing output: 82/ for test: gen9_exec_parse
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: perf_pmu
results: parsing output: 85/ for test: kms_cursor_crc
results: parsing output: 86/ for test: kms_fbcon_fbt
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: gem_bad_reloc
results: parsing output: 89/ for test: kms_chamelium_color
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: gem_exec_capture
results: parsing output: 92/ for test: vgem_basic
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: gem_fenced_exec_thrash
results: parsing output: 96/ for test: device_reset
results: parsing output: 97/ for test: kms_force_connector_basic
results: parsing output: 98/ for test: gem_flink_basic
results: parsing output: 99/ for test: gem_render_copy
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_psr2_sf
results: parsing output: 104/ for test: i915_suspend
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_flip_scaled_crc
results: parsing output: 107/ for test: gem_exec_store
results: parsing output: 108/ for test: kms_busy
results: parsing output: 109/ for test: sw_sync
results: parsing output: 110/ for test: kms_psr
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: gem_pread
results: parsing output: 113/ for test: kms_vrr
results: parsing output: 114/ for test: gem_softpin
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_cursor_legacy
results: parsing output: 117/ for test: gem_ctx_persistence
results: parsing output: 118/ for test: gem_exec_params
results: parsing output: 119/ for test: gem_exec_parallel
results: parsing output: 120/ for test: gem_render_copy_redux
results: parsing output: 121/ for test: gem_mmap_wc
results: parsing output: 122/ for test: gem_exec_schedule
results: parsing output: 123/ for test: kms_psr2_sf
results: parsing output: 124/ for test: kms_flip_event_leak
results: parsing output: 125/ for test: gem_exec_schedule
results: parsing output: 126/ for test: gem_ctx_param
results: parsing output: 127/ for test: gem_ctx_shared
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: syncobj_wait
results: parsing output: 130/ for test: prime_mmap
results: parsing output: 131/ for test: kms_psr
Done.