[64.011137] Initializing watchdogs [64.011278] /dev/watchdog0 [64.026679] [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] [64.031151] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [64.033333] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [64.036810] [001/133] (960s left) gem_exec_reloc (basic-gtt-cpu-noreloc) [64.116532] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s) [64.176100] [002/133] (960s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier) [64.282956] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier [64.287508] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier: SKIP (0.000s) [64.364152] [003/133] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu) [64.466446] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu [64.472500] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [64.561866] [004/133] (960s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions) [64.684250] Starting subtest: short-flip-before-cursor-atomic-transitions [65.695506] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (1.010s) [66.560907] [005/133] (958s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render) [66.671264] Starting subtest: fbc-rgb101010-draw-render [71.271719] Subtest fbc-rgb101010-draw-render: SUCCESS (4.609s) [72.476988] [006/133] (952s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc) [72.589944] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc [72.592327] Starting dynamic subtest: pipe-A-eDP-1 [72.613370] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [72.621952] Starting dynamic subtest: pipe-B-eDP-1 [72.641715] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [72.648494] Starting dynamic subtest: pipe-C-eDP-1 [72.668019] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [72.674591] Starting dynamic subtest: pipe-D-eDP-1 [72.694255] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [72.696108] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.004s) [74.831840] [007/133] (949s left) syncobj_wait (wait-for-submit-delayed-submit) [74.902674] Starting subtest: wait-for-submit-delayed-submit [75.005777] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s) [75.089445] [008/133] (949s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf) [75.181082] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf [75.185681] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s) [75.256799] [009/133] (949s left) perf (low-oa-exponent-permissions) [75.370353] Starting subtest: low-oa-exponent-permissions [75.401476] Subtest low-oa-exponent-permissions: SUCCESS (0.032s) [75.443878] [010/133] (949s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area) [75.555287] Starting subtest: fbc-psr2-plane-move-sf-dmg-area [75.557645] Starting dynamic subtest: pipe-A-eDP-1 [75.641891] Dynamic subtest pipe-A-eDP-1: SKIP (0.089s) [75.648836] Starting dynamic subtest: pipe-B-eDP-1 [76.793870] Dynamic subtest pipe-B-eDP-1: SKIP (1.150s) [76.798229] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.242s) [77.968902] [011/133] (946s left) syncobj_timeline (wait-any-snapshot) [78.022906] Starting subtest: wait-any-snapshot [78.104081] Subtest wait-any-snapshot: SUCCESS (0.082s) [78.174386] [012/133] (946s left) kms_cursor_crc (cursor-size-change) [78.268702] Starting subtest: cursor-size-change [78.270793] Starting dynamic subtest: pipe-A-eDP-1 [79.046574] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.776s) [79.055305] Starting dynamic subtest: pipe-D-eDP-1 [80.517166] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.471s) [80.519458] Subtest cursor-size-change: SUCCESS (2.249s) [81.342494] [013/133] (943s left) kms_pipe_crc_basic (suspend-read-crc) [81.441734] Starting subtest: suspend-read-crc [81.443626] Starting dynamic subtest: pipe-A-eDP-1 [99.164039] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.637s) [99.173809] Starting dynamic subtest: pipe-B-eDP-1 [117.147375] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.177s) [117.156597] Starting dynamic subtest: pipe-C-eDP-1 [135.139336] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.151s) [135.147603] Starting dynamic subtest: pipe-D-eDP-1 [153.099911] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.094s) [153.102310] Subtest suspend-read-crc: SUCCESS (12.063s) [153.919235] [014/133] (871s left) perf (gen12-mi-rpc) [154.000591] Starting subtest: gen12-mi-rpc [154.003041] Starting dynamic subtest: rcs0 [154.019577] Dynamic subtest rcs0: SUCCESS (0.019s) [154.022221] Subtest gen12-mi-rpc: SUCCESS (0.020s) [154.063882] [015/133] (870s left) gem_exec_reloc (basic-cpu-wc-active) [154.160232] Subtest basic-cpu-wc-active: SKIP (0.000s) [154.233284] [016/133] (870s left) sw_sync (timeline_closed_signaled) [154.266132] Starting subtest: timeline_closed_signaled [154.268478] Subtest timeline_closed_signaled: SUCCESS (0.000s) [154.329935] [017/133] (870s left) kms_chamelium_color (ctm-negative) [154.422647] Subtest ctm-negative: SKIP (0.000s) [154.463680] [018/133] (870s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle) [154.574615] Starting subtest: short-busy-flip-before-cursor-toggle [154.579031] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s) [154.749001] [019/133] (870s left) kms_flip (2x-absolute-wf_vblank-interruptible) [154.841034] Starting subtest: 2x-absolute-wf_vblank-interruptible [154.851251] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.010s) [154.922138] [020/133] (870s left) gem_exec_fence (syncobj-timeline-wait) [155.467463] Starting subtest: syncobj-timeline-wait [156.705711] Subtest syncobj-timeline-wait: SUCCESS (1.254s) [156.914403] [FACT gem_exec_fence (syncobj-timeline-wait)] new: kernel.kmod_is_loaded.vgem: true [156.918958] [021/133] (868s left) kms_cursor_legacy (short-flip-before-cursor-toggle) [157.039616] Starting subtest: short-flip-before-cursor-toggle [157.947332] Subtest short-flip-before-cursor-toggle: SUCCESS (0.916s) [158.785474] [022/133] (866s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180) [158.884713] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180 [158.888778] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s) [158.969865] [023/133] (866s left) kms_frontbuffer_tracking (psr-modesetfrombusy) [159.076267] Starting subtest: psr-modesetfrombusy [165.210252] Subtest psr-modesetfrombusy: SUCCESS (6.175s) [165.336445] [024/133] (860s left) syncobj_timeline (single-wait-all-for-submit-available-signaled) [165.394837] Starting subtest: single-wait-all-for-submit-available-signaled [165.396910] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s) [165.481510] [025/133] (859s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling) [165.581155] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling [165.584671] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s) [165.666439] [026/133] (859s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted) [165.719214] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted [165.721184] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s) [165.829800] [027/133] (859s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt) [165.915252] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt [165.918981] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [165.998376] [028/133] (859s left) vgem_basic (create) [166.040642] Starting subtest: create [166.042303] Subtest create: SUCCESS (0.000s) [166.097477] [029/133] (859s left) kms_flip (flip-vs-panning-vs-hang) [166.183203] Starting subtest: flip-vs-panning-vs-hang [166.185092] Starting dynamic subtest: A-eDP1 [217.130940] Dynamic subtest A-eDP1: SUCCESS (50.971s) [217.140097] Starting dynamic subtest: D-eDP1 [267.119489] Dynamic subtest D-eDP1: SUCCESS (49.989s) [267.125026] Subtest flip-vs-panning-vs-hang: SUCCESS (100.966s) [268.368327] [030/133] (757s left) gem_exec_suspend (basic-s3-devices) [268.432489] Starting subtest: basic-S3-devices [268.434901] Starting dynamic subtest: smem [279.683698] Dynamic subtest smem: SUCCESS (11.248s) [279.686927] Subtest basic-S3-devices: SUCCESS (11.250s) [279.867164] [031/133] (745s left) i915_hangman (detector) [279.956497] Starting subtest: detector [279.958703] Starting dynamic subtest: rcs0 [291.617815] Dynamic subtest rcs0: SUCCESS (11.661s) [291.628405] Starting dynamic subtest: bcs0 [303.648596] Dynamic subtest bcs0: SUCCESS (12.030s) [303.660252] Starting dynamic subtest: vcs0 [315.552622] Dynamic subtest vcs0: SUCCESS (11.903s) [315.563806] Starting dynamic subtest: vcs1 [325.602394] Dynamic subtest vcs1: SUCCESS (10.049s) [325.613152] Starting dynamic subtest: vecs0 [337.569725] Dynamic subtest vecs0: SUCCESS (11.967s) [337.581394] Starting dynamic subtest: ccs0 [349.601124] Dynamic subtest ccs0: SUCCESS (12.031s) [349.603830] Subtest detector: SUCCESS (69.653s) [349.733266] [032/133] (675s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary) [349.838275] Starting subtest: fbcpsr-indfb-scaledprimary [355.906473] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (6.070s) [356.019028] [033/133] (669s left) kms_psr (fbc-psr-cursor-mmap-gtt) [356.110492] Starting subtest: fbc-psr-cursor-mmap-gtt [356.112745] Starting dynamic subtest: eDP-1 [356.116804] Dynamic subtest eDP-1: SKIP (0.000s) [356.120994] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s) [356.187128] [034/133] (669s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt) [356.291807] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt [356.295908] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [356.379948] [035/133] (669s left) kms_big_fb (4-tiled-addfb-size-offset-overflow) [356.477311] Starting subtest: 4-tiled-addfb-size-offset-overflow [356.479568] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s) [356.587717] [036/133] (669s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping) [356.684720] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping [356.688773] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (0.000s) [356.768044] [037/133] (669s left) kms_atomic (plane-cursor-legacy) [356.856704] Starting subtest: plane-cursor-legacy [356.858660] Starting dynamic subtest: pipe-A-eDP-1 [357.228545] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.369s) [357.230793] Subtest plane-cursor-legacy: SUCCESS (0.371s) [358.082634] [038/133] (667s left) kms_pm_backlight (brightness-with-dpms) [358.184890] Starting subtest: brightness-with-dpms [358.231838] Starting dynamic subtest: eDP-1 [360.673839] Dynamic subtest eDP-1: SUCCESS (2.440s) [360.676449] Subtest brightness-with-dpms: SUCCESS (2.490s) [361.539500] [039/133] (664s left) gem_close_race (multigpu-basic-threads) [361.600591] Starting subtest: multigpu-basic-threads [361.605166] Subtest multigpu-basic-threads: SKIP (0.000s) [361.829981] [040/133] (664s left) api_intel_allocator (simple-allocator) [361.887178] Starting subtest: simple-allocator [361.889209] Starting dynamic subtest: basic [361.891613] Dynamic subtest basic: SUCCESS (0.004s) [361.903121] Starting dynamic subtest: parallel-one [362.079600] Dynamic subtest parallel-one: SUCCESS (0.188s) [362.090209] Starting dynamic subtest: print [362.092389] Dynamic subtest print: SUCCESS (0.000s) [362.100306] Starting dynamic subtest: reuse [362.102184] Dynamic subtest reuse: SUCCESS (0.000s) [362.109584] Starting dynamic subtest: reserve [362.111424] Dynamic subtest reserve: SUCCESS (0.000s) [362.119454] Starting dynamic subtest: fork-reopen-allocator [362.121349] Dynamic subtest fork-reopen-allocator: SUCCESS (0.011s) [362.123244] Subtest simple-allocator: SUCCESS (0.209s) [362.220883] [041/133] (663s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu) [362.315174] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu [362.319472] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [362.417605] [042/133] (663s left) kms_lease (possible-crtcs-filtering) [362.501776] Starting subtest: possible-crtcs-filtering [362.506511] Subtest possible-crtcs-filtering: SUCCESS (0.005s) [362.612956] [043/133] (663s left) kms_big_fb (yf-tiled-16bpp-rotate-270) [362.717307] Starting subtest: yf-tiled-16bpp-rotate-270 [362.721386] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s) [362.820410] [044/133] (663s left) kms_big_fb (x-tiled-addfb) [362.921197] Starting subtest: x-tiled-addfb [362.923348] Subtest x-tiled-addfb: SUCCESS (0.000s) [363.019081] [045/133] (663s left) kms_rotation_crc (primary-4-tiled-reflect-x-180) [363.103495] Starting subtest: primary-4-tiled-reflect-x-180 [370.095601] Subtest primary-4-tiled-reflect-x-180: SUCCESS (6.992s) [371.302449] [046/133] (655s left) gem_exec_balancer (parallel) [371.575449] Starting subtest: parallel [372.472065] Subtest parallel: SUCCESS (0.897s) [373.688141] [047/133] (652s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render) [373.804490] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render [373.808486] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [373.920650] [048/133] (652s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render) [374.027287] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render [374.031789] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [374.112039] [049/133] (652s left) kms_vblank (ts-continuation-idle-hang) [374.209715] Starting subtest: ts-continuation-idle-hang [374.212013] Starting dynamic subtest: pipe-A-eDP-1 [401.412586] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.206s) [401.427928] Starting dynamic subtest: pipe-D-eDP-1 [416.457800] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.047s) [416.460111] Subtest ts-continuation-idle-hang: SUCCESS (42.257s) [417.275808] [050/133] (609s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted) [417.334415] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted [417.439055] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.104s) [417.519561] [051/133] (608s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render) [417.623115] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render [417.627069] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [417.716891] [052/133] (608s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy) [417.834821] Starting subtest: flip-vs-cursor-busy-crc-legacy [418.653565] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.819s) [419.478260] [053/133] (607s left) gem_pread (display) [419.542184] Subtest display: SKIP (0.000s) [419.598893] [054/133] (607s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt) [419.704108] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt [419.708347] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [419.791991] [055/133] (606s left) gem_userptr_blits (dmabuf-unsync) [419.863646] Subtest dmabuf-unsync: SKIP (0.000s) [419.995539] [056/133] (606s left) gem_eio (unwedge-stress) [420.213748] Starting subtest: unwedge-stress [420.216219] Starting dynamic subtest: render [424.637623] Dynamic subtest render: SUCCESS (4.422s) [424.653118] Starting dynamic subtest: bsd1 [443.119699] Dynamic subtest bsd1: SUCCESS (18.485s) [443.135497] Starting dynamic subtest: bsd2 [461.119150] Dynamic subtest bsd2: SUCCESS (18.001s) [461.133276] Starting dynamic subtest: blt [461.137339] Dynamic subtest blt: SKIP (0.000s) [461.145912] Starting dynamic subtest: vebox [479.083961] Dynamic subtest vebox: SUCCESS (17.965s) [479.086055] Subtest unwedge-stress: SUCCESS (58.877s) [480.682111] [057/133] (546s left) kms_addfb_basic (master-rmfb) [480.752267] Starting subtest: master-rmfb [480.754673] Subtest master-rmfb: SUCCESS (0.001s) [480.884179] [058/133] (545s left) gem_exec_schedule (preempt-user) [480.950115] Starting subtest: preempt-user [480.952370] Starting dynamic subtest: rcs0 [480.965396] Dynamic subtest rcs0: SUCCESS (0.024s) [480.976933] Starting dynamic subtest: bcs0 [480.989192] Dynamic subtest bcs0: SUCCESS (0.023s) [480.997892] Starting dynamic subtest: vcs0 [481.009869] Dynamic subtest vcs0: SUCCESS (0.020s) [481.026421] Starting dynamic subtest: vcs1 [481.032486] Dynamic subtest vcs1: SUCCESS (0.020s) [481.052281] Starting dynamic subtest: vecs0 [481.054838] Dynamic subtest vecs0: SUCCESS (0.022s) [481.075501] Starting dynamic subtest: ccs0 [481.078794] Dynamic subtest ccs0: SUCCESS (0.023s) [481.081351] Subtest preempt-user: SUCCESS (0.137s) [482.809209] [059/133] (544s left) drm_buddy (drm_buddy) [482.853964] Starting subtest: drm_buddy [482.858623] Subtest drm_buddy: SKIP (0.001s) [482.917971] [060/133] (543s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render) [483.009994] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render [487.130805] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.124s) [488.336252] [061/133] (538s left) kms_getfb (getfb2-accept-nv12) [488.440890] Starting subtest: getfb2-accept-nv12 [488.443199] Subtest getfb2-accept-nv12: SUCCESS (0.001s) [488.591344] [062/133] (538s left) gem_ppgtt (flink-and-close-vma-leak) [488.656043] Starting subtest: flink-and-close-vma-leak [488.695408] Subtest flink-and-close-vma-leak: SUCCESS (0.042s) [488.813251] [063/133] (538s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt) [488.917347] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt [488.921465] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [489.020991] [064/133] (538s left) kms_cursor_crc (cursor-offscreen-128x128) [489.242943] Starting subtest: cursor-offscreen-128x128 [489.244899] Starting dynamic subtest: pipe-A-eDP-1 [491.214675] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.967s) [491.240035] Starting dynamic subtest: pipe-D-eDP-1 [493.793244] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.558s) [493.795156] Subtest cursor-offscreen-128x128: SUCCESS (4.551s) [494.656182] [065/133] (532s left) kms_dsc (dsc-fractional-bpp) [494.745721] Starting subtest: dsc-fractional-bpp [494.758597] Subtest dsc-fractional-bpp: SKIP (0.000s) [494.817473] [066/133] (532s left) i915_pm_rpm (gem-pread) [496.760797] Starting subtest: gem-pread [498.821700] Subtest gem-pread: SUCCESS (2.063s) [498.906032] [067/133] (528s left) kms_joiner (basic-ultra-joiner) [499.005033] Starting subtest: basic-ultra-joiner [499.009055] Subtest basic-ultra-joiner: SKIP (0.000s) [499.070117] [068/133] (528s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy) [499.197087] Starting subtest: 2x-long-cursor-vs-flip-legacy [499.201536] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.001s) [499.344275] [069/133] (528s left) kms_psr (psr2-sprite-blt) [499.435820] Starting subtest: psr2-sprite-blt [499.438086] Starting dynamic subtest: eDP-1 [501.197817] Dynamic subtest eDP-1: SUCCESS (1.763s) [501.200142] Subtest psr2-sprite-blt: SUCCESS (1.765s) [502.065270] [070/133] (525s left) gem_softpin (evict-prime) [502.126922] Starting subtest: evict-prime [502.129237] Starting dynamic subtest: rcs0 [503.281810] Dynamic subtest rcs0: SUCCESS (1.154s) [503.292848] Starting dynamic subtest: bcs0 [504.407771] Dynamic subtest bcs0: SUCCESS (1.124s) [504.418796] Starting dynamic subtest: vcs0 [505.607041] Dynamic subtest vcs0: SUCCESS (1.196s) [505.618938] Starting dynamic subtest: vcs1 [507.656191] Dynamic subtest vcs1: SUCCESS (2.047s) [507.668568] Starting dynamic subtest: vecs0 [509.636162] Dynamic subtest vecs0: SUCCESS (1.978s) [509.651346] Starting dynamic subtest: ccs0 [510.763469] Dynamic subtest ccs0: SUCCESS (1.126s) [510.775247] Starting dynamic subtest: all [512.653520] Dynamic subtest all: SUCCESS (1.888s) [512.655758] Subtest evict-prime: SUCCESS (10.528s) [512.728187] [071/133] (514s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [512.830648] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [512.835028] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [512.915393] [072/133] (514s left) kms_prime (basic-modeset-hybrid) [513.008436] Subtest basic-modeset-hybrid: SKIP (0.000s) [513.108140] [073/133] (514s left) kms_panel_fitting (legacy) [513.197360] Starting subtest: legacy [513.199622] Starting dynamic subtest: pipe-A-eDP-1 [513.752485] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.558s) [513.780253] Starting dynamic subtest: pipe-B-eDP-1 [515.350838] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.578s) [515.378072] Starting dynamic subtest: pipe-C-eDP-1 [516.913808] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.542s) [516.939866] Starting dynamic subtest: pipe-D-eDP-1 [518.453677] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.520s) [518.455922] Subtest legacy: SUCCESS (5.259s) [519.671237] [074/133] (507s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area) [519.772053] Starting subtest: psr2-plane-move-sf-dmg-area [519.774378] Starting dynamic subtest: pipe-A-eDP-1 [524.324989] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.558s) [524.333833] Starting dynamic subtest: pipe-B-eDP-1 [529.637315] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.308s) [529.639628] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.869s) [530.514684] [075/133] (497s left) prime_vgem (fence-wait) [530.598033] Starting subtest: fence-wait [530.600300] Starting dynamic subtest: rcs0 [531.648551] Dynamic subtest rcs0: SUCCESS (1.049s) [531.659436] Starting dynamic subtest: bcs0 [532.723038] Dynamic subtest bcs0: SUCCESS (1.073s) [532.734394] Starting dynamic subtest: vcs0 [533.774803] Dynamic subtest vcs0: SUCCESS (1.051s) [533.785790] Starting dynamic subtest: vcs1 [534.823517] Dynamic subtest vcs1: SUCCESS (1.040s) [534.841290] Starting dynamic subtest: vecs0 [535.858800] Dynamic subtest vecs0: SUCCESS (1.042s) [535.870154] Starting dynamic subtest: ccs0 [536.904253] Dynamic subtest ccs0: SUCCESS (1.043s) [536.906835] Subtest fence-wait: SUCCESS (6.307s) [537.029923] [076/133] (490s left) gem_exec_flush (basic-wb-set-default) [537.116244] Starting subtest: basic-wb-set-default [542.569362] Subtest basic-wb-set-default: SUCCESS (5.454s) [542.762921] [077/133] (484s left) gem_softpin (invalid) [542.809473] Starting subtest: invalid [542.820478] Subtest invalid: SUCCESS (0.010s) [542.927654] [078/133] (484s left) kms_psr (pr-primary-blt) [543.028779] Starting subtest: pr-primary-blt [543.033064] Subtest pr-primary-blt: SKIP (0.000s) [543.121955] [079/133] (484s left) gem_render_tiled_blits (basic) [543.176200] Subtest basic: SKIP (0.000s) [543.234569] [080/133] (484s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render) [543.327680] Starting subtest: fbc-rgb565-draw-render [547.472463] Subtest fbc-rgb565-draw-render: SUCCESS (4.150s) [548.614117] [081/133] (479s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled) [548.680848] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled [548.683134] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s) [548.790715] [082/133] (479s left) kms_concurrent (multi-plane-atomic-lowres) [548.877876] Starting subtest: multi-plane-atomic-lowres [548.880209] Starting dynamic subtest: pipe-A-eDP-1 [549.383366] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.504s) [549.394089] Starting dynamic subtest: pipe-B-eDP-1 [550.650271] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.265s) [550.663448] Starting dynamic subtest: pipe-C-eDP-1 [551.871320] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.222s) [551.880711] Starting dynamic subtest: pipe-D-eDP-1 [553.095259] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.219s) [553.097644] Subtest multi-plane-atomic-lowres: SUCCESS (4.216s) [553.921245] [083/133] (474s left) gem_mmap_gtt (big-copy) [553.987298] Subtest big-copy: SKIP (0.000s) [554.040362] [084/133] (473s left) gem_ctx_shared (q-smoketest) [554.109417] Starting subtest: Q-smoketest [554.111755] Starting dynamic subtest: rcs0 [559.676531] Dynamic subtest rcs0: SUCCESS (5.523s) [559.688437] Starting dynamic subtest: bcs0 [565.191992] Dynamic subtest bcs0: SUCCESS (5.518s) [565.202238] Starting dynamic subtest: vcs0 [570.675387] Dynamic subtest vcs0: SUCCESS (5.480s) [570.685750] Starting dynamic subtest: vcs1 [576.151626] Dynamic subtest vcs1: SUCCESS (5.478s) [576.161972] Starting dynamic subtest: vecs0 [581.625137] Dynamic subtest vecs0: SUCCESS (5.473s) [581.635632] Starting dynamic subtest: ccs0 [587.091810] Dynamic subtest ccs0: SUCCESS (5.465s) [587.094029] Subtest Q-smoketest: SUCCESS (32.944s) [587.234432] [085/133] (440s left) kms_getfb (getfb-handle-valid) [587.335251] Starting subtest: getfb-handle-valid [587.337746] Subtest getfb-handle-valid: SUCCESS (0.000s) [587.467205] [086/133] (440s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted) [587.522506] Starting subtest: multi-wait-all-for-submit-available-submitted [587.524775] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s) [587.625383] [087/133] (440s left) kms_big_fb (y-tiled-8bpp-rotate-270) [587.728070] Starting subtest: y-tiled-8bpp-rotate-270 [587.732452] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s) [587.831504] [088/133] (440s left) gem_pxp (hw-rejects-pxp-context) [587.959683] Starting subtest: hw-rejects-pxp-context [587.964606] Subtest hw-rejects-pxp-context: SKIP (0.000s) [588.070458] [089/133] (440s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size) [588.181606] Starting subtest: basic-busy-flip-before-cursor-varying-size [588.185266] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s) [588.340245] [090/133] (439s left) sw_sync (alloc_fence_invalid_timeline) [588.377389] Starting subtest: alloc_fence_invalid_timeline [588.379229] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s) [588.438974] [091/133] (439s left) gem_exec_fence (basic-wait) [588.613778] Starting subtest: basic-wait [588.616506] Starting dynamic subtest: rcs0 [588.698636] Dynamic subtest rcs0: SUCCESS (0.084s) [588.710056] Starting dynamic subtest: bcs0 [588.766561] Dynamic subtest bcs0: SUCCESS (0.066s) [588.778054] Starting dynamic subtest: vcs0 [588.826874] Dynamic subtest vcs0: SUCCESS (0.059s) [588.837670] Starting dynamic subtest: vcs1 [588.891982] Dynamic subtest vcs1: SUCCESS (0.063s) [588.903284] Starting dynamic subtest: vecs0 [588.957095] Dynamic subtest vecs0: SUCCESS (0.063s) [588.967836] Starting dynamic subtest: ccs0 [589.014680] Dynamic subtest ccs0: SUCCESS (0.055s) [589.017279] Subtest basic-wait: SUCCESS (0.402s) [590.760761] [092/133] (437s left) kms_sequence (get-idle) [590.860748] Starting subtest: get-idle [590.863149] Starting dynamic subtest: pipe-A-eDP-1 [592.679113] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.819s) [592.688720] Starting dynamic subtest: pipe-B-eDP-1 [595.168743] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.489s) [595.179486] Starting dynamic subtest: pipe-C-eDP-1 [597.584896] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.416s) [597.594524] Starting dynamic subtest: pipe-D-eDP-1 [600.028827] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.441s) [600.031164] Subtest get-idle: SUCCESS (9.170s) [600.838754] [093/133] (427s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt) [600.934897] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt [608.301041] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.370s) [608.411686] [094/133] (419s left) gem_ctx_persistence (engines-hang) [608.488971] Starting subtest: engines-hang [608.490864] Starting dynamic subtest: rcs0 [608.558592] Dynamic subtest rcs0: SUCCESS (0.071s) [608.569251] Starting dynamic subtest: bcs0 [608.653425] Dynamic subtest bcs0: SUCCESS (0.093s) [608.664893] Starting dynamic subtest: vcs0 [608.746881] Dynamic subtest vcs0: SUCCESS (0.091s) [608.758209] Starting dynamic subtest: vcs1 [608.839486] Dynamic subtest vcs1: SUCCESS (0.090s) [608.849725] Starting dynamic subtest: vecs0 [608.943481] Dynamic subtest vecs0: SUCCESS (0.102s) [608.955713] Starting dynamic subtest: ccs0 [609.051575] Dynamic subtest ccs0: SUCCESS (0.106s) [609.054387] Subtest engines-hang: SUCCESS (0.567s) [609.131583] [095/133] (419s left) gem_mmap (bad-size) [609.187894] Subtest bad-size: SKIP (0.000s) [609.241630] [096/133] (419s left) perf_pmu (module-unload) [609.310845] Starting subtest: module-unload [627.828253] Killing the test because the kernel is tainted. [628.409874] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 2296 [max: 8192] dynamic-keys: 318 direct dependencies: 25800 [max: 524288] indirect dependencies: 191029 all direct dependencies: 535959 dependency chains: 36894 [max: 524288] dependency chain hlocks used: 154543 [max: 2621440] dependency chain hlocks lost: 0 in-hardirq chains: 248 in-softirq chains: 827 in-process chains: 35819 stack-trace entries: 343847 [max: 524288] number of stack traces: 14988 number of stack hash chains: 9809 combined max dependencies: 3090113744 hardirq-safe locks: 114 hardirq-unsafe locks: 1339 softirq-safe locks: 244 softirq-unsafe locks: 1232 irq-safe locks: 267 irq-unsafe locks: 1339 hardirq-read-safe locks: 4 hardirq-read-unsafe locks: 468 softirq-read-safe locks: 9 softirq-read-unsafe locks: 465 irq-read-safe locks: 9 irq-read-unsafe locks: 468 uncategorized locks: 380 unused locks: 1 max locking depth: 16 max bfs queue depth: 539 max lock class index: 2476 debug_locks: 0 zapped classes: 333 zapped lock chains: 11945 large chain blocks: 1 [628.417901] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [628.417944] [FACT perf_pmu (module-unload)] new: kernel.is_tainted.taint_die: true [628.417946] [FACT perf_pmu (module-unload)] new: kernel.is_tainted.taint_warn: true [628.418493] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true [628.418573] 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.