[71.163926] Initializing watchdogs
[71.164335]   /dev/watchdog0
[71.294067] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[71.314691] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[71.328988] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[71.337678] [001/133] (960s left) kms_pm_backlight (fade)
[72.841033] Subtest fade: SKIP (0.000s)
[72.909234] [002/133] (958s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[72.956779] Starting subtest: single-wait-for-submit-available-submitted
[72.958361] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.001s)
[73.064532] [003/133] (958s left) gem_exec_reloc (basic-wc-gtt)
[73.121623] Subtest basic-wc-gtt: SKIP (0.000s)
[73.205668] [004/133] (958s left) kms_async_flips (async-flip-dpms)
[74.678092] Starting subtest: async-flip-dpms
[74.893126] Starting dynamic subtest: pipe-A-HDMI-A-4
[77.634762] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.766s)
[78.586650] Starting dynamic subtest: pipe-B-HDMI-A-4
[80.711668] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (2.144s)
[80.987939] Starting dynamic subtest: pipe-C-HDMI-A-4
[83.102755] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (2.134s)
[83.371695] Starting dynamic subtest: pipe-D-HDMI-A-4
[85.483890] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.135s)
[85.485376] Subtest async-flip-dpms: SUCCESS (10.871s)
[85.909327] [005/133] (946s left) perf_pmu (render-node-busy-idle)
[85.966451] Starting subtest: render-node-busy-idle
[85.967933] Starting dynamic subtest: rcs0
[86.670044] Dynamic subtest rcs0: SUCCESS (0.704s)
[86.682439] Starting dynamic subtest: bcs0
[87.326673] Dynamic subtest bcs0: SUCCESS (0.657s)
[87.338199] Starting dynamic subtest: vcs0
[87.985613] Dynamic subtest vcs0: SUCCESS (0.659s)
[87.999457] Starting dynamic subtest: vcs1
[88.644102] Dynamic subtest vcs1: SUCCESS (0.658s)
[88.658177] Starting dynamic subtest: vecs0
[89.304237] Dynamic subtest vecs0: SUCCESS (0.660s)
[89.306940] Subtest render-node-busy-idle: SUCCESS (3.344s)
[89.426171] [006/133] (942s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[90.918470] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[90.921386] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[91.112327] [007/133] (941s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[92.606255] Starting subtest: fbcpsr-tiling-linear
[92.609173] Subtest fbcpsr-tiling-linear: SKIP (0.000s)
[92.778671] [008/133] (939s left) gem_exec_parallel (contexts)
[92.841253] Starting subtest: contexts
[92.842783] Starting dynamic subtest: rcs0
[97.120043] Dynamic subtest rcs0: SUCCESS (4.279s)
[97.131798] Starting dynamic subtest: bcs0
[101.625776] Dynamic subtest bcs0: SUCCESS (4.505s)
[101.636275] Starting dynamic subtest: vcs0
[106.133767] Dynamic subtest vcs0: SUCCESS (4.508s)
[106.144323] Starting dynamic subtest: vcs1
[110.256926] Dynamic subtest vcs1: SUCCESS (4.123s)
[110.267054] Starting dynamic subtest: vecs0
[114.680967] Dynamic subtest vecs0: SUCCESS (4.423s)
[114.683196] Subtest contexts: SUCCESS (21.841s)
[114.950855] [009/133] (917s left) kms_lease (implicit-plane-lease)
[116.437103] Starting subtest: implicit-plane-lease
[116.438894] Subtest implicit-plane-lease: SUCCESS (0.003s)
[116.553803] [010/133] (915s left) gem_lmem_swapping (random-engines)
[120.815308] Starting subtest: random-engines
[120.819370] Starting dynamic subtest: lmem0
[122.031575] Dynamic subtest lmem0: SUCCESS (1.213s)
[122.032972] Subtest random-engines: SUCCESS (1.214s)
[124.662378] [FACT gem_lmem_swapping (random-engines)] deleted: kernel.kmod_is_loaded.i915: true
[124.665172] [011/133] (907s left) perf_pmu (frequency)
[128.008300] Starting subtest: frequency
[128.011819] Starting dynamic subtest: gt0
[130.351952] Dynamic subtest gt0: FAIL (2.207s)
[130.387851] Starting dynamic subtest: idle-gt0
[130.729022] Dynamic subtest idle-gt0: SUCCESS (0.505s)
[130.730645] Subtest frequency: FAIL (2.720s)
[130.812224] [FACT perf_pmu (frequency)] new: kernel.kmod_is_loaded.i915: true
[130.815660] [012/133] (901s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[132.329881] Starting subtest: extended-modeset-hang-newfb-with-reset
[132.331552] Starting dynamic subtest: pipe-A
[153.331573] Dynamic subtest pipe-A: SUCCESS (21.001s)
[153.346147] Starting dynamic subtest: pipe-D
[174.306607] Dynamic subtest pipe-D: SUCCESS (20.970s)
[174.308284] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (41.978s)
[174.488044] [013/133] (858s left) kms_psr (psr2-cursor-render)
[175.977154] Subtest psr2-cursor-render: SKIP (0.000s)
[176.050343] [014/133] (856s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[177.540944] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[177.560048] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.017s)
[177.691313] [015/133] (855s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[179.191756] Starting subtest: cursorB-vs-flipB-toggle
[179.194832] Subtest cursorB-vs-flipB-toggle: SKIP (0.002s)
[179.318805] [016/133] (853s left) syncobj_wait (multi-wait-for-submit-signaled)
[179.380835] Starting subtest: multi-wait-for-submit-signaled
[179.382604] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[179.518302] [017/133] (853s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[179.566167] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[179.672940] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[179.819265] [018/133] (853s left) kms_prime (basic-crc-vgem)
[181.359406] Subtest basic-crc-vgem: SKIP (0.000s)
[181.594580] [FACT kms_prime (basic-crc-vgem)] new: kernel.kmod_is_loaded.vgem: true
[181.601215] [019/133] (851s left) kms_hdr (static-toggle-suspend)
[183.089106] Starting subtest: static-toggle-suspend
[183.094221] Subtest static-toggle-suspend: SKIP (0.001s)
[183.194838] [020/133] (850s left) gem_exec_flush (basic-uc-pro-default)
[183.250957] Subtest basic-uc-pro-default: SKIP (0.000s)
[183.364388] [021/133] (850s left) gem_exec_params (rs-invalid)
[183.415372] Starting subtest: rs-invalid
[183.419358] Subtest rs-invalid: SUCCESS (0.003s)
[183.592417] [022/133] (849s left) gen9_exec_parse (bb-start-out)
[183.643666] Subtest bb-start-out: SKIP (0.000s)
[183.719448] [023/133] (849s left) gem_exec_reloc (basic-wc-read)
[183.771616] Subtest basic-wc-read: SKIP (0.000s)
[183.878957] [024/133] (849s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier)
[185.363843] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier
[185.367143] Subtest pixel-format-4-tiled-bmg-ccs-modifier: SKIP (0.000s)
[185.487785] [025/133] (848s left) kms_plane (pixel-format-yf-tiled-modifier-source-clamping)
[186.985100] Starting subtest: pixel-format-yf-tiled-modifier-source-clamping
[186.988368] Subtest pixel-format-yf-tiled-modifier-source-clamping: SKIP (0.000s)
[187.098746] [026/133] (846s left) syncobj_wait (multi-wait-all-submitted-signaled)
[187.152741] Starting subtest: multi-wait-all-submitted-signaled
[187.258643] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.101s)
[187.412226] [027/133] (846s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[188.909156] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[188.912828] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[189.048887] [028/133] (844s left) gem_pipe_control_store_loop (fresh-buffer)
[189.113523] Starting subtest: fresh-buffer
[191.284448] Subtest fresh-buffer: SUCCESS (2.168s)
[191.456179] [029/133] (842s left) kms_properties (plane-properties-legacy)
[192.943143] Starting subtest: plane-properties-legacy
[192.944863] Starting dynamic subtest: pipe-A-HDMI-A-4
[193.431611] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.489s)
[193.442618] Starting dynamic subtest: pipe-B-HDMI-A-4
[193.891944] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.458s)
[193.903295] Starting dynamic subtest: pipe-C-HDMI-A-4
[194.360869] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.467s)
[194.372229] Starting dynamic subtest: pipe-D-HDMI-A-4
[194.830090] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.468s)
[194.831574] Subtest plane-properties-legacy: SUCCESS (1.889s)
[195.012055] [030/133] (839s left) kms_content_protection (uevent-hdcp14)
[196.555820] Starting subtest: uevent-hdcp14
[196.563229] Subtest uevent-hdcp14: SKIP (0.002s)
[196.782569] [031/133] (837s left) kms_cursor_edge_walk (256x256-top-edge)
[198.269588] Starting subtest: 256x256-top-edge
[198.271073] Starting dynamic subtest: pipe-A-HDMI-A-4
[201.588864] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (3.318s)
[201.600306] Starting dynamic subtest: pipe-D-HDMI-A-4
[204.806979] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (3.216s)
[204.808394] Subtest 256x256-top-edge: SUCCESS (6.538s)
[204.984507] [032/133] (829s left) kms_vblank (query-busy)
[206.471516] Starting subtest: query-busy
[206.472981] Starting dynamic subtest: pipe-A-HDMI-A-4
[209.025553] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.553s)
[209.039743] Starting dynamic subtest: pipe-D-HDMI-A-4
[211.403026] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.373s)
[211.404698] Subtest query-busy: SUCCESS (4.932s)
[211.578220] [033/133] (822s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[213.065890] Starting subtest: plane-all-modeset-transition-fencing
[213.067581] Starting dynamic subtest: pipe-A-HDMI-A-4
[224.737854] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (11.668s)
[224.793195] Starting dynamic subtest: pipe-B-HDMI-A-4
[232.735498] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (7.952s)
[232.751026] Subtest plane-all-modeset-transition-fencing: SUCCESS (19.686s)
[232.945262] [034/133] (801s left) gem_mmap_gtt (big-copy-odd)
[232.995079] Subtest big-copy-odd: SKIP (0.000s)
[233.074429] [035/133] (801s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[234.584849] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[235.828768] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.244s)
[236.021830] [036/133] (798s left) i915_drm_fdinfo (virtual-busy-all)
[236.074115] Starting subtest: virtual-busy-all
[236.077222] Subtest virtual-busy-all: SKIP (0.000s)
[236.180308] [037/133] (798s left) syncobj_wait (invalid-signal-zero-handles)
[236.225548] Starting subtest: invalid-signal-zero-handles
[236.227094] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[236.328112] [038/133] (798s left) gem_userptr_blits (dmabuf-sync)
[236.390350] Starting subtest: dmabuf-sync
[236.393368] Subtest dmabuf-sync: SKIP (0.003s)
[236.612669] [039/133] (798s left) gem_exec_balancer (full)
[236.670107] Starting subtest: full
[239.063125] Subtest full: SUCCESS (2.393s)
[239.568758] [040/133] (795s left) gem_exec_await (wide-contexts)
[239.732790] Starting subtest: wide-contexts
[262.010801] Subtest wide-contexts: SUCCESS (22.278s)
[262.251977] [041/133] (772s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[263.799142] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[263.802474] Starting dynamic subtest: pipe-A-HDMI-A-4
[263.815456] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[263.827704] Starting dynamic subtest: pipe-B-HDMI-A-4
[263.841165] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[263.852932] Starting dynamic subtest: pipe-C-HDMI-A-4
[263.866508] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[263.878393] Starting dynamic subtest: pipe-D-HDMI-A-4
[263.892543] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[263.895500] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.008s)
[264.062293] [042/133] (771s left) gem_ctx_exec (basic-close-race)
[264.114507] Starting subtest: basic-close-race
[269.671830] Subtest basic-close-race: SUCCESS (5.553s)
[269.882375] [043/133] (765s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[271.375428] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.000s)
[271.457176] [044/133] (763s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[272.972985] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[272.976211] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.004s)
[273.162633] [045/133] (762s left) gem_exec_schedule (preempt-other)
[273.238501] Starting subtest: preempt-other
[273.240093] Starting dynamic subtest: rcs0
[273.363714] Dynamic subtest rcs0: SUCCESS (0.125s)
[273.376189] Starting dynamic subtest: bcs0
[273.469844] Dynamic subtest bcs0: SUCCESS (0.107s)
[273.482227] Starting dynamic subtest: vcs0
[273.577936] Dynamic subtest vcs0: SUCCESS (0.108s)
[273.590493] Starting dynamic subtest: vcs1
[273.687049] Dynamic subtest vcs1: SUCCESS (0.108s)
[273.699763] Starting dynamic subtest: vecs0
[273.797900] Dynamic subtest vecs0: SUCCESS (0.110s)
[273.799691] Subtest preempt-other: SUCCESS (0.561s)
[274.238456] [046/133] (761s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[275.744957] Starting subtest: 4-tiled-32bpp-rotate-270
[275.748424] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.000s)
[275.915701] [047/133] (759s left) gem_linear_blits (basic)
[276.044148] Starting subtest: basic
[276.065035] Subtest basic: SUCCESS (0.022s)
[276.296952] [048/133] (759s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[276.422531] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[276.426574] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.002s)
[276.564208] [049/133] (759s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[278.056111] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[278.057824] Starting dynamic subtest: pipe-A-HDMI-A-4
[278.086610] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[278.098995] Starting dynamic subtest: pipe-B-HDMI-A-4
[278.112646] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[278.124681] Starting dynamic subtest: pipe-C-HDMI-A-4
[278.138843] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[278.150787] Starting dynamic subtest: pipe-D-HDMI-A-4
[278.165460] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[278.171058] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.008s)
[278.305970] [050/133] (757s left) api_intel_allocator (alloc-simple)
[278.353741] Starting subtest: alloc-simple
[278.370585] Subtest alloc-simple: SUCCESS (0.017s)
[278.586678] [051/133] (757s left) gem_eio (in-flight-immediate)
[278.811168] Starting subtest: in-flight-immediate
[282.962804] Subtest in-flight-immediate: SUCCESS (4.152s)
[284.545176] [052/133] (751s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[286.051063] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[286.135880] [053/133] (750s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[287.630830] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[287.633766] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[287.787216] [054/133] (748s left) kms_vblank (wait-forked-busy)
[289.281751] Starting subtest: wait-forked-busy
[289.283225] Starting dynamic subtest: pipe-A-HDMI-A-4
[291.828535] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.546s)
[291.844108] Starting dynamic subtest: pipe-D-HDMI-A-4
[294.224269] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.392s)
[294.225975] Subtest wait-forked-busy: SUCCESS (4.945s)
[294.398867] [055/133] (741s left) syncobj_eventfd (invalid-illegal-eventfd)
[294.449174] Starting subtest: invalid-illegal-eventfd
[294.450417] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[294.567940] [056/133] (741s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[296.061368] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[296.080822] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.018s)
[296.216752] [057/133] (740s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[297.730112] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[297.733169] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[297.909322] [058/133] (738s left) kms_color (legacy-gamma-reset)
[299.397568] Starting subtest: legacy-gamma-reset
[299.398963] Starting dynamic subtest: pipe-A-HDMI-A-4
[299.673357] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.276s)
[299.689614] Starting dynamic subtest: pipe-B-HDMI-A-4
[299.725438] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.051s)
[299.738175] Starting dynamic subtest: pipe-C-HDMI-A-4
[299.764756] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.038s)
[299.777636] Starting dynamic subtest: pipe-D-HDMI-A-4
[299.804143] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.039s)
[299.805837] Subtest legacy-gamma-reset: SUCCESS (0.409s)
[299.956271] [059/133] (736s left) gem_close (many-handles-one-vma)
[300.009055] Starting subtest: many-handles-one-vma
[300.046386] Subtest many-handles-one-vma: SUCCESS (0.037s)
[300.216145] [060/133] (736s left) gem_ctx_shared (create-shared-gtt)
[300.275634] Starting subtest: create-shared-gtt
[302.428997] Subtest create-shared-gtt: SUCCESS (2.150s)
[303.359975] [061/133] (733s left) gem_pxp (hw-rejects-pxp-context)
[305.933087] Starting subtest: hw-rejects-pxp-context
[305.934798] Subtest hw-rejects-pxp-context: SUCCESS (0.003s)
[306.044701] [062/133] (730s left) syncobj_wait (multi-wait-submitted)
[306.093871] Starting subtest: multi-wait-submitted
[306.202032] Subtest multi-wait-submitted: SUCCESS (0.105s)
[306.383085] [063/133] (730s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[307.877674] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[307.879681] Starting dynamic subtest: pipe-A-HDMI-A-4
[307.893633] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[307.906437] Starting dynamic subtest: pipe-B-HDMI-A-4
[307.920216] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[307.932422] Starting dynamic subtest: pipe-C-HDMI-A-4
[307.946627] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[307.958864] Starting dynamic subtest: pipe-D-HDMI-A-4
[307.973965] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[307.976903] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SKIP (0.008s)
[308.134723] [064/133] (728s left) gem_exec_whisper (basic-queues-forked-all)
[308.196105] Starting subtest: basic-queues-forked-all
[322.199471] Subtest basic-queues-forked-all: SUCCESS (13.999s)
[322.491758] [065/133] (714s left) gem_ccs (block-multicopy-compressed)
[322.544112] Starting subtest: block-multicopy-compressed
[322.546783] Subtest block-multicopy-compressed: SKIP (0.000s)
[322.659321] [066/133] (714s left) kms_chamelium_audio (hdmi-audio-edid)
[324.193047] Subtest hdmi-audio-edid: SKIP (0.000s)
[324.311900] [067/133] (713s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[325.798315] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[325.799674] Starting dynamic subtest: pipe-A-HDMI-A-4
[325.804938] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[325.817964] Starting dynamic subtest: pipe-B-HDMI-A-4
[325.823382] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[325.836314] Starting dynamic subtest: pipe-C-HDMI-A-4
[325.841715] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[325.854280] Starting dynamic subtest: pipe-D-HDMI-A-4
[325.859867] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[325.862741] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SKIP (0.009s)
[326.057205] [068/133] (711s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[327.553260] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[327.556180] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[327.721417] [069/133] (709s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[329.209497] Starting subtest: plane-scaler-unity-scaling-with-rotation
[329.210973] Starting dynamic subtest: pipe-A
[329.625173] Dynamic subtest pipe-A: SKIP (0.410s)
[329.640838] Starting dynamic subtest: pipe-B
[330.078072] Dynamic subtest pipe-B: SKIP (0.454s)
[330.090749] Starting dynamic subtest: pipe-C
[330.519280] Dynamic subtest pipe-C: SKIP (0.439s)
[330.532280] Starting dynamic subtest: pipe-D
[330.975819] Dynamic subtest pipe-D: SKIP (0.456s)
[330.978958] Subtest plane-scaler-unity-scaling-with-rotation: SKIP (1.763s)
[331.156924] [070/133] (706s left) kms_psr (fbc-pr-cursor-blt)
[332.653757] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[332.736547] [071/133] (704s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[332.793718] Starting subtest: y-tiled-to-vebox-x-tiled
[332.795368] Starting dynamic subtest: smem
[332.880348] Dynamic subtest smem: SUCCESS (0.086s)
[332.893376] Starting dynamic subtest: lmem0
[333.630634] Dynamic subtest lmem0: SUCCESS (0.745s)
[333.632575] Subtest y-tiled-to-vebox-x-tiled: SUCCESS (0.834s)
[333.907972] [072/133] (703s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[335.398541] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[335.401708] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SKIP (0.000s)
[335.505332] [073/133] (702s left) syncobj_basic (bad-pad-fd-to-handle)
[335.555658] Starting subtest: bad-pad-fd-to-handle
[335.557304] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[335.695146] [074/133] (702s left) gem_wait (invalid-flags)
[335.748266] Starting subtest: invalid-flags
[335.749966] Subtest invalid-flags: SUCCESS (0.000s)
[336.042840] [075/133] (701s left) i915_pm_rpm (reg-read-ioctl)
[340.108376] Starting subtest: reg-read-ioctl
[342.049224] Subtest reg-read-ioctl: SUCCESS (1.949s)
[343.108979] [076/133] (694s left) device_reset (unbind-cold-reset-rebind)
[343.212637] Starting subtest: unbind-cold-reset-rebind
[343.216143] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[343.391969] [077/133] (694s left) kms_getfb (getfb-handle-closed)
[344.879509] Starting subtest: getfb-handle-closed
[344.880991] Subtest getfb-handle-closed: SUCCESS (0.000s)
[345.065455] [078/133] (693s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[346.553837] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[346.557090] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SKIP (0.000s)
[346.683630] [079/133] (691s left) i915_query (query-regions-sanity-check)
[346.743376] Starting subtest: query-regions-sanity-check
[346.773374] Subtest query-regions-sanity-check: SUCCESS (0.031s)
[346.977889] [080/133] (691s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[348.473793] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[348.476651] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[348.649386] [081/133] (689s left) gem_softpin (noreloc)
[348.706385] Starting subtest: noreloc
[354.194615] Subtest noreloc: SUCCESS (5.485s)
[354.341713] [082/133] (684s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[355.835748] Starting subtest: fbc-rgb101010-draw-render
[358.835744] Subtest fbc-rgb101010-draw-render: SUCCESS (3.001s)
[359.050472] [083/133] (679s left) kms_atomic (plane-invalid-params-fence)
[360.541485] Starting subtest: plane-invalid-params-fence
[360.542926] Starting dynamic subtest: pipe-A-HDMI-A-4
[360.859065] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.316s)
[360.860595] Subtest plane-invalid-params-fence: SUCCESS (0.318s)
[361.041343] [084/133] (677s left) i915_hangman (engine-error-state-capture)
[361.105900] Starting subtest: engine-error-state-capture
[361.107597] Starting dynamic subtest: rcs0
[363.500142] Dynamic subtest rcs0: SUCCESS (2.395s)
[363.526738] Starting dynamic subtest: bcs0
[367.506895] Dynamic subtest bcs0: SUCCESS (4.005s)
[367.523419] Starting dynamic subtest: vcs0
[371.474853] Dynamic subtest vcs0: SUCCESS (3.966s)
[371.487872] Starting dynamic subtest: vcs1
[375.504824] Dynamic subtest vcs1: SUCCESS (4.029s)
[375.518642] Starting dynamic subtest: vecs0
[379.474899] Dynamic subtest vecs0: SUCCESS (3.968s)
[379.476465] Subtest engine-error-state-capture: SUCCESS (18.372s)
[379.664657] [085/133] (659s left) i915_query (query-topology-known-pci-ids)
[379.711120] Starting subtest: query-topology-known-pci-ids
[379.714820] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[379.848736] [086/133] (659s left) kms_feature_discovery (dp-mst)
[381.337349] Starting subtest: dp-mst
[381.340153] Subtest dp-mst: SKIP (0.000s)
[381.478436] [087/133] (657s left) kms_plane_scaling (planes-upscale-factor-0-25)
[382.979366] Starting subtest: planes-upscale-factor-0-25
[382.980841] Starting dynamic subtest: pipe-A
[383.089458] Dynamic subtest pipe-A: SUCCESS (0.112s)
[383.105344] Starting dynamic subtest: pipe-B
[383.231385] Dynamic subtest pipe-B: SUCCESS (0.140s)
[383.244268] Starting dynamic subtest: pipe-C
[383.372116] Dynamic subtest pipe-C: SUCCESS (0.139s)
[383.385313] Starting dynamic subtest: pipe-D
[383.512674] Dynamic subtest pipe-D: SUCCESS (0.140s)
[383.513996] Subtest planes-upscale-factor-0-25: SUCCESS (0.536s)
[383.703187] [088/133] (655s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[385.197439] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[385.200226] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[385.354920] [089/133] (653s left) gem_mmap_offset (blt-coherency)
[385.406358] Starting subtest: blt-coherency
[385.431151] Subtest blt-coherency: SUCCESS (0.024s)
[385.646229] [090/133] (653s left) api_intel_bb (intel-bb-blit-none)
[385.694124] Starting subtest: intel-bb-blit-none
[386.358110] Subtest intel-bb-blit-none: SUCCESS (0.664s)
[386.511286] [091/133] (652s left) prime_mmap_kms (buffer-sharing)
[388.000319] Starting subtest: buffer-sharing
[388.377350] Subtest buffer-sharing: SUCCESS (0.377s)
[388.563615] [092/133] (651s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[388.612980] Subtest flip-primary-invalidate-overlay: SKIP (0.000s)
[388.706328] [093/133] (650s left) sysfs_defaults (readonly)
[388.759165] Starting subtest: readonly
[388.760814] Starting dynamic subtest: vecs0
[388.762437] Dynamic subtest vecs0: SUCCESS (0.001s)
[388.776040] Starting dynamic subtest: vcs0
[388.777981] Dynamic subtest vcs0: SUCCESS (0.001s)
[388.790994] Starting dynamic subtest: bcs0
[388.792918] Dynamic subtest bcs0: SUCCESS (0.000s)
[388.805597] Starting dynamic subtest: rcs0
[388.807279] Dynamic subtest rcs0: SUCCESS (0.000s)
[388.820255] Starting dynamic subtest: vcs1
[388.822196] Dynamic subtest vcs1: SUCCESS (0.001s)
[388.823886] Subtest readonly: SUCCESS (0.011s)
[388.990973] [094/133] (650s left) gem_ctx_shared (q-in-order)
[389.060206] Starting subtest: Q-in-order
[389.061626] Starting dynamic subtest: rcs0
[389.250559] Dynamic subtest rcs0: SUCCESS (0.186s)
[389.263586] Starting dynamic subtest: bcs0
[389.384618] Dynamic subtest bcs0: SUCCESS (0.133s)
[389.397532] Starting dynamic subtest: vcs0
[389.511706] Dynamic subtest vcs0: SUCCESS (0.126s)
[389.524559] Starting dynamic subtest: vcs1
[389.650239] Dynamic subtest vcs1: SUCCESS (0.137s)
[389.662653] Starting dynamic subtest: vecs0
[389.787230] Dynamic subtest vecs0: SUCCESS (0.136s)
[389.788945] Subtest Q-in-order: SUCCESS (0.725s)
[390.142548] [095/133] (649s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[391.632377] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[391.707012] [096/133] (648s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[391.764069] Subtest writes-after-reads-uncached: SKIP (0.000s)
[391.857057] [097/133] (648s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[393.385462] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[393.504633] [098/133] (646s left) kms_cursor_legacy (torture-bo)
[394.993275] Starting subtest: torture-bo
[394.995141] Starting dynamic subtest: pipe-A
[400.543729] Dynamic subtest pipe-A: SUCCESS (5.512s)
[400.557164] Starting dynamic subtest: pipe-B
[406.040966] Dynamic subtest pipe-B: SUCCESS (5.501s)
[406.060334] Starting dynamic subtest: pipe-C
[411.545342] Dynamic subtest pipe-C: SUCCESS (5.503s)
[411.558955] Starting dynamic subtest: pipe-D
[417.012304] Dynamic subtest pipe-D: SUCCESS (5.465s)
[417.025224] Starting dynamic subtest: all-pipes
[422.474502] Dynamic subtest all-pipes: SUCCESS (5.460s)
[422.475862] Subtest torture-bo: SUCCESS (27.479s)
[422.599287] [099/133] (617s left) kms_psr (fbc-psr2-dpms)
[424.100053] Subtest fbc-psr2-dpms: SKIP (0.000s)
[424.185811] [100/133] (616s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[425.682045] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[425.685486] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[425.887986] [101/133] (614s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[427.384939] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[427.390622] Subtest psr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[427.567484] [102/133] (612s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[429.061226] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[429.064263] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[429.220654] [103/133] (611s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[429.647835] Starting subtest: parallel-dmabuf-import-out-fence
[432.058978] Subtest parallel-dmabuf-import-out-fence: SUCCESS (2.411s)
[432.171589] [104/133] (608s left) gem_exec_schedule (preempt-self)
[432.236721] Starting subtest: preempt-self
[432.238326] Starting dynamic subtest: rcs0
[432.280141] Dynamic subtest rcs0: SUCCESS (0.042s)
[432.293627] Starting dynamic subtest: bcs0
[432.306436] Dynamic subtest bcs0: SUCCESS (0.025s)
[432.321512] Starting dynamic subtest: vcs0
[432.331976] Dynamic subtest vcs0: SUCCESS (0.024s)
[432.346881] Starting dynamic subtest: vcs1
[432.358578] Dynamic subtest vcs1: SUCCESS (0.025s)
[432.373622] Starting dynamic subtest: vecs0
[432.385263] Dynamic subtest vecs0: SUCCESS (0.024s)
[432.386576] Subtest preempt-self: SUCCESS (0.150s)
[432.917392] [105/133] (607s left) perf_pmu (semaphore-wait-idle)
[432.969039] Starting subtest: semaphore-wait-idle
[432.970465] Starting dynamic subtest: rcs0
[433.503269] Dynamic subtest rcs0: SUCCESS (0.529s)
[433.516643] Starting dynamic subtest: bcs0
[434.017843] Dynamic subtest bcs0: SUCCESS (0.509s)
[434.033244] Starting dynamic subtest: vcs0
[434.532745] Dynamic subtest vcs0: SUCCESS (0.509s)
[434.548268] Starting dynamic subtest: vcs1
[435.047751] Dynamic subtest vcs1: SUCCESS (0.509s)
[435.063473] Starting dynamic subtest: vecs0
[435.562668] Dynamic subtest vecs0: SUCCESS (0.509s)
[435.564128] Subtest semaphore-wait-idle: SUCCESS (2.594s)
[435.759513] [106/133] (605s left) gem_tiled_blits (basic)
[435.813070] Subtest basic: SKIP (0.000s)
[435.900866] [107/133] (605s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[437.700725] Starting subtest: cursor-rapid-movement-max-size
[437.706347] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[437.892285] [108/133] (603s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[439.387122] Starting subtest: fbc-1p-pri-indfb-multidraw
[448.237115] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (8.851s)
[448.463867] [109/133] (592s left) gem_softpin (allocator-basic-reserve)
[448.516618] Starting subtest: allocator-basic-reserve
[448.794412] Subtest allocator-basic-reserve: SUCCESS (0.274s)
[448.997843] [110/133] (592s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[449.509468] Starting subtest: syncobj-timeline-multiple-ext-nodes
[449.511112] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.003s)
[449.789306] [111/133] (591s left) syncobj_timeline (invalid-signal-zero-handles)
[449.836831] Starting subtest: invalid-signal-zero-handles
[449.838346] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[449.981448] [112/133] (591s left) kms_rmfb (close-fd)
[451.469899] Starting subtest: close-fd
[451.473913] Starting dynamic subtest: pipe-A-HDMI-A-4
[451.695724] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.222s)
[451.738480] Starting dynamic subtest: pipe-B-HDMI-A-4
[451.946990] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.238s)
[451.960363] Starting dynamic subtest: pipe-C-HDMI-A-4
[452.170860] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.223s)
[452.187954] Starting dynamic subtest: pipe-D-HDMI-A-4
[452.396987] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.221s)
[452.398566] Subtest close-fd: SUCCESS (0.926s)
[452.584657] [113/133] (588s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[454.079247] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[454.082346] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[454.274816] [114/133] (587s left) gem_pwrite (basic-self)
[454.324442] Subtest basic-self: SKIP (0.000s)
[454.413792] [115/133] (587s left) gem_exec_whisper (basic-contexts-forked)
[454.476180] Starting subtest: basic-contexts-forked
[470.200537] Subtest basic-contexts-forked: SUCCESS (15.722s)
[470.455889] [116/133] (571s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[471.992540] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[472.109570] [117/133] (569s left) kms_psr (pr-dpms)
[473.600266] Subtest pr-dpms: SKIP (0.000s)
[473.672378] [118/133] (568s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[475.179736] Starting subtest: x-tiled-32bpp-rotate-90
[475.283589] Subtest x-tiled-32bpp-rotate-90: SKIP (0.100s)
[475.425605] [119/133] (566s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[476.919249] Starting subtest: fbcpsr-rgb565-draw-render
[476.922476] Subtest fbcpsr-rgb565-draw-render: SKIP (0.000s)
[477.114661] [120/133] (564s left) kms_cursor_crc (cursor-onscreen-256x85)
[478.844283] Starting subtest: cursor-onscreen-256x85
[478.852283] Starting dynamic subtest: pipe-A-HDMI-A-4
[481.646397] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.794s)
[481.683101] Starting dynamic subtest: pipe-D-HDMI-A-4
[484.313382] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.641s)
[484.315177] Subtest cursor-onscreen-256x85: SUCCESS (5.469s)
[484.621728] [121/133] (557s left) gem_exec_flush (basic-wb-rw-before-default)
[484.676595] Subtest basic-wb-rw-before-default: SKIP (0.000s)
[484.787335] [122/133] (557s left) perf (sysctl-defaults)
[484.919609] Starting subtest: sysctl-defaults
[484.921332] Subtest sysctl-defaults: SUCCESS (0.000s)
[485.022822] [123/133] (557s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[486.516567] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[489.318945] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (2.803s)
[489.549018] [124/133] (552s left) gem_wait (wait)
[489.612523] Starting subtest: wait
[489.613851] Starting dynamic subtest: all-engines
[490.705625] Dynamic subtest all-engines: SUCCESS (1.092s)
[490.723917] Starting dynamic subtest: rcs0
[491.761373] Dynamic subtest rcs0: SUCCESS (1.053s)
[491.779347] Starting dynamic subtest: bcs0
[492.819166] Dynamic subtest bcs0: SUCCESS (1.055s)
[492.868396] Starting dynamic subtest: vcs0
[493.886336] Dynamic subtest vcs0: SUCCESS (1.061s)
[493.904366] Starting dynamic subtest: vcs1
[494.941485] Dynamic subtest vcs1: SUCCESS (1.053s)
[494.960144] Starting dynamic subtest: vecs0
[495.998195] Dynamic subtest vecs0: SUCCESS (1.053s)
[496.002484] Subtest wait: SUCCESS (6.389s)
[496.336994] [125/133] (546s left) sw_sync (sync_multi_producer_single_consumer)
[496.383104] Starting subtest: sync_multi_producer_single_consumer
[497.462553] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s)
[497.562121] [126/133] (545s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[499.056533] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[499.059126] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[499.223817] [127/133] (543s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[500.713992] Starting subtest: read-crc-frame-sequence
[500.715760] Starting dynamic subtest: pipe-A-HDMI-A-4
[501.389988] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.677s)
[501.405667] Starting dynamic subtest: pipe-B-HDMI-A-4
[501.886107] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.493s)
[501.901991] Starting dynamic subtest: pipe-C-HDMI-A-4
[502.429100] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.540s)
[502.444113] Starting dynamic subtest: pipe-D-HDMI-A-4
[502.970404] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.537s)
[502.971778] Subtest read-crc-frame-sequence: SUCCESS (2.258s)
[503.147844] [128/133] (539s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[504.640594] Starting subtest: fbcpsr-suspend
[504.643552] Subtest fbcpsr-suspend: SKIP (0.000s)
[504.817607] [129/133] (538s left) gem_ctx_exec (basic-nohangcheck)
[504.870335] Starting subtest: basic-nohangcheck
[504.993371] Subtest basic-nohangcheck: SUCCESS (0.126s)
[505.194869] [130/133] (537s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[506.703430] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[506.706670] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[506.859391] [131/133] (536s left) kms_panel_fitting (atomic-fastset)
[508.349154] Starting subtest: atomic-fastset
[508.352098] Subtest atomic-fastset: SKIP (0.000s)
[508.474094] [132/133] (534s left) gem_eio (in-flight-internal-immediate)
[508.653021] Starting subtest: in-flight-internal-immediate
[509.858819] Subtest in-flight-internal-immediate: SUCCESS (1.205s)
[511.412750] [133/133] (531s left) perf_pmu (busy-double-start)
[511.463105] Starting subtest: busy-double-start
[511.464701] Starting dynamic subtest: rcs0
[515.066908] Dynamic subtest rcs0: SUCCESS (3.602s)
[515.084986] Starting dynamic subtest: bcs0
[518.658888] Dynamic subtest bcs0: SUCCESS (3.586s)
[518.676669] Starting dynamic subtest: vcs0
[522.245048] Dynamic subtest vcs0: SUCCESS (3.581s)
[522.262852] Starting dynamic subtest: vcs1
[525.817984] Dynamic subtest vcs1: SUCCESS (3.568s)
[525.835914] Starting dynamic subtest: vecs0
[529.404897] Dynamic subtest vecs0: SUCCESS (3.582s)
[529.406541] Subtest busy-double-start: SUCCESS (17.943s)
[529.569444] Closing watchdogs
results: parsing output: 0/ for test: kms_pm_backlight
results: parsing output: 1/ for test: syncobj_timeline
results: parsing output: 2/ for test: gem_exec_reloc
results: parsing output: 3/ for test: kms_async_flips
results: parsing output: 4/ for test: perf_pmu
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: gem_exec_parallel
results: parsing output: 8/ for test: kms_lease
results: parsing output: 9/ for test: gem_lmem_swapping
results: parsing output: 10/ for test: perf_pmu
results: parsing output: 11/ for test: kms_busy
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: kms_flip
results: parsing output: 14/ for test: kms_cursor_legacy
results: parsing output: 15/ for test: syncobj_wait
results: parsing output: 16/ for test: syncobj_timeline
results: parsing output: 17/ for test: kms_prime
results: parsing output: 18/ for test: kms_hdr
results: parsing output: 19/ for test: gem_exec_flush
results: parsing output: 20/ for test: gem_exec_params
results: parsing output: 21/ for test: gen9_exec_parse
results: parsing output: 22/ for test: gem_exec_reloc
results: parsing output: 23/ for test: kms_plane
results: parsing output: 24/ for test: kms_plane
results: parsing output: 25/ for test: syncobj_wait
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_pipe_control_store_loop
results: parsing output: 28/ for test: kms_properties
results: parsing output: 29/ for test: kms_content_protection
results: parsing output: 30/ for test: kms_cursor_edge_walk
results: parsing output: 31/ for test: kms_vblank
results: parsing output: 32/ for test: kms_atomic_transition
results: parsing output: 33/ for test: gem_mmap_gtt
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: i915_drm_fdinfo
results: parsing output: 36/ for test: syncobj_wait
results: parsing output: 37/ for test: gem_userptr_blits
results: parsing output: 38/ for test: gem_exec_balancer
results: parsing output: 39/ for test: gem_exec_await
results: parsing output: 40/ for test: kms_ccs
results: parsing output: 41/ for test: gem_ctx_exec
results: parsing output: 42/ for test: kms_psr
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: gem_exec_schedule
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: gem_linear_blits
results: parsing output: 47/ for test: syncobj_timeline
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: api_intel_allocator
results: parsing output: 50/ for test: gem_eio
results: parsing output: 51/ for test: kms_psr2_sf
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_vblank
results: parsing output: 54/ for test: syncobj_eventfd
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: kms_color
results: parsing output: 58/ for test: gem_close
results: parsing output: 59/ for test: gem_ctx_shared
results: parsing output: 60/ for test: gem_pxp
results: parsing output: 61/ for test: syncobj_wait
results: parsing output: 62/ for test: kms_ccs
results: parsing output: 63/ for test: gem_exec_whisper
results: parsing output: 64/ for test: gem_ccs
results: parsing output: 65/ for test: kms_chamelium_audio
results: parsing output: 66/ for test: kms_ccs
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_plane_scaling
results: parsing output: 69/ for test: kms_psr
results: parsing output: 70/ for test: gem_render_copy
results: parsing output: 71/ for test: kms_flip_scaled_crc
results: parsing output: 72/ for test: syncobj_basic
results: parsing output: 73/ for test: gem_wait
results: parsing output: 74/ for test: i915_pm_rpm
results: parsing output: 75/ for test: device_reset
results: parsing output: 76/ for test: kms_getfb
results: parsing output: 77/ for test: kms_flip_scaled_crc
results: parsing output: 78/ for test: i915_query
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: gem_softpin
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_atomic
results: parsing output: 83/ for test: i915_hangman
results: parsing output: 84/ for test: i915_query
results: parsing output: 85/ for test: kms_feature_discovery
results: parsing output: 86/ for test: kms_plane_scaling
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_mmap_offset
results: parsing output: 89/ for test: api_intel_bb
results: parsing output: 90/ for test: prime_mmap_kms
results: parsing output: 91/ for test: kms_psr_stress_test
results: parsing output: 92/ for test: sysfs_defaults
results: parsing output: 93/ for test: gem_ctx_shared
results: parsing output: 94/ for test: kms_psr2_sf
results: parsing output: 95/ for test: gem_partial_pwrite_pread
results: parsing output: 96/ for test: kms_chamelium_hpd
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: kms_psr
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_exec_balancer
results: parsing output: 103/ for test: gem_exec_schedule
results: parsing output: 104/ for test: perf_pmu
results: parsing output: 105/ for test: gem_tiled_blits
results: parsing output: 106/ for test: kms_cursor_crc
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_softpin
results: parsing output: 109/ for test: gem_exec_fence
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: kms_rmfb
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_pwrite
results: parsing output: 114/ for test: gem_exec_whisper
results: parsing output: 115/ for test: kms_chamelium_frames
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_cursor_crc
results: parsing output: 120/ for test: gem_exec_flush
results: parsing output: 121/ for test: perf
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gem_wait
results: parsing output: 124/ for test: sw_sync
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_pipe_crc_basic
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: gem_ctx_exec
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: kms_panel_fitting
results: parsing output: 131/ for test: gem_eio
results: parsing output: 132/ for test: perf_pmu
Done.