[116.993469] Initializing watchdogs [116.993550] /dev/watchdog0 [117.024834] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics] [117.039596] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [117.044282] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [117.046976] [001/130] (960s left) syncobj_wait (single-wait-for-submit-signaled) [117.096257] Starting subtest: single-wait-for-submit-signaled [117.097141] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s) [117.270792] [002/130] (960s left) kms_hdr (invalid-metadata-sizes) [118.759802] Starting subtest: invalid-metadata-sizes [118.762556] Subtest invalid-metadata-sizes: SKIP (0.001s) [118.978345] [003/130] (958s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs) [120.463358] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs [120.465810] Starting dynamic subtest: pipe-A-HDMI-A-4 [120.474706] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.002s) [120.482510] Starting dynamic subtest: pipe-B-HDMI-A-4 [120.491189] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.002s) [120.498618] Starting dynamic subtest: pipe-C-HDMI-A-4 [120.507376] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.002s) [120.515148] Starting dynamic subtest: pipe-D-HDMI-A-4 [120.524383] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.002s) [120.525462] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SUCCESS (0.013s) [120.767937] [004/130] (957s left) i915_module_load (reload) [120.811044] Starting subtest: reload [125.168231] Subtest reload: SUCCESS (4.357s) [125.227997] [005/130] (952s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render) [126.784575] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render [126.786200] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [127.056973] [006/130] (951s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation) [128.544036] Starting subtest: plane-scaler-unity-scaling-with-rotation [128.544952] Starting dynamic subtest: pipe-A [128.953103] Dynamic subtest pipe-A: SKIP (0.407s) [128.961177] Starting dynamic subtest: pipe-B [129.390546] Dynamic subtest pipe-B: SKIP (0.437s) [129.398499] Starting dynamic subtest: pipe-C [129.830394] Dynamic subtest pipe-C: SKIP (0.439s) [129.838411] Starting dynamic subtest: pipe-D [130.271953] Dynamic subtest pipe-D: SKIP (0.440s) [130.273959] Subtest plane-scaler-unity-scaling-with-rotation: SKIP (1.726s) [130.489604] [007/130] (947s left) gem_exec_big (single) [130.547551] Starting subtest: single [138.331170] Subtest single: SUCCESS (7.780s) [139.261419] [008/130] (938s left) perf_pmu (busy) [139.362898] Starting subtest: busy [139.363871] Starting dynamic subtest: rcs0 [140.011549] Dynamic subtest rcs0: SUCCESS (0.648s) [140.020811] Starting dynamic subtest: bcs0 [140.621550] Dynamic subtest bcs0: SUCCESS (0.609s) [140.630894] Starting dynamic subtest: vcs0 [141.211551] Dynamic subtest vcs0: SUCCESS (0.589s) [141.220978] Starting dynamic subtest: vcs1 [141.777549] Dynamic subtest vcs1: SUCCESS (0.565s) [141.786906] Starting dynamic subtest: vecs0 [142.343441] Dynamic subtest vecs0: SUCCESS (0.565s) [142.344513] Subtest busy: SUCCESS (2.981s) [142.494127] [009/130] (935s left) gem_exec_fence (syncobj-repeat) [142.905447] Starting subtest: syncobj-repeat [143.325217] Subtest syncobj-repeat: SUCCESS (0.416s) [143.730060] [FACT gem_exec_fence (syncobj-repeat)] new: kernel.kmod_is_loaded.vgem: true [143.732382] [010/130] (934s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu) [145.228174] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu [147.730720] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (2.503s) [147.942687] [011/130] (930s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs) [149.428198] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs [149.430444] Starting dynamic subtest: pipe-A-HDMI-A-4 [170.466407] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (10.504s) [170.477696] Starting dynamic subtest: pipe-B-HDMI-A-4 [192.445958] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (10.015s) [192.457135] Starting dynamic subtest: pipe-C-HDMI-A-4 [214.376625] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (9.891s) [214.387952] Starting dynamic subtest: pipe-D-HDMI-A-4 [236.357412] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (9.822s) [236.358327] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SUCCESS (40.239s) [241.627597] [012/130] (841s left) kms_draw_crc (draw-method-mmap-wc) [243.116537] Starting subtest: draw-method-mmap-wc [243.118261] Subtest draw-method-mmap-wc: SKIP (0.000s) [243.357947] [013/130] (840s left) gem_workarounds (suspend-resume-context) [243.436307] Starting subtest: suspend-resume-context [264.520345] Subtest suspend-resume-context: SUCCESS (10.036s) [270.694201] [014/130] (819s left) kms_sequence (queue-busy) [272.186307] Starting subtest: queue-busy [272.187232] Starting dynamic subtest: pipe-A-HDMI-A-4 [274.793402] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.611s) [274.805302] Starting dynamic subtest: pipe-B-HDMI-A-4 [277.205736] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (2.410s) [277.217577] Starting dynamic subtest: pipe-C-HDMI-A-4 [279.640759] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (2.433s) [279.654416] Starting dynamic subtest: pipe-D-HDMI-A-4 [282.065888] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.423s) [282.066780] Subtest queue-busy: SUCCESS (9.884s) [282.309019] [015/130] (807s left) tools_test (tools_test) [282.357273] Starting subtest: tools_test [282.461016] Subtest tools_test: SUCCESS (0.109s) [282.622982] [016/130] (807s left) kms_psr (psr-dpms) [284.110871] Subtest psr-dpms: SKIP (0.000s) [284.192277] [017/130] (805s left) kms_psr (fbc-psr2-cursor-plane-move) [285.679404] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s) [285.757432] [018/130] (804s left) gem_mmap_gtt (basic-write-gtt) [285.802528] Subtest basic-write-gtt: SKIP (0.000s) [285.874979] [019/130] (804s left) kms_cursor_legacy (cursorb-vs-flipa-atomic) [287.360553] Starting subtest: cursorB-vs-flipA-atomic [287.364635] Subtest cursorB-vs-flipA-atomic: SKIP (0.003s) [287.502625] [020/130] (802s left) gem_exec_reloc (basic-gtt) [287.561875] Subtest basic-gtt: SKIP (0.000s) [287.658852] [021/130] (802s left) kms_flip (flip-vs-panning-vs-hang) [289.145906] Starting subtest: flip-vs-panning-vs-hang [289.150630] Starting dynamic subtest: A-HDMI-A4 [340.193856] Dynamic subtest A-HDMI-A4: SUCCESS (51.043s) [340.207022] Starting dynamic subtest: D-HDMI-A4 [390.158098] Dynamic subtest D-HDMI-A4: SUCCESS (49.962s) [390.159052] Subtest flip-vs-panning-vs-hang: SUCCESS (101.011s) [390.386469] [022/130] (699s left) kms_cursor_crc (cursor-offscreen-512x512) [392.145659] Starting subtest: cursor-offscreen-512x512 [392.147537] Subtest cursor-offscreen-512x512: SKIP (0.001s) [392.473350] [023/130] (697s left) gem_exec_params (readonly) [392.524687] Starting subtest: readonly [392.526913] Subtest readonly: SUCCESS (0.002s) [392.761881] [024/130] (697s left) gem_exec_whisper (basic-contexts) [392.819890] Starting subtest: basic-contexts [396.863670] Subtest basic-contexts: SUCCESS (4.039s) [397.196204] [025/130] (693s left) kms_color (invalid-gamma-lut-sizes) [398.684419] Starting subtest: invalid-gamma-lut-sizes [398.685314] Starting dynamic subtest: pipe-A [398.739791] Dynamic subtest pipe-A: SUCCESS (0.057s) [398.751865] Starting dynamic subtest: pipe-B [398.752747] Dynamic subtest pipe-B: SUCCESS (0.002s) [398.765506] Starting dynamic subtest: pipe-C [398.766404] Dynamic subtest pipe-C: SUCCESS (0.002s) [398.778559] Starting dynamic subtest: pipe-D [398.779620] Dynamic subtest pipe-D: SUCCESS (0.002s) [398.780620] Subtest invalid-gamma-lut-sizes: SUCCESS (0.066s) [398.952410] [026/130] (691s left) kms_cursor_edge_walk (256x256-top-bottom) [400.440833] Starting subtest: 256x256-top-bottom [400.441774] Starting dynamic subtest: pipe-A-HDMI-A-4 [403.766961] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (3.325s) [403.780317] Starting dynamic subtest: pipe-D-HDMI-A-4 [407.004077] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (3.235s) [407.004944] Subtest 256x256-top-bottom: SUCCESS (6.565s) [407.247333] [027/130] (683s left) gem_partial_pwrite_pread (writes-after-reads-uncached) [407.298222] Subtest writes-after-reads-uncached: SKIP (0.000s) [407.397156] [028/130] (683s left) gem_ringfill (engines-basic) [407.824151] Starting subtest: engines-basic [407.825985] Starting dynamic subtest: rcs0 [407.912427] Dynamic subtest rcs0: SUCCESS (0.087s) [407.926286] Starting dynamic subtest: bcs0 [407.955492] Dynamic subtest bcs0: SUCCESS (0.042s) [407.979931] Starting dynamic subtest: vcs0 [407.999654] Dynamic subtest vcs0: SUCCESS (0.042s) [408.024165] Starting dynamic subtest: vcs1 [408.044564] Dynamic subtest vcs1: SUCCESS (0.043s) [408.065551] Starting dynamic subtest: vecs0 [408.087670] Dynamic subtest vecs0: SUCCESS (0.041s) [408.091253] Subtest engines-basic: SUCCESS (0.265s) [408.317758] [029/130] (682s left) prime_busy (hang) [408.373623] Starting subtest: hang [408.375679] Starting dynamic subtest: rcs0 [434.170953] Dynamic subtest rcs0: SUCCESS (25.796s) [434.184602] Starting dynamic subtest: bcs0 [441.319734] Dynamic subtest bcs0: SUCCESS (7.147s) [441.331774] Starting dynamic subtest: vcs0 [448.297563] Dynamic subtest vcs0: SUCCESS (6.976s) [448.309543] Starting dynamic subtest: vcs1 [455.273180] Dynamic subtest vcs1: SUCCESS (6.976s) [455.285547] Starting dynamic subtest: vecs0 [462.311835] Dynamic subtest vecs0: SUCCESS (7.038s) [462.314140] Subtest hang: SUCCESS (53.938s) [462.488255] [030/130] (628s left) syncobj_wait (multi-wait-for-submit-unsubmitted) [462.533965] Starting subtest: multi-wait-for-submit-unsubmitted [462.639113] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.101s) [462.823985] [031/130] (628s left) kms_atomic_interruptible (legacy-pageflip) [464.310713] Starting subtest: legacy-pageflip [464.312836] Starting dynamic subtest: pipe-A-HDMI-A-4 [470.533598] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (6.220s) [470.534354] Subtest legacy-pageflip: SUCCESS (6.222s) [470.765478] [032/130] (620s left) perf_pmu (semaphore-busy) [470.813818] Starting subtest: semaphore-busy [470.814657] Starting dynamic subtest: rcs0 [472.515665] Dynamic subtest rcs0: SUCCESS (1.697s) [472.527931] Starting dynamic subtest: bcs0 [474.166977] Dynamic subtest bcs0: SUCCESS (1.646s) [474.178995] Starting dynamic subtest: vcs0 [475.815211] Dynamic subtest vcs0: SUCCESS (1.643s) [475.827566] Starting dynamic subtest: vcs1 [477.466511] Dynamic subtest vcs1: SUCCESS (1.645s) [477.482727] Starting dynamic subtest: vecs0 [479.122793] Dynamic subtest vecs0: SUCCESS (1.652s) [479.123797] Subtest semaphore-busy: SUCCESS (8.307s) [479.313336] [033/130] (612s left) i915_drm_fdinfo (memory-info-shared) [479.362010] Starting subtest: memory-info-shared [479.362889] Starting dynamic subtest: lmem0 [479.452980] Dynamic subtest lmem0: SUCCESS (0.090s) [479.473863] Starting dynamic subtest: smem0 [479.517549] Dynamic subtest smem0: SUCCESS (0.063s) [479.518749] Subtest memory-info-shared: SUCCESS (0.156s) [479.665694] [034/130] (611s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area) [481.163186] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s) [481.231923] [035/130] (610s left) gem_eio (wait-wedge-1us) [481.393541] Starting subtest: wait-wedge-1us [482.602874] Subtest wait-wedge-1us: SUCCESS (1.209s) [484.230686] [036/130] (607s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc) [485.722229] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc [485.723798] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [485.999567] [037/130] (605s left) gem_exec_params (secure-non-root) [486.073636] Starting subtest: secure-non-root [486.075495] Subtest secure-non-root: SKIP (0.000s) [486.279191] [038/130] (605s left) gem_exec_schedule (preempt-self) [486.340858] Starting subtest: preempt-self [486.341824] Starting dynamic subtest: rcs0 [486.384294] Dynamic subtest rcs0: SUCCESS (0.043s) [486.398388] Starting dynamic subtest: bcs0 [486.410678] Dynamic subtest bcs0: SUCCESS (0.025s) [486.424642] Starting dynamic subtest: vcs0 [486.435873] Dynamic subtest vcs0: SUCCESS (0.024s) [486.449960] Starting dynamic subtest: vcs1 [486.463849] Dynamic subtest vcs1: SUCCESS (0.027s) [486.477885] Starting dynamic subtest: vecs0 [486.489689] Dynamic subtest vecs0: SUCCESS (0.025s) [486.490575] Subtest preempt-self: SUCCESS (0.149s) [486.995391] [039/130] (605s left) kms_vrr (flip-dpms) [488.482586] Starting subtest: flip-dpms [488.485417] Subtest flip-dpms: SKIP (0.000s) [488.701409] [040/130] (603s left) gem_ctx_create (basic) [488.757287] Starting subtest: basic [488.758499] Subtest basic: SUCCESS (0.000s) [489.079425] [041/130] (603s left) gem_create (create-ext-set-pat) [489.241922] Starting subtest: create-ext-set-pat [489.244407] Subtest create-ext-set-pat: SKIP (0.000s) [489.428913] [042/130] (602s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs) [490.916633] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs [490.917583] Starting dynamic subtest: pipe-A-HDMI-A-4 [490.925272] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.002s) [490.938199] Starting dynamic subtest: pipe-B-HDMI-A-4 [490.946047] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.002s) [490.958864] Starting dynamic subtest: pipe-C-HDMI-A-4 [490.967252] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.002s) [490.979776] Starting dynamic subtest: pipe-D-HDMI-A-4 [490.987642] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.002s) [490.988489] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SUCCESS (0.015s) [491.204523] [043/130] (601s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip) [492.711419] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip [492.713241] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [492.929887] [044/130] (599s left) gem_eio (create) [493.096615] Starting subtest: create [493.345648] Subtest create: SUCCESS (0.250s) [494.986685] [045/130] (597s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite) [496.480690] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite [496.482566] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [496.738670] [046/130] (596s left) gem_pxp (create-regular-context-1) [499.306786] Starting subtest: create-regular-context-1 [499.308849] Subtest create-regular-context-1: SKIP (0.000s) [499.451987] [047/130] (593s left) gem_spin_batch (spin-each) [499.509057] Starting subtest: spin-each [502.813529] Subtest spin-each: SUCCESS (3.304s) [503.191338] [048/130] (589s left) kms_force_connector_basic (prune-stale-modes) [503.322943] Starting subtest: prune-stale-modes [503.345792] Subtest prune-stale-modes: SUCCESS (0.023s) [505.080386] [049/130] (588s left) kms_big_fb (linear-32bpp-rotate-270) [506.587180] Starting subtest: linear-32bpp-rotate-270 [506.684814] Subtest linear-32bpp-rotate-270: SKIP (0.097s) [506.940581] [050/130] (586s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted) [506.988889] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted [507.092842] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.103s) [507.216323] [051/130] (586s left) gem_tiled_blits (basic) [507.266939] Subtest basic: SKIP (0.000s) [507.343619] [052/130] (586s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k) [508.872473] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s) [508.986193] [053/130] (584s left) kms_lease (master-vs-lease) [510.473923] Starting subtest: master-vs-lease [510.474895] Subtest master-vs-lease: SUCCESS (0.002s) [510.680242] [054/130] (582s left) gem_exec_reloc (basic-wc-cpu-noreloc) [510.731624] Subtest basic-wc-cpu-noreloc: SKIP (0.000s) [510.834549] [055/130] (582s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc) [512.320809] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc [512.321666] Starting dynamic subtest: pipe-A-HDMI-A-4 [512.330280] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s) [512.343490] Starting dynamic subtest: pipe-B-HDMI-A-4 [512.352151] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s) [512.364953] Starting dynamic subtest: pipe-C-HDMI-A-4 [512.373711] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s) [512.386230] Starting dynamic subtest: pipe-D-HDMI-A-4 [512.394894] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s) [512.396560] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.010s) [512.607241] [056/130] (581s left) kms_big_fb (x-tiled-8bpp-rotate-0) [514.113861] Starting subtest: x-tiled-8bpp-rotate-0 [515.852560] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.734s) [516.025322] [057/130] (577s left) gem_exec_reloc (basic-cpu-read) [516.076479] Subtest basic-cpu-read: SKIP (0.000s) [516.181781] [058/130] (577s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc) [517.673549] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc [517.675420] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [517.931714] [059/130] (576s left) kms_chamelium_audio (dp-audio-edid) [519.473275] Subtest dp-audio-edid: SKIP (0.000s) [519.595938] [060/130] (574s left) gem_caching (reads) [519.647762] Starting subtest: reads [523.471929] Subtest reads: SUCCESS (3.824s) [523.637009] [061/130] (570s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0) [525.124828] Starting subtest: primary-yf-tiled-reflect-x-0 [525.227402] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.102s) [525.449548] [062/130] (568s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size) [526.937564] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size [537.866840] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (10.929s) [538.079240] [063/130] (556s left) gem_exec_schedule (pi-common) [538.302367] Starting subtest: pi-common [538.306954] Starting dynamic subtest: rcs0 [538.360429] Dynamic subtest rcs0: SUCCESS (0.056s) [538.375669] Starting dynamic subtest: bcs0 [538.404343] Dynamic subtest bcs0: SUCCESS (0.042s) [538.419712] Starting dynamic subtest: vcs0 [538.442268] Dynamic subtest vcs0: SUCCESS (0.036s) [538.457365] Starting dynamic subtest: vcs1 [538.477335] Dynamic subtest vcs1: SUCCESS (0.033s) [538.495066] Starting dynamic subtest: vecs0 [538.511073] Dynamic subtest vecs0: SUCCESS (0.032s) [538.511916] Subtest pi-common: SUCCESS (0.210s) [538.836201] [064/130] (555s left) kms_flip (blocking-wf_vblank) [540.323297] Starting subtest: blocking-wf_vblank [540.331930] Starting dynamic subtest: A-HDMI-A4 [548.519280] Dynamic subtest A-HDMI-A4: SUCCESS (8.187s) [548.535704] Starting dynamic subtest: B-HDMI-A4 [556.650078] Dynamic subtest B-HDMI-A4: SUCCESS (8.128s) [556.665853] Starting dynamic subtest: C-HDMI-A4 [564.784475] Dynamic subtest C-HDMI-A4: SUCCESS (8.133s) [564.800727] Starting dynamic subtest: D-HDMI-A4 [572.751934] Dynamic subtest D-HDMI-A4: SUCCESS (7.965s) [572.752889] Subtest blocking-wf_vblank: SUCCESS (32.430s) [573.043201] [065/130] (521s left) syncobj_wait (single-wait-all-for-submit-signaled) [573.089884] Starting subtest: single-wait-all-for-submit-signaled [573.090706] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [573.268149] [066/130] (521s left) syncobj_timeline (host-signal-ordered) [573.313293] Starting subtest: host-signal-ordered [573.314299] Subtest host-signal-ordered: SUCCESS (0.001s) [573.530626] [067/130] (521s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25) [575.019920] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25 [575.020973] Starting dynamic subtest: pipe-A [575.125214] Dynamic subtest pipe-A: SUCCESS (0.107s) [575.140688] Starting dynamic subtest: pipe-B [575.265799] Dynamic subtest pipe-B: SUCCESS (0.139s) [575.281018] Starting dynamic subtest: pipe-C [575.406672] Dynamic subtest pipe-C: SUCCESS (0.139s) [575.421641] Starting dynamic subtest: pipe-D [575.547111] Dynamic subtest pipe-D: SUCCESS (0.139s) [575.548140] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (0.530s) [575.800339] [068/130] (519s left) i915_pm_rpm (system-suspend-execbuf) [579.840150] Starting subtest: system-suspend-execbuf [643.460562] Subtest system-suspend-execbuf: SUCCESS (52.936s) [644.466315] [069/130] (450s left) sw_sync (sync_busy) [644.519775] Starting subtest: sync_busy [644.523830] Subtest sync_busy: SUCCESS (0.004s) [644.689720] [070/130] (450s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc) [646.182514] Starting subtest: fbc-rgb101010-draw-mmap-wc [646.184514] Subtest fbc-rgb101010-draw-mmap-wc: SKIP (0.000s) [646.439454] [071/130] (448s left) gem_eio (wait-wedge-immediate) [646.624124] Starting subtest: wait-wedge-immediate [648.292533] Subtest wait-wedge-immediate: SUCCESS (1.669s) [649.947937] [072/130] (445s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render) [651.441576] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render [651.443489] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [651.682196] [073/130] (443s left) gem_userptr_blits (readonly-pwrite-unsync) [651.736741] Subtest readonly-pwrite-unsync: SKIP (0.000s) [651.988775] [074/130] (443s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0) [653.496990] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0 [653.499189] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s) [653.757868] [075/130] (442s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite) [655.251578] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite [655.253511] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s) [655.461241] [076/130] (440s left) kms_plane_alpha_blend (constant-alpha-min) [656.949575] Starting subtest: constant-alpha-min [657.222764] Starting dynamic subtest: pipe-A-HDMI-A-4 [657.892550] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.669s) [657.908939] Starting dynamic subtest: pipe-D-HDMI-A-4 [658.579606] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.684s) [658.580441] Subtest constant-alpha-min: SUCCESS (1.632s) [658.816074] [077/130] (437s left) kms_big_fb (yf-tiled-64bpp-rotate-270) [660.325919] Starting subtest: yf-tiled-64bpp-rotate-270 [660.328243] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s) [660.570934] [078/130] (435s left) kms_pm_rpm (modeset-non-lpsp-stress) [666.199272] Starting subtest: modeset-non-lpsp-stress [677.163196] Subtest modeset-non-lpsp-stress: SUCCESS (10.966s) [678.132768] [079/130] (418s left) gem_pxp (reject-modify-context-protection-off-3) [680.708320] Starting subtest: reject-modify-context-protection-off-3 [680.710000] Subtest reject-modify-context-protection-off-3: SKIP (0.000s) [680.845476] [080/130] (415s left) syncobj_wait (multi-wait-submitted-signaled) [680.891507] Starting subtest: multi-wait-submitted-signaled [680.892327] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s) [681.082563] [081/130] (415s left) kms_chamelium_hpd (vga-hpd) [682.617954] Subtest vga-hpd: SKIP (0.000s) [682.735153] [082/130] (413s left) kms_atomic_interruptible (legacy-cursor) [684.224112] Starting subtest: legacy-cursor [684.224989] Starting dynamic subtest: pipe-A-HDMI-A-4 [690.433137] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (6.208s) [690.434034] Subtest legacy-cursor: SUCCESS (6.211s) [690.645991] [083/130] (405s left) kms_flip (basic-flip-vs-dpms) [692.134264] Starting subtest: basic-flip-vs-dpms [692.141339] Starting dynamic subtest: A-HDMI-A4 [692.859810] Dynamic subtest A-HDMI-A4: SUCCESS (0.717s) [692.874024] Starting dynamic subtest: B-HDMI-A4 [693.586197] Dynamic subtest B-HDMI-A4: SUCCESS (0.725s) [693.600097] Starting dynamic subtest: C-HDMI-A4 [694.310449] Dynamic subtest C-HDMI-A4: SUCCESS (0.723s) [694.324419] Starting dynamic subtest: D-HDMI-A4 [695.052796] Dynamic subtest D-HDMI-A4: SUCCESS (0.741s) [695.053668] Subtest basic-flip-vs-dpms: SUCCESS (2.921s) [695.311373] [084/130] (401s left) gem_mmap_offset (open-flood) [695.360935] Starting subtest: open-flood [716.845283] Subtest open-flood: SUCCESS (21.486s) [717.029007] [085/130] (379s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [718.522947] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt [718.524753] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [718.785430] [086/130] (378s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite) [720.329823] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite [720.334112] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [720.590545] [087/130] (376s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area) [722.083914] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s) [722.156591] [088/130] (375s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt) [723.648454] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt [723.650225] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [723.916157] [089/130] (373s left) gem_lmem_swapping (parallel-random-engines) [728.430559] Starting subtest: parallel-random-engines [728.433014] Starting dynamic subtest: lmem0 [771.840460] Dynamic subtest lmem0: SUCCESS (43.430s) [771.841518] Subtest parallel-random-engines: SUCCESS (43.431s) [772.982923] [FACT gem_lmem_swapping (parallel-random-engines)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [772.984116] [FACT gem_lmem_swapping (parallel-random-engines)] deleted: kernel.kmod_is_loaded.i915: true [772.986273] [090/130] (324s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary) [777.759822] Starting subtest: fbcpsr-indfb-scaledprimary [777.761449] Subtest fbcpsr-indfb-scaledprimary: SKIP (0.000s) [778.021304] [FACT kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [778.024504] [FACT kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)] new: kernel.kmod_is_loaded.i915: true [778.030600] [091/130] (319s left) syncobj_basic (bad-flags-fd-to-handle) [778.076910] Starting subtest: bad-flags-fd-to-handle [778.077837] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s) [778.260852] [092/130] (319s left) gem_exec_balancer (individual) [778.324613] Starting subtest: individual [780.743095] Subtest individual: SUCCESS (2.415s) [781.270289] [093/130] (316s left) api_intel_bb (simple-bb-ctx) [781.315448] Starting subtest: simple-bb-ctx [781.339213] Subtest simple-bb-ctx: SUCCESS (0.024s) [781.566058] [094/130] (316s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render) [783.056753] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render [785.924486] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (2.867s) [786.164444] [095/130] (311s left) intel_hwmon (hwmon-write) [786.210722] Starting subtest: hwmon-write [786.231202] Subtest hwmon-write: SUCCESS (0.022s) [786.421952] [096/130] (311s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt) [787.913877] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt [787.916205] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [788.146934] [097/130] (310s left) kms_dither (fb-8bpc-vs-panel-8bpc) [789.637812] Starting subtest: fb-8bpc-vs-panel-8bpc [789.640749] Subtest fb-8bpc-vs-panel-8bpc: SKIP (0.001s) [789.863801] [098/130] (308s left) kms_psr (psr2-cursor-mmap-cpu) [791.352147] Subtest psr2-cursor-mmap-cpu: SKIP (0.000s) [791.436733] [099/130] (306s left) gem_ctx_persistence (legacy-engines-mixed) [791.490673] Starting subtest: legacy-engines-mixed [791.491573] Starting dynamic subtest: render [791.568419] Dynamic subtest render: SUCCESS (0.077s) [791.588628] Starting dynamic subtest: bsd1 [791.627693] Dynamic subtest bsd1: SUCCESS (0.057s) [791.672925] Starting dynamic subtest: bsd2 [791.709375] Dynamic subtest bsd2: SUCCESS (0.078s) [791.733357] Starting dynamic subtest: blt [791.759119] Dynamic subtest blt: SUCCESS (0.047s) [791.785858] Starting dynamic subtest: vebox [791.824576] Dynamic subtest vebox: SUCCESS (0.064s) [791.829334] Subtest legacy-engines-mixed: SUCCESS (0.335s) [792.066962] [100/130] (306s left) i915_selftest (live) [793.190377] Starting subtest: live [793.191348] Starting dynamic subtest: sanitycheck [794.748794] Dynamic subtest sanitycheck: SUCCESS (1.558s) [794.761741] Starting dynamic subtest: uncore [796.285908] Dynamic subtest uncore: SUCCESS (1.536s) [796.297279] Starting dynamic subtest: workarounds [799.832033] Dynamic subtest workarounds: SUCCESS (3.544s) [799.842908] Starting dynamic subtest: gt_engines [801.934699] Dynamic subtest gt_engines: SUCCESS (2.101s) [801.945794] Starting dynamic subtest: gt_timelines [868.567876] Dynamic subtest gt_timelines: SUCCESS (66.632s) [868.580283] Starting dynamic subtest: gt_contexts [870.108939] Dynamic subtest gt_contexts: SUCCESS (1.540s) [870.121841] Starting dynamic subtest: gt_lrc [876.300218] Dynamic subtest gt_lrc: SUCCESS (6.190s) [876.311392] Starting dynamic subtest: gt_mocs [878.822005] Dynamic subtest gt_mocs: SUCCESS (2.520s) [878.833144] Starting dynamic subtest: gt_pm [882.924833] Dynamic subtest gt_pm: SUCCESS (4.101s) [882.935919] Starting dynamic subtest: gt_heartbeat [884.459618] Dynamic subtest gt_heartbeat: SUCCESS (1.533s) [884.470729] Starting dynamic subtest: gt_tlb [898.691200] Dynamic subtest gt_tlb: SUCCESS (14.230s) [898.705504] Starting dynamic subtest: requests [909.813283] Dynamic subtest requests: SUCCESS (11.120s) [909.824445] Starting dynamic subtest: migrate [914.597769] Dynamic subtest migrate: SUCCESS (4.782s) [914.608735] Starting dynamic subtest: active [916.174799] Dynamic subtest active: SUCCESS (1.573s) [916.186166] Starting dynamic subtest: objects [918.660797] Dynamic subtest objects: SUCCESS (2.485s) [918.672897] Starting dynamic subtest: mman [922.469766] Dynamic subtest mman: SUCCESS (3.807s) [922.481060] Starting dynamic subtest: dmabuf [924.038896] Dynamic subtest dmabuf: SUCCESS (1.567s) [924.050368] Starting dynamic subtest: vma [925.570778] Dynamic subtest vma: SUCCESS (1.530s) [925.582261] Starting dynamic subtest: coherency [935.754912] Dynamic subtest coherency: SUCCESS (10.182s) [935.766230] Starting dynamic subtest: gtt [945.073144] Dynamic subtest gtt: SUCCESS (9.317s) [945.084638] Starting dynamic subtest: gem [946.788870] Dynamic subtest gem: SUCCESS (1.714s) [946.802444] Starting dynamic subtest: evict [958.551064] Dynamic subtest evict: SUCCESS (11.760s) [958.562229] Starting dynamic subtest: hugepages [974.317074] Warning: kernel log ringbuffer underflow, some records lost. [974.598263] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 2242 [max: 8192] dynamic-keys: 317 direct dependencies: 25276 [max: 524288] indirect dependencies: 226924 all direct dependencies: 509650 dependency chains: 37633 [max: 524288] dependency chain hlocks used: 167079 [max: 2621440] dependency chain hlocks lost: 0 in-hardirq chains: 224 in-softirq chains: 845 in-process chains: 36564 stack-trace entries: 372683 [max: 524288] number of stack traces: 15641 number of stack hash chains: 10066 combined max dependencies: 2665180454 hardirq-safe locks: 104 hardirq-unsafe locks: 1353 softirq-safe locks: 238 softirq-unsafe locks: 1247 irq-safe locks: 254 irq-unsafe locks: 1353 hardirq-read-safe locks: 5 hardirq-read-unsafe locks: 414 softirq-read-safe locks: 10 softirq-read-unsafe locks: 411 irq-read-safe locks: 10 irq-read-unsafe locks: 414 uncategorized locks: 383 unused locks: 1 max locking depth: 18 max bfs queue depth: 424 max lock class index: 2306 debug_locks: 0 zapped classes: 3011 zapped lock chains: 37700 large chain blocks: 1 [974.636445] [FACT i915_selftest (live)] new: kernel.is_tainted.taint_die: true [974.636471] [FACT i915_selftest (live)] new: kernel.is_tainted.taint_warn: true [974.637521] Closing watchdogs results: parsing output: 0/ for test: syncobj_wait results: parsing output: 1/ for test: kms_hdr results: parsing output: 2/ for test: kms_ccs results: parsing output: 3/ for test: i915_module_load results: parsing output: 4/ for test: kms_frontbuffer_tracking results: parsing output: 5/ for test: kms_plane_scaling results: parsing output: 6/ for test: gem_exec_big results: parsing output: 7/ for test: perf_pmu results: parsing output: 8/ for test: gem_exec_fence results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: kms_ccs results: parsing output: 11/ for test: kms_draw_crc results: parsing output: 12/ for test: gem_workarounds results: parsing output: 13/ for test: kms_sequence results: parsing output: 14/ for test: tools_test results: parsing output: 15/ for test: kms_psr results: parsing output: 16/ for test: kms_psr results: parsing output: 17/ for test: gem_mmap_gtt results: parsing output: 18/ for test: kms_cursor_legacy results: parsing output: 19/ for test: gem_exec_reloc results: parsing output: 20/ for test: kms_flip results: parsing output: 21/ for test: kms_cursor_crc results: parsing output: 22/ for test: gem_exec_params results: parsing output: 23/ for test: gem_exec_whisper results: parsing output: 24/ for test: kms_color results: parsing output: 25/ for test: kms_cursor_edge_walk results: parsing output: 26/ for test: gem_partial_pwrite_pread results: parsing output: 27/ for test: gem_ringfill results: parsing output: 28/ for test: prime_busy results: parsing output: 29/ for test: syncobj_wait results: parsing output: 30/ for test: kms_atomic_interruptible results: parsing output: 31/ for test: perf_pmu results: parsing output: 32/ for test: i915_drm_fdinfo results: parsing output: 33/ for test: kms_psr2_sf results: parsing output: 34/ for test: gem_eio results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: gem_exec_params results: parsing output: 37/ for test: gem_exec_schedule results: parsing output: 38/ for test: kms_vrr results: parsing output: 39/ for test: gem_ctx_create results: parsing output: 40/ for test: gem_create results: parsing output: 41/ for test: kms_ccs results: parsing output: 42/ for test: kms_big_fb results: parsing output: 43/ for test: gem_eio results: parsing output: 44/ for test: kms_frontbuffer_tracking results: parsing output: 45/ for test: gem_pxp results: parsing output: 46/ for test: gem_spin_batch results: parsing output: 47/ for test: kms_force_connector_basic results: parsing output: 48/ for test: kms_big_fb results: parsing output: 49/ for test: syncobj_timeline results: parsing output: 50/ for test: gem_tiled_blits results: parsing output: 51/ for test: kms_chamelium_edid results: parsing output: 52/ for test: kms_lease results: parsing output: 53/ for test: gem_exec_reloc results: parsing output: 54/ for test: kms_ccs results: parsing output: 55/ for test: kms_big_fb results: parsing output: 56/ for test: gem_exec_reloc results: parsing output: 57/ for test: kms_frontbuffer_tracking results: parsing output: 58/ for test: kms_chamelium_audio results: parsing output: 59/ for test: gem_caching results: parsing output: 60/ for test: kms_rotation_crc results: parsing output: 61/ for test: kms_cursor_legacy results: parsing output: 62/ for test: gem_exec_schedule results: parsing output: 63/ for test: kms_flip results: parsing output: 64/ for test: syncobj_wait results: parsing output: 65/ for test: syncobj_timeline results: parsing output: 66/ for test: kms_plane_scaling results: parsing output: 67/ for test: i915_pm_rpm results: parsing output: 68/ for test: sw_sync results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: gem_eio results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: gem_userptr_blits results: parsing output: 73/ for test: kms_big_fb results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: kms_plane_alpha_blend results: parsing output: 76/ for test: kms_big_fb results: parsing output: 77/ for test: kms_pm_rpm results: parsing output: 78/ for test: gem_pxp results: parsing output: 79/ for test: syncobj_wait results: parsing output: 80/ for test: kms_chamelium_hpd results: parsing output: 81/ for test: kms_atomic_interruptible results: parsing output: 82/ for test: kms_flip results: parsing output: 83/ for test: gem_mmap_offset results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: kms_frontbuffer_tracking results: parsing output: 86/ for test: kms_psr2_sf results: parsing output: 87/ for test: kms_frontbuffer_tracking results: parsing output: 88/ for test: gem_lmem_swapping results: parsing output: 89/ for test: kms_frontbuffer_tracking results: parsing output: 90/ for test: syncobj_basic results: parsing output: 91/ for test: gem_exec_balancer results: parsing output: 92/ for test: api_intel_bb results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: intel_hwmon results: parsing output: 95/ for test: kms_frontbuffer_tracking results: parsing output: 96/ for test: kms_dither results: parsing output: 97/ for test: kms_psr results: parsing output: 98/ for test: gem_ctx_persistence results: parsing output: 99/ for test: i915_selftest results: parsing output: 100/ for test: gem_lmem_swapping results: no output, setting notrun results: parsing output: 101/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 102/ for test: syncobj_timeline results: no output, setting notrun results: parsing output: 103/ for test: kms_cursor_crc results: no output, setting notrun results: parsing output: 104/ for test: gem_ctx_exec results: no output, setting notrun results: parsing output: 105/ for test: api_intel_allocator results: no output, setting notrun results: parsing output: 106/ for test: gem_userptr_blits results: no output, setting notrun results: parsing output: 107/ for test: kms_atomic results: no output, setting notrun results: parsing output: 108/ for test: syncobj_timeline results: no output, setting notrun results: parsing output: 109/ for test: kms_pipe_crc_basic results: no output, setting notrun results: parsing output: 110/ for test: kms_psr results: no output, setting notrun results: parsing output: 111/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 112/ for test: kms_flip results: no output, setting notrun results: parsing output: 113/ for test: syncobj_wait results: no output, setting notrun results: parsing output: 114/ for test: kms_psr results: no output, setting notrun results: parsing output: 115/ for test: dumb_buffer results: no output, setting notrun results: parsing output: 116/ for test: gem_basic results: no output, setting notrun results: parsing output: 117/ for test: kms_flip_scaled_crc results: no output, setting notrun results: parsing output: 118/ for test: syncobj_timeline results: no output, setting notrun results: parsing output: 119/ for test: kms_getfb results: no output, setting notrun results: parsing output: 120/ for test: kms_pm_rpm results: no output, setting notrun results: parsing output: 121/ for test: kms_atomic_transition results: no output, setting notrun results: parsing output: 122/ for test: kms_big_fb results: no output, setting notrun results: parsing output: 123/ for test: gem_exec_params results: no output, setting notrun results: parsing output: 124/ for test: kms_ccs results: no output, setting notrun results: parsing output: 125/ for test: kms_psr results: no output, setting notrun results: parsing output: 126/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 127/ for test: kms_rotation_crc results: no output, setting notrun results: parsing output: 128/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 129/ for test: gen7_exec_parse results: no output, setting notrun Done.