[61.518558] Initializing watchdogs [61.518601] /dev/watchdog0 [61.532144] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [61.536560] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [61.538705] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [61.541892] [001/133] (960s left) gem_exec_reloc (basic-gtt-cpu-noreloc) [61.622394] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s) [61.700046] [002/133] (960s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier) [61.785394] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier [61.789968] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier: SKIP (0.000s) [61.854554] [003/133] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu) [61.956626] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu [61.961106] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [62.053425] [004/133] (960s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions) [62.167039] Starting subtest: short-flip-before-cursor-atomic-transitions [63.173305] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (1.006s) [64.040685] [005/133] (958s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render) [64.147194] Starting subtest: fbc-rgb101010-draw-render [68.744465] Subtest fbc-rgb101010-draw-render: SUCCESS (4.601s) [69.935882] [006/133] (952s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc) [70.026550] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc [70.028932] Starting dynamic subtest: pipe-A-eDP-1 [70.051875] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [70.061062] Starting dynamic subtest: pipe-B-eDP-1 [70.081096] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [70.088079] Starting dynamic subtest: pipe-C-eDP-1 [70.106947] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [70.116755] Starting dynamic subtest: pipe-D-eDP-1 [70.136338] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [70.138621] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.004s) [72.285200] [007/133] (949s left) syncobj_wait (wait-for-submit-delayed-submit) [72.343176] Starting subtest: wait-for-submit-delayed-submit [72.448365] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s) [72.521645] [008/133] (949s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf) [72.625254] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf [72.629759] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s) [72.691919] [009/133] (949s left) perf (low-oa-exponent-permissions) [72.829047] Starting subtest: low-oa-exponent-permissions [72.860827] Subtest low-oa-exponent-permissions: SUCCESS (0.033s) [72.905446] [010/133] (949s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area) [73.002298] Starting subtest: fbc-psr2-plane-move-sf-dmg-area [73.004689] Starting dynamic subtest: pipe-A-eDP-1 [73.088724] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s) [73.096555] Starting dynamic subtest: pipe-B-eDP-1 [74.265604] Dynamic subtest pipe-B-eDP-1: SKIP (1.176s) [74.270114] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.266s) [75.446978] [011/133] (946s left) syncobj_timeline (wait-any-snapshot) [75.500656] Starting subtest: wait-any-snapshot [75.582040] Subtest wait-any-snapshot: SUCCESS (0.082s) [75.658361] [012/133] (946s left) kms_cursor_crc (cursor-size-change) [75.753924] Starting subtest: cursor-size-change [75.756214] Starting dynamic subtest: pipe-A-eDP-1 [76.548548] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.794s) [76.557256] Starting dynamic subtest: pipe-D-eDP-1 [77.997313] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.448s) [77.999503] Subtest cursor-size-change: SUCCESS (2.244s) [78.810667] [013/133] (943s left) kms_pipe_crc_basic (suspend-read-crc) [78.918589] Starting subtest: suspend-read-crc [78.920834] Starting dynamic subtest: pipe-A-eDP-1 [97.182998] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.653s) [97.191448] Starting dynamic subtest: pipe-B-eDP-1 [115.192393] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.117s) [115.202020] Starting dynamic subtest: pipe-C-eDP-1 [133.142478] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.049s) [133.150643] Starting dynamic subtest: pipe-D-eDP-1 [151.145549] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.046s) [151.147658] Subtest suspend-read-crc: SUCCESS (11.869s) [151.956589] [014/133] (870s left) perf (gen12-mi-rpc) [152.059318] Starting subtest: gen12-mi-rpc [152.061619] Starting dynamic subtest: rcs0 [152.076163] Dynamic subtest rcs0: SUCCESS (0.015s) [152.078038] Subtest gen12-mi-rpc: SUCCESS (0.016s) [152.116089] [015/133] (870s left) gem_exec_reloc (basic-cpu-wc-active) [152.193379] Subtest basic-cpu-wc-active: SKIP (0.000s) [152.253637] [016/133] (870s left) sw_sync (timeline_closed_signaled) [152.291279] Starting subtest: timeline_closed_signaled [152.293555] Subtest timeline_closed_signaled: SUCCESS (0.000s) [152.347052] [017/133] (870s left) kms_chamelium_color (ctm-negative) [152.444743] Subtest ctm-negative: SKIP (0.000s) [152.486130] [018/133] (870s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle) [152.597527] Starting subtest: short-busy-flip-before-cursor-toggle [152.601924] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s) [152.745034] [019/133] (869s left) kms_flip (2x-absolute-wf_vblank-interruptible) [152.833877] Starting subtest: 2x-absolute-wf_vblank-interruptible [152.845627] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.010s) [152.924316] [020/133] (869s left) gem_exec_fence (syncobj-timeline-wait) [153.472975] Starting subtest: syncobj-timeline-wait [154.462706] Subtest syncobj-timeline-wait: SUCCESS (1.003s) [154.673705] [FACT gem_exec_fence (syncobj-timeline-wait)] new: kernel.kmod_is_loaded.vgem: true [154.677760] [021/133] (868s left) kms_cursor_legacy (short-flip-before-cursor-toggle) [154.800544] Starting subtest: short-flip-before-cursor-toggle [155.708935] Subtest short-flip-before-cursor-toggle: SUCCESS (0.919s) [156.530878] [022/133] (866s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180) [156.641377] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180 [156.645726] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s) [156.751785] [023/133] (866s left) kms_frontbuffer_tracking (psr-modesetfrombusy) [156.844601] Starting subtest: psr-modesetfrombusy [162.974086] Subtest psr-modesetfrombusy: SUCCESS (6.174s) [163.110918] [024/133] (859s left) syncobj_timeline (single-wait-all-for-submit-available-signaled) [163.169623] Starting subtest: single-wait-all-for-submit-available-signaled [163.171456] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s) [163.258612] [025/133] (859s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling) [163.348784] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling [163.352193] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s) [163.420771] [026/133] (859s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted) [163.473025] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted [163.474963] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s) [163.578392] [027/133] (859s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt) [163.683590] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt [163.687000] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [163.800264] [028/133] (859s left) vgem_basic (create) [163.853635] Starting subtest: create [163.855200] Subtest create: SUCCESS (0.000s) [163.926297] [029/133] (859s left) kms_flip (flip-vs-panning-vs-hang) [164.012309] Starting subtest: flip-vs-panning-vs-hang [164.014282] Starting dynamic subtest: A-eDP1 [214.894428] Dynamic subtest A-eDP1: SUCCESS (50.915s) [214.902818] Starting dynamic subtest: D-eDP1 [254.905662] Dynamic subtest D-eDP1: SUCCESS (40.015s) [254.908008] Subtest flip-vs-panning-vs-hang: SUCCESS (90.933s) [256.097615] [030/133] (767s left) gem_exec_suspend (basic-s3-devices) [256.158543] Starting subtest: basic-S3-devices [256.160894] Starting dynamic subtest: smem [267.403263] Dynamic subtest smem: SUCCESS (11.238s) [267.406303] Subtest basic-S3-devices: SUCCESS (11.240s) [267.600235] [031/133] (755s left) i915_hangman (detector) [267.665469] Starting subtest: detector [267.667691] Starting dynamic subtest: rcs0 [279.401337] Dynamic subtest rcs0: SUCCESS (11.734s) [279.413242] Starting dynamic subtest: bcs0 [291.433102] Dynamic subtest bcs0: SUCCESS (12.031s) [291.444437] Starting dynamic subtest: vcs0 [303.336397] Dynamic subtest vcs0: SUCCESS (11.903s) [303.347845] Starting dynamic subtest: vcs1 [313.384576] Dynamic subtest vcs1: SUCCESS (10.047s) [313.396546] Starting dynamic subtest: vecs0 [325.352857] Dynamic subtest vecs0: SUCCESS (11.967s) [325.364924] Starting dynamic subtest: ccs0 [336.424921] Dynamic subtest ccs0: SUCCESS (11.071s) [336.427735] Subtest detector: SUCCESS (68.766s) [336.517471] [032/133] (686s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary) [336.623428] Starting subtest: fbcpsr-indfb-scaledprimary [342.390719] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.772s) [342.515199] [033/133] (680s left) kms_psr (fbc-psr-cursor-mmap-gtt) [342.612180] Starting subtest: fbc-psr-cursor-mmap-gtt [342.614478] Starting dynamic subtest: eDP-1 [342.618682] Dynamic subtest eDP-1: SKIP (0.000s) [342.622730] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s) [342.685540] [034/133] (680s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt) [342.780970] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt [342.785250] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [342.865995] [035/133] (680s left) kms_big_fb (4-tiled-addfb-size-offset-overflow) [342.959879] Starting subtest: 4-tiled-addfb-size-offset-overflow [342.961827] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s) [343.057827] [036/133] (680s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping) [343.154428] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping [343.158833] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (0.000s) [343.230618] [037/133] (680s left) kms_atomic (plane-cursor-legacy) [343.332191] Starting subtest: plane-cursor-legacy [343.333775] Starting dynamic subtest: pipe-A-eDP-1 [343.703124] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.366s) [343.705116] Subtest plane-cursor-legacy: SUCCESS (0.369s) [344.557414] [038/133] (678s left) kms_pm_backlight (brightness-with-dpms) [344.646018] Starting subtest: brightness-with-dpms [344.693241] Starting dynamic subtest: eDP-1 [347.232925] Dynamic subtest eDP-1: SUCCESS (2.537s) [347.235158] Subtest brightness-with-dpms: SUCCESS (2.587s) [348.092586] [039/133] (675s left) gem_close_race (multigpu-basic-threads) [348.163425] Starting subtest: multigpu-basic-threads [348.167966] Subtest multigpu-basic-threads: SKIP (0.000s) [348.379475] [040/133] (675s left) api_intel_allocator (simple-allocator) [348.427787] Starting subtest: simple-allocator [348.430023] Starting dynamic subtest: basic [348.431977] Dynamic subtest basic: SUCCESS (0.003s) [348.446392] Starting dynamic subtest: parallel-one [348.619945] Dynamic subtest parallel-one: SUCCESS (0.189s) [348.633713] Starting dynamic subtest: print [348.635927] Dynamic subtest print: SUCCESS (0.000s) [348.644639] Starting dynamic subtest: reuse [348.646525] Dynamic subtest reuse: SUCCESS (0.000s) [348.654330] Starting dynamic subtest: reserve [348.656188] Dynamic subtest reserve: SUCCESS (0.000s) [348.663970] Starting dynamic subtest: fork-reopen-allocator [348.665869] Dynamic subtest fork-reopen-allocator: SUCCESS (0.013s) [348.668074] Subtest simple-allocator: SUCCESS (0.209s) [348.743473] [041/133] (674s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu) [348.839511] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu [348.843622] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [348.947780] [042/133] (674s left) kms_lease (possible-crtcs-filtering) [349.040583] Starting subtest: possible-crtcs-filtering [349.042418] Subtest possible-crtcs-filtering: SUCCESS (0.005s) [349.143230] [043/133] (674s left) kms_big_fb (yf-tiled-16bpp-rotate-270) [349.238777] Starting subtest: yf-tiled-16bpp-rotate-270 [349.243176] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s) [349.343741] [044/133] (674s left) kms_big_fb (x-tiled-addfb) [349.448692] Starting subtest: x-tiled-addfb [349.450530] Subtest x-tiled-addfb: SUCCESS (0.000s) [349.551532] [045/133] (674s left) kms_rotation_crc (primary-4-tiled-reflect-x-180) [349.640393] Starting subtest: primary-4-tiled-reflect-x-180 [356.725750] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.089s) [357.971010] [046/133] (665s left) gem_exec_balancer (parallel) [358.226084] Starting subtest: parallel [359.197868] Subtest parallel: SUCCESS (0.975s) [359.408654] [047/133] (664s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render) [359.498214] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render [359.502566] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [359.621683] [048/133] (664s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render) [359.717262] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render [359.721689] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [359.822742] [049/133] (664s left) kms_vblank (ts-continuation-idle-hang) [359.905521] Starting subtest: ts-continuation-idle-hang [359.907376] Starting dynamic subtest: pipe-A-eDP-1 [386.244716] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.343s) [386.259649] Starting dynamic subtest: pipe-D-eDP-1 [401.243182] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.999s) [401.245558] Subtest ts-continuation-idle-hang: SUCCESS (41.346s) [402.127438] [050/133] (621s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted) [402.198544] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted [402.301952] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.104s) [402.382176] [051/133] (621s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render) [402.486748] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render [402.490851] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [402.596301] [052/133] (621s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy) [402.714984] Starting subtest: flip-vs-cursor-busy-crc-legacy [403.535648] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.822s) [404.355648] [053/133] (619s left) gem_pread (display) [404.420668] Subtest display: SKIP (0.000s) [404.484444] [054/133] (619s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt) [404.577238] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt [404.581521] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [404.677372] [055/133] (619s left) gem_userptr_blits (dmabuf-unsync) [404.737331] Subtest dmabuf-unsync: SKIP (0.000s) [404.867544] [056/133] (619s left) gem_eio (unwedge-stress) [405.079726] Starting subtest: unwedge-stress [405.082101] Starting dynamic subtest: render [409.463350] Dynamic subtest render: SUCCESS (4.381s) [409.477889] Starting dynamic subtest: bsd1 [427.921313] Dynamic subtest bsd1: SUCCESS (18.459s) [427.937312] Starting dynamic subtest: bsd2 [447.811423] Dynamic subtest bsd2: SUCCESS (19.891s) [447.827577] Starting dynamic subtest: blt [447.831850] Dynamic subtest blt: SKIP (0.000s) [447.840600] Starting dynamic subtest: vebox [465.876180] Dynamic subtest vebox: SUCCESS (18.065s) [465.878260] Subtest unwedge-stress: SUCCESS (60.801s) [467.445039] [057/133] (556s left) kms_addfb_basic (master-rmfb) [467.498688] Starting subtest: master-rmfb [467.500884] Subtest master-rmfb: SUCCESS (0.001s) [467.631860] [058/133] (556s left) gem_exec_schedule (preempt-user) [467.697506] Starting subtest: preempt-user [467.699805] Starting dynamic subtest: rcs0 [467.710674] Dynamic subtest rcs0: SUCCESS (0.024s) [467.721716] Starting dynamic subtest: bcs0 [467.730474] Dynamic subtest bcs0: SUCCESS (0.019s) [467.739437] Starting dynamic subtest: vcs0 [467.749805] Dynamic subtest vcs0: SUCCESS (0.019s) [467.758963] Starting dynamic subtest: vcs1 [467.780298] Dynamic subtest vcs1: SUCCESS (0.030s) [467.789548] Starting dynamic subtest: vecs0 [467.802242] Dynamic subtest vecs0: SUCCESS (0.021s) [467.811144] Starting dynamic subtest: ccs0 [467.826557] Dynamic subtest ccs0: SUCCESS (0.023s) [467.828956] Subtest preempt-user: SUCCESS (0.141s) [469.598797] [059/133] (554s left) drm_buddy (drm_buddy) [469.640871] Starting subtest: drm_buddy [469.645216] Subtest drm_buddy: SKIP (0.001s) [469.703607] [060/133] (554s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render) [469.801596] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render [473.923077] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.125s) [475.057649] [061/133] (549s left) kms_getfb (getfb2-accept-nv12) [475.143261] Starting subtest: getfb2-accept-nv12 [475.145529] Subtest getfb2-accept-nv12: SUCCESS (0.001s) [475.241061] [062/133] (549s left) gem_ppgtt (flink-and-close-vma-leak) [475.291313] Starting subtest: flink-and-close-vma-leak [475.328671] Subtest flink-and-close-vma-leak: SUCCESS (0.040s) [475.433101] [063/133] (549s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt) [475.532624] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt [475.536553] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [475.612990] [064/133] (549s left) kms_cursor_crc (cursor-offscreen-128x128) [475.836050] Starting subtest: cursor-offscreen-128x128 [475.838219] Starting dynamic subtest: pipe-A-eDP-1 [477.775938] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.937s) [477.804622] Starting dynamic subtest: pipe-D-eDP-1 [480.362063] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.565s) [480.364345] Subtest cursor-offscreen-128x128: SUCCESS (4.528s) [481.217145] [065/133] (543s left) kms_dsc (dsc-fractional-bpp) [481.303853] Starting subtest: dsc-fractional-bpp [481.316893] Subtest dsc-fractional-bpp: SKIP (0.000s) [481.398127] [066/133] (543s left) i915_pm_rpm (gem-pread) [483.624805] Starting subtest: gem-pread [485.665342] Subtest gem-pread: SUCCESS (2.044s) [485.770537] [067/133] (539s left) kms_joiner (basic-ultra-joiner) [485.873348] Starting subtest: basic-ultra-joiner [485.877631] Subtest basic-ultra-joiner: SKIP (0.000s) [485.938746] [068/133] (538s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy) [486.061743] Starting subtest: 2x-long-cursor-vs-flip-legacy [486.066324] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.001s) [486.203967] [069/133] (538s left) kms_psr (psr2-sprite-blt) [486.287821] Starting subtest: psr2-sprite-blt [486.290095] Starting dynamic subtest: eDP-1 [488.030312] Dynamic subtest eDP-1: SUCCESS (1.742s) [488.032679] Subtest psr2-sprite-blt: SUCCESS (1.743s) [488.890734] [070/133] (536s left) gem_softpin (evict-prime) [488.952881] Starting subtest: evict-prime [488.955205] Starting dynamic subtest: rcs0 [490.112580] Dynamic subtest rcs0: SUCCESS (1.159s) [490.125145] Starting dynamic subtest: bcs0 [491.244394] Dynamic subtest bcs0: SUCCESS (1.129s) [491.256021] Starting dynamic subtest: vcs0 [492.425238] Dynamic subtest vcs0: SUCCESS (1.178s) [492.437551] Starting dynamic subtest: vcs1 [494.421990] Dynamic subtest vcs1: SUCCESS (1.994s) [494.434532] Starting dynamic subtest: vecs0 [496.400870] Dynamic subtest vecs0: SUCCESS (1.978s) [496.413241] Starting dynamic subtest: ccs0 [497.533460] Dynamic subtest ccs0: SUCCESS (1.131s) [497.545881] Starting dynamic subtest: all [499.403709] Dynamic subtest all: SUCCESS (1.868s) [499.406370] Subtest evict-prime: SUCCESS (10.453s) [499.485135] [071/133] (525s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [499.585738] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [499.589792] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [499.685709] [072/133] (525s left) kms_prime (basic-modeset-hybrid) [499.774336] Subtest basic-modeset-hybrid: SKIP (0.000s) [499.879762] [073/133] (525s left) kms_panel_fitting (legacy) [499.973675] Starting subtest: legacy [499.975894] Starting dynamic subtest: pipe-A-eDP-1 [500.615183] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.644s) [500.642166] Starting dynamic subtest: pipe-B-eDP-1 [502.135756] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.501s) [502.163203] Starting dynamic subtest: pipe-C-eDP-1 [503.637730] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.481s) [503.663483] Starting dynamic subtest: pipe-D-eDP-1 [505.184012] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.527s) [505.186337] Subtest legacy: SUCCESS (5.212s) [506.417090] [074/133] (518s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area) [506.510114] Starting subtest: psr2-plane-move-sf-dmg-area [506.512578] Starting dynamic subtest: pipe-A-eDP-1 [511.059565] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.556s) [511.070196] Starting dynamic subtest: pipe-B-eDP-1 [516.376547] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.314s) [516.378886] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.872s) [517.237288] [075/133] (507s left) prime_vgem (fence-wait) [517.314882] Starting subtest: fence-wait [517.316878] Starting dynamic subtest: rcs0 [518.371552] Dynamic subtest rcs0: SUCCESS (1.055s) [518.383241] Starting dynamic subtest: bcs0 [519.432263] Dynamic subtest bcs0: SUCCESS (1.060s) [519.442793] Starting dynamic subtest: vcs0 [520.476517] Dynamic subtest vcs0: SUCCESS (1.043s) [520.487462] Starting dynamic subtest: vcs1 [521.518280] Dynamic subtest vcs1: SUCCESS (1.041s) [521.529843] Starting dynamic subtest: vecs0 [522.562260] Dynamic subtest vecs0: SUCCESS (1.041s) [522.572709] Starting dynamic subtest: ccs0 [523.602054] Dynamic subtest ccs0: SUCCESS (1.039s) [523.604915] Subtest fence-wait: SUCCESS (6.288s) [523.739330] [076/133] (501s left) gem_exec_flush (basic-wb-set-default) [523.810249] Starting subtest: basic-wb-set-default [529.265789] Subtest basic-wb-set-default: SUCCESS (5.456s) [529.464836] [077/133] (495s left) gem_softpin (invalid) [529.522187] Starting subtest: invalid [529.532030] Subtest invalid: SUCCESS (0.010s) [529.649596] [078/133] (495s left) kms_psr (pr-primary-blt) [529.740424] Starting subtest: pr-primary-blt [529.744888] Subtest pr-primary-blt: SKIP (0.000s) [529.809958] [079/133] (495s left) gem_render_tiled_blits (basic) [529.886541] Subtest basic: SKIP (0.000s) [529.969528] [080/133] (495s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render) [530.070874] Starting subtest: fbc-rgb565-draw-render [534.170879] Subtest fbc-rgb565-draw-render: SUCCESS (4.104s) [535.333322] [081/133] (490s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled) [535.384992] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled [535.387146] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s) [535.488750] [082/133] (489s left) kms_concurrent (multi-plane-atomic-lowres) [535.583631] Starting subtest: multi-plane-atomic-lowres [535.585451] Starting dynamic subtest: pipe-A-eDP-1 [536.103244] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.519s) [536.112611] Starting dynamic subtest: pipe-B-eDP-1 [537.353704] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.249s) [537.363965] Starting dynamic subtest: pipe-C-eDP-1 [538.601144] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.244s) [538.610967] Starting dynamic subtest: pipe-D-eDP-1 [539.833323] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.231s) [539.835526] Subtest multi-plane-atomic-lowres: SUCCESS (4.249s) [540.674995] [083/133] (484s left) gem_mmap_gtt (big-copy) [540.731166] Subtest big-copy: SKIP (0.000s) [540.792075] [084/133] (484s left) gem_ctx_shared (q-smoketest) [540.851944] Starting subtest: Q-smoketest [540.854305] Starting dynamic subtest: rcs0 [546.409445] Dynamic subtest rcs0: SUCCESS (5.511s) [546.421534] Starting dynamic subtest: bcs0 [551.911371] Dynamic subtest bcs0: SUCCESS (5.500s) [551.922293] Starting dynamic subtest: vcs0 [557.387104] Dynamic subtest vcs0: SUCCESS (5.477s) [557.403009] Starting dynamic subtest: vcs1 [562.864706] Dynamic subtest vcs1: SUCCESS (5.475s) [562.877696] Starting dynamic subtest: vecs0 [568.351802] Dynamic subtest vecs0: SUCCESS (5.487s) [568.362086] Starting dynamic subtest: ccs0 [573.848450] Dynamic subtest ccs0: SUCCESS (5.492s) [573.850787] Subtest Q-smoketest: SUCCESS (32.951s) [573.989126] [085/133] (451s left) kms_getfb (getfb-handle-valid) [574.089390] Starting subtest: getfb-handle-valid [574.091715] Subtest getfb-handle-valid: SUCCESS (0.000s) [574.194424] [086/133] (451s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted) [574.248394] Starting subtest: multi-wait-all-for-submit-available-submitted [574.250553] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s) [574.359120] [087/133] (451s left) kms_big_fb (y-tiled-8bpp-rotate-270) [574.457848] Starting subtest: y-tiled-8bpp-rotate-270 [574.462042] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s) [574.540748] [088/133] (451s left) gem_pxp (hw-rejects-pxp-context) [574.660723] Starting subtest: hw-rejects-pxp-context [574.665230] Subtest hw-rejects-pxp-context: SKIP (0.000s) [574.770710] [089/133] (450s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size) [574.880804] Starting subtest: basic-busy-flip-before-cursor-varying-size [574.884428] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s) [575.037470] [090/133] (450s left) sw_sync (alloc_fence_invalid_timeline) [575.077590] Starting subtest: alloc_fence_invalid_timeline [575.079352] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s) [575.136796] [091/133] (450s left) gem_exec_fence (basic-wait) [575.312825] Starting subtest: basic-wait [575.315402] Starting dynamic subtest: rcs0 [575.408515] Dynamic subtest rcs0: SUCCESS (0.095s) [575.420168] Starting dynamic subtest: bcs0 [575.461395] Dynamic subtest bcs0: SUCCESS (0.050s) [575.472009] Starting dynamic subtest: vcs0 [575.515523] Dynamic subtest vcs0: SUCCESS (0.052s) [575.526112] Starting dynamic subtest: vcs1 [575.570926] Dynamic subtest vcs1: SUCCESS (0.053s) [575.581608] Starting dynamic subtest: vecs0 [575.633056] Dynamic subtest vecs0: SUCCESS (0.060s) [575.644168] Starting dynamic subtest: ccs0 [575.693974] Dynamic subtest ccs0: SUCCESS (0.059s) [575.696454] Subtest basic-wait: SUCCESS (0.383s) [577.506376] [092/133] (448s left) kms_sequence (get-idle) [577.600842] Starting subtest: get-idle [577.603173] Starting dynamic subtest: pipe-A-eDP-1 [579.414957] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.811s) [579.424549] Starting dynamic subtest: pipe-B-eDP-1 [581.915351] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.501s) [581.925230] Starting dynamic subtest: pipe-C-eDP-1 [584.340683] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.423s) [584.351066] Starting dynamic subtest: pipe-D-eDP-1 [586.764869] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.423s) [586.767246] Subtest get-idle: SUCCESS (9.163s) [587.576579] [093/133] (438s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt) [587.668995] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt [594.922425] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.257s) [595.055199] [094/133] (430s left) gem_ctx_persistence (engines-hang) [595.112504] Starting subtest: engines-hang [595.114419] Starting dynamic subtest: rcs0 [595.176288] Dynamic subtest rcs0: SUCCESS (0.066s) [595.189259] Starting dynamic subtest: bcs0 [595.272344] Dynamic subtest bcs0: SUCCESS (0.094s) [595.284704] Starting dynamic subtest: vcs0 [595.373516] Dynamic subtest vcs0: SUCCESS (0.099s) [595.385294] Starting dynamic subtest: vcs1 [595.474337] Dynamic subtest vcs1: SUCCESS (0.099s) [595.486195] Starting dynamic subtest: vecs0 [595.576382] Dynamic subtest vecs0: SUCCESS (0.100s) [595.588182] Starting dynamic subtest: ccs0 [595.687451] Dynamic subtest ccs0: SUCCESS (0.109s) [595.690313] Subtest engines-hang: SUCCESS (0.579s) [595.766878] [095/133] (430s left) gem_mmap (bad-size) [595.827538] Subtest bad-size: SKIP (0.000s) [595.887661] [096/133] (430s left) perf_pmu (module-unload) [595.984704] Starting subtest: module-unload [614.853368] Killing the test because the kernel is tainted. [615.438321] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 2296 [max: 8192] dynamic-keys: 318 direct dependencies: 26040 [max: 524288] indirect dependencies: 189064 all direct dependencies: 532182 dependency chains: 37124 [max: 524288] dependency chain hlocks used: 155664 [max: 2621440] dependency chain hlocks lost: 0 in-hardirq chains: 242 in-softirq chains: 799 in-process chains: 36083 stack-trace entries: 346762 [max: 524288] number of stack traces: 15095 number of stack hash chains: 9892 combined max dependencies: 2719762304 hardirq-safe locks: 113 hardirq-unsafe locks: 1339 softirq-safe locks: 242 softirq-unsafe locks: 1232 irq-safe locks: 265 irq-unsafe locks: 1339 hardirq-read-safe locks: 4 hardirq-read-unsafe locks: 467 softirq-read-safe locks: 9 softirq-read-unsafe locks: 464 irq-read-safe locks: 9 irq-read-unsafe locks: 467 uncategorized locks: 382 unused locks: 1 max locking depth: 16 max bfs queue depth: 546 max lock class index: 2476 debug_locks: 0 zapped classes: 329 zapped lock chains: 12021 large chain blocks: 1 [615.446417] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [615.446463] [FACT perf_pmu (module-unload)] new: kernel.is_tainted.taint_die: true [615.446464] [FACT perf_pmu (module-unload)] new: kernel.is_tainted.taint_warn: true [615.447072] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true [615.447157] Closing watchdogs results: parsing output: 0/ for test: gem_exec_reloc results: parsing output: 1/ for test: kms_plane results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: kms_cursor_legacy results: parsing output: 4/ for test: kms_frontbuffer_tracking results: parsing output: 5/ for test: kms_ccs results: parsing output: 6/ for test: syncobj_wait results: parsing output: 7/ for test: kms_psr2_sf results: parsing output: 8/ for test: perf results: parsing output: 9/ for test: kms_psr2_sf results: parsing output: 10/ for test: syncobj_timeline results: parsing output: 11/ for test: kms_cursor_crc results: parsing output: 12/ for test: kms_pipe_crc_basic results: parsing output: 13/ for test: perf results: parsing output: 14/ for test: gem_exec_reloc results: parsing output: 15/ for test: sw_sync results: parsing output: 16/ for test: kms_chamelium_color results: parsing output: 17/ for test: kms_cursor_legacy results: parsing output: 18/ for test: kms_flip results: parsing output: 19/ for test: gem_exec_fence results: parsing output: 20/ for test: kms_cursor_legacy results: parsing output: 21/ for test: kms_big_fb results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: syncobj_timeline results: parsing output: 24/ for test: kms_flip_scaled_crc results: parsing output: 25/ for test: syncobj_timeline results: parsing output: 26/ for test: kms_frontbuffer_tracking results: parsing output: 27/ for test: vgem_basic results: parsing output: 28/ for test: kms_flip results: parsing output: 29/ for test: gem_exec_suspend results: parsing output: 30/ for test: i915_hangman results: parsing output: 31/ for test: kms_frontbuffer_tracking results: parsing output: 32/ for test: kms_psr results: parsing output: 33/ for test: kms_frontbuffer_tracking results: parsing output: 34/ for test: kms_big_fb results: parsing output: 35/ for test: kms_plane results: parsing output: 36/ for test: kms_atomic results: parsing output: 37/ for test: kms_pm_backlight results: parsing output: 38/ for test: gem_close_race results: parsing output: 39/ for test: api_intel_allocator results: parsing output: 40/ for test: kms_frontbuffer_tracking results: parsing output: 41/ for test: kms_lease results: parsing output: 42/ for test: kms_big_fb results: parsing output: 43/ for test: kms_big_fb results: parsing output: 44/ for test: kms_rotation_crc results: parsing output: 45/ for test: gem_exec_balancer results: parsing output: 46/ for test: kms_frontbuffer_tracking results: parsing output: 47/ for test: kms_frontbuffer_tracking results: parsing output: 48/ for test: kms_vblank results: parsing output: 49/ for test: syncobj_timeline results: parsing output: 50/ for test: kms_frontbuffer_tracking results: parsing output: 51/ for test: kms_cursor_legacy results: parsing output: 52/ for test: gem_pread results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: gem_userptr_blits results: parsing output: 55/ for test: gem_eio results: parsing output: 56/ for test: kms_addfb_basic results: parsing output: 57/ for test: gem_exec_schedule results: parsing output: 58/ for test: drm_buddy results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: kms_getfb results: parsing output: 61/ for test: gem_ppgtt results: parsing output: 62/ for test: kms_frontbuffer_tracking results: parsing output: 63/ for test: kms_cursor_crc results: parsing output: 64/ for test: kms_dsc results: parsing output: 65/ for test: i915_pm_rpm results: parsing output: 66/ for test: kms_joiner results: parsing output: 67/ for test: kms_cursor_legacy results: parsing output: 68/ for test: kms_psr results: parsing output: 69/ for test: gem_softpin results: parsing output: 70/ for test: kms_big_fb results: parsing output: 71/ for test: kms_prime results: parsing output: 72/ for test: kms_panel_fitting results: parsing output: 73/ for test: kms_psr2_sf results: parsing output: 74/ for test: prime_vgem results: parsing output: 75/ for test: gem_exec_flush results: parsing output: 76/ for test: gem_softpin results: parsing output: 77/ for test: kms_psr results: parsing output: 78/ for test: gem_render_tiled_blits results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: syncobj_timeline results: parsing output: 81/ for test: kms_concurrent results: parsing output: 82/ for test: gem_mmap_gtt results: parsing output: 83/ for test: gem_ctx_shared results: parsing output: 84/ for test: kms_getfb results: parsing output: 85/ for test: syncobj_timeline results: parsing output: 86/ for test: kms_big_fb results: parsing output: 87/ for test: gem_pxp results: parsing output: 88/ for test: kms_cursor_legacy results: parsing output: 89/ for test: sw_sync results: parsing output: 90/ for test: gem_exec_fence results: parsing output: 91/ for test: kms_sequence results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: gem_ctx_persistence results: parsing output: 94/ for test: gem_mmap results: parsing output: 95/ for test: perf_pmu results: parsing output: 96/ for test: kms_color results: no output, setting notrun results: parsing output: 97/ for test: gem_exec_whisper results: no output, setting notrun results: parsing output: 98/ for test: kms_cursor_legacy results: no output, setting notrun results: parsing output: 99/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 100/ for test: gem_ppgtt results: no output, setting notrun results: parsing output: 101/ for test: i915_suspend results: no output, setting notrun results: parsing output: 102/ for test: syncobj_wait results: no output, setting notrun results: parsing output: 103/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 104/ for test: gem_exec_whisper results: no output, setting notrun results: parsing output: 105/ for test: kms_psr results: no output, setting notrun results: parsing output: 106/ for test: kms_plane_lowres results: no output, setting notrun results: parsing output: 107/ for test: gem_tiled_pread_basic results: no output, setting notrun results: parsing output: 108/ for test: kms_big_fb results: no output, setting notrun results: parsing output: 109/ for test: gem_reg_read results: no output, setting notrun results: parsing output: 110/ for test: gen9_exec_parse 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: gem_exec_schedule results: no output, setting notrun results: parsing output: 113/ for test: gem_exec_reloc results: no output, setting notrun results: parsing output: 114/ for test: kms_chamelium_hpd results: no output, setting notrun results: parsing output: 115/ for test: kms_ccs results: no output, setting notrun results: parsing output: 116/ for test: gem_ccs results: no output, setting notrun results: parsing output: 117/ for test: gem_mmap_wc results: no output, setting notrun results: parsing output: 118/ for test: kms_cursor_crc results: no output, setting notrun results: parsing output: 119/ for test: i915_drm_fdinfo results: no output, setting notrun results: parsing output: 120/ for test: gem_ctx_persistence results: no output, setting notrun results: parsing output: 121/ for test: kms_fbcon_fbt results: no output, setting notrun results: parsing output: 122/ for test: kms_chamelium_edid results: no output, setting notrun results: parsing output: 123/ for test: kms_rotation_crc results: no output, setting notrun results: parsing output: 124/ for test: kms_plane_scaling results: no output, setting notrun results: parsing output: 125/ for test: kms_ccs results: no output, setting notrun results: parsing output: 126/ for test: api_intel_bb results: no output, setting notrun results: parsing output: 127/ for test: kms_ccs results: no output, setting notrun results: parsing output: 128/ for test: gem_exec_fence results: no output, setting notrun results: parsing output: 129/ for test: gem_render_copy results: no output, setting notrun results: parsing output: 130/ for test: gem_partial_pwrite_pread results: no output, setting notrun results: parsing output: 131/ for test: kms_flip_scaled_crc results: no output, setting notrun results: parsing output: 132/ for test: gem_mmap_offset results: no output, setting notrun Done.