[60.153920] Initializing watchdogs [60.153980] /dev/watchdog0 [60.167940] [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] [60.172149] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [60.174286] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [60.177572] [001/131] (960s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled) [60.257385] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled [60.261611] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s) [60.450830] [002/131] (960s left) gem_exec_balancer (full-pulse) [60.521466] Starting subtest: full-pulse [64.750481] Subtest full-pulse: SUCCESS (4.229s) [65.062534] [003/131] (955s left) i915_drm_fdinfo (virtual-idle) [65.106458] Starting subtest: virtual-idle [68.172737] Subtest virtual-idle: SUCCESS (3.062s) [68.240554] [004/131] (952s left) gem_ccs (suspend-resume) [68.297949] Starting subtest: suspend-resume [68.302753] Subtest suspend-resume: SKIP (0.000s) [68.390936] [005/131] (952s left) kms_psr2_sf (psr2-cursor-plane-update-sf) [68.503569] Starting subtest: psr2-cursor-plane-update-sf [68.505714] Starting dynamic subtest: pipe-A-eDP-1 [69.107114] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.606s) [69.114689] Starting dynamic subtest: pipe-B-eDP-1 [70.424814] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.316s) [70.427137] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.924s) [71.218178] [006/131] (949s left) kms_cursor_legacy (cursorb-vs-flipb-toggle) [71.347232] Starting subtest: cursorB-vs-flipB-toggle [71.351846] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s) [71.501414] [007/131] (949s left) kms_big_fb (x-tiled-16bpp-rotate-180) [71.597380] Starting subtest: x-tiled-16bpp-rotate-180 [72.953238] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.356s) [73.083113] [008/131] (947s left) kms_rmfb (rmfb-ioctl) [73.180257] Starting subtest: rmfb-ioctl [73.181932] Starting dynamic subtest: pipe-A-eDP-1 [73.284364] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.105s) [73.295761] Starting dynamic subtest: pipe-B-eDP-1 [74.485356] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.199s) [74.495689] Starting dynamic subtest: pipe-C-eDP-1 [75.625663] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.139s) [75.634551] Starting dynamic subtest: pipe-D-eDP-1 [76.761461] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.135s) [76.763845] Subtest rmfb-ioctl: SUCCESS (3.583s) [77.882194] [009/131] (943s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move) [77.985577] Starting subtest: fbc-1p-primscrn-cur-indfb-move [82.093204] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.092s) [83.313784] [010/131] (937s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic) [83.402289] Starting subtest: async-flip-with-page-flip-events-tiled-atomic [83.774800] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs [86.578223] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.793s) [86.589813] Starting dynamic subtest: pipe-A-eDP-1-4 [88.759623] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.176s) [88.767612] Starting dynamic subtest: pipe-A-eDP-1-4 [90.762798] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (1.999s) [90.773077] Starting dynamic subtest: pipe-A-eDP-1-x [92.934248] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.168s) [93.292208] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs [96.016059] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.727s) [96.023902] Starting dynamic subtest: pipe-B-eDP-1-4 [98.204083] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.186s) [98.214363] Starting dynamic subtest: pipe-B-eDP-1-4 [100.214126] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.010s) [100.222267] Starting dynamic subtest: pipe-B-eDP-1-x [102.406615] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.190s) [102.792864] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs [105.555319] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.768s) [105.564220] Starting dynamic subtest: pipe-C-eDP-1-4 [107.739353] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.183s) [107.747421] Starting dynamic subtest: pipe-C-eDP-1-4 [109.749927] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.010s) [109.760311] Starting dynamic subtest: pipe-C-eDP-1-x [111.928786] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.176s) [112.303100] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs [115.092077] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.786s) [115.100238] Starting dynamic subtest: pipe-D-eDP-1-4 [117.262215] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.164s) [117.275447] Starting dynamic subtest: pipe-D-eDP-1-4 [119.266295] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (1.999s) [119.276764] Starting dynamic subtest: pipe-D-eDP-1-x [121.427574] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.157s) [121.430067] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (37.969s) [122.615685] [011/131] (898s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw) [122.711420] Starting subtest: psr-1p-pri-indfb-multidraw [145.267494] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (22.533s) [145.387563] [012/131] (875s left) gem_mmap_wc (pf-nonblock) [145.449988] Subtest pf-nonblock: SKIP (0.000s) [145.511508] [013/131] (875s left) i915_pm_rpm (gem-evict-pwrite) [147.045861] Starting subtest: gem-evict-pwrite [147.050687] Subtest gem-evict-pwrite: SKIP (0.000s) [147.824870] [014/131] (873s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip) [147.932738] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip [148.880515] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.947s) [148.996855] [015/131] (872s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite) [149.103831] Starting subtest: fbcpsr-rgb565-draw-pwrite [156.391929] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (7.287s) [156.502901] [016/131] (864s left) syncobj_timeline (invalid-transfer-non-existent-point) [156.562976] Starting subtest: invalid-transfer-non-existent-point [156.565335] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s) [156.653251] [017/131] (864s left) kms_vblank (wait-forked-busy) [156.748982] Starting subtest: wait-forked-busy [156.751170] Starting dynamic subtest: pipe-A-eDP-1 [158.636950] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.888s) [158.650935] Starting dynamic subtest: pipe-D-eDP-1 [161.200726] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.557s) [161.202711] Subtest wait-forked-busy: SUCCESS (4.449s) [162.004422] [018/131] (859s left) gem_exec_schedule (preempt-contexts) [162.075796] Starting subtest: preempt-contexts [162.078174] Starting dynamic subtest: rcs0 [162.117639] Dynamic subtest rcs0: SUCCESS (0.050s) [162.126626] Starting dynamic subtest: bcs0 [162.177709] Dynamic subtest bcs0: SUCCESS (0.060s) [162.185903] Starting dynamic subtest: vcs0 [162.227119] Dynamic subtest vcs0: SUCCESS (0.048s) [162.234988] Starting dynamic subtest: vcs1 [162.269753] Dynamic subtest vcs1: SUCCESS (0.041s) [162.278333] Starting dynamic subtest: vecs0 [162.308821] Dynamic subtest vecs0: SUCCESS (0.037s) [162.316590] Starting dynamic subtest: ccs0 [162.350582] Dynamic subtest ccs0: SUCCESS (0.042s) [162.352964] Subtest preempt-contexts: SUCCESS (0.283s) [164.014757] [019/131] (857s left) kms_pipe_crc_basic (read-crc) [164.121025] Starting subtest: read-crc [164.123285] Starting dynamic subtest: pipe-A-eDP-1 [164.839636] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.716s) [164.856831] Starting dynamic subtest: pipe-B-eDP-1 [166.182867] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.344s) [166.190944] Starting dynamic subtest: pipe-C-eDP-1 [167.488228] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.300s) [167.496820] Starting dynamic subtest: pipe-D-eDP-1 [168.833959] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.347s) [168.836285] Subtest read-crc: SUCCESS (4.713s) [169.650477] [020/131] (851s left) gem_set_tiling_vs_blt (tiled-to-tiled) [169.701830] Subtest tiled-to-tiled: SKIP (0.000s) [169.757193] [021/131] (851s left) kms_content_protection (dp-mst-type-1-suspend-resume) [169.888689] Starting subtest: dp-mst-type-1-suspend-resume [169.893146] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s) [170.015845] [022/131] (851s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs) [170.106291] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs [170.110857] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s) [171.186681] [023/131] (850s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [171.279964] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [171.284298] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s) [171.349226] [024/131] (850s left) kms_addfb_basic (bo-too-small) [171.446859] Starting subtest: bo-too-small [171.449037] Subtest bo-too-small: SUCCESS (0.000s) [171.554830] [025/131] (850s left) kms_atomic (plane-cursor-legacy) [171.655978] Starting subtest: plane-cursor-legacy [171.658917] Starting dynamic subtest: pipe-A-eDP-1 [172.016064] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.361s) [172.018517] Subtest plane-cursor-legacy: SUCCESS (0.363s) [172.832558] [026/131] (848s left) kms_rotation_crc (primary-y-tiled-reflect-x-0) [172.933093] Starting subtest: primary-y-tiled-reflect-x-0 [173.004076] Subtest primary-y-tiled-reflect-x-0: SKIP (0.071s) [173.107566] [027/131] (848s left) syncobj_timeline (multi-wait-submitted-signaled) [173.164506] Starting subtest: multi-wait-submitted-signaled [173.167154] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s) [173.287798] [028/131] (848s left) syncobj_wait (wait-for-submit-snapshot) [173.348058] Starting subtest: wait-for-submit-snapshot [173.429061] Subtest wait-for-submit-snapshot: SUCCESS (0.081s) [173.514647] [029/131] (848s left) kms_chamelium_audio (hdmi-audio-edid) [173.891888] Subtest hdmi-audio-edid: SKIP (0.000s) [174.735140] [030/131] (847s left) kms_busy (extended-pageflip-modeset-hang-oldfb) [174.836110] Starting subtest: extended-pageflip-modeset-hang-oldfb [174.838232] Starting dynamic subtest: pipe-A [182.750979] Dynamic subtest pipe-A: SUCCESS (7.909s) [182.759721] Starting dynamic subtest: pipe-D [191.380825] Dynamic subtest pipe-D: SUCCESS (8.622s) [191.383190] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.536s) [192.233423] [031/131] (829s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs) [192.327147] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs [192.329314] Starting dynamic subtest: pipe-A-eDP-1 [192.351686] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [192.361884] Starting dynamic subtest: pipe-B-eDP-1 [192.382969] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [192.390966] Starting dynamic subtest: pipe-C-eDP-1 [192.411775] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [192.419152] Starting dynamic subtest: pipe-D-eDP-1 [192.440142] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [192.444084] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.004s) [194.513662] [032/131] (827s left) perf (invalid-oa-format-id) [194.632325] Starting subtest: invalid-oa-format-id [194.642956] Subtest invalid-oa-format-id: SUCCESS (0.011s) [194.677759] [033/131] (827s left) kms_hdr (static-swap) [194.768503] Starting subtest: static-swap [194.775186] Subtest static-swap: SKIP (0.000s) [194.843316] [034/131] (827s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render) [194.933144] Starting subtest: psr-rgb101010-draw-render [202.076117] Subtest psr-rgb101010-draw-render: SUCCESS (7.143s) [202.199881] [035/131] (819s left) kms_flip (dpms-vs-vblank-race) [202.308370] Starting subtest: dpms-vs-vblank-race [202.310583] Starting dynamic subtest: A-eDP1 [206.190435] Dynamic subtest A-eDP1: SUCCESS (3.879s) [206.199043] Starting dynamic subtest: B-eDP1 [209.790284] Dynamic subtest B-eDP1: SUCCESS (3.595s) [209.803122] Starting dynamic subtest: C-eDP1 [214.395558] Dynamic subtest C-eDP1: SUCCESS (4.601s) [214.404098] Starting dynamic subtest: D-eDP1 [219.047711] Dynamic subtest D-eDP1: SUCCESS (4.648s) [219.049678] Subtest dpms-vs-vblank-race: SUCCESS (16.734s) [219.912662] [036/131] (802s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [220.022134] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip [220.026448] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s) [220.113647] [037/131] (801s left) kms_vrr (seamless-rr-switch-virtual) [220.201073] Starting subtest: seamless-rr-switch-virtual [220.207160] Subtest seamless-rr-switch-virtual: SKIP (0.000s) [220.269671] [038/131] (801s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt) [220.363591] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt [220.367679] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [220.451874] [039/131] (801s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu) [220.540969] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu [227.102043] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.562s) [227.227424] [040/131] (794s left) core_sysfs (read-all-entries) [227.294561] Starting subtest: read-all-entries [227.302673] Subtest read-all-entries: SUCCESS (0.010s) [227.372910] [041/131] (794s left) kms_big_fb (4-tiled-8bpp-rotate-90) [227.469495] Starting subtest: 4-tiled-8bpp-rotate-90 [227.494059] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.021s) [227.612821] [042/131] (794s left) kms_cursor_crc (cursor-onscreen-256x256) [227.851493] Starting subtest: cursor-onscreen-256x256 [227.856343] Starting dynamic subtest: pipe-A-eDP-1 [229.993748] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.136s) [230.027984] Starting dynamic subtest: pipe-D-eDP-1 [232.728220] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.708s) [232.730172] Subtest cursor-onscreen-256x256: SUCCESS (4.872s) [233.532826] [043/131] (788s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180) [233.633809] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180 [234.657312] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.023s) [234.774221] [044/131] (787s left) kms_addfb_basic (addfb25-bad-modifier) [234.873812] Starting subtest: addfb25-bad-modifier [234.875743] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [234.988555] [045/131] (787s left) gem_ctx_freq (sysfs) [235.055344] Starting subtest: sysfs [235.057328] Starting dynamic subtest: gt0 [240.567966] Dynamic subtest gt0: SUCCESS (5.509s) [240.576373] Starting dynamic subtest: gt1 [281.877309] Dynamic subtest gt1: SUCCESS (41.288s) [281.880230] Subtest sysfs: SUCCESS (46.801s) [282.011730] [046/131] (740s left) i915_selftest (live) [286.638948] Starting subtest: live [286.641436] Starting dynamic subtest: sanitycheck [289.258598] Dynamic subtest sanitycheck: SUCCESS (2.618s) [289.268036] Starting dynamic subtest: uncore [293.548037] Dynamic subtest uncore: SUCCESS (4.285s) [293.557475] Starting dynamic subtest: workarounds [296.631674] Dynamic subtest workarounds: SUCCESS (3.080s) [296.643631] Starting dynamic subtest: gt_engines [299.697790] Dynamic subtest gt_engines: SUCCESS (3.064s) [299.707275] Starting dynamic subtest: gt_timelines [315.430053] Dynamic subtest gt_timelines: SUCCESS (15.717s) [315.443781] Starting dynamic subtest: gt_contexts [319.716040] Dynamic subtest gt_contexts: SUCCESS (4.280s) [319.725145] Starting dynamic subtest: gt_lrc [324.035536] Dynamic subtest gt_lrc: SUCCESS (4.314s) [324.044801] Starting dynamic subtest: gt_mocs [326.891353] Dynamic subtest gt_mocs: SUCCESS (2.851s) [326.900546] Starting dynamic subtest: gt_pm [331.659247] Dynamic subtest gt_pm: SUCCESS (4.762s) [331.668552] Starting dynamic subtest: gt_heartbeat [335.968196] Dynamic subtest gt_heartbeat: SUCCESS (4.303s) [335.976201] Starting dynamic subtest: gt_tlb [345.217364] Dynamic subtest gt_tlb: SUCCESS (9.239s) [345.226691] Starting dynamic subtest: requests [356.768783] Dynamic subtest requests: SUCCESS (11.541s) [356.777941] Starting dynamic subtest: migrate [362.420553] Dynamic subtest migrate: SUCCESS (5.646s) [362.429991] Starting dynamic subtest: active [366.751080] Dynamic subtest active: SUCCESS (4.325s) [366.759891] Starting dynamic subtest: objects [371.373221] Dynamic subtest objects: SUCCESS (4.617s) [371.382449] Starting dynamic subtest: mman [376.052734] Dynamic subtest mman: SUCCESS (4.675s) [376.062060] Starting dynamic subtest: dmabuf [378.778584] Dynamic subtest dmabuf: SUCCESS (2.722s) [378.787885] Starting dynamic subtest: vma [383.087351] Dynamic subtest vma: SUCCESS (4.304s) [383.096540] Starting dynamic subtest: coherency [386.984344] Dynamic subtest coherency: SUCCESS (3.893s) [386.993434] Starting dynamic subtest: gtt [398.472224] Dynamic subtest gtt: SUCCESS (11.479s) [398.481707] Starting dynamic subtest: gem [406.578261] Dynamic subtest gem: SUCCESS (8.100s) [406.587497] Starting dynamic subtest: evict [410.501037] Dynamic subtest evict: SUCCESS (3.919s) [410.509983] Starting dynamic subtest: hugepages [421.203049] Dynamic subtest hugepages: SUCCESS (10.694s) [421.212674] Starting dynamic subtest: gem_contexts [449.762203] Dynamic subtest gem_contexts: SUCCESS (28.542s) [449.771905] Starting dynamic subtest: client [452.512710] Dynamic subtest client: SUCCESS (2.748s) [452.521758] Starting dynamic subtest: gem_migrate [456.831865] Dynamic subtest gem_migrate: SUCCESS (4.315s) [456.841177] Starting dynamic subtest: reset [461.146549] Dynamic subtest reset: SUCCESS (4.309s) [461.153802] Starting dynamic subtest: memory_region [465.416064] Dynamic subtest memory_region: SUCCESS (4.265s) [465.427099] Starting dynamic subtest: hangcheck [478.674769] Dynamic subtest hangcheck: SUCCESS (13.250s) [478.683235] Starting dynamic subtest: execlists [483.003059] Dynamic subtest execlists: SUCCESS (4.324s) [483.012292] Starting dynamic subtest: ring_submission [487.272793] Dynamic subtest ring_submission: SUCCESS (4.265s) [487.281989] Starting dynamic subtest: perf [491.558855] Dynamic subtest perf: SUCCESS (4.282s) [491.568562] Starting dynamic subtest: slpc [503.684350] Dynamic subtest slpc: SUCCESS (12.118s) [503.693706] Starting dynamic subtest: guc [507.609692] Dynamic subtest guc: SUCCESS (3.922s) [507.619082] Starting dynamic subtest: guc_multi_lrc [511.902034] Dynamic subtest guc_multi_lrc: SUCCESS (4.289s) [511.911584] Starting dynamic subtest: guc_hang [516.812203] Dynamic subtest guc_hang: SUCCESS (4.905s) [516.821945] Starting dynamic subtest: late_gt_pm [519.541408] Dynamic subtest late_gt_pm: SUCCESS (2.727s) [519.543922] Subtest live: SUCCESS (232.753s) [519.570728] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true [519.574196] [047/131] (502s left) gem_exec_schedule (preempt-queue-contexts-chain) [521.088874] Subtest preempt-queue-contexts-chain: SKIP (0.000s) [521.350433] [FACT gem_exec_schedule (preempt-queue-contexts-chain)] new: kernel.kmod_is_loaded.i915: true [521.354697] [048/131] (501s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area) [521.467176] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area [521.469623] Starting dynamic subtest: pipe-A-eDP-1 [521.589816] Dynamic subtest pipe-A-eDP-1: SKIP (0.124s) [521.600665] Starting dynamic subtest: pipe-B-eDP-1 [522.734654] Dynamic subtest pipe-B-eDP-1: SKIP (1.143s) [522.739446] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.270s) [523.936450] [049/131] (498s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt) [524.030150] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt [524.034119] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [524.121838] [050/131] (498s left) kms_psr (psr2-primary-blt) [524.221058] Starting subtest: psr2-primary-blt [524.223357] Starting dynamic subtest: eDP-1 [525.915729] Dynamic subtest eDP-1: SUCCESS (1.693s) [525.917918] Subtest psr2-primary-blt: SUCCESS (1.695s) [526.804964] [051/131] (495s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [526.901395] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt [526.905635] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [527.007257] [052/131] (495s left) gem_exec_fence (basic-busy-all) [527.063154] Starting subtest: basic-busy-all [527.156790] Subtest basic-busy-all: SUCCESS (0.094s) [528.990304] [FACT gem_exec_fence (basic-busy-all)] new: kernel.kmod_is_loaded.vgem: true [528.993854] [053/131] (493s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions) [529.107161] Starting subtest: cursorB-vs-flipA-atomic-transitions [529.111443] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s) [529.254396] [054/131] (493s left) gem_exec_capture (capture-invisible) [529.312782] Starting subtest: capture-invisible [529.315173] Starting dynamic subtest: smem0 [529.319313] Dynamic subtest smem0: SKIP (0.000s) [529.323425] Subtest capture-invisible: SKIP (0.001s) [529.412320] [055/131] (493s left) kms_psr (fbc-psr2-cursor-mmap-cpu) [529.510076] Starting subtest: fbc-psr2-cursor-mmap-cpu [529.512217] Starting dynamic subtest: eDP-1 [529.516126] Dynamic subtest eDP-1: SKIP (0.000s) [529.520163] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s) [529.581414] [056/131] (493s left) gen3_render_linear_blits [529.699870] [057/131] (493s left) gem_lmem_evict (dontneed-evict-race) [529.740325] Subtest dontneed-evict-race: SKIP (0.000s) [529.782490] [058/131] (493s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt) [529.881070] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt [529.884948] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [529.977259] [059/131] (492s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt) [530.070912] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt [530.074223] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [530.182591] [060/131] (492s left) gem_exec_fence (syncobj-invalid-flags) [530.594253] Starting subtest: syncobj-invalid-flags [530.596742] Subtest syncobj-invalid-flags: SUCCESS (0.000s) [532.000572] [061/131] (490s left) kms_rotation_crc (bad-pixel-format) [532.093333] Starting subtest: bad-pixel-format [532.097409] Subtest bad-pixel-format: SKIP (0.001s) [532.164326] [062/131] (490s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc) [532.253194] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc [532.257246] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [532.345538] [063/131] (490s left) kms_prop_blob (blob-prop-validate) [532.390663] Starting subtest: blob-prop-validate [532.392585] Subtest blob-prop-validate: SUCCESS (0.000s) [532.483646] [064/131] (490s left) gem_pxp (verify-pxp-execution-after-suspend-resume) [532.606069] Starting subtest: verify-pxp-execution-after-suspend-resume [540.491889] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.883s) [540.626477] [065/131] (482s left) kms_force_connector_basic (prune-stale-modes) [540.710830] Starting subtest: prune-stale-modes [541.153419] Subtest prune-stale-modes: SUCCESS (0.448s) [541.283173] [066/131] (481s left) api_intel_bb (blit-reloc-keep-cache) [541.340829] Starting subtest: blit-reloc-keep-cache [541.345252] Subtest blit-reloc-keep-cache: SKIP (0.001s) [541.453843] [067/131] (481s left) drm_read (short-buffer-nonblock) [541.593790] Starting subtest: short-buffer-nonblock [541.595831] Subtest short-buffer-nonblock: SUCCESS (0.000s) [541.715570] [068/131] (481s left) kms_chamelium_hpd (hdmi-hpd-storm-disable) [542.095817] Subtest hdmi-hpd-storm-disable: SKIP (0.000s) [542.868841] [069/131] (480s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted) [542.917609] Starting subtest: etime-single-wait-all-for-submit-submitted [543.025821] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.111s) [543.101307] [070/131] (480s left) i915_drm_fdinfo (all-busy-check-all) [543.143321] Starting subtest: all-busy-check-all [543.147335] Subtest all-busy-check-all: SKIP (0.004s) [543.204988] [071/131] (480s left) kms_psr (psr-primary-page-flip) [543.314251] Starting subtest: psr-primary-page-flip [543.316509] Starting dynamic subtest: eDP-1 [544.996501] Dynamic subtest eDP-1: SUCCESS (1.722s) [544.998765] Subtest psr-primary-page-flip: SUCCESS (1.723s) [545.814354] [072/131] (477s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format) [545.905062] Starting subtest: plane-scaler-unity-scaling-with-pixel-format [545.907206] Starting dynamic subtest: pipe-A [547.112190] Dynamic subtest pipe-A: SUCCESS (1.230s) [547.124568] Starting dynamic subtest: pipe-B [549.322064] Dynamic subtest pipe-B: SUCCESS (2.239s) [549.332274] Starting dynamic subtest: pipe-C [550.488485] Dynamic subtest pipe-C: SUCCESS (1.178s) [550.497786] Starting dynamic subtest: pipe-D [551.699553] Dynamic subtest pipe-D: SUCCESS (1.221s) [551.701956] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.871s) [552.826038] [073/131] (470s left) gen7_exec_parse (basic-allowed) [552.906616] Subtest basic-allowed: SKIP (0.000s) [552.980294] [074/131] (470s left) gem_mmap (short-mmap) [553.044133] Subtest short-mmap: SKIP (0.000s) [553.103260] [075/131] (470s left) gem_ctx_bad_destroy (double-destroy) [553.153785] Starting subtest: double-destroy [553.156038] Subtest double-destroy: SUCCESS (0.000s) [553.254967] [076/131] (470s left) gem_ctx_persistence (legacy-engines-persistence) [553.307970] Starting subtest: legacy-engines-persistence [553.310334] Starting dynamic subtest: render [554.126857] Dynamic subtest render: SUCCESS (0.824s) [554.141186] Starting dynamic subtest: bsd1 [554.896080] Dynamic subtest bsd1: SUCCESS (0.770s) [554.907880] Starting dynamic subtest: bsd2 [555.650771] Dynamic subtest bsd2: SUCCESS (0.756s) [555.662085] Starting dynamic subtest: blt [556.413289] Dynamic subtest blt: SUCCESS (0.763s) [556.424665] Starting dynamic subtest: vebox [557.193763] Dynamic subtest vebox: SUCCESS (0.781s) [557.196279] Subtest legacy-engines-persistence: SUCCESS (3.909s) [557.277137] [077/131] (466s left) kms_flip (2x-flip-vs-blocking-wf-vblank) [557.367149] Starting subtest: 2x-flip-vs-blocking-wf-vblank [557.378617] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.011s) [557.487782] [078/131] (466s left) gem_eio (create) [557.676734] Starting subtest: create [557.934265] Subtest create: SUCCESS (0.260s) [558.084609] [079/131] (465s left) syncobj_timeline (wait-all-complex) [558.142626] Starting subtest: wait-all-complex [558.356559] Subtest wait-all-complex: SUCCESS (0.214s) [558.437504] [080/131] (465s left) kms_ccs (bad-pixel-format-yf-tiled-ccs) [558.539638] Starting subtest: bad-pixel-format-yf-tiled-ccs [558.542048] Starting dynamic subtest: pipe-A-eDP-1 [558.566300] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [558.577980] Starting dynamic subtest: pipe-B-eDP-1 [558.599815] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [558.611827] Starting dynamic subtest: pipe-C-eDP-1 [558.633689] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [558.642396] Starting dynamic subtest: pipe-D-eDP-1 [558.664134] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [558.668471] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.005s) [560.781388] [081/131] (463s left) gen9_exec_parse (cmd-crossing-page) [560.832185] Subtest cmd-crossing-page: SKIP (0.000s) [560.901334] [082/131] (462s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip) [560.988085] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip [560.992556] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [561.085664] [083/131] (462s left) prime_busy (hang-wait) [561.151481] Starting subtest: hang-wait [561.153834] Starting dynamic subtest: rcs0 [587.347609] Dynamic subtest rcs0: SUCCESS (26.342s) [587.358455] Starting dynamic subtest: bcs0 [594.536844] Dynamic subtest bcs0: SUCCESS (7.198s) [594.547809] Starting dynamic subtest: vcs0 [601.510823] Dynamic subtest vcs0: SUCCESS (6.978s) [601.521526] Starting dynamic subtest: vcs1 [608.486219] Dynamic subtest vcs1: SUCCESS (6.976s) [608.497264] Starting dynamic subtest: vecs0 [615.518997] Dynamic subtest vecs0: SUCCESS (7.032s) [615.529574] Starting dynamic subtest: ccs0 [629.356640] Dynamic subtest ccs0: SUCCESS (13.841s) [629.359238] Subtest hang-wait: SUCCESS (68.385s) [629.481986] [084/131] (394s left) perf_pmu (init-busy) [629.527363] Starting subtest: init-busy [629.529748] Starting dynamic subtest: rcs0 [629.532075] Dynamic subtest rcs0: SUCCESS (0.002s) [629.550673] Starting dynamic subtest: bcs0 [629.552954] Dynamic subtest bcs0: SUCCESS (0.000s) [629.571913] Starting dynamic subtest: vcs0 [629.574523] Dynamic subtest vcs0: SUCCESS (0.000s) [629.593167] Starting dynamic subtest: vcs1 [629.595382] Dynamic subtest vcs1: SUCCESS (0.000s) [629.613457] Starting dynamic subtest: vecs0 [629.615703] Dynamic subtest vecs0: SUCCESS (0.001s) [629.633991] Starting dynamic subtest: ccs0 [629.636188] Dynamic subtest ccs0: SUCCESS (0.000s) [629.638276] Subtest init-busy: SUCCESS (0.008s) [629.719364] [085/131] (394s left) gem_partial_pwrite_pread (writes-after-reads-uncached) [629.796211] Subtest writes-after-reads-uncached: SKIP (0.000s) [629.871265] [086/131] (394s left) gem_userptr_blits (stress-mm-invalidate-close) [629.941633] Starting subtest: stress-mm-invalidate-close [632.091719] Subtest stress-mm-invalidate-close: SUCCESS (2.148s) [632.236927] [087/131] (391s left) gem_exec_whisper (basic-fds-priority) [632.300866] Starting subtest: basic-fds-priority [656.293267] Subtest basic-fds-priority: SUCCESS (24.000s) [656.480173] [088/131] (367s left) api_intel_bb (lot-of-buffers) [656.533116] Starting subtest: lot-of-buffers [657.601664] Subtest lot-of-buffers: SUCCESS (1.070s) [658.334564] [089/131] (365s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs) [658.433876] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs [658.435773] Starting dynamic subtest: pipe-A-eDP-1 [658.707187] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.242s) [658.717305] Starting dynamic subtest: pipe-B-eDP-1 [659.922977] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.216s) [659.932608] Starting dynamic subtest: pipe-C-eDP-1 [661.200959] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.278s) [661.212181] Starting dynamic subtest: pipe-D-eDP-1 [662.396261] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.194s) [662.398300] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.936s) [663.571339] [090/131] (360s left) gem_exec_schedule (fifo) [663.646139] Starting subtest: fifo [663.648163] Starting dynamic subtest: rcs0 [663.744744] Dynamic subtest rcs0: SUCCESS (0.104s) [663.761493] Starting dynamic subtest: vcs0 [663.823102] Dynamic subtest vcs0: SUCCESS (0.078s) [663.832779] Starting dynamic subtest: vcs1 [663.907864] Dynamic subtest vcs1: SUCCESS (0.084s) [663.920777] Starting dynamic subtest: vecs0 [663.984917] Dynamic subtest vecs0: SUCCESS (0.075s) [663.998515] Starting dynamic subtest: ccs0 [664.076410] Dynamic subtest ccs0: SUCCESS (0.091s) [664.078596] Subtest fifo: SUCCESS (0.437s) [665.005530] [091/131] (359s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc) [665.108201] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc [665.112439] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [665.220399] [092/131] (359s left) gem_lmem_swapping (verify-ccs) [665.268639] Subtest verify-ccs: SKIP (0.000s) [665.318829] [093/131] (359s left) kms_dsc (dsc-basic) [665.430071] Starting subtest: dsc-basic [665.442630] Subtest dsc-basic: SKIP (0.000s) [665.507874] [094/131] (358s left) sysfs_timeslice_duration (idempotent) [665.564734] Starting subtest: idempotent [665.566916] Starting dynamic subtest: vecs0 [665.569305] Dynamic subtest vecs0: SUCCESS (0.000s) [665.579640] Starting dynamic subtest: ccs0 [665.581493] Dynamic subtest ccs0: SUCCESS (0.000s) [665.590769] Starting dynamic subtest: vcs0 [665.592596] Dynamic subtest vcs0: SUCCESS (0.000s) [665.601297] Starting dynamic subtest: bcs0 [665.603105] Dynamic subtest bcs0: SUCCESS (0.000s) [665.611864] Starting dynamic subtest: rcs0 [665.613656] Dynamic subtest rcs0: SUCCESS (0.000s) [665.622852] Starting dynamic subtest: vcs1 [665.624958] Dynamic subtest vcs1: SUCCESS (0.000s) [665.627082] Subtest idempotent: SUCCESS (0.006s) [665.679927] [095/131] (358s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt) [665.774552] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt [665.778950] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [665.869919] [096/131] (358s left) gem_mmap_offset (mmap-unmap) [665.929498] Starting subtest: mmap-unmap [665.931686] Starting dynamic subtest: smem0 [688.538481] Dynamic subtest smem0: SUCCESS (22.613s) [688.541076] Subtest mmap-unmap: SUCCESS (22.614s) [688.647335] [097/131] (335s left) kms_chamelium_frames (dp-frame-dump) [689.037366] Subtest dp-frame-dump: SKIP (0.000s) [689.850028] [098/131] (334s left) kms_hdr (bpc-switch-dpms) [689.945453] Starting subtest: bpc-switch-dpms [691.010803] Starting dynamic subtest: pipe-A-eDP-1 [695.416844] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.409s) [695.419106] Subtest bpc-switch-dpms: SUCCESS (5.477s) [695.529629] [099/131] (329s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d) [695.627928] Starting subtest: plane-lut1d-ctm3x4-lut1d [695.752385] Starting dynamic subtest: pipe-A-plane-0 [695.939939] Dynamic subtest pipe-A-plane-0: SUCCESS (0.188s) [695.950156] Starting dynamic subtest: pipe-A-plane-1 [696.073298] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s) [696.083071] Starting dynamic subtest: pipe-A-plane-2 [696.206214] Dynamic subtest pipe-A-plane-2: SUCCESS (0.132s) [697.436251] Starting dynamic subtest: pipe-B-plane-0 [697.637970] Dynamic subtest pipe-B-plane-0: SUCCESS (0.211s) [697.647827] Starting dynamic subtest: pipe-B-plane-1 [697.815673] Dynamic subtest pipe-B-plane-1: SUCCESS (0.177s) [697.825979] Starting dynamic subtest: pipe-B-plane-2 [697.949751] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s) [699.131693] Starting dynamic subtest: pipe-C-plane-0 [699.268214] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s) [699.278838] Starting dynamic subtest: pipe-C-plane-1 [699.413199] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s) [699.423187] Starting dynamic subtest: pipe-C-plane-2 [699.546610] Dynamic subtest pipe-C-plane-2: SUCCESS (0.132s) [700.725325] Starting dynamic subtest: pipe-D-plane-0 [700.850615] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s) [700.860344] Starting dynamic subtest: pipe-D-plane-1 [700.983989] Dynamic subtest pipe-D-plane-1: SUCCESS (0.133s) [700.993785] Starting dynamic subtest: pipe-D-plane-2 [701.117051] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s) [701.405599] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (5.779s) [702.264073] [100/131] (322s left) fbdev (pan) [702.307349] Starting subtest: pan [702.339763] Subtest pan: SUCCESS (0.034s) [702.409708] [101/131] (322s left) kms_cursor_edge_walk (128x128-left-edge) [702.510721] Starting subtest: 128x128-left-edge [702.512915] Starting dynamic subtest: pipe-A-eDP-1 [706.008747] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.500s) [706.018546] Starting dynamic subtest: pipe-D-eDP-1 [709.185637] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.176s) [709.187958] Subtest 128x128-left-edge: SUCCESS (6.679s) [710.060220] [102/131] (314s left) kms_lease (implicit-plane-lease) [710.163833] Starting subtest: implicit-plane-lease [710.165978] Subtest implicit-plane-lease: SUCCESS (0.002s) [710.291841] [103/131] (314s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu) [710.398659] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu [713.985555] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.594s) [715.175464] [104/131] (309s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling) [715.264057] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling [715.268091] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s) [715.336666] [105/131] (309s left) gem_exec_params (invalid-bsd2-flag-on-blt) [715.397118] Starting subtest: invalid-bsd2-flag-on-blt [715.399587] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s) [715.514432] [106/131] (309s left) gem_linear_blits (normal) [716.159682] Starting subtest: normal [720.066061] Subtest normal: SUCCESS (3.907s) [720.288224] [107/131] (304s left) gem_exec_parallel (fds) [720.393129] Starting subtest: fds [720.395600] Starting dynamic subtest: rcs0 [724.033309] Dynamic subtest rcs0: SUCCESS (3.640s) [724.045066] Starting dynamic subtest: bcs0 [727.708051] Dynamic subtest bcs0: SUCCESS (3.674s) [727.722028] Starting dynamic subtest: vcs0 [732.968563] Dynamic subtest vcs0: SUCCESS (5.260s) [732.978825] Starting dynamic subtest: vcs1 [737.284216] Dynamic subtest vcs1: SUCCESS (4.316s) [737.298030] Starting dynamic subtest: vecs0 [741.186889] Dynamic subtest vecs0: SUCCESS (3.901s) [741.198116] Starting dynamic subtest: ccs0 [745.166931] Dynamic subtest ccs0: SUCCESS (3.979s) [745.169983] Subtest fds: SUCCESS (24.783s) [745.365794] [108/131] (279s left) sw_sync (sync_merge_same) [745.421682] Starting subtest: sync_merge_same [745.424032] Subtest sync_merge_same: SUCCESS (0.000s) [745.486443] [109/131] (279s left) kms_dither (fb-8bpc-vs-panel-8bpc) [745.586054] Starting subtest: fb-8bpc-vs-panel-8bpc [745.588366] Starting dynamic subtest: pipe-A-eDP-1 [745.914418] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.330s) [745.916761] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (0.332s) [746.739059] [110/131] (278s left) gem_exec_params (secure-non-master) [746.808807] Starting subtest: secure-non-master [746.813365] Subtest secure-non-master: SKIP (0.000s) [746.916121] [111/131] (278s left) kms_universal_plane (universal-plane-functional) [747.003920] Starting subtest: universal-plane-functional [747.006213] Starting dynamic subtest: pipe-A-eDP-1 [750.826335] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.821s) [750.844010] Starting dynamic subtest: pipe-B-eDP-1 [755.355549] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.529s) [755.366903] Starting dynamic subtest: pipe-C-eDP-1 [759.671671] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.315s) [759.682881] Starting dynamic subtest: pipe-D-eDP-1 [763.974041] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.303s) [763.976595] Subtest universal-plane-functional: SUCCESS (16.976s) [764.840805] [112/131] (260s left) kms_vblank (crtc-id) [764.942179] Starting subtest: crtc-id [764.944062] Starting dynamic subtest: pipe-A-eDP-1 [765.393756] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.452s) [765.410041] Starting dynamic subtest: pipe-D-eDP-1 [766.531931] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.134s) [766.533858] Subtest crtc-id: SUCCESS (1.590s) [767.326907] [113/131] (257s left) gem_spin_batch (resubmit-new) [767.383569] Starting subtest: resubmit-new [767.385875] Starting dynamic subtest: rcs0 [767.391574] Dynamic subtest rcs0: SUCCESS (0.008s) [767.403611] Starting dynamic subtest: bcs0 [767.405908] Dynamic subtest bcs0: SUCCESS (0.004s) [767.417521] Starting dynamic subtest: vcs0 [767.419802] Dynamic subtest vcs0: SUCCESS (0.005s) [767.429758] Starting dynamic subtest: vcs1 [767.432068] Dynamic subtest vcs1: SUCCESS (0.004s) [767.441748] Starting dynamic subtest: vecs0 [767.444020] Dynamic subtest vecs0: SUCCESS (0.005s) [767.453652] Starting dynamic subtest: ccs0 [767.455893] Dynamic subtest ccs0: SUCCESS (0.005s) [767.458194] Subtest resubmit-new: SUCCESS (0.036s) [768.954816] [114/131] (256s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted) [769.020836] Starting subtest: invalid-multi-wait-unsubmitted-submitted [769.022798] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [769.145882] [115/131] (256s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled) [769.206618] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled [769.208824] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s) [769.320209] [116/131] (256s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt) [769.409762] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt [769.414216] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [769.529736] [117/131] (255s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt) [769.632878] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt [769.637362] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [769.720480] [118/131] (255s left) kms_flip (2x-flip-vs-rmfb) [769.813622] Starting subtest: 2x-flip-vs-rmfb [769.825671] Subtest 2x-flip-vs-rmfb: SKIP (0.011s) [769.909223] [119/131] (255s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu) [770.002692] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu [776.687473] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.688s) [776.815059] [120/131] (248s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier) [776.901697] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier [776.927876] Starting dynamic subtest: pipe-A-plane-0 [777.360411] Dynamic subtest pipe-A-plane-0: SUCCESS (0.433s) [777.371463] Starting dynamic subtest: pipe-A-plane-3 [777.627136] Dynamic subtest pipe-A-plane-3: SUCCESS (0.265s) [777.638544] Starting dynamic subtest: pipe-A-plane-5 [777.643258] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [778.704058] Starting dynamic subtest: pipe-B-plane-0 [779.160998] Dynamic subtest pipe-B-plane-0: SUCCESS (0.466s) [779.171849] Starting dynamic subtest: pipe-B-plane-3 [779.438569] Dynamic subtest pipe-B-plane-3: SUCCESS (0.276s) [779.449820] Starting dynamic subtest: pipe-B-plane-5 [779.454412] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [779.748828] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.848s) [780.628548] [121/131] (244s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping) [780.724418] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping [780.728951] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.000s) [780.813168] [122/131] (244s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [780.937667] Starting subtest: basic-flip-after-cursor-legacy [781.879357] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.940s) [782.726126] [123/131] (242s left) kms_psr (pr-sprite-plane-move) [782.834389] Starting subtest: pr-sprite-plane-move [782.838518] Subtest pr-sprite-plane-move: SKIP (0.000s) [782.915251] [124/131] (242s left) kms_plane_scaling (planes-upscale-factor-0-25) [783.010373] Starting subtest: planes-upscale-factor-0-25 [783.012655] Starting dynamic subtest: pipe-A [783.070353] Dynamic subtest pipe-A: SUCCESS (0.062s) [783.084660] Starting dynamic subtest: pipe-B [784.211387] Dynamic subtest pipe-B: SUCCESS (1.139s) [784.224059] Starting dynamic subtest: pipe-C [785.295123] Dynamic subtest pipe-C: SUCCESS (1.082s) [785.305481] Starting dynamic subtest: pipe-D [786.399495] Dynamic subtest pipe-D: SUCCESS (1.104s) [786.402614] Subtest planes-upscale-factor-0-25: SUCCESS (3.393s) [787.618886] [125/131] (238s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt) [787.711777] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt [787.715743] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [787.811908] [126/131] (237s left) kms_psr (fbc-psr-cursor-render) [787.903415] Starting subtest: fbc-psr-cursor-render [787.905822] Starting dynamic subtest: eDP-1 [787.910315] Dynamic subtest eDP-1: SKIP (0.000s) [787.914830] Subtest fbc-psr-cursor-render: SKIP (0.001s) [787.975845] [127/131] (237s left) syncobj_basic (bad-fd-to-handle) [788.030117] Starting subtest: bad-fd-to-handle [788.032268] Subtest bad-fd-to-handle: SUCCESS (0.000s) [788.127157] [128/131] (237s left) kms_cursor_crc (cursor-rapid-movement-max-size) [788.438826] Starting subtest: cursor-rapid-movement-max-size [788.445411] Subtest cursor-rapid-movement-max-size: SKIP (0.000s) [788.562114] [129/131] (237s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa [788.616310] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled [788.722385] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.106s) [788.800929] [130/131] (237s left) drm_read (short-buffer-block) [788.940185] Starting subtest: short-buffer-block [788.942470] Subtest short-buffer-block: SUCCESS (0.000s) [789.065430] [131/131] (236s left) kms_pm_dc (dc9-dpms) [790.154550] Starting subtest: dc9-dpms [791.592069] Subtest dc9-dpms: SUCCESS (1.438s) [791.689477] Closing watchdogs results: parsing output: 0/ for test: gem_render_copy results: parsing output: 1/ for test: gem_exec_balancer results: parsing output: 2/ for test: i915_drm_fdinfo results: parsing output: 3/ for test: gem_ccs results: parsing output: 4/ for test: kms_psr2_sf results: parsing output: 5/ for test: kms_cursor_legacy results: parsing output: 6/ for test: kms_big_fb results: parsing output: 7/ for test: kms_rmfb results: parsing output: 8/ for test: kms_frontbuffer_tracking results: parsing output: 9/ for test: kms_async_flips results: parsing output: 10/ for test: kms_frontbuffer_tracking results: parsing output: 11/ for test: gem_mmap_wc results: parsing output: 12/ for test: i915_pm_rpm results: parsing output: 13/ for test: kms_big_fb results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: syncobj_timeline results: parsing output: 16/ for test: kms_vblank results: parsing output: 17/ for test: gem_exec_schedule results: parsing output: 18/ for test: kms_pipe_crc_basic results: parsing output: 19/ for test: gem_set_tiling_vs_blt results: parsing output: 20/ for test: kms_content_protection results: parsing output: 21/ for test: kms_ccs results: parsing output: 22/ for test: kms_flip_scaled_crc results: parsing output: 23/ for test: kms_addfb_basic results: parsing output: 24/ for test: kms_atomic results: parsing output: 25/ for test: kms_rotation_crc results: parsing output: 26/ for test: syncobj_timeline results: parsing output: 27/ for test: syncobj_wait results: parsing output: 28/ for test: kms_chamelium_audio results: parsing output: 29/ for test: kms_busy results: parsing output: 30/ for test: kms_ccs results: parsing output: 31/ for test: perf results: parsing output: 32/ for test: kms_hdr results: parsing output: 33/ for test: kms_frontbuffer_tracking results: parsing output: 34/ for test: kms_flip results: parsing output: 35/ for test: kms_big_fb results: parsing output: 36/ for test: kms_vrr results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: core_sysfs results: parsing output: 40/ for test: kms_big_fb results: parsing output: 41/ for test: kms_cursor_crc results: parsing output: 42/ for test: kms_big_fb results: parsing output: 43/ for test: kms_addfb_basic results: parsing output: 44/ for test: gem_ctx_freq results: parsing output: 45/ for test: i915_selftest results: parsing output: 46/ for test: gem_exec_schedule results: parsing output: 47/ for test: kms_psr2_sf results: parsing output: 48/ for test: kms_frontbuffer_tracking results: parsing output: 49/ for test: kms_psr results: parsing output: 50/ for test: kms_frontbuffer_tracking results: parsing output: 51/ for test: gem_exec_fence results: parsing output: 52/ for test: kms_cursor_legacy results: parsing output: 53/ for test: gem_exec_capture results: parsing output: 54/ for test: kms_psr results: parsing output: 55/ for test: gen3_render_linear_blits results: parsing output: 56/ for test: gem_lmem_evict results: parsing output: 57/ for test: kms_frontbuffer_tracking results: parsing output: 58/ for test: kms_frontbuffer_tracking results: parsing output: 59/ for test: gem_exec_fence results: parsing output: 60/ for test: kms_rotation_crc results: parsing output: 61/ for test: kms_frontbuffer_tracking results: parsing output: 62/ for test: kms_prop_blob results: parsing output: 63/ for test: gem_pxp results: parsing output: 64/ for test: kms_force_connector_basic results: parsing output: 65/ for test: api_intel_bb results: parsing output: 66/ for test: drm_read results: parsing output: 67/ for test: kms_chamelium_hpd results: parsing output: 68/ for test: syncobj_timeline results: parsing output: 69/ for test: i915_drm_fdinfo results: parsing output: 70/ for test: kms_psr results: parsing output: 71/ for test: kms_plane_scaling results: parsing output: 72/ for test: gen7_exec_parse results: parsing output: 73/ for test: gem_mmap results: parsing output: 74/ for test: gem_ctx_bad_destroy results: parsing output: 75/ for test: gem_ctx_persistence results: parsing output: 76/ for test: kms_flip results: parsing output: 77/ for test: gem_eio results: parsing output: 78/ for test: syncobj_timeline results: parsing output: 79/ for test: kms_ccs results: parsing output: 80/ for test: gen9_exec_parse results: parsing output: 81/ for test: kms_big_fb results: parsing output: 82/ for test: prime_busy results: parsing output: 83/ for test: perf_pmu results: parsing output: 84/ for test: gem_partial_pwrite_pread results: parsing output: 85/ for test: gem_userptr_blits results: parsing output: 86/ for test: gem_exec_whisper results: parsing output: 87/ for test: api_intel_bb results: parsing output: 88/ for test: kms_ccs results: parsing output: 89/ for test: gem_exec_schedule results: parsing output: 90/ for test: kms_frontbuffer_tracking results: parsing output: 91/ for test: gem_lmem_swapping results: parsing output: 92/ for test: kms_dsc results: parsing output: 93/ for test: sysfs_timeslice_duration results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: gem_mmap_offset results: parsing output: 96/ for test: kms_chamelium_frames results: parsing output: 97/ for test: kms_hdr results: parsing output: 98/ for test: kms_color_pipeline results: parsing output: 99/ for test: fbdev results: parsing output: 100/ for test: kms_cursor_edge_walk results: parsing output: 101/ for test: kms_lease results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: kms_flip_scaled_crc results: parsing output: 104/ for test: gem_exec_params results: parsing output: 105/ for test: gem_linear_blits results: parsing output: 106/ for test: gem_exec_parallel results: parsing output: 107/ for test: sw_sync results: parsing output: 108/ for test: kms_dither results: parsing output: 109/ for test: gem_exec_params results: parsing output: 110/ for test: kms_universal_plane results: parsing output: 111/ for test: kms_vblank results: parsing output: 112/ for test: gem_spin_batch results: parsing output: 113/ for test: syncobj_wait results: parsing output: 114/ for test: syncobj_wait results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: kms_frontbuffer_tracking results: parsing output: 117/ for test: kms_flip results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: kms_plane results: parsing output: 120/ for test: kms_plane results: parsing output: 121/ for test: kms_cursor_legacy results: parsing output: 122/ for test: kms_psr results: parsing output: 123/ for test: kms_plane_scaling results: parsing output: 124/ for test: kms_frontbuffer_tracking results: parsing output: 125/ for test: kms_psr results: parsing output: 126/ for test: syncobj_basic results: parsing output: 127/ for test: kms_cursor_crc results: parsing output: 128/ for test: syncobj_timeline results: parsing output: 129/ for test: drm_read results: parsing output: 130/ for test: kms_pm_dc Done.