[41.246481] Initializing watchdogs [41.246570] /dev/watchdog0 [41.254789] [001/130] (960s left) gem_exec_reloc (basic-cpu-noreloc) [41.323360] Subtest basic-cpu-noreloc: SKIP (0.000s) [41.367934] [002/130] (960s left) gem_exec_schedule (u-submit-late-slice) [41.428733] Starting subtest: u-submit-late-slice [41.430976] Starting dynamic subtest: rcs0 [41.455768] Dynamic subtest rcs0: SUCCESS (0.036s) [41.463304] Starting dynamic subtest: bcs0 [41.475598] Dynamic subtest bcs0: SUCCESS (0.020s) [41.480700] Starting dynamic subtest: vcs0 [41.496210] Dynamic subtest vcs0: SUCCESS (0.020s) [41.501151] Starting dynamic subtest: vcs1 [41.520056] Dynamic subtest vcs1: SUCCESS (0.024s) [41.528903] Starting dynamic subtest: vecs0 [41.540014] Dynamic subtest vecs0: SUCCESS (0.020s) [41.545099] Starting dynamic subtest: ccs0 [41.561714] Dynamic subtest ccs0: SUCCESS (0.022s) [41.564136] Subtest u-submit-late-slice: SUCCESS (0.142s) [43.470140] [003/130] (958s left) kms_psr (psr-primary-render) [43.562246] Starting subtest: psr-primary-render [43.564711] Starting dynamic subtest: eDP-1 [45.328822] Dynamic subtest eDP-1: SUCCESS (1.766s) [45.331519] Subtest psr-primary-render: SUCCESS (1.766s) [46.245122] [004/130] (955s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation) [46.338849] Starting subtest: plane-upscale-factor-0-25-with-rotation [46.341334] Starting dynamic subtest: pipe-A [46.566156] Dynamic subtest pipe-A: SUCCESS (0.227s) [46.572916] Starting dynamic subtest: pipe-B [47.955803] Dynamic subtest pipe-B: SUCCESS (1.389s) [47.962484] Starting dynamic subtest: pipe-C [49.300167] Dynamic subtest pipe-C: SUCCESS (1.345s) [49.306576] Starting dynamic subtest: pipe-D [50.642879] Dynamic subtest pipe-D: SUCCESS (1.342s) [50.645593] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.304s) [51.876786] [005/130] (949s left) kms_vrr (max-min) [51.981839] Starting subtest: max-min [51.988891] Subtest max-min: SKIP (0.000s) [52.029763] [006/130] (949s left) gem_ctx_param (invalid-get-no-zeromap) [52.071049] Starting subtest: invalid-get-no-zeromap [52.073321] Subtest invalid-get-no-zeromap: SUCCESS (0.001s) [52.153709] [007/130] (949s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [52.249275] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip [52.828212] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.581s) [52.952244] [008/130] (948s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render) [53.049774] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render [53.054050] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [53.119657] [009/130] (948s left) kms_big_fb (yf-tiled-32bpp-rotate-0) [53.215894] Starting subtest: yf-tiled-32bpp-rotate-0 [53.219974] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s) [53.270914] [010/130] (948s left) api_intel_allocator (fork-simple-stress) [53.323169] Starting subtest: fork-simple-stress [58.709398] Subtest fork-simple-stress: SUCCESS (5.387s) [58.800907] [011/130] (943s left) gem_exec_fence (syncobj-repeat) [59.223574] Starting subtest: syncobj-repeat [59.323945] Subtest syncobj-repeat: SUCCESS (0.101s) [60.445156] [012/130] (941s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic) [60.552874] Starting subtest: 2x-flip-vs-cursor-atomic [60.557468] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s) [60.660338] [013/130] (941s left) i915_query (test-query-geometry-subslices) [60.697746] Starting subtest: test-query-geometry-subslices [60.700495] Subtest test-query-geometry-subslices: SUCCESS (0.000s) [60.761954] [014/130] (941s left) kms_properties (crtc-properties-atomic) [60.854078] Starting subtest: crtc-properties-atomic [60.856480] Starting dynamic subtest: pipe-A-eDP-1 [61.287737] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.433s) [61.294484] Starting dynamic subtest: pipe-B-eDP-1 [62.527353] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.238s) [62.535992] Starting dynamic subtest: pipe-C-eDP-1 [63.732977] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.205s) [63.743204] Starting dynamic subtest: pipe-D-eDP-1 [64.952378] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.217s) [64.954934] Subtest crtc-properties-atomic: SUCCESS (4.096s) [65.828166] [015/130] (936s left) gem_exec_reloc (basic-gtt) [65.884884] Subtest basic-gtt: SKIP (0.000s) [65.923504] [016/130] (936s left) gem_fence_thrash (bo-write-verify-threaded-y) [65.946319] Starting subtest: bo-write-verify-threaded-y [65.971587] Subtest bo-write-verify-threaded-y: SKIP (0.020s) [65.998838] [017/130] (935s left) kms_psr (pr-primary-mmap-gtt) [66.086529] Starting subtest: pr-primary-mmap-gtt [66.090491] Subtest pr-primary-mmap-gtt: SKIP (0.000s) [66.134126] [018/130] (935s left) kms_plane_alpha_blend (constant-alpha-mid) [66.228672] Starting subtest: constant-alpha-mid [66.504151] Starting dynamic subtest: pipe-A-eDP-1 [67.282691] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.777s) [67.288439] Starting dynamic subtest: pipe-D-eDP-1 [68.835089] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.553s) [68.837383] Subtest constant-alpha-mid: SUCCESS (2.605s) [69.733951] [019/130] (932s left) kms_pm_rpm (modeset-stress-extra-wait) [71.562626] Starting subtest: modeset-stress-extra-wait [125.691295] Subtest modeset-stress-extra-wait: SUCCESS (54.125s) [125.754847] [020/130] (876s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt) [125.852301] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt [128.975123] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (3.127s) [129.098828] [021/130] (872s left) kms_cursor_edge_walk (128x128-left-edge) [129.181392] Starting subtest: 128x128-left-edge [129.183291] Starting dynamic subtest: pipe-A-eDP-1 [132.701389] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.518s) [132.708507] Starting dynamic subtest: pipe-D-eDP-1 [135.943956] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.239s) [135.946215] Subtest 128x128-left-edge: SUCCESS (6.759s) [136.806825] [022/130] (865s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-render) [136.905481] Starting subtest: psr-1p-offscren-pri-shrfb-draw-render [141.455441] Subtest psr-1p-offscren-pri-shrfb-draw-render: SUCCESS (4.553s) [141.555927] [023/130] (860s left) gem_create (create-ext-placement-all) [141.714195] Starting subtest: create-ext-placement-all [141.717421] Subtest create-ext-placement-all: SUCCESS (0.000s) [141.803812] [024/130] (860s left) gem_pxp (display-protected-crc) [144.383867] Subtest display-protected-crc: SKIP (0.000s) [144.424137] [025/130] (857s left) debugfs_test (read_all_entries_display_on) [144.522691] Starting subtest: read_all_entries_display_on [144.793079] Subtest read_all_entries_display_on: SUCCESS (0.269s) [144.902083] [026/130] (857s left) vgem_basic (sysfs) [144.935322] Starting subtest: sysfs [144.937824] Subtest sysfs: SUCCESS (0.000s) [144.969951] [027/130] (857s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move) [145.068273] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move [145.073172] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [145.136255] [028/130] (856s left) kms_color (ctm-red-to-blue) [145.221163] Starting subtest: ctm-red-to-blue [145.223681] Starting dynamic subtest: pipe-A-eDP-1 [145.874031] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.652s) [145.881970] Starting dynamic subtest: pipe-B-eDP-1 [147.339051] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.465s) [147.345670] Starting dynamic subtest: pipe-C-eDP-1 [148.689293] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.349s) [148.697624] Starting dynamic subtest: pipe-D-eDP-1 [150.107513] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.418s) [150.109447] Subtest ctm-red-to-blue: SUCCESS (4.884s) [151.014156] [029/130] (851s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf) [156.140857] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf [156.144613] Starting dynamic subtest: pipe-A-eDP-1 [168.233236] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.091s) [168.243918] Starting dynamic subtest: pipe-B-eDP-1 [180.351046] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.117s) [180.353812] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (24.210s) [181.219368] [030/130] (820s left) gem_exec_whisper (basic-queues-priority-all) [181.278355] Starting subtest: basic-queues-priority-all [202.593649] Subtest basic-queues-priority-all: SUCCESS (21.313s) [202.752808] [031/130] (799s left) api_intel_bb (simple-bb-ctx) [202.800275] Starting subtest: simple-bb-ctx [202.804962] Subtest simple-bb-ctx: SUCCESS (0.007s) [202.916892] [032/130] (799s left) gem_spin_batch (resubmit) [202.972419] Starting subtest: resubmit [202.975560] Starting dynamic subtest: rcs0 [202.978191] Dynamic subtest rcs0: SUCCESS (0.005s) [202.985698] Starting dynamic subtest: bcs0 [202.988306] Dynamic subtest bcs0: SUCCESS (0.002s) [202.994465] Starting dynamic subtest: vcs0 [202.996603] Dynamic subtest vcs0: SUCCESS (0.002s) [203.002252] Starting dynamic subtest: vcs1 [203.004603] Dynamic subtest vcs1: SUCCESS (0.003s) [203.010306] Starting dynamic subtest: vecs0 [203.013103] Dynamic subtest vecs0: SUCCESS (0.003s) [203.019233] Starting dynamic subtest: ccs0 [203.021743] Dynamic subtest ccs0: SUCCESS (0.004s) [203.023905] Subtest resubmit: SUCCESS (0.021s) [203.207977] [033/130] (798s left) kms_lease (lease-invalid-crtc) [203.300426] Starting subtest: lease-invalid-crtc [203.303267] Starting dynamic subtest: pipe-A-eDP-1 [203.305803] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [203.314472] Starting dynamic subtest: pipe-B-eDP-1 [203.316906] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [203.322615] Starting dynamic subtest: pipe-C-eDP-1 [203.324492] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [203.330428] Starting dynamic subtest: pipe-D-eDP-1 [203.332574] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [203.334756] Subtest lease-invalid-crtc: SUCCESS (0.002s) [203.353498] [034/130] (798s left) kms_cursor_edge_walk (256x256-right-edge) [203.439967] Starting subtest: 256x256-right-edge [203.442408] Starting dynamic subtest: pipe-A-eDP-1 [206.942477] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.498s) [206.950593] Starting dynamic subtest: pipe-D-eDP-1 [210.186925] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.243s) [210.189798] Subtest 256x256-right-edge: SUCCESS (6.743s) [211.047375] [035/130] (791s left) gem_madvise (dontneed-before-mmap) [211.074115] Starting subtest: dontneed-before-mmap [211.101762] Subtest dontneed-before-mmap: SUCCESS (0.028s) [211.188883] [036/130] (791s left) gem_create (create-valid-nonaligned) [211.230907] Starting subtest: create-valid-nonaligned [211.233117] Subtest create-valid-nonaligned: SUCCESS (0.000s) [211.389635] [037/130] (790s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf) [216.527059] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf [216.529592] Starting dynamic subtest: pipe-A-eDP-1 [217.421496] Dynamic subtest pipe-A-eDP-1: SKIP (0.890s) [217.429217] Starting dynamic subtest: pipe-B-eDP-1 [218.630772] Dynamic subtest pipe-B-eDP-1: SKIP (1.210s) [218.635057] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (2.104s) [219.877444] [038/130] (782s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip) [219.974665] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip [219.979078] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [220.043082] [039/130] (782s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc) [220.143689] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc [224.432948] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (4.294s) [224.533445] [040/130] (777s left) kms_flip (blocking-absolute-wf_vblank-interruptible) [224.626185] Starting subtest: blocking-absolute-wf_vblank-interruptible [224.628581] Starting dynamic subtest: A-eDP1 [233.446413] Dynamic subtest A-eDP1: SUCCESS (8.819s) [233.455456] Starting dynamic subtest: B-eDP1 [242.213108] Dynamic subtest B-eDP1: SUCCESS (8.766s) [242.219738] Starting dynamic subtest: C-eDP1 [250.969068] Dynamic subtest C-eDP1: SUCCESS (8.755s) [250.975462] Starting dynamic subtest: D-eDP1 [259.739671] Dynamic subtest D-eDP1: SUCCESS (8.769s) [259.744538] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (35.120s) [260.967033] [041/130] (741s left) kms_psr (fbc-psr-cursor-mmap-gtt) [261.056922] Starting subtest: fbc-psr-cursor-mmap-gtt [261.059155] Starting dynamic subtest: eDP-1 [261.063214] Dynamic subtest eDP-1: SKIP (0.000s) [261.067310] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.000s) [261.109574] [042/130] (741s left) gem_exec_create (madvise) [261.162163] Starting subtest: madvise [261.164531] Starting dynamic subtest: smem [281.306911] Dynamic subtest smem: SUCCESS (20.142s) [281.310676] Subtest madvise: SUCCESS (20.142s) [282.382655] [043/130] (719s left) gem_exec_fence (syncobj-wait) [282.785465] Starting subtest: syncobj-wait [284.458221] Subtest syncobj-wait: SUCCESS (1.672s) [284.780250] [044/130] (717s left) gem_mmap_wc (read) [284.820095] Subtest read: SKIP (0.000s) [284.852438] [045/130] (717s left) syncobj_wait (single-wait-all-for-submit-signaled) [284.903143] Starting subtest: single-wait-all-for-submit-signaled [284.905326] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [284.980786] [046/130] (717s left) kms_big_fb (y-tiled-addfb-size-overflow) [285.082363] Starting subtest: y-tiled-addfb-size-overflow [285.086564] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s) [285.146660] [047/130] (717s left) gem_mmap (bad-offset) [285.202188] Subtest bad-offset: SKIP (0.000s) [285.241241] [048/130] (717s left) kms_flip (flip-vs-wf_vblank-interruptible) [285.333782] Starting subtest: flip-vs-wf_vblank-interruptible [285.339191] Starting dynamic subtest: A-eDP1 [287.305690] Dynamic subtest A-eDP1: SUCCESS (1.968s) [287.314855] Starting dynamic subtest: B-eDP1 [289.291168] Dynamic subtest B-eDP1: SUCCESS (1.983s) [289.299946] Starting dynamic subtest: C-eDP1 [291.261962] Dynamic subtest C-eDP1: SUCCESS (1.970s) [291.269577] Starting dynamic subtest: D-eDP1 [293.248047] Dynamic subtest D-eDP1: SUCCESS (1.985s) [293.253776] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.917s) [294.503329] [049/130] (707s left) kms_psr2_su (page_flip-xrgb8888) [294.557094] Subtest page_flip-XRGB8888: SKIP (0.000s) [294.592720] [050/130] (707s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt) [294.679480] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt [294.684029] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [294.748448] [051/130] (707s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [294.835019] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [294.837284] Starting dynamic subtest: pipe-A-default-mode [296.027781] Dynamic subtest pipe-A-default-mode: SKIP (1.186s) [296.032909] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.187s) [296.159799] [052/130] (706s left) kms_pm_rpm (basic-pci-d3-state) [297.579782] Starting subtest: basic-pci-d3-state [299.029295] Subtest basic-pci-d3-state: SUCCESS (1.449s) [299.094869] [053/130] (703s left) kms_panel_fitting (legacy) [299.186902] Starting subtest: legacy [299.189208] Starting dynamic subtest: pipe-A-eDP-1 [299.704055] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.517s) [299.727607] Starting dynamic subtest: pipe-B-eDP-1 [301.320043] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.596s) [301.345573] Starting dynamic subtest: pipe-C-eDP-1 [302.939369] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.599s) [302.965750] Starting dynamic subtest: pipe-D-eDP-1 [304.541118] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.582s) [304.543622] Subtest legacy: SUCCESS (5.353s) [305.833196] [054/130] (696s left) gem_userptr_blits (set-cache-level) [305.885216] Starting subtest: set-cache-level [305.889185] Subtest set-cache-level: SKIP (0.000s) [305.993393] [055/130] (696s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt) [306.085968] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt [306.090092] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [306.171064] [056/130] (696s left) gem_eio (wait-wedge-1us) [306.376783] Starting subtest: wait-wedge-1us [307.469813] Subtest wait-wedge-1us: SUCCESS (1.093s) [307.566782] [057/130] (695s left) i915_pm_rpm (system-suspend-execbuf) [309.585666] Starting subtest: system-suspend-execbuf [368.355477] Subtest system-suspend-execbuf: SUCCESS (43.970s) [368.684173] [058/130] (648s left) kms_big_fb (x-tiled-8bpp-rotate-0) [368.772929] Starting subtest: x-tiled-8bpp-rotate-0 [369.760504] Subtest x-tiled-8bpp-rotate-0: SUCCESS (0.990s) [369.880827] [059/130] (647s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted) [369.922304] Starting subtest: etime-multi-wait-all-for-submit-submitted [370.030118] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.107s) [370.084712] [060/130] (647s left) gem_exec_flush (basic-batch-kernel-default-uc) [370.140177] Starting subtest: basic-batch-kernel-default-uc [376.490955] Subtest basic-batch-kernel-default-uc: SUCCESS (6.353s) [376.656662] [061/130] (640s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers) [376.745806] Starting subtest: plane-scaler-unity-scaling-with-modifiers [376.748256] Starting dynamic subtest: pipe-A [377.097186] Dynamic subtest pipe-A: SUCCESS (0.351s) [377.105747] Starting dynamic subtest: pipe-B [378.562474] Dynamic subtest pipe-B: SUCCESS (1.464s) [378.569925] Starting dynamic subtest: pipe-C [380.044926] Dynamic subtest pipe-C: SUCCESS (1.481s) [380.052955] Starting dynamic subtest: pipe-D [381.510275] Dynamic subtest pipe-D: SUCCESS (1.465s) [381.513062] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.764s) [382.754863] [062/130] (634s left) syncobj_timeline (single-wait-for-submit-signaled) [382.805606] Starting subtest: single-wait-for-submit-signaled [382.807458] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s) [382.867903] [063/130] (634s left) kms_flip (2x-flip-vs-fences-interruptible) [382.954829] Starting subtest: 2x-flip-vs-fences-interruptible [382.959146] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s) [383.028498] [064/130] (634s left) kms_big_fb (linear-32bpp-rotate-180) [383.119190] Starting subtest: linear-32bpp-rotate-180 [384.473633] Subtest linear-32bpp-rotate-180: SUCCESS (1.356s) [384.584054] [065/130] (632s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [384.678795] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [384.682282] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [384.747183] [066/130] (632s left) kms_cursor_crc (cursor-onscreen-max-size) [384.991028] Starting subtest: cursor-onscreen-max-size [384.996566] Subtest cursor-onscreen-max-size: SKIP (0.000s) [385.098336] [067/130] (632s left) gem_ctx_param (root-set) [385.140783] Starting subtest: root-set [385.143164] Subtest root-set: SUCCESS (0.001s) [385.220288] [068/130] (632s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt) [385.317369] Starting subtest: psr-farfromfence-mmap-gtt [385.320917] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s) [385.401871] [069/130] (632s left) gem_render_copy (y-tiled-to-vebox-linear) [385.455220] Starting subtest: y-tiled-to-vebox-linear [385.459513] Subtest y-tiled-to-vebox-linear: SKIP (0.000s) [385.613827] [070/130] (631s left) syncobj_timeline (wait-for-submit-snapshot) [385.666635] Starting subtest: wait-for-submit-snapshot [385.747971] Subtest wait-for-submit-snapshot: SUCCESS (0.082s) [385.799777] [071/130] (631s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff) [385.897606] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff [388.881025] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (2.987s) [389.004341] [072/130] (628s left) kms_cursor_legacy (cursora-vs-flipa-varying-size) [389.118268] Starting subtest: cursorA-vs-flipA-varying-size [400.235808] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.116s) [401.130388] [073/130] (616s left) kms_selftest (drm_plane_helper) [401.184116] Starting subtest: drm_plane_helper [401.192113] Starting dynamic subtest: drm_test_check_plane_state [401.284637] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.091s) [401.295955] Starting dynamic subtest: drm_test_check_invalid_plane_state [401.342195] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.058s) [401.344603] Subtest drm_plane_helper: SUCCESS (0.158s) [401.478107] [074/130] (616s left) gem_ctx_persistence (heartbeat-stop) [401.536878] Starting subtest: heartbeat-stop [401.541449] Subtest heartbeat-stop: SKIP (0.000s) [401.616759] [075/130] (616s left) kms_flip (2x-flip-vs-suspend-interruptible) [401.707767] Starting subtest: 2x-flip-vs-suspend-interruptible [401.724351] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.014s) [401.775625] [076/130] (615s left) kms_chamelium_frames (hdmi-crc-fast) [402.158456] Subtest hdmi-crc-fast: SKIP (0.000s) [403.026133] [077/130] (614s left) gen9_exec_parse (bb-start-cmd) [403.091819] Subtest bb-start-cmd: SKIP (0.000s) [403.136033] [078/130] (614s left) kms_chamelium_color (ctm-0-75) [403.221931] Subtest ctm-0-75: SKIP (0.000s) [403.245922] [079/130] (614s left) gem_exec_schedule (preempt-engines) [403.316362] Starting subtest: preempt-engines [403.318654] Starting dynamic subtest: rcs0 [405.557867] Dynamic subtest rcs0: SUCCESS (2.250s) [405.571066] Starting dynamic subtest: bcs0 [407.788800] Dynamic subtest bcs0: SUCCESS (2.230s) [407.796065] Starting dynamic subtest: vcs0 [410.043207] Dynamic subtest vcs0: SUCCESS (2.252s) [410.053646] Starting dynamic subtest: vcs1 [412.292149] Dynamic subtest vcs1: SUCCESS (2.248s) [412.302508] Starting dynamic subtest: vecs0 [414.530640] Dynamic subtest vecs0: SUCCESS (2.237s) [414.543483] Starting dynamic subtest: ccs0 [416.800195] Dynamic subtest ccs0: SUCCESS (2.268s) [416.802573] Subtest preempt-engines: SUCCESS (13.490s) [417.078056] [080/130] (600s left) gem_readwrite (beyond-eob) [417.133254] Subtest beyond-EOB: SKIP (0.000s) [417.172782] [081/130] (600s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted) [417.225540] Starting subtest: etime-single-wait-all-available-unsubmitted [417.334170] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.108s) [417.391068] [082/130] (600s left) gem_exec_balancer (full-late) [417.432608] Starting subtest: full-late [421.694656] Subtest full-late: SUCCESS (4.261s) [421.961323] [083/130] (595s left) gem_mmap_offset (partial-unmap) [422.001399] Starting subtest: partial-unmap [422.003277] Starting dynamic subtest: smem0 [422.474760] Dynamic subtest smem0: SUCCESS (0.473s) [422.477738] Subtest partial-unmap: SUCCESS (0.474s) [422.543657] [084/130] (595s left) perf_pmu (semaphore-wait) [422.574019] Starting subtest: semaphore-wait [422.575932] Starting dynamic subtest: rcs0 [423.088599] Dynamic subtest rcs0: SUCCESS (0.513s) [423.098920] Starting dynamic subtest: bcs0 [423.607211] Dynamic subtest bcs0: SUCCESS (0.517s) [423.624644] Starting dynamic subtest: vcs0 [424.122288] Dynamic subtest vcs0: SUCCESS (0.514s) [424.131846] Starting dynamic subtest: vcs1 [424.636183] Dynamic subtest vcs1: SUCCESS (0.512s) [424.647660] Starting dynamic subtest: vecs0 [425.149600] Dynamic subtest vecs0: SUCCESS (0.512s) [425.159172] Starting dynamic subtest: ccs0 [425.663244] Dynamic subtest ccs0: SUCCESS (0.512s) [425.666355] Subtest semaphore-wait: SUCCESS (3.090s) [425.766545] [085/130] (592s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe) [426.152122] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s) [427.027270] [086/130] (590s left) gem_exec_fair (basic-flow) [427.089147] Subtest basic-flow: SKIP (0.000s) [427.124702] [087/130] (590s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy) [427.234623] Starting subtest: flip-vs-cursor-busy-crc-legacy [428.038841] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.804s) [428.903093] [088/130] (588s left) kms_psr (psr2-sprite-mmap-gtt) [428.995943] Starting subtest: psr2-sprite-mmap-gtt [428.998178] Starting dynamic subtest: eDP-1 [431.439788] Dynamic subtest eDP-1: FAIL (2.284s) [431.441797] Subtest psr2-sprite-mmap-gtt: FAIL (2.285s) [431.462193] [089/130] (586s left) kms_cursor_crc (cursor-offscreen-64x21) [431.610390] Starting subtest: cursor-offscreen-64x21 [431.645933] Subtest cursor-offscreen-64x21: SKIP (0.030s) [431.853667] [090/130] (586s left) kms_hdr (bpc-switch-dpms) [431.946869] Starting subtest: bpc-switch-dpms [433.091805] Starting dynamic subtest: pipe-A-eDP-1 [437.825776] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.734s) [437.828163] Subtest bpc-switch-dpms: SUCCESS (5.880s) [437.929307] [091/130] (580s left) kms_big_fb (4-tiled-16bpp-rotate-0) [438.030760] Starting subtest: 4-tiled-16bpp-rotate-0 [439.051431] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.021s) [439.162309] [092/130] (578s left) drm_read (short-buffer-nonblock) [439.304803] Starting subtest: short-buffer-nonblock [439.307881] Subtest short-buffer-nonblock: SUCCESS (0.000s) [439.416513] [093/130] (578s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled) [439.468092] Starting subtest: invalid-multi-wait-unsubmitted-signaled [439.469922] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s) [439.535242] [094/130] (578s left) kms_force_connector_basic (force-connector-state) [439.610090] Starting subtest: force-connector-state [440.198472] Subtest force-connector-state: SUCCESS (0.588s) [441.181136] [095/130] (576s left) kms_cursor_legacy (flip-vs-cursor-varying-size) [441.297525] Starting subtest: flip-vs-cursor-varying-size [448.490047] Subtest flip-vs-cursor-varying-size: SUCCESS (7.193s) [449.381808] [096/130] (568s left) kms_psr (fbc-psr2-primary-mmap-gtt) [449.470861] Starting subtest: fbc-psr2-primary-mmap-gtt [449.473292] Starting dynamic subtest: eDP-1 [449.477801] Dynamic subtest eDP-1: SKIP (0.000s) [449.482326] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s) [449.520774] [097/130] (568s left) gem_exec_flush (basic-batch-kernel-default-cmd) [449.569352] Starting subtest: basic-batch-kernel-default-cmd [449.573482] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s) [449.728101] [098/130] (568s left) kms_vrr (seamless-rr-switch-virtual) [449.813841] Starting subtest: seamless-rr-switch-virtual [449.820787] Subtest seamless-rr-switch-virtual: SKIP (0.000s) [449.865750] [099/130] (568s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs) [449.945728] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs [449.950257] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s) [451.109125] [100/130] (566s left) gem_userptr_blits (sync-overlap) [451.172407] Starting subtest: sync-overlap [451.174750] Subtest sync-overlap: SUCCESS (0.000s) [451.281958] [101/130] (566s left) gem_exec_params (rel-constants-invalid-rel-gen5) [451.324316] Starting subtest: rel-constants-invalid-rel-gen5 [451.326632] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s) [451.396918] [102/130] (566s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc) [451.485353] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc [455.738839] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (4.256s) [455.827907] [103/130] (562s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt) [455.924408] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt [458.631548] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (2.711s) [458.766206] [104/130] (559s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt) [458.866863] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt [462.074554] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (3.210s) [462.208337] [105/130] (555s left) gem_exec_schedule (submit-early-slice) [462.267930] Starting subtest: submit-early-slice [462.269951] Starting dynamic subtest: rcs0 [462.297045] Dynamic subtest rcs0: SUCCESS (0.034s) [462.304443] Starting dynamic subtest: bcs0 [462.327330] Dynamic subtest bcs0: SUCCESS (0.030s) [462.335939] Starting dynamic subtest: vcs0 [462.360186] Dynamic subtest vcs0: SUCCESS (0.032s) [462.367400] Starting dynamic subtest: vcs1 [462.392673] Dynamic subtest vcs1: SUCCESS (0.033s) [462.399670] Starting dynamic subtest: vecs0 [462.419005] Dynamic subtest vecs0: SUCCESS (0.026s) [462.425824] Starting dynamic subtest: ccs0 [462.443428] Dynamic subtest ccs0: SUCCESS (0.024s) [462.445446] Subtest submit-early-slice: SUCCESS (0.181s) [464.241089] [106/130] (553s left) gem_exec_params (invalid-bsd2-flag-on-blt) [464.296174] Starting subtest: invalid-bsd2-flag-on-blt [464.298121] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s) [464.387492] [107/130] (553s left) perf_pmu (module-unload) [464.445074] Starting subtest: module-unload [502.571801] Subtest module-unload: SUCCESS (38.123s) [502.588010] [108/130] (515s left) kms_feature_discovery (display-4x) [504.217072] Starting subtest: display-4x [504.221543] Subtest display-4x: SKIP (0.000s) [504.242881] [109/130] (513s left) gem_exec_flush (basic-wb-ro-before-default) [504.307515] Starting subtest: basic-wb-ro-before-default [509.743644] Subtest basic-wb-ro-before-default: SUCCESS (5.429s) [509.898251] [110/130] (508s left) kms_fbcon_fbt (psr-suspend) [509.951832] Starting subtest: psr-suspend [557.385728] Subtest psr-suspend: SUCCESS (18.509s) [557.429140] [111/130] (489s left) gem_busy (extended) [557.602024] Starting subtest: extended [557.604734] Starting dynamic subtest: rcs0 [557.680912] Dynamic subtest rcs0: SUCCESS (0.079s) [557.690394] Starting dynamic subtest: bcs0 [557.721971] Dynamic subtest bcs0: SUCCESS (0.040s) [557.730823] Starting dynamic subtest: vcs0 [559.077065] Dynamic subtest vcs0: SUCCESS (1.351s) [559.087189] Starting dynamic subtest: vcs1 [561.059954] Dynamic subtest vcs1: SUCCESS (1.980s) [561.069926] Starting dynamic subtest: vecs0 [563.108197] Dynamic subtest vecs0: SUCCESS (2.045s) [563.116942] Starting dynamic subtest: ccs0 [563.157329] Dynamic subtest ccs0: SUCCESS (0.049s) [563.161888] Subtest extended: SUCCESS (5.550s) [563.387735] [112/130] (483s left) i915_hangman (engine-error-state-capture) [563.451119] Starting subtest: engine-error-state-capture [563.453388] Starting dynamic subtest: rcs0 [567.043701] Dynamic subtest rcs0: SUCCESS (3.590s) [567.053303] Starting dynamic subtest: bcs0 [573.057975] Dynamic subtest bcs0: SUCCESS (6.009s) [573.068108] Starting dynamic subtest: vcs0 [579.010512] Dynamic subtest vcs0: SUCCESS (5.948s) [579.020268] Starting dynamic subtest: vcs1 [585.024111] Dynamic subtest vcs1: SUCCESS (6.009s) [585.031737] Starting dynamic subtest: vecs0 [591.042232] Dynamic subtest vecs0: SUCCESS (6.019s) [591.051241] Starting dynamic subtest: ccs0 [597.058281] Dynamic subtest ccs0: SUCCESS (6.016s) [597.061104] Subtest engine-error-state-capture: SUCCESS (33.597s) [597.115892] [113/130] (450s left) kms_flip (dpms-vs-vblank-race) [597.211698] Starting subtest: dpms-vs-vblank-race [597.214216] Starting dynamic subtest: A-eDP1 [601.246905] Dynamic subtest A-eDP1: SUCCESS (4.034s) [601.255099] Starting dynamic subtest: B-eDP1 [604.894834] Dynamic subtest B-eDP1: SUCCESS (3.647s) [604.904010] Starting dynamic subtest: C-eDP1 [608.533532] Dynamic subtest C-eDP1: SUCCESS (3.637s) [608.542089] Starting dynamic subtest: D-eDP1 [612.183489] Dynamic subtest D-eDP1: SUCCESS (3.649s) [612.186107] Subtest dpms-vs-vblank-race: SUCCESS (14.972s) [613.062767] [114/130] (434s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc) [613.155739] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc [613.158038] Starting dynamic subtest: pipe-A-eDP-1 [613.214608] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [613.221209] Starting dynamic subtest: pipe-B-eDP-1 [613.279057] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [613.286934] Starting dynamic subtest: pipe-C-eDP-1 [613.345084] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [613.353393] Starting dynamic subtest: pipe-D-eDP-1 [613.410652] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [613.415130] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s) [615.499051] [115/130] (431s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt) [615.592101] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt [620.594172] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (5.005s) [620.708645] [116/130] (426s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs) [620.795618] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs [620.797771] Starting dynamic subtest: pipe-A-eDP-1 [622.599940] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.802s) [622.607047] Starting dynamic subtest: pipe-B-eDP-1 [624.771055] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.169s) [624.778802] Starting dynamic subtest: pipe-C-eDP-1 [626.878754] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.106s) [626.886633] Starting dynamic subtest: pipe-D-eDP-1 [628.938108] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.059s) [628.940562] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.139s) [630.216093] [117/130] (417s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render) [630.318653] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render [634.915138] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (4.598s) [635.029672] [118/130] (412s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt) [635.125367] Starting subtest: psr-rgb101010-draw-mmap-gtt [635.129720] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [635.191689] [119/130] (412s left) gem_mmap_offset (close-race) [635.241881] Starting subtest: close-race [646.907257] Abort requested by /sbin/init [1] via Terminated, terminating children [647.488716] Abort requested by /sbin/init [1] via Hangup, terminating children [647.488747] Exiting gracefully, currently running test will have a 'notrun' result [647.498346] Closing watchdogs Done.