[100.184935] Initializing watchdogs [100.185262] /dev/watchdog0 [100.225479] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600] [100.240263] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [100.247924] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [100.256142] [001/156] (960s left) kms_pm_rpm (modeset-lpsp) [102.278068] Starting subtest: modeset-lpsp [102.492562] Subtest modeset-lpsp: SKIP (0.206s) [102.928914] [002/156] (957s left) gen9_exec_parse (bb-chained) [103.070278] Starting subtest: bb-chained [103.082308] Subtest bb-chained: SUCCESS (0.015s) [103.358263] [003/156] (957s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-blt) [103.575345] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-blt [104.417808] Subtest fbchdr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (0.846s) [104.718610] [004/156] (956s left) kms_addfb_basic (unused-modifier) [104.835373] Starting subtest: unused-modifier [104.839482] Subtest unused-modifier: SUCCESS (0.000s) [105.072425] [005/156] (956s left) gem_exec_schedule (preemptive-hang) [105.327875] Starting subtest: preemptive-hang [105.331490] Starting dynamic subtest: rcs0 [111.122898] Dynamic subtest rcs0: SUCCESS (5.789s) [111.149211] Starting dynamic subtest: bcs0 [117.130335] Dynamic subtest bcs0: SUCCESS (6.012s) [117.164140] Starting dynamic subtest: vcs0 [123.086529] Dynamic subtest vcs0: SUCCESS (5.960s) [123.120516] Starting dynamic subtest: vecs0 [129.099084] Dynamic subtest vecs0: SUCCESS (6.008s) [129.104486] Subtest preemptive-hang: SUCCESS (23.776s) [129.366344] [006/156] (931s left) gem_userptr_blits (process-exit) [129.506471] Starting subtest: process-exit [129.534245] Subtest process-exit: SUCCESS (0.027s) [129.700654] [007/156] (931s left) gem_mmap_gtt (cpuset-big-copy-odd) [129.809370] Starting subtest: cpuset-big-copy-odd [148.717122] Subtest cpuset-big-copy-odd: SUCCESS (18.905s) [148.911856] [008/156] (912s left) syncobj_timeline (invalid-multi-wait-unsubmitted) [149.181702] Starting subtest: invalid-multi-wait-unsubmitted [149.185116] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.001s) [149.350746] [009/156] (912s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc) [149.542204] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc [149.546577] Starting dynamic subtest: pipe-A-HDMI-A-1 [149.598366] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [149.642173] Starting dynamic subtest: pipe-A-HDMI-A-2 [149.686212] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s) [149.710186] Starting dynamic subtest: pipe-B-HDMI-A-1 [149.745632] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s) [149.767100] Starting dynamic subtest: pipe-B-HDMI-A-2 [149.801472] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s) [149.823109] Starting dynamic subtest: pipe-C-HDMI-A-1 [149.859056] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s) [149.881364] Starting dynamic subtest: pipe-C-HDMI-A-2 [149.915729] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s) [149.922399] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.018s) [150.543924] [010/156] (911s left) gem_ctx_engines (execute-one) [150.687201] Starting subtest: execute-one [153.544296] Subtest execute-one: SUCCESS (2.861s) [153.835991] [011/156] (907s left) gem_mmap_gtt (zero-extend) [153.949214] Starting subtest: zero-extend [153.952999] Subtest zero-extend: SUCCESS (0.000s) [154.090863] [012/156] (907s left) gem_exec_schedule (implicit-boths) [154.235273] Starting subtest: implicit-boths [154.239262] Starting dynamic subtest: rcs0 [154.354996] Dynamic subtest rcs0: SUCCESS (0.125s) [154.392305] Starting dynamic subtest: bcs0 [154.487417] Dynamic subtest bcs0: SUCCESS (0.130s) [154.520531] Starting dynamic subtest: vcs0 [154.608133] Dynamic subtest vcs0: SUCCESS (0.124s) [154.632201] Starting dynamic subtest: vecs0 [154.735550] Dynamic subtest vecs0: SUCCESS (0.125s) [154.740262] Subtest implicit-boths: SUCCESS (0.509s) [155.127521] [013/156] (906s left) kms_vblank (wait-forked-hang) [155.324255] Starting subtest: wait-forked-hang [155.329088] Starting dynamic subtest: pipe-A-HDMI-A-1 [162.882085] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (7.557s) [162.939277] Starting dynamic subtest: pipe-A-HDMI-A-2 [169.870888] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (6.981s) [169.906401] Starting dynamic subtest: pipe-C-HDMI-A-1 [176.811440] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (6.931s) [176.844528] Starting dynamic subtest: pipe-C-HDMI-A-2 [183.860908] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (7.046s) [183.864345] Subtest wait-forked-hang: SUCCESS (28.544s) [184.180184] [014/156] (877s left) kms_cursor_edge_walk (256x256-right-edge) [184.370623] Starting subtest: 256x256-right-edge [184.373984] Starting dynamic subtest: pipe-A-HDMI-A-1 [188.381560] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.008s) [188.427090] Starting dynamic subtest: pipe-C-HDMI-A-1 [191.880588] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.494s) [191.885268] Subtest 256x256-right-edge: SUCCESS (7.508s) [192.223826] [015/156] (869s left) gem_pxp (verify-pxp-stale-ctx-execution) [194.882601] Starting subtest: verify-pxp-stale-ctx-execution [194.889999] Subtest verify-pxp-stale-ctx-execution: SKIP (0.000s) [195.020233] [016/156] (867s left) gem_vm_create (invalid-create) [195.145860] Starting subtest: invalid-create [195.149829] Subtest invalid-create: SUCCESS (0.000s) [195.288742] [017/156] (866s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-mmap-cpu) [195.493548] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-mmap-cpu [196.689541] Subtest fbchdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (1.202s) [196.891053] [018/156] (865s left) gem_userptr_blits (forbidden-operations) [197.031164] Starting subtest: forbidden-operations [197.036105] Subtest forbidden-operations: SUCCESS (0.002s) [197.224962] [019/156] (865s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc) [197.433161] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc [200.255293] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (2.825s) [200.611828] [020/156] (861s left) gem_blits (basic) [200.729318] Starting subtest: basic [211.653889] Subtest basic: SUCCESS (10.927s) [211.827564] [021/156] (850s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-blt) [212.041283] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-blt [212.047421] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [212.196554] [022/156] (850s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-pwrite) [212.403406] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-pwrite [212.410325] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [212.547552] [023/156] (850s left) kms_addfb_basic (addfb25-x-tiled-legacy) [212.744094] Starting subtest: addfb25-x-tiled-legacy [212.747583] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [212.898630] [024/156] (850s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines) [213.695925] Starting subtest: syncobj-stationary-timeline-chain-engines [213.821440] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.124s) [214.080758] [FACT gem_exec_fence (syncobj-stationary-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true [214.087593] [025/156] (848s left) kms_frontbuffer_tracking (psrhdr-1p-pri-indfb-multidraw) [214.288236] Starting subtest: psrhdr-1p-pri-indfb-multidraw [214.294701] Subtest psrhdr-1p-pri-indfb-multidraw: SKIP (0.000s) [214.455490] [026/156] (848s left) core_auth (basic-auth) [214.567390] Starting subtest: basic-auth [214.571248] Subtest basic-auth: SUCCESS (0.001s) [214.702412] [027/156] (848s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite) [214.914541] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite [214.923090] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [215.059354] [028/156] (848s left) kms_psr (psr2-sprite-mmap-gtt) [215.249124] Subtest psr2-sprite-mmap-gtt: SKIP (0.000s) [215.377101] [029/156] (848s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [215.618117] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu [218.101759] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (2.488s) [218.302412] [030/156] (845s left) gem_spin_batch (engines) [218.436222] Starting subtest: engines [218.439525] Starting dynamic subtest: rcs0 [221.672080] Dynamic subtest rcs0: SUCCESS (3.232s) [221.698654] Starting dynamic subtest: bcs0 [224.902130] Dynamic subtest bcs0: SUCCESS (3.230s) [224.925181] Starting dynamic subtest: vcs0 [228.133259] Dynamic subtest vcs0: SUCCESS (3.229s) [228.155876] Starting dynamic subtest: vecs0 [231.461444] Dynamic subtest vecs0: SUCCESS (3.328s) [231.465353] Subtest engines: SUCCESS (13.024s) [231.723312] [031/156] (831s left) gem_exec_balancer (bonded-semaphore) [231.857933] Starting subtest: bonded-semaphore [236.190206] Subtest bonded-semaphore: SUCCESS (4.333s) [236.471921] [032/156] (827s left) perf (global-sseu-config-invalid) [236.732300] Starting subtest: global-sseu-config-invalid [236.735610] Starting dynamic subtest: 0-rcs0 [236.761816] Dynamic subtest 0-rcs0: SUCCESS (0.030s) [236.765521] Subtest global-sseu-config-invalid: SUCCESS (0.031s) [236.886431] [033/156] (826s left) gem_tiled_swapping (non-threaded) [259.141685] Starting subtest: non-threaded [287.811055] Subtest non-threaded: SUCCESS (28.659s) [293.130150] [034/156] (771s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt) [293.609408] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt [293.617509] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [293.778917] [035/156] (770s left) gem_ppgtt (shrink-vs-evict-pinned) [293.908544] Starting subtest: shrink-vs-evict-pinned [299.970121] Subtest shrink-vs-evict-pinned: SUCCESS (6.059s) [300.115858] [036/156] (764s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc) [300.309393] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc [300.315338] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [300.479246] [037/156] (764s left) gem_exec_capture (capture-recoverable) [300.606416] Starting subtest: capture-recoverable [300.612627] Subtest capture-recoverable: SKIP (0.000s) [300.758207] [038/156] (764s left) kms_vblank (query-idle) [300.940933] Starting subtest: query-idle [300.944368] Starting dynamic subtest: pipe-A-HDMI-A-1 [303.607467] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.662s) [303.637297] Starting dynamic subtest: pipe-A-HDMI-A-2 [306.068515] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.452s) [306.108059] Starting dynamic subtest: pipe-C-HDMI-A-1 [308.496501] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.422s) [308.525234] Starting dynamic subtest: pipe-C-HDMI-A-2 [310.927598] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.423s) [310.932549] Subtest query-idle: SUCCESS (9.985s) [311.300872] [039/156] (753s left) prime_self_import (basic-with_two_bos) [311.409641] Starting subtest: basic-with_two_bos [311.416381] Subtest basic-with_two_bos: SUCCESS (0.007s) [311.621252] [040/156] (753s left) gem_exec_params (cliprects-invalid) [311.744676] Starting subtest: cliprects-invalid [311.749195] Subtest cliprects-invalid: SUCCESS (0.001s) [311.917451] [041/156] (753s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-pwrite) [312.121479] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-pwrite [313.475190] Subtest hdr-2p-primscrn-spr-indfb-draw-pwrite: SUCCESS (1.354s) [313.708190] [042/156] (751s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-onoff) [313.937203] Starting subtest: hdr-1p-primscrn-spr-indfb-onoff [314.806228] Subtest hdr-1p-primscrn-spr-indfb-onoff: SUCCESS (0.869s) [315.146261] [043/156] (750s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [315.374507] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu [315.381264] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [315.529881] [044/156] (750s left) vgem_basic (bad-fence) [315.664342] Starting subtest: bad-fence [315.667888] Subtest bad-fence: SUCCESS (0.000s) [315.793735] [045/156] (749s left) vgem_basic (debugfs) [315.910376] Starting subtest: debugfs [315.913988] Subtest debugfs: SUCCESS (0.001s) [316.041697] [046/156] (749s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-mmap-gtt) [316.264056] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-mmap-gtt [317.005407] Subtest hdr-1p-primscrn-cur-indfb-draw-mmap-gtt: SUCCESS (0.741s) [317.409021] [047/156] (748s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs) [317.598986] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs [317.607114] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s) [317.878060] [048/156] (748s left) gem_linear_blits (normal) [318.147166] Starting subtest: normal [333.116912] Subtest normal: SUCCESS (14.970s) [333.277170] [049/156] (732s left) kms_pm_rpm (system-suspend-idle) [335.453061] Starting subtest: system-suspend-idle [352.358388] Subtest system-suspend-idle: SUCCESS (2.119s) [360.900333] [050/156] (713s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-mmap-cpu) [361.108713] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-mmap-cpu [362.205992] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SUCCESS (1.102s) [362.446766] [051/156] (712s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt) [362.689510] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt [362.695775] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [362.856527] [052/156] (711s left) gem_mmap_gtt (fault-concurrent) [362.978612] Starting subtest: fault-concurrent [366.300989] Subtest fault-concurrent: SUCCESS (3.337s) [366.493198] [053/156] (708s left) gem_sync (basic-all) [366.661817] Starting subtest: basic-all [369.047323] Subtest basic-all: SUCCESS (2.418s) [369.318623] [054/156] (705s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled) [369.449091] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled [369.557357] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.108s) [369.715452] [055/156] (705s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [369.930266] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-mmap-gtt [370.692064] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SUCCESS (0.759s) [371.026936] [056/156] (704s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-mmap-cpu) [371.240414] Starting subtest: psrhdr-rgb565-draw-mmap-cpu [371.247226] Subtest psrhdr-rgb565-draw-mmap-cpu: SKIP (0.000s) [371.441937] [057/156] (703s left) i915_hangman (detector) [371.581279] Starting subtest: detector [371.586199] Starting dynamic subtest: rcs0 [380.994827] Dynamic subtest rcs0: SUCCESS (9.428s) [381.036166] Starting dynamic subtest: bcs0 [390.911437] Dynamic subtest bcs0: SUCCESS (9.921s) [390.945507] Starting dynamic subtest: vcs0 [400.949241] Dynamic subtest vcs0: SUCCESS (10.040s) [400.982965] Starting dynamic subtest: vecs0 [410.923751] Dynamic subtest vecs0: SUCCESS (9.978s) [410.927095] Subtest detector: SUCCESS (39.378s) [411.120873] [058/156] (664s left) gem_ctx_param (invalid-param-set) [411.232523] Starting subtest: invalid-param-set [411.235995] Subtest invalid-param-set: SUCCESS (0.000s) [411.407065] [059/156] (664s left) kms_hdr (bpc-switch) [411.603400] Starting subtest: bpc-switch [411.607246] Starting dynamic subtest: pipe-A-HDMI-A-1-XRGB2101010 [427.102154] Dynamic subtest pipe-A-HDMI-A-1-XRGB2101010: SKIP (15.502s) [427.138391] Starting dynamic subtest: pipe-A-HDMI-A-1-XRGB16161616F [442.226706] Dynamic subtest pipe-A-HDMI-A-1-XRGB16161616F: SKIP (15.128s) [442.281516] Starting dynamic subtest: pipe-A-HDMI-A-2-XRGB2101010 [457.265982] Dynamic subtest pipe-A-HDMI-A-2-XRGB2101010: SKIP (15.033s) [457.331986] Starting dynamic subtest: pipe-A-HDMI-A-2-XRGB16161616F [472.590760] Dynamic subtest pipe-A-HDMI-A-2-XRGB16161616F: SKIP (15.307s) [472.599506] Subtest bpc-switch: SKIP (60.995s) [473.137975] [060/156] (602s left) kms_cursor_legacy (cursorb-vs-flipb-legacy) [473.343278] Starting subtest: cursorB-vs-flipB-legacy [484.720334] Subtest cursorB-vs-flipB-legacy: SUCCESS (11.376s) [485.150956] [061/156] (590s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt) [485.380818] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt [485.387268] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [485.551298] [062/156] (590s left) syncobj_timeline (wait-for-submit-snapshot) [485.676615] Starting subtest: wait-for-submit-snapshot [485.760300] Subtest wait-for-submit-snapshot: SUCCESS (0.088s) [485.941963] [063/156] (589s left) i915_query (query-regions-sanity-check) [486.056948] Starting subtest: query-regions-sanity-check [486.083524] Subtest query-regions-sanity-check: SUCCESS (0.031s) [486.264594] [064/156] (589s left) kms_frontbuffer_tracking (hdr-rgb565-draw-render) [486.469504] Starting subtest: hdr-rgb565-draw-render [487.321100] Subtest hdr-rgb565-draw-render: SUCCESS (0.848s) [487.648187] [065/156] (588s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt) [487.860557] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt [490.816430] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SUCCESS (2.963s) [491.059937] [066/156] (585s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu) [491.279890] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu [493.701385] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (2.421s) [494.013938] [067/156] (582s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [494.225175] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [494.233724] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [494.397196] [068/156] (582s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render) [494.606316] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render [494.613241] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [494.797796] [069/156] (581s left) gem_exec_whisper (basic-normal-all) [494.937839] Starting subtest: basic-normal-all [501.588769] Subtest basic-normal-all: SUCCESS (6.646s) [501.864240] [070/156] (574s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-render) [502.070603] Starting subtest: fbchdr-rgb101010-draw-render [502.820287] Subtest fbchdr-rgb101010-draw-render: SUCCESS (0.746s) [503.139985] [071/156] (573s left) kms_psr (fbc-pr-sprite-render) [503.338104] Subtest fbc-pr-sprite-render: SKIP (0.000s) [503.478691] [072/156] (573s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt) [503.702662] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt [503.709601] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.001s) [503.876688] [073/156] (573s left) kms_chamelium_color (gamma) [504.076841] Subtest gamma: SKIP (0.000s) [504.219403] [074/156] (572s left) syncobj_wait (single-wait-signaled) [504.341147] Starting subtest: single-wait-signaled [504.345250] Subtest single-wait-signaled: SUCCESS (0.001s) [504.533210] [075/156] (572s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite) [504.739699] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite [504.747077] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [504.938208] [076/156] (572s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu) [505.158126] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu [508.557868] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (3.402s) [508.769350] [077/156] (568s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs) [508.968085] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs [508.972282] Starting dynamic subtest: pipe-A-HDMI-A-1 [508.987043] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s) [509.062046] Starting dynamic subtest: pipe-A-HDMI-A-2 [509.084539] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s) [509.126557] Starting dynamic subtest: pipe-B-HDMI-A-1 [509.140084] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s) [509.174935] Starting dynamic subtest: pipe-B-HDMI-A-2 [509.186843] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s) [509.220447] Starting dynamic subtest: pipe-C-HDMI-A-1 [509.232101] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s) [509.265567] Starting dynamic subtest: pipe-C-HDMI-A-2 [509.280442] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s) [509.286740] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SKIP (0.033s) [510.106364] [078/156] (567s left) kms_flip (2x-flip-vs-expired-vblank-interruptible) [510.319155] Starting subtest: 2x-flip-vs-expired-vblank-interruptible [510.322608] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2 [521.132955] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (10.822s) [521.173809] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2 [531.897339] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (10.760s) [531.941335] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2 [542.682644] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.779s) [542.688503] Subtest 2x-flip-vs-expired-vblank-interruptible: SUCCESS (32.384s) [543.406463] [079/156] (534s left) i915_drm_fdinfo (most-busy-idle-check-all) [543.537169] Starting subtest: most-busy-idle-check-all [543.541376] Starting dynamic subtest: rcs0 [544.163328] Dynamic subtest rcs0: SUCCESS (0.629s) [544.198851] Starting dynamic subtest: bcs0 [544.793122] Dynamic subtest bcs0: SUCCESS (0.624s) [544.828954] Starting dynamic subtest: vcs0 [545.421143] Dynamic subtest vcs0: SUCCESS (0.627s) [545.460395] Starting dynamic subtest: vecs0 [546.052734] Dynamic subtest vecs0: SUCCESS (0.626s) [546.057118] Subtest most-busy-idle-check-all: SUCCESS (2.520s) [546.209298] [080/156] (531s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats) [546.413826] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats [546.417779] Starting dynamic subtest: pipe-A [547.542636] Dynamic subtest pipe-A: SUCCESS (1.132s) [547.612659] Starting dynamic subtest: pipe-B [548.705072] Dynamic subtest pipe-B: SUCCESS (1.158s) [548.743365] Starting dynamic subtest: pipe-C [549.238912] Dynamic subtest pipe-C: SUCCESS (0.530s) [549.242292] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (2.832s) [549.901309] [081/156] (528s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled) [550.021182] Starting subtest: multi-wait-available-unsubmitted-signaled [550.026055] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.002s) [550.183291] [082/156] (527s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-render) [550.389871] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-render [551.845227] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-render: SUCCESS (1.454s) [552.060304] [083/156] (526s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-blt) [552.288932] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-blt [553.788326] Subtest hdr-2p-scndscrn-pri-indfb-draw-blt: SUCCESS (1.501s) [554.003974] [084/156] (524s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping) [554.210991] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping [554.218234] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SKIP (0.000s) [554.372515] [085/156] (524s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic) [554.578316] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic [555.995986] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.415s) [556.426588] [086/156] (522s left) kms_flip (absolute-wf_vblank-interruptible) [556.657179] Starting subtest: absolute-wf_vblank-interruptible [556.667721] Starting dynamic subtest: A-HDMI-A1 [562.521652] Dynamic subtest A-HDMI-A1: SUCCESS (5.856s) [562.565333] Starting dynamic subtest: B-HDMI-A1 [568.086420] Dynamic subtest B-HDMI-A1: SUCCESS (5.557s) [568.130758] Starting dynamic subtest: C-HDMI-A1 [573.625049] Dynamic subtest C-HDMI-A1: SUCCESS (5.533s) [573.670516] Starting dynamic subtest: A-HDMI-A2 [579.182814] Dynamic subtest A-HDMI-A2: SUCCESS (5.553s) [579.231531] Starting dynamic subtest: B-HDMI-A2 [584.574331] Dynamic subtest B-HDMI-A2: SUCCESS (5.381s) [584.611793] Starting dynamic subtest: C-HDMI-A2 [589.980239] Dynamic subtest C-HDMI-A2: SUCCESS (5.398s) [589.985609] Subtest absolute-wf_vblank-interruptible: SUCCESS (33.325s) [590.615733] [087/156] (488s left) kms_ccs (crc-primary-basic-yf-tiled-ccs) [590.819157] Starting subtest: crc-primary-basic-yf-tiled-ccs [590.823066] Starting dynamic subtest: pipe-A-HDMI-A-1 [591.358843] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.524s) [591.399637] Starting dynamic subtest: pipe-A-HDMI-A-2 [591.821677] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.457s) [591.889971] Starting dynamic subtest: pipe-B-HDMI-A-1 [592.323066] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.489s) [592.358336] Starting dynamic subtest: pipe-B-HDMI-A-2 [592.751174] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.430s) [592.819928] Starting dynamic subtest: pipe-C-HDMI-A-1 [592.849857] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s) [592.887829] Starting dynamic subtest: pipe-C-HDMI-A-2 [592.915329] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.002s) [592.918302] Subtest crc-primary-basic-yf-tiled-ccs: SUCCESS (1.933s) [593.710222] [088/156] (485s left) kms_psr (fbc-pr-cursor-plane-move) [593.913888] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s) [594.047849] [089/156] (484s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs) [594.241928] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs [594.247265] Starting dynamic subtest: pipe-A-HDMI-A-1 [594.296510] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s) [594.367652] Starting dynamic subtest: pipe-A-HDMI-A-2 [594.401116] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s) [594.434639] Starting dynamic subtest: pipe-B-HDMI-A-1 [594.484578] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [594.528985] Starting dynamic subtest: pipe-B-HDMI-A-2 [594.563584] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s) [594.597766] Starting dynamic subtest: pipe-C-HDMI-A-1 [594.630892] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [594.664070] Starting dynamic subtest: pipe-C-HDMI-A-2 [594.700132] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s) [594.706660] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.031s) [595.332586] [090/156] (483s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling) [595.539555] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling [595.543355] Starting dynamic subtest: pipe-A-valid-mode [596.587260] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.045s) [596.591983] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SUCCESS (1.052s) [596.983859] [091/156] (482s left) kms_psr (fbc-psr-sprite-plane-move) [597.181949] Subtest fbc-psr-sprite-plane-move: SKIP (0.000s) [597.319651] [092/156] (481s left) gem_mmap_gtt (basic-write-gtt) [597.438957] Starting subtest: basic-write-gtt [598.163990] Subtest basic-write-gtt: SUCCESS (0.732s) [598.327815] [093/156] (481s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt) [598.548142] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt [598.555617] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [598.716095] [094/156] (480s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf) [598.926480] Subtest psr2-cursor-plane-move-continuous-sf: SKIP (0.000s) [599.057320] [095/156] (480s left) kms_cursor_legacy (single-move) [599.253114] Starting subtest: single-move [599.258127] Starting dynamic subtest: pipe-A [604.658212] Dynamic subtest pipe-A: SUCCESS (5.399s) [604.698371] Starting dynamic subtest: pipe-B [610.061212] Dynamic subtest pipe-B: SUCCESS (5.403s) [610.097712] Starting dynamic subtest: pipe-C [615.465289] Dynamic subtest pipe-C: SUCCESS (5.398s) [615.507902] Starting dynamic subtest: all-pipes [620.868053] Dynamic subtest all-pipes: SUCCESS (5.399s) [620.871710] Subtest single-move: SUCCESS (21.615s) [621.049402] [096/156] (458s left) gem_close (many-handles-one-vma) [621.174100] Starting subtest: many-handles-one-vma [621.252040] Subtest many-handles-one-vma: SUCCESS (0.077s) [621.417124] [097/156] (458s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf) [621.627077] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.000s) [621.762102] [098/156] (458s left) perf_pmu (rc6-suspend) [621.892044] Starting subtest: rc6-suspend