[56.154317] Initializing watchdogs [56.154365] /dev/watchdog0 [56.170292] [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] [56.175035] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [56.177441] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [56.181442] [001/156] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render) [56.313365] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render [56.317893] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [56.432191] [002/156] (960s left) i915_drm_fdinfo (idle) [56.472721] Starting subtest: idle [56.475112] Starting dynamic subtest: rcs0 [57.056091] Dynamic subtest rcs0: SUCCESS (0.573s) [57.065052] Starting dynamic subtest: bcs0 [57.569968] Dynamic subtest bcs0: SUCCESS (0.503s) [57.578264] Starting dynamic subtest: vcs0 [58.083808] Dynamic subtest vcs0: SUCCESS (0.505s) [58.094378] Starting dynamic subtest: vcs1 [58.595111] Dynamic subtest vcs1: SUCCESS (0.504s) [58.605427] Starting dynamic subtest: vecs0 [59.105817] Dynamic subtest vecs0: SUCCESS (0.503s) [59.115749] Starting dynamic subtest: ccs0 [59.613865] Dynamic subtest ccs0: SUCCESS (0.502s) [59.616504] Subtest idle: SUCCESS (3.095s) [59.691860] [003/156] (957s left) syncobj_wait (wait-all-for-submit-snapshot) [59.748923] Starting subtest: wait-all-for-submit-snapshot [59.831422] Subtest wait-all-for-submit-snapshot: SUCCESS (0.081s) [59.907377] [004/156] (956s left) syncobj_wait (invalid-multi-wait-unsubmitted) [59.967036] Starting subtest: invalid-multi-wait-unsubmitted [59.969468] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s) [60.068173] [005/156] (956s left) kms_chamelium_edid (hdmi-mode-timings) [60.457428] Subtest hdmi-mode-timings: SKIP (0.000s) [61.321469] [006/156] (955s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt) [61.426911] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt [61.431365] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [61.544220] [007/156] (955s left) kms_psr (psr2-suspend) [61.637684] Starting subtest: psr2-suspend [61.639968] Starting dynamic subtest: eDP-1 [79.217133] Dynamic subtest eDP-1: SUCCESS (2.957s) [79.219642] Subtest psr2-suspend: SUCCESS (2.958s) [80.114849] [008/156] (936s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs) [80.228835] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs [80.231314] Starting dynamic subtest: pipe-A-eDP-1 [80.255082] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [80.265845] Starting dynamic subtest: pipe-B-eDP-1 [80.288237] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [80.297633] Starting dynamic subtest: pipe-C-eDP-1 [80.320601] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [80.329830] Starting dynamic subtest: pipe-D-eDP-1 [80.353452] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [80.360372] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.003s) [82.554029] [009/156] (934s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled) [82.604632] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled [82.706590] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.100s) [82.781151] [010/156] (934s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-indfb-pgflip-blt) [82.882894] Starting subtest: hdr-2p-scndscrn-indfb-pgflip-blt [82.887340] Subtest hdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [82.983021] [011/156] (934s left) gem_exec_params (invalid-flag) [83.038098] Starting subtest: invalid-flag [83.040442] Subtest invalid-flag: SUCCESS (0.000s) [83.137029] [012/156] (933s left) gem_exec_schedule (preemptive-hang) [83.311402] Starting subtest: preemptive-hang [83.313966] Starting dynamic subtest: rcs0 [93.046461] Dynamic subtest rcs0: SUCCESS (9.634s) [93.058179] Starting dynamic subtest: bcs0 [101.998081] Dynamic subtest bcs0: SUCCESS (8.927s) [102.013495] Starting dynamic subtest: vcs0 [111.022918] Dynamic subtest vcs0: SUCCESS (9.013s) [111.033789] Starting dynamic subtest: vcs1 [119.985085] Dynamic subtest vcs1: SUCCESS (8.956s) [119.997859] Starting dynamic subtest: vecs0 [129.008561] Dynamic subtest vecs0: SUCCESS (9.022s) [129.018167] Starting dynamic subtest: ccs0 [138.035067] Dynamic subtest ccs0: SUCCESS (9.024s) [138.037879] Subtest preemptive-hang: SUCCESS (54.579s) [138.277752] [013/156] (878s left) gem_softpin (evict-active-interruptible) [138.341386] Starting subtest: evict-active-interruptible [138.351579] Subtest evict-active-interruptible: SUCCESS (0.010s) [138.474358] [014/156] (878s left) kms_plane_alpha_blend (alpha-basic) [138.575180] Starting subtest: alpha-basic [138.865609] Starting dynamic subtest: pipe-A-eDP-1 [140.802654] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.934s) [140.831905] Starting dynamic subtest: pipe-D-eDP-1 [143.479439] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.653s) [143.481825] Subtest alpha-basic: SUCCESS (4.901s) [144.362402] [015/156] (872s left) i915_drm_fdinfo (virtual-busy-idle) [144.414451] Starting subtest: virtual-busy-idle [144.418858] Subtest virtual-busy-idle: SKIP (0.000s) [144.497343] [016/156] (872s left) gem_exec_schedule (smoketest) [144.689664] Starting subtest: smoketest [144.692392] Starting dynamic subtest: rcs0 [150.297046] Dynamic subtest rcs0: SUCCESS (5.500s) [150.307752] Starting dynamic subtest: bcs0 [155.748917] Dynamic subtest bcs0: SUCCESS (5.497s) [155.759455] Starting dynamic subtest: vcs0 [161.293644] Dynamic subtest vcs0: SUCCESS (5.492s) [161.304822] Starting dynamic subtest: vcs1 [166.791500] Dynamic subtest vcs1: SUCCESS (5.495s) [166.804364] Starting dynamic subtest: vecs0 [172.293175] Dynamic subtest vecs0: SUCCESS (5.500s) [172.303504] Starting dynamic subtest: ccs0 [177.801095] Dynamic subtest ccs0: SUCCESS (5.504s) [177.803835] Subtest smoketest: SUCCESS (32.994s) [177.936398] [017/156] (839s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-render) [178.043370] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-render [178.048031] Subtest hdr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [178.147068] [018/156] (839s left) gem_fence_thrash (bo-write-verify-threaded-x) [178.180282] Starting subtest: bo-write-verify-threaded-x [178.194989] Subtest bo-write-verify-threaded-x: SKIP (0.012s) [178.265248] [019/156] (839s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [178.362203] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt [178.366257] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [178.471958] [020/156] (838s left) kms_setmode (basic) [178.523425] Starting subtest: basic [178.882710] Starting dynamic subtest: pipe-A-eDP-1 [182.484774] Dynamic subtest pipe-A-eDP-1: FAIL (3.489s) [182.710596] Starting dynamic subtest: pipe-B-eDP-1 [184.829805] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.126s) [185.136914] Subtest basic: FAIL (6.615s) [185.982376] [021/156] (831s left) kms_rotation_crc (primary-y-tiled-reflect-x-270) [186.084205] Starting subtest: primary-y-tiled-reflect-x-270 [186.088611] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s) [186.168006] [022/156] (831s left) gem_mmap_wc (read-write-distinct) [186.218848] Subtest read-write-distinct: SKIP (0.000s) [186.274746] [023/156] (831s left) gem_exec_flush (basic-wb-prw-default) [186.335108] Starting subtest: basic-wb-prw-default [191.819500] Subtest basic-wb-prw-default: SUCCESS (5.467s) [191.985441] [024/156] (825s left) kms_color (invalid-degamma-lut-sizes) [192.075675] Starting subtest: invalid-degamma-lut-sizes [192.078079] Starting dynamic subtest: pipe-A [192.377023] Dynamic subtest pipe-A: SUCCESS (0.301s) [192.387113] Starting dynamic subtest: pipe-B [192.389432] Dynamic subtest pipe-B: SUCCESS (0.000s) [192.398401] Starting dynamic subtest: pipe-C [192.400734] Dynamic subtest pipe-C: SUCCESS (0.000s) [192.409761] Starting dynamic subtest: pipe-D [192.412059] Dynamic subtest pipe-D: SUCCESS (0.000s) [192.414287] Subtest invalid-degamma-lut-sizes: SUCCESS (0.303s) [193.212038] [025/156] (824s left) sw_sync (sync_multi_producer_single_consumer) [193.254133] Starting subtest: sync_multi_producer_single_consumer [194.329531] Subtest sync_multi_producer_single_consumer: SUCCESS (1.076s) [194.388424] [026/156] (823s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite) [194.491815] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite [194.496411] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [194.582672] [027/156] (823s left) kms_content_protection (dp-mst-type-0) [194.730877] Starting subtest: dp-mst-type-0 [194.735415] Subtest dp-mst-type-0: SKIP (0.000s) [194.858971] [028/156] (822s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-indfb-msflip-blt) [194.962617] Starting subtest: fbcpsrhdr-2p-scndscrn-indfb-msflip-blt [194.967407] Subtest fbcpsrhdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s) [195.073105] [029/156] (822s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation) [195.163129] Starting subtest: plane-upscale-factor-0-25-with-rotation [195.165837] Starting dynamic subtest: pipe-A [195.387959] Dynamic subtest pipe-A: SUCCESS (0.227s) [195.396381] Starting dynamic subtest: pipe-B [196.699871] Dynamic subtest pipe-B: SUCCESS (1.312s) [196.711990] Starting dynamic subtest: pipe-C [198.018205] Dynamic subtest pipe-C: SUCCESS (1.318s) [198.030687] Starting dynamic subtest: pipe-D [199.351324] Dynamic subtest pipe-D: SUCCESS (1.333s) [199.353809] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.191s) [200.521962] [030/156] (817s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc) [200.626105] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc [204.951026] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.330s) [206.124980] [031/156] (811s left) perf (invalid-oa-format-id) [206.237229] Starting subtest: invalid-oa-format-id [206.248738] Subtest invalid-oa-format-id: SUCCESS (0.012s) [206.288327] [032/156] (811s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc) [206.388658] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc [206.391047] Starting dynamic subtest: pipe-A-eDP-1 [206.414474] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [206.426667] Starting dynamic subtest: pipe-B-eDP-1 [206.449039] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [206.457968] Starting dynamic subtest: pipe-C-eDP-1 [206.479847] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [206.488761] Starting dynamic subtest: pipe-D-eDP-1 [206.511655] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [206.515755] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s) [208.684808] [033/156] (809s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size) [208.806302] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size [209.782916] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.975s) [210.615492] [034/156] (807s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-blt) [210.710109] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-blt [210.713966] Subtest psrhdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s) [210.820241] [035/156] (807s left) kms_lease (lease-unleased-crtc) [210.921302] Starting subtest: lease-unleased-crtc [210.923441] Starting dynamic subtest: pipe-A-eDP-1 [211.211559] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.290s) [211.222654] Starting dynamic subtest: pipe-B-eDP-1 [211.948414] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.733s) [211.958905] Starting dynamic subtest: pipe-C-eDP-1 [211.961539] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.005s) [211.970676] Starting dynamic subtest: pipe-D-eDP-1 [211.973258] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.005s) [211.975564] Subtest lease-unleased-crtc: SUCCESS (1.038s) [212.335620] [036/156] (805s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted) [212.392396] Starting subtest: etime-multi-wait-for-submit-unsubmitted [212.497717] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.103s) [212.587557] [037/156] (805s left) kms_psr2_sf (pr-cursor-plane-update-sf) [212.686037] Starting subtest: pr-cursor-plane-update-sf [212.690582] Subtest pr-cursor-plane-update-sf: SKIP (0.000s) [212.754768] [038/156] (805s left) perf_pmu (busy-idle) [212.797360] Starting subtest: busy-idle [212.799536] Starting dynamic subtest: rcs0 [213.495487] Dynamic subtest rcs0: SUCCESS (0.700s) [213.507772] Starting dynamic subtest: bcs0 [214.161685] Dynamic subtest bcs0: SUCCESS (0.665s) [214.173770] Starting dynamic subtest: vcs0 [215.878700] Dynamic subtest vcs0: SUCCESS (1.714s) [215.890981] Starting dynamic subtest: vcs1 [217.925365] Dynamic subtest vcs1: SUCCESS (2.045s) [217.937700] Starting dynamic subtest: vecs0 [219.909892] Dynamic subtest vecs0: SUCCESS (1.983s) [219.922712] Starting dynamic subtest: ccs0 [220.572183] Dynamic subtest ccs0: SUCCESS (0.662s) [220.574712] Subtest busy-idle: SUCCESS (7.777s) [220.678758] [039/156] (797s left) kms_plane (plane-panning-bottom-right) [220.772829] Starting subtest: plane-panning-bottom-right [220.775246] Starting dynamic subtest: pipe-A [222.501454] Dynamic subtest pipe-A: SUCCESS (1.727s) [222.513289] Starting dynamic subtest: pipe-B [224.930848] Dynamic subtest pipe-B: SUCCESS (2.428s) [224.933573] Subtest plane-panning-bottom-right: SUCCESS (4.158s) [225.743763] [040/156] (792s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping) [225.840523] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping [225.844998] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (0.000s) [225.913553] [041/156] (792s left) gem_readwrite (new-obj) [225.974131] Subtest new-obj: SKIP (0.000s) [226.027795] [042/156] (792s left) kms_big_fb (yf-tiled-16bpp-rotate-90) [226.132347] Starting subtest: yf-tiled-16bpp-rotate-90 [226.136729] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s) [226.238009] [043/156] (792s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling) [226.322660] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling [226.327425] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.000s) [226.418072] [044/156] (792s left) kms_frontbuffer_tracking (hdr-2p-primscrn-shrfb-msflip-blt) [226.529702] Starting subtest: hdr-2p-primscrn-shrfb-msflip-blt [226.534391] Subtest hdr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [226.616734] [045/156] (791s left) kms_big_fb (x-tiled-8bpp-rotate-90) [226.728710] Starting subtest: x-tiled-8bpp-rotate-90 [226.749398] Subtest x-tiled-8bpp-rotate-90: SKIP (0.020s) [226.885705] [046/156] (791s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt) [226.984648] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt [226.988177] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [227.084058] [047/156] (791s left) kms_flip (flip-vs-blocking-wf-vblank) [227.171434] Starting subtest: flip-vs-blocking-wf-vblank [227.173490] Starting dynamic subtest: A-eDP1 [236.093397] Dynamic subtest A-eDP1: SUCCESS (8.920s) [236.105057] Starting dynamic subtest: B-eDP1 [245.027928] Dynamic subtest B-eDP1: SUCCESS (8.932s) [245.039635] Starting dynamic subtest: C-eDP1 [253.992257] Dynamic subtest C-eDP1: SUCCESS (8.915s) [254.002134] Starting dynamic subtest: D-eDP1 [262.877055] Dynamic subtest D-eDP1: SUCCESS (8.923s) [262.879082] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.702s) [264.103212] [048/156] (754s left) gem_ctx_param (non-root-set) [264.153843] Starting subtest: non-root-set [264.170873] Subtest non-root-set: SUCCESS (0.020s) [264.256833] [049/156] (754s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-move) [264.357159] Starting subtest: fbchdr-2p-primscrn-cur-indfb-move [264.361607] Subtest fbchdr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [264.452596] [050/156] (754s left) syncobj_wait (reset-multiple-signaled) [264.506547] Starting subtest: reset-multiple-signaled [264.508851] Subtest reset-multiple-signaled: SUCCESS (0.001s) [264.606012] [051/156] (754s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [264.709549] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu [264.713822] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [264.805315] [052/156] (753s left) kms_psr (pr-sprite-mmap-cpu) [264.900725] Starting subtest: pr-sprite-mmap-cpu [264.905238] Subtest pr-sprite-mmap-cpu: SKIP (0.000s) [264.970716] [053/156] (753s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [265.066348] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-mmap-gtt [265.069942] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [265.189238] [054/156] (753s left) kms_vrr (flip-basic) [265.277345] Starting subtest: flip-basic [265.282882] Subtest flip-basic: SKIP (0.000s) [265.351107] [055/156] (753s left) gem_ctx_exec (basic-invalid-context) [265.401304] Starting subtest: basic-invalid-context [265.405646] Subtest basic-invalid-context: SUCCESS (0.004s) [265.545250] [056/156] (753s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc) [265.640986] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc [265.644268] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [265.740890] [057/156] (753s left) gem_mmap_gtt (medium-copy) [265.791872] Subtest medium-copy: SKIP (0.000s) [265.850490] [058/156] (753s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt) [265.946321] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt [265.949955] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [266.049999] [059/156] (752s left) gem_ctx_persistence (legacy-engines-mixed) [266.111297] Starting subtest: legacy-engines-mixed [266.112991] Starting dynamic subtest: render [266.194828] Dynamic subtest render: SUCCESS (0.086s) [266.206748] Starting dynamic subtest: bsd1 [266.244106] Dynamic subtest bsd1: SUCCESS (0.047s) [266.254882] Starting dynamic subtest: bsd2 [266.297314] Dynamic subtest bsd2: SUCCESS (0.051s) [266.307920] Starting dynamic subtest: blt [266.352652] Dynamic subtest blt: SUCCESS (0.053s) [266.364468] Starting dynamic subtest: vebox [266.409487] Dynamic subtest vebox: SUCCESS (0.055s) [266.412044] Subtest legacy-engines-mixed: SUCCESS (0.301s) [266.498770] [060/156] (752s left) syncobj_timeline (invalid-transfer-bad-pad) [266.564131] Starting subtest: invalid-transfer-bad-pad [266.565856] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s) [266.662809] [061/156] (752s left) gem_exec_reloc (basic-wc-gtt-noreloc) [266.723767] Subtest basic-wc-gtt-noreloc: SKIP (0.000s) [266.810643] [062/156] (752s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-indfb-msflip-blt) [266.904652] Starting subtest: fbchdr-1p-primscrn-indfb-msflip-blt [266.908416] Subtest fbchdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s) [267.006655] [063/156] (752s left) gen9_exec_parse (secure-batches) [267.064849] Subtest secure-batches: SKIP (0.000s) [267.125665] [064/156] (752s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format) [267.215366] Starting subtest: plane-scaler-unity-scaling-with-pixel-format [267.217389] Starting dynamic subtest: pipe-A [268.342271] Dynamic subtest pipe-A: SUCCESS (1.128s) [268.352061] Starting dynamic subtest: pipe-B [270.552690] Dynamic subtest pipe-B: SUCCESS (2.209s) [270.562492] Starting dynamic subtest: pipe-C [271.797562] Dynamic subtest pipe-C: SUCCESS (1.243s) [271.807339] Starting dynamic subtest: pipe-D [273.036451] Dynamic subtest pipe-D: SUCCESS (1.238s) [273.038892] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.822s) [274.231696] [065/156] (745s left) api_intel_allocator (reserve-simple) [274.285230] Starting subtest: reserve-simple [274.287874] Subtest reserve-simple: SUCCESS (0.003s) [274.410389] [066/156] (744s left) kms_cursor_edge_walk (64x64-right-edge) [274.504748] Starting subtest: 64x64-right-edge [274.507185] Starting dynamic subtest: pipe-A-eDP-1 [278.009455] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.503s) [278.020827] Starting dynamic subtest: pipe-D-eDP-1 [281.221854] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.213s) [281.224018] Subtest 64x64-right-edge: SUCCESS (6.719s) [282.029412] [067/156] (737s left) kms_flip (2x-flip-vs-suspend) [282.130161] Starting subtest: 2x-flip-vs-suspend [282.136024] Subtest 2x-flip-vs-suspend: SKIP (0.002s) [282.230291] [068/156] (737s left) gem_exec_balancer (invalid-bonds) [282.290818] Starting subtest: invalid-bonds [282.295076] Subtest invalid-bonds: SKIP (0.000s) [282.603611] [069/156] (736s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled) [282.665578] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled [282.670065] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s) [282.867687] [070/156] (736s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot) [282.984616] Starting subtest: modeset-atomic-cursor-hotspot [282.989320] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s) [283.129057] [071/156] (736s left) perf (low-oa-exponent-permissions) [283.218444] Starting subtest: low-oa-exponent-permissions [283.255257] Subtest low-oa-exponent-permissions: SUCCESS (0.037s) [283.305989] [072/156] (736s left) gem_exec_fence (basic-wait-all) [283.367408] Starting subtest: basic-wait-all [283.473162] Subtest basic-wait-all: SUCCESS (0.106s) [284.932393] [FACT gem_exec_fence (basic-wait-all)] new: kernel.kmod_is_loaded.vgem: true [284.935802] [073/156] (734s left) gem_ctx_param (basic-default) [284.992835] Starting subtest: basic-default [284.995167] Subtest basic-default: SUCCESS (0.000s) [285.065883] [074/156] (734s left) kms_async_flips (async-flip-with-page-flip-events-tiled) [285.163317] Starting subtest: async-flip-with-page-flip-events-tiled [285.534503] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs [288.364577] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.774s) [288.376653] Starting dynamic subtest: pipe-A-eDP-1-4 [290.538819] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.174s) [290.553982] Starting dynamic subtest: pipe-A-eDP-1-4 [292.497302] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s) [292.510543] Starting dynamic subtest: pipe-A-eDP-1-x [294.739270] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.189s) [295.069898] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs [297.898673] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.784s) [297.912100] Starting dynamic subtest: pipe-B-eDP-1-4 [300.093577] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.193s) [300.105361] Starting dynamic subtest: pipe-B-eDP-1-4 [302.052564] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s) [302.062835] Starting dynamic subtest: pipe-B-eDP-1-x [304.305901] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.201s) [304.627671] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs [307.425740] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.754s) [307.438180] Starting dynamic subtest: pipe-C-eDP-1-4 [309.599504] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s) [309.609445] Starting dynamic subtest: pipe-C-eDP-1-4 [311.557580] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s) [311.571099] Starting dynamic subtest: pipe-C-eDP-1-x [313.787830] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s) [314.102295] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs [316.906351] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.815s) [316.919679] Starting dynamic subtest: pipe-D-eDP-1-4 [319.151401] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.184s) [319.168445] Starting dynamic subtest: pipe-D-eDP-1-4 [321.102008] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s) [321.112157] Starting dynamic subtest: pipe-D-eDP-1-x [323.291029] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.189s) [323.293881] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.126s) [324.495755] [075/156] (695s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt) [324.611047] Starting subtest: psr-rgb101010-draw-blt [332.059495] Subtest psr-rgb101010-draw-blt: SUCCESS (7.455s) [332.198700] [076/156] (687s left) kms_psr2_su (page_flip-xrgb8888) [332.261723] Subtest page_flip-XRGB8888: SKIP (0.000s) [332.324208] [077/156] (687s left) kms_async_flips (invalid-async-flip) [332.422736] Starting subtest: invalid-async-flip [332.793435] Starting dynamic subtest: pipe-A-eDP-1 [333.646967] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.855s) [334.005684] Starting dynamic subtest: pipe-B-eDP-1 [334.882447] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.886s) [335.242082] Starting dynamic subtest: pipe-C-eDP-1 [336.012903] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.779s) [336.368414] Starting dynamic subtest: pipe-D-eDP-1 [337.145350] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.788s) [337.147741] Subtest invalid-async-flip: SUCCESS (4.725s) [338.301693] [078/156] (681s left) gem_softpin (allocator-basic-reserve) [338.357290] Starting subtest: allocator-basic-reserve [338.436535] Subtest allocator-basic-reserve: SUCCESS (0.079s) [338.561110] [079/156] (681s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu) [338.663822] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu [342.288227] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.632s) [343.431228] [080/156] (676s left) gem_mmap_offset (partial-remap) [343.481427] Starting subtest: partial-remap [343.483355] Starting dynamic subtest: smem0 [343.492072] Dynamic subtest smem0: SUCCESS (0.004s) [343.493855] Subtest partial-remap: SUCCESS (0.006s) [343.613972] [081/156] (676s left) kms_prop_blob (basic) [343.670366] Starting subtest: basic [343.672442] Subtest basic: SUCCESS (0.000s) [343.796176] [082/156] (676s left) syncobj_timeline (single-wait-available-signaled) [343.845331] Starting subtest: single-wait-available-signaled [343.847517] Subtest single-wait-available-signaled: SUCCESS (0.000s) [343.948449] [083/156] (676s left) gem_unfence_active_buffers [344.124226] [084/156] (675s left) kms_lease (atomic-implicit-crtc) [344.211013] Starting subtest: atomic-implicit-crtc [344.213375] Starting dynamic subtest: pipe-A-eDP-1 [344.224715] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s) [344.237756] Starting dynamic subtest: pipe-B-eDP-1 [344.248964] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.011s) [344.258544] Starting dynamic subtest: pipe-C-eDP-1 [344.268761] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s) [344.278059] Starting dynamic subtest: pipe-D-eDP-1 [344.287956] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s) [344.289815] Subtest atomic-implicit-crtc: SUCCESS (0.037s) [344.375200] [085/156] (675s left) kms_cursor_crc (cursor-random-32x32) [344.524882] Starting subtest: cursor-random-32x32 [344.572231] Subtest cursor-random-32x32: SKIP (0.045s) [344.872746] [086/156] (675s left) gem_pxp (reject-modify-context-protection-on) [344.999800] Starting subtest: reject-modify-context-protection-on [345.002026] Subtest reject-modify-context-protection-on: SUCCESS (0.001s) [345.116989] [087/156] (675s left) gem_exec_balancer (bonded-chain) [345.181793] Starting subtest: bonded-chain [352.224531] Subtest bonded-chain: SUCCESS (7.040s) [352.557736] [088/156] (667s left) kms_pm_dc (dc5-dpms-negative) [353.659919] Starting subtest: dc5-dpms-negative [353.664414] Subtest dc5-dpms-negative: SKIP (0.000s) [353.734305] [089/156] (666s left) kms_flip (2x-plain-flip-ts-check) [353.833712] Starting subtest: 2x-plain-flip-ts-check [353.843860] Subtest 2x-plain-flip-ts-check: SKIP (0.012s) [353.939692] [090/156] (666s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-linear) [354.036089] Starting subtest: fbcpsrhdr-tiling-linear [354.040409] Subtest fbcpsrhdr-tiling-linear: SKIP (0.000s) [354.135838] [091/156] (666s left) kms_frontbuffer_tracking (fbcpsr-slowdraw) [354.233702] Starting subtest: fbcpsr-slowdraw [379.567121] Subtest fbcpsr-slowdraw: SUCCESS (25.338s) [379.698379] [092/156] (640s left) gem_ctx_isolation (nonpriv-switch) [379.760619] Starting subtest: nonpriv-switch [379.762969] Starting dynamic subtest: rcs0 [380.048381] Dynamic subtest rcs0: SUCCESS (0.287s) [380.060155] Starting dynamic subtest: bcs0 [380.353040] Dynamic subtest bcs0: SUCCESS (0.304s) [380.363062] Starting dynamic subtest: vcs0 [380.647677] Dynamic subtest vcs0: SUCCESS (0.293s) [380.658538] Starting dynamic subtest: vcs1 [382.146603] Dynamic subtest vcs1: SUCCESS (1.497s) [382.157582] Starting dynamic subtest: vecs0 [384.168457] Dynamic subtest vecs0: SUCCESS (2.020s) [384.182589] Starting dynamic subtest: ccs0 [386.198179] Dynamic subtest ccs0: SUCCESS (2.029s) [386.200609] Subtest nonpriv-switch: SUCCESS (6.437s) [386.449370] [093/156] (634s left) kms_universal_plane (universal-plane-sanity) [386.546986] Starting subtest: universal-plane-sanity [386.549373] Starting dynamic subtest: pipe-A-eDP-1 [387.141419] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.593s) [387.152560] Starting dynamic subtest: pipe-B-eDP-1 [388.362232] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.218s) [388.373332] Starting dynamic subtest: pipe-C-eDP-1 [389.568970] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.207s) [389.579812] Starting dynamic subtest: pipe-D-eDP-1 [390.811251] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.238s) [390.813214] Subtest universal-plane-sanity: SUCCESS (4.264s) [391.684237] [094/156] (628s left) gem_pxp (create-regular-context-1) [391.748334] Starting subtest: create-regular-context-1 [391.750823] Subtest create-regular-context-1: SUCCESS (0.001s) [391.848965] [095/156] (628s left) kms_frontbuffer_tracking (fbcpsrhdr-farfromfence-mmap-gtt) [391.953173] Starting subtest: fbcpsrhdr-farfromfence-mmap-gtt [391.957609] Subtest fbcpsrhdr-farfromfence-mmap-gtt: SKIP (0.000s) [392.057283] [096/156] (628s left) kms_cursor_crc (cursor-onscreen-32x10) [392.207463] Starting subtest: cursor-onscreen-32x10 [392.260179] Subtest cursor-onscreen-32x10: SKIP (0.047s) [392.525209] [097/156] (628s left) kms_big_fb (y-tiled-addfb-size-overflow) [392.625797] Starting subtest: y-tiled-addfb-size-overflow [392.629579] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s) [392.722983] [098/156] (628s left) kms_feature_discovery (display) [392.809229] Starting subtest: display [392.811118] Subtest display: SUCCESS (0.000s) [392.886246] [099/156] (627s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-pri-indfb-multidraw) [392.988930] Starting subtest: fbcpsrhdr-2p-pri-indfb-multidraw [392.992355] Subtest fbcpsrhdr-2p-pri-indfb-multidraw: SKIP (0.000s) [393.080246] [100/156] (627s left) syncobj_timeline (multi-wait-submitted-signaled) [393.137277] Starting subtest: multi-wait-submitted-signaled [393.139224] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s) [393.246677] [101/156] (627s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite) [393.350713] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite [393.354324] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [393.464986] [102/156] (627s left) kms_chamelium_color (ctm-negative) [393.560565] Subtest ctm-negative: SKIP (0.000s) [393.606408] [103/156] (627s left) core_auth (getclient-master-drop) [393.639753] Starting subtest: getclient-master-drop [393.669013] Subtest getclient-master-drop: SUCCESS (0.032s) [393.788136] [104/156] (627s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt) [393.881417] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt [393.884975] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [393.981075] [105/156] (627s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc) [394.076495] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc [394.079992] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [394.176936] [106/156] (626s left) gem_exec_endless (dispatch) [394.262838] Starting subtest: dispatch [394.264475] Starting dynamic subtest: rcs0 [394.268270] Dynamic subtest rcs0: SUCCESS (0.005s) [394.282244] Starting dynamic subtest: bcs0 [394.286624] Dynamic subtest bcs0: SUCCESS (0.005s) [394.298098] Starting dynamic subtest: vcs0 [394.301563] Dynamic subtest vcs0: SUCCESS (0.004s) [394.310998] Starting dynamic subtest: vcs1 [394.314413] Dynamic subtest vcs1: SUCCESS (0.004s) [394.324132] Starting dynamic subtest: vecs0 [394.327550] Dynamic subtest vecs0: SUCCESS (0.004s) [394.337062] Starting dynamic subtest: ccs0 [394.340529] Dynamic subtest ccs0: SUCCESS (0.004s) [394.342259] Subtest dispatch: SUCCESS (0.030s) [395.955225] [107/156] (625s left) syncobj_wait (reset-unsignaled) [396.015932] Starting subtest: reset-unsignaled [396.018123] Subtest reset-unsignaled: SUCCESS (0.000s) [396.104185] [108/156] (625s left) drm_read (short-buffer-wakeup) [396.248419] Starting subtest: short-buffer-wakeup [428.470246] Subtest short-buffer-wakeup: SUCCESS (32.215s) [428.646064] [109/156] (592s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc) [428.743836] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc [428.748205] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [428.840990] [110/156] (592s left) gem_ccs (block-copy-compressed) [428.896658] Starting subtest: block-copy-compressed [428.901401] Subtest block-copy-compressed: SKIP (0.000s) [429.016888] [111/156] (592s left) kms_big_fb (linear-64bpp-rotate-270) [429.125414] Starting subtest: linear-64bpp-rotate-270 [429.144924] Subtest linear-64bpp-rotate-270: SKIP (0.019s) [429.293004] [112/156] (592s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing) [429.382054] Starting subtest: plane-all-transition-nonblocking-fencing [429.384371] Starting dynamic subtest: pipe-A-eDP-1 [431.876734] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s) [432.188117] Starting dynamic subtest: pipe-B-eDP-1 [435.417963] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.238s) [435.716085] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.334s) [436.539863] [113/156] (584s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite) [436.644983] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite [436.649307] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [436.745704] [114/156] (584s left) kms_psr (fbc-psr2-sprite-blt) [436.843071] Starting subtest: fbc-psr2-sprite-blt [436.845326] Starting dynamic subtest: eDP-1 [436.849508] Dynamic subtest eDP-1: SKIP (0.000s) [436.853852] Subtest fbc-psr2-sprite-blt: SKIP (0.001s) [436.919922] [115/156] (584s left) kms_frontbuffer_tracking (fbchdr-stridechange) [437.021815] Starting subtest: fbchdr-stridechange [437.025972] Subtest fbchdr-stridechange: SKIP (0.000s) [437.130616] [116/156] (584s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs) [437.226664] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs [437.228985] Starting dynamic subtest: pipe-A-eDP-1 [437.249856] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [437.262337] Starting dynamic subtest: pipe-B-eDP-1 [437.282214] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [437.291846] Starting dynamic subtest: pipe-C-eDP-1 [437.311222] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [437.321030] Starting dynamic subtest: pipe-D-eDP-1 [437.340186] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [437.342091] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.006s) [439.492491] [117/156] (582s left) prime_mmap (test_forked) [439.543798] Starting subtest: test_forked [439.545897] Starting dynamic subtest: test_forked-smem [439.582728] Dynamic subtest test_forked-smem: SUCCESS (0.041s) [439.585271] Subtest test_forked: SUCCESS (0.043s) [439.691943] [118/156] (581s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [439.789803] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-mmap-cpu [439.793965] Subtest hdr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [439.918602] [119/156] (581s left) kms_chamelium_hpd (common-hpd-after-suspend) [440.301676] Subtest common-hpd-after-suspend: SKIP (0.000s) [441.108218] [120/156] (580s left) gem_mmap_wc (invalid-flags) [441.169493] Subtest invalid-flags: SKIP (0.000s) [441.231677] [121/156] (580s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-blt) [441.340645] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-blt [441.344655] Subtest psrhdr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [441.438807] [122/156] (580s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff) [441.546538] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff [441.550963] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [441.638615] [123/156] (580s left) kms_frontbuffer_tracking (hdr-1p-primscrn-shrfb-plflip-blt) [441.734999] Starting subtest: hdr-1p-primscrn-shrfb-plflip-blt [441.738921] Subtest hdr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [441.839657] [124/156] (580s left) gem_exec_reloc (basic-write-gtt-active) [441.891466] Subtest basic-write-gtt-active: SKIP (0.000s) [441.963416] [125/156] (579s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc) [442.070215] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc [442.073591] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [442.170102] [126/156] (579s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-shrfb-pgflip-blt) [442.265416] Starting subtest: psrhdr-2p-primscrn-shrfb-pgflip-blt [442.268992] Subtest psrhdr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [442.398275] [127/156] (579s left) gem_exec_whisper (basic-fds) [442.465024] Starting subtest: basic-fds [449.831817] Subtest basic-fds: SUCCESS (7.360s) [450.016525] [128/156] (572s left) kms_big_fb (yf-tiled-8bpp-rotate-180) [450.121908] Starting subtest: yf-tiled-8bpp-rotate-180 [450.126178] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s) [450.221543] [129/156] (571s left) gem_exec_params (invalid-ring) [450.278800] Starting subtest: invalid-ring [450.281137] Subtest invalid-ring: SUCCESS (0.000s) [450.378112] [130/156] (571s left) gem_ctx_create (basic) [450.437877] Starting subtest: basic [450.440242] Subtest basic: SUCCESS (0.000s) [450.626175] [131/156] (571s left) i915_suspend (fence-restore-untiled) [450.678841] Starting subtest: fence-restore-untiled [450.683071] Subtest fence-restore-untiled: SKIP (0.000s) [450.761629] [132/156] (571s left) gem_vm_create (invalid-destroy) [450.812344] Starting subtest: invalid-destroy [450.814654] Subtest invalid-destroy: SUCCESS (0.002s) [450.924864] [133/156] (571s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [451.022095] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [451.026174] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s) [451.109283] [134/156] (571s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all) [451.167238] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all [451.171823] Subtest enable-vfs-bind-unbind-each-numvfs-all: SKIP (0.001s) [451.275940] [135/156] (571s left) gem_fenced_exec_thrash (too-many-fences) [451.330051] Subtest too-many-fences: SKIP (0.000s) [451.399084] [136/156] (571s left) gem_exec_fence (parallel) [451.569730] Starting subtest: parallel [451.572184] Starting dynamic subtest: rcs0 [453.727143] Dynamic subtest rcs0: SUCCESS (2.157s) [453.740629] Starting dynamic subtest: bcs0 [455.876865] Dynamic subtest bcs0: SUCCESS (2.149s) [455.888836] Starting dynamic subtest: vcs0 [458.026096] Dynamic subtest vcs0: SUCCESS (2.148s) [458.037161] Starting dynamic subtest: vcs1 [460.181761] Dynamic subtest vcs1: SUCCESS (2.154s) [460.193898] Starting dynamic subtest: vecs0 [462.332821] Dynamic subtest vecs0: SUCCESS (2.150s) [462.344276] Starting dynamic subtest: ccs0 [464.485602] Dynamic subtest ccs0: SUCCESS (2.152s) [464.487672] Subtest parallel: SUCCESS (12.914s) [465.076103] [137/156] (557s left) kms_scaling_modes (scaling-mode-full) [465.177153] Starting subtest: scaling-mode-full [465.179408] Starting dynamic subtest: pipe-A-eDP-1 [465.271771] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.096s) [465.283144] Starting dynamic subtest: pipe-B-eDP-1 [466.447457] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.174s) [466.459754] Starting dynamic subtest: pipe-C-eDP-1 [467.669484] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.220s) [467.680816] Starting dynamic subtest: pipe-D-eDP-1 [468.806839] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.135s) [468.809020] Subtest scaling-mode-full: SUCCESS (3.632s) [470.060963] [138/156] (552s left) perf_pmu (gt-awake) [470.104386] Starting subtest: gt-awake [478.919409] Subtest gt-awake: SUCCESS (8.813s) [479.036336] [139/156] (543s left) kms_big_fb (4-tiled-64bpp-rotate-270) [479.151118] Starting subtest: 4-tiled-64bpp-rotate-270 [479.171640] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.020s) [479.277843] [140/156] (543s left) gem_mmap_gtt (cpuset-basic-small-copy-odd) [479.337451] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s) [479.405502] [141/156] (543s left) kms_frontbuffer_tracking (psrhdr-1p-pri-indfb-multidraw) [479.506892] Starting subtest: psrhdr-1p-pri-indfb-multidraw [479.511083] Subtest psrhdr-1p-pri-indfb-multidraw: SKIP (0.000s) [479.611092] [142/156] (543s left) i915_pm_rpm (debugfs-read) [481.133975] Starting subtest: debugfs-read [482.291732] Subtest debugfs-read: SUCCESS (1.158s) [482.688584] [143/156] (540s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render) [482.786261] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render [489.570305] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.788s) [489.714393] [144/156] (533s left) kms_psr (fbc-psr-primary-mmap-gtt) [489.812618] Starting subtest: fbc-psr-primary-mmap-gtt [489.814871] Starting dynamic subtest: eDP-1 [489.818952] Dynamic subtest eDP-1: SKIP (0.000s) [489.823076] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.002s) [489.924755] [145/156] (532s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf) [490.019975] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf [490.023994] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s) [490.104471] [146/156] (532s left) gem_fenced_exec_thrash (no-spare-fences) [490.162463] Subtest no-spare-fences: SKIP (0.000s) [490.227452] [147/156] (532s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-render) [490.322037] Starting subtest: psrhdr-rgb565-draw-render [490.326341] Subtest psrhdr-rgb565-draw-render: SKIP (0.000s) [490.436059] [148/156] (532s left) gem_lmem_swapping (heavy-multi) [490.480146] Subtest heavy-multi: SKIP (0.000s) [490.536550] [149/156] (532s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt) [490.630601] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt [490.634013] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [490.723782] [150/156] (532s left) gem_exec_schedule (implicit-boths) [490.788165] Starting subtest: implicit-boths [490.789860] Starting dynamic subtest: rcs0 [490.894732] Dynamic subtest rcs0: SUCCESS (0.112s) [490.909159] Starting dynamic subtest: vcs0 [490.982541] Dynamic subtest vcs0: SUCCESS (0.084s) [490.996256] Starting dynamic subtest: vcs1 [491.061622] Dynamic subtest vcs1: SUCCESS (0.078s) [491.076314] Starting dynamic subtest: vecs0 [491.140870] Dynamic subtest vecs0: SUCCESS (0.079s) [491.153639] Starting dynamic subtest: ccs0 [491.230774] Dynamic subtest ccs0: SUCCESS (0.089s) [491.233038] Subtest implicit-boths: SUCCESS (0.449s) [491.962154] [151/156] (531s left) kms_flip (2x-flip-vs-wf_vblank-interruptible) [492.062769] Starting subtest: 2x-flip-vs-wf_vblank-interruptible [492.077054] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.012s) [492.166728] [152/156] (531s left) kms_frontbuffer_tracking (fbchdr-2p-rte) [492.263936] Starting subtest: fbchdr-2p-rte [492.268222] Subtest fbchdr-2p-rte: SKIP (0.000s) [492.373680] [153/156] (530s left) syncobj_wait (wait-zero-handles) [492.420704] Starting subtest: wait-zero-handles [492.422824] Subtest wait-zero-handles: SUCCESS (0.000s) [492.532942] [154/156] (530s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [492.620916] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [492.624955] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [492.744952] [155/156] (530s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu) [492.833637] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu [499.386645] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.555s) [499.550250] [156/156] (523s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs) [499.638439] Starting subtest: crc-primary-suspend-yf-tiled-ccs [499.640635] Starting dynamic subtest: pipe-A-eDP-1 [499.650286] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [499.667411] Starting dynamic subtest: pipe-B-eDP-1 [499.675794] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [499.685294] Starting dynamic subtest: pipe-C-eDP-1 [499.693680] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [499.703408] Starting dynamic subtest: pipe-D-eDP-1 [499.711881] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [499.716125] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.005s) [501.898328] Closing watchdogs results: parsing output: 0/ for test: kms_frontbuffer_tracking results: parsing output: 1/ for test: i915_drm_fdinfo results: parsing output: 2/ for test: syncobj_wait results: parsing output: 3/ for test: syncobj_wait results: parsing output: 4/ for test: kms_chamelium_edid results: parsing output: 5/ for test: kms_frontbuffer_tracking results: parsing output: 6/ for test: kms_psr results: parsing output: 7/ for test: kms_ccs results: parsing output: 8/ for test: syncobj_timeline results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: gem_exec_params results: parsing output: 11/ for test: gem_exec_schedule results: parsing output: 12/ for test: gem_softpin results: parsing output: 13/ for test: kms_plane_alpha_blend results: parsing output: 14/ for test: i915_drm_fdinfo results: parsing output: 15/ for test: gem_exec_schedule results: parsing output: 16/ for test: kms_frontbuffer_tracking results: parsing output: 17/ for test: gem_fence_thrash results: parsing output: 18/ for test: kms_frontbuffer_tracking results: parsing output: 19/ for test: kms_setmode results: parsing output: 20/ for test: kms_rotation_crc results: parsing output: 21/ for test: gem_mmap_wc results: parsing output: 22/ for test: gem_exec_flush results: parsing output: 23/ for test: kms_color results: parsing output: 24/ for test: sw_sync results: parsing output: 25/ for test: kms_frontbuffer_tracking results: parsing output: 26/ for test: kms_content_protection results: parsing output: 27/ for test: kms_frontbuffer_tracking results: parsing output: 28/ for test: kms_plane_scaling results: parsing output: 29/ for test: kms_frontbuffer_tracking results: parsing output: 30/ for test: perf results: parsing output: 31/ for test: kms_ccs results: parsing output: 32/ for test: kms_cursor_legacy results: parsing output: 33/ for test: kms_frontbuffer_tracking results: parsing output: 34/ for test: kms_lease results: parsing output: 35/ for test: syncobj_timeline results: parsing output: 36/ for test: kms_psr2_sf results: parsing output: 37/ for test: perf_pmu results: parsing output: 38/ for test: kms_plane results: parsing output: 39/ for test: kms_plane results: parsing output: 40/ for test: gem_readwrite results: parsing output: 41/ for test: kms_big_fb results: parsing output: 42/ for test: kms_flip_scaled_crc results: parsing output: 43/ for test: kms_frontbuffer_tracking results: parsing output: 44/ for test: kms_big_fb results: parsing output: 45/ for test: kms_frontbuffer_tracking results: parsing output: 46/ for test: kms_flip results: parsing output: 47/ for test: gem_ctx_param results: parsing output: 48/ for test: kms_frontbuffer_tracking results: parsing output: 49/ for test: syncobj_wait results: parsing output: 50/ for test: kms_frontbuffer_tracking results: parsing output: 51/ for test: kms_psr results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: kms_vrr results: parsing output: 54/ for test: gem_ctx_exec results: parsing output: 55/ for test: kms_frontbuffer_tracking results: parsing output: 56/ for test: gem_mmap_gtt results: parsing output: 57/ for test: kms_frontbuffer_tracking results: parsing output: 58/ for test: gem_ctx_persistence results: parsing output: 59/ for test: syncobj_timeline results: parsing output: 60/ for test: gem_exec_reloc results: parsing output: 61/ for test: kms_frontbuffer_tracking results: parsing output: 62/ for test: gen9_exec_parse results: parsing output: 63/ for test: kms_plane_scaling results: parsing output: 64/ for test: api_intel_allocator results: parsing output: 65/ for test: kms_cursor_edge_walk results: parsing output: 66/ for test: kms_flip results: parsing output: 67/ for test: gem_exec_balancer results: parsing output: 68/ for test: gem_render_copy results: parsing output: 69/ for test: kms_cursor_legacy results: parsing output: 70/ for test: perf results: parsing output: 71/ for test: gem_exec_fence results: parsing output: 72/ for test: gem_ctx_param results: parsing output: 73/ for test: kms_async_flips results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: kms_psr2_su results: parsing output: 76/ for test: kms_async_flips results: parsing output: 77/ for test: gem_softpin results: parsing output: 78/ for test: kms_frontbuffer_tracking results: parsing output: 79/ for test: gem_mmap_offset results: parsing output: 80/ for test: kms_prop_blob results: parsing output: 81/ for test: syncobj_timeline results: parsing output: 82/ for test: gem_unfence_active_buffers results: parsing output: 83/ for test: kms_lease results: parsing output: 84/ for test: kms_cursor_crc results: parsing output: 85/ for test: gem_pxp results: parsing output: 86/ for test: gem_exec_balancer results: parsing output: 87/ for test: kms_pm_dc results: parsing output: 88/ for test: kms_flip results: parsing output: 89/ for test: kms_frontbuffer_tracking results: parsing output: 90/ for test: kms_frontbuffer_tracking results: parsing output: 91/ for test: gem_ctx_isolation results: parsing output: 92/ for test: kms_universal_plane results: parsing output: 93/ for test: gem_pxp results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: kms_cursor_crc results: parsing output: 96/ for test: kms_big_fb results: parsing output: 97/ for test: kms_feature_discovery results: parsing output: 98/ for test: kms_frontbuffer_tracking results: parsing output: 99/ for test: syncobj_timeline results: parsing output: 100/ for test: kms_frontbuffer_tracking results: parsing output: 101/ for test: kms_chamelium_color results: parsing output: 102/ for test: core_auth results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: gem_exec_endless results: parsing output: 106/ for test: syncobj_wait results: parsing output: 107/ for test: drm_read results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: gem_ccs results: parsing output: 110/ for test: kms_big_fb results: parsing output: 111/ for test: kms_atomic_transition results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: kms_psr results: parsing output: 114/ for test: kms_frontbuffer_tracking results: parsing output: 115/ for test: kms_ccs results: parsing output: 116/ for test: prime_mmap results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: kms_chamelium_hpd results: parsing output: 119/ for test: gem_mmap_wc results: parsing output: 120/ for test: kms_frontbuffer_tracking results: parsing output: 121/ for test: kms_frontbuffer_tracking results: parsing output: 122/ for test: kms_frontbuffer_tracking results: parsing output: 123/ for test: gem_exec_reloc results: parsing output: 124/ for test: kms_frontbuffer_tracking results: parsing output: 125/ for test: kms_frontbuffer_tracking results: parsing output: 126/ for test: gem_exec_whisper results: parsing output: 127/ for test: kms_big_fb results: parsing output: 128/ for test: gem_exec_params results: parsing output: 129/ for test: gem_ctx_create results: parsing output: 130/ for test: i915_suspend results: parsing output: 131/ for test: gem_vm_create results: parsing output: 132/ for test: kms_flip_scaled_crc results: parsing output: 133/ for test: sriov_basic results: parsing output: 134/ for test: gem_fenced_exec_thrash results: parsing output: 135/ for test: gem_exec_fence results: parsing output: 136/ for test: kms_scaling_modes results: parsing output: 137/ for test: perf_pmu results: parsing output: 138/ for test: kms_big_fb results: parsing output: 139/ for test: gem_mmap_gtt results: parsing output: 140/ for test: kms_frontbuffer_tracking results: parsing output: 141/ for test: i915_pm_rpm results: parsing output: 142/ for test: kms_frontbuffer_tracking results: parsing output: 143/ for test: kms_psr results: parsing output: 144/ for test: kms_psr2_sf results: parsing output: 145/ for test: gem_fenced_exec_thrash results: parsing output: 146/ for test: kms_frontbuffer_tracking results: parsing output: 147/ for test: gem_lmem_swapping results: parsing output: 148/ for test: kms_frontbuffer_tracking results: parsing output: 149/ for test: gem_exec_schedule results: parsing output: 150/ for test: kms_flip results: parsing output: 151/ for test: kms_frontbuffer_tracking results: parsing output: 152/ for test: syncobj_wait results: parsing output: 153/ for test: kms_big_fb results: parsing output: 154/ for test: kms_frontbuffer_tracking results: parsing output: 155/ for test: kms_ccs Done.