[74.812354] Initializing watchdogs [74.812400] /dev/watchdog0 [74.827331] [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] [74.832019] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [74.834206] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [74.837357] [001/154] (960s left) kms_prime (basic-crc-vgem) [74.959470] Starting subtest: basic-crc-vgem [74.961730] Starting dynamic subtest: second-to-first [75.967984] Dynamic subtest second-to-first: SUCCESS (1.011s) [75.969971] Subtest basic-crc-vgem: SUCCESS (1.012s) [76.066984] [FACT kms_prime (basic-crc-vgem)] new: kernel.kmod_is_loaded.vgem: true [76.069290] [002/154] (959s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc) [76.200829] Starting subtest: fbc-rgb565-draw-mmap-wc [80.230819] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (4.035s) [81.416607] [003/154] (953s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [81.544276] Starting subtest: basic-flip-after-cursor-varying-size [82.500993] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.957s) [83.333132] [004/154] (952s left) kms_color_pipeline (plane-lut1d) [83.435836] Starting subtest: plane-lut1d [83.584608] Starting dynamic subtest: pipe-A-plane-0 [83.751405] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s) [83.761183] Starting dynamic subtest: pipe-A-plane-1 [83.895279] Dynamic subtest pipe-A-plane-1: SUCCESS (0.144s) [83.903976] Starting dynamic subtest: pipe-A-plane-2 [84.050511] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s) [85.242732] Starting dynamic subtest: pipe-B-plane-0 [85.403422] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s) [85.414279] Starting dynamic subtest: pipe-B-plane-1 [85.570754] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s) [85.584619] Starting dynamic subtest: pipe-B-plane-2 [85.725563] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s) [86.966190] Starting dynamic subtest: pipe-C-plane-0 [87.115054] Dynamic subtest pipe-C-plane-0: SUCCESS (0.156s) [87.129399] Starting dynamic subtest: pipe-C-plane-1 [87.281199] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s) [87.290456] Starting dynamic subtest: pipe-C-plane-2 [87.437054] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s) [88.619747] Starting dynamic subtest: pipe-D-plane-0 [88.767259] Dynamic subtest pipe-D-plane-0: SUCCESS (0.156s) [88.774907] Starting dynamic subtest: pipe-D-plane-1 [88.933807] Dynamic subtest pipe-D-plane-1: SUCCESS (0.165s) [88.945247] Starting dynamic subtest: pipe-D-plane-2 [89.100241] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s) [89.403039] Subtest plane-lut1d: SUCCESS (5.964s) [90.276545] [005/154] (945s left) prime_self_import (basic-llseek-bad) [90.312465] Starting subtest: basic-llseek-bad [90.339078] Subtest basic-llseek-bad: SUCCESS (0.026s) [90.442608] [006/154] (945s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc) [90.548877] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc [90.553416] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [90.644853] [007/154] (944s left) kms_content_protection (dp-mst-lic-type-0) [90.780794] Starting subtest: dp-mst-lic-type-0 [90.785412] Subtest dp-mst-lic-type-0: SKIP (0.000s) [90.892546] [008/154] (944s left) kms_psr (psr-sprite-mmap-gtt) [90.996611] Starting subtest: psr-sprite-mmap-gtt [90.998922] Starting dynamic subtest: eDP-1 [92.490947] Dynamic subtest eDP-1: SKIP (1.491s) [92.496056] Subtest psr-sprite-mmap-gtt: SKIP (1.493s) [92.647932] [009/154] (943s left) kms_psr (psr2-cursor-plane-move) [92.743164] Starting subtest: psr2-cursor-plane-move [92.745533] Starting dynamic subtest: eDP-1 [95.290063] Dynamic subtest eDP-1: SUCCESS (2.546s) [95.292485] Subtest psr2-cursor-plane-move: SUCCESS (2.547s) [95.689225] [010/154] (940s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-pwrite) [95.784306] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-pwrite [95.788599] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [95.907907] [011/154] (939s left) gem_tiled_partial_pwrite_pread (writes-after-reads) [95.970325] Subtest writes-after-reads: SKIP (0.000s) [96.038883] [012/154] (939s left) gem_exec_store (basic) [96.107926] Starting subtest: basic [96.208977] Subtest basic: SUCCESS (0.102s) [96.388491] [013/154] (939s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-mmap-gtt) [96.477830] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-mmap-gtt [96.482389] Subtest hdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [96.569891] [014/154] (939s left) kms_psr (fbc-pr-cursor-mmap-cpu) [96.658889] Starting subtest: fbc-pr-cursor-mmap-cpu [96.663601] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s) [96.728440] [015/154] (939s left) gen7_exec_parse (basic-allowed) [96.786620] Subtest basic-allowed: SKIP (0.000s) [96.843542] [016/154] (939s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-indfb-msflip-blt) [96.936084] Starting subtest: fbcpsrhdr-2p-scndscrn-indfb-msflip-blt [96.940657] Subtest fbcpsrhdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s) [97.022199] [017/154] (938s left) perf_pmu (busy-no-semaphores) [97.058941] Starting subtest: busy-no-semaphores [97.061331] Starting dynamic subtest: rcs0 [97.623615] Dynamic subtest rcs0: SUCCESS (0.563s) [97.636305] Starting dynamic subtest: bcs0 [98.176650] Dynamic subtest bcs0: SUCCESS (0.551s) [98.186998] Starting dynamic subtest: vcs0 [98.727462] Dynamic subtest vcs0: SUCCESS (0.548s) [98.739061] Starting dynamic subtest: vcs1 [99.842718] Dynamic subtest vcs1: SUCCESS (1.113s) [99.854327] Starting dynamic subtest: vecs0 [101.830834] Dynamic subtest vecs0: SUCCESS (1.986s) [101.842570] Starting dynamic subtest: ccs0 [103.811709] Dynamic subtest ccs0: SUCCESS (1.979s) [103.814594] Subtest busy-no-semaphores: SUCCESS (6.753s) [103.929760] [018/154] (932s left) kms_plane_alpha_blend (constant-alpha-mid) [104.038234] Starting subtest: constant-alpha-mid [104.327862] Starting dynamic subtest: pipe-A-eDP-1 [105.240928] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.912s) [105.251212] Starting dynamic subtest: pipe-D-eDP-1 [106.778271] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.535s) [106.780361] Subtest constant-alpha-mid: SUCCESS (2.740s) [107.630067] [019/154] (928s left) gem_exec_balancer (parallel) [107.902959] Starting subtest: parallel [108.846649] Subtest parallel: SUCCESS (0.947s) [109.349976] [020/154] (926s left) gem_wait (invalid-buf) [109.402700] Starting subtest: invalid-buf [109.405176] Subtest invalid-buf: SUCCESS (0.000s) [109.628365] [021/154] (926s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-pwrite) [109.723596] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-pwrite [109.727939] Subtest psrhdr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s) [109.817977] [022/154] (926s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area) [109.933662] Starting subtest: fbc-psr2-plane-move-sf-dmg-area [109.936051] Starting dynamic subtest: pipe-A-eDP-1 [110.029983] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s) [110.040282] Starting dynamic subtest: pipe-B-eDP-1 [111.208783] Dynamic subtest pipe-B-eDP-1: SKIP (1.175s) [111.213450] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.277s) [112.497408] [023/154] (923s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic) [112.587490] Starting subtest: async-flip-with-page-flip-events-tiled-atomic [112.962307] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs [115.762762] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.800s) [115.774595] Starting dynamic subtest: pipe-A-eDP-1-4 [117.959989] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.195s) [117.970907] Starting dynamic subtest: pipe-A-eDP-1-4 [119.969650] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s) [119.980728] Starting dynamic subtest: pipe-A-eDP-1-x [122.148125] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s) [122.512805] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs [125.289387] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.781s) [125.301063] Starting dynamic subtest: pipe-B-eDP-1-4 [127.474605] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s) [127.485978] Starting dynamic subtest: pipe-B-eDP-1-4 [129.484973] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.010s) [129.493523] Starting dynamic subtest: pipe-B-eDP-1-x [131.674718] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s) [132.061248] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs [134.830629] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.776s) [134.839717] Starting dynamic subtest: pipe-C-eDP-1-4 [137.004732] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s) [137.013250] Starting dynamic subtest: pipe-C-eDP-1-4 [139.015675] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s) [139.026811] Starting dynamic subtest: pipe-C-eDP-1-x [141.193864] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s) [141.557553] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs [144.360366] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.810s) [144.371744] Starting dynamic subtest: pipe-D-eDP-1-4 [146.544934] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.184s) [146.555589] Starting dynamic subtest: pipe-D-eDP-1-4 [148.555247] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.010s) [148.563664] Starting dynamic subtest: pipe-D-eDP-1-x [150.733804] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s) [150.736457] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.147s) [151.944445] [024/154] (884s left) kms_plane (plane-position-covered) [152.039239] Starting subtest: plane-position-covered [152.554688] Starting dynamic subtest: pipe-A-plane-1 [153.818820] Dynamic subtest pipe-A-plane-1: SUCCESS (1.262s) [153.827738] Starting dynamic subtest: pipe-A-plane-2 [155.119764] Dynamic subtest pipe-A-plane-2: SUCCESS (1.301s) [155.130150] Starting dynamic subtest: pipe-A-plane-3 [156.358726] Dynamic subtest pipe-A-plane-3: SUCCESS (1.239s) [156.367522] Starting dynamic subtest: pipe-A-plane-4 [157.629779] Dynamic subtest pipe-A-plane-4: SUCCESS (1.268s) [157.638509] Starting dynamic subtest: pipe-A-plane-5 [157.655599] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s) [158.881041] Starting dynamic subtest: pipe-B-plane-1 [160.190485] Dynamic subtest pipe-B-plane-1: SUCCESS (1.316s) [160.199514] Starting dynamic subtest: pipe-B-plane-2 [161.515616] Dynamic subtest pipe-B-plane-2: SUCCESS (1.326s) [161.525406] Starting dynamic subtest: pipe-B-plane-3 [162.853893] Dynamic subtest pipe-B-plane-3: SUCCESS (1.335s) [162.863582] Starting dynamic subtest: pipe-B-plane-4 [164.155396] Dynamic subtest pipe-B-plane-4: SUCCESS (1.301s) [164.164429] Starting dynamic subtest: pipe-B-plane-5 [164.180885] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s) [164.182883] Subtest plane-position-covered: SUCCESS (12.141s) [164.959365] [025/154] (871s left) syncobj_wait (single-wait-for-submit-unsubmitted) [165.013421] Starting subtest: single-wait-for-submit-unsubmitted [165.115965] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.102s) [165.190294] [026/154] (871s left) kms_flip (basic-plain-flip) [165.271338] Starting subtest: basic-plain-flip [165.273688] Starting dynamic subtest: A-eDP1 [166.959837] Dynamic subtest A-eDP1: SUCCESS (1.688s) [166.974942] Starting dynamic subtest: B-eDP1 [168.688058] Dynamic subtest B-eDP1: SUCCESS (1.725s) [168.698637] Starting dynamic subtest: C-eDP1 [170.321651] Dynamic subtest C-eDP1: SUCCESS (1.633s) [170.333420] Starting dynamic subtest: D-eDP1 [171.961068] Dynamic subtest D-eDP1: SUCCESS (1.637s) [171.965912] Subtest basic-plain-flip: SUCCESS (6.694s) [173.145633] [027/154] (863s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-shrfb-msflip-blt) [173.246182] Starting subtest: fbchdr-2p-primscrn-shrfb-msflip-blt [173.250479] Subtest fbchdr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [173.353832] [028/154] (863s left) gem_unfence_active_buffers [173.513343] [029/154] (862s left) gem_exec_reloc (basic-wc-read-active) [173.581737] Subtest basic-wc-read-active: SKIP (0.000s) [173.642567] [030/154] (862s left) perf_pmu (semaphore-busy) [173.679861] Starting subtest: semaphore-busy [173.682390] Starting dynamic subtest: rcs0 [175.316495] Dynamic subtest rcs0: SUCCESS (1.632s) [175.326204] Starting dynamic subtest: bcs0 [176.950207] Dynamic subtest bcs0: SUCCESS (1.632s) [176.960227] Starting dynamic subtest: vcs0 [180.794911] Dynamic subtest vcs0: SUCCESS (3.840s) [180.806199] Starting dynamic subtest: vcs1 [186.810595] Dynamic subtest vcs1: SUCCESS (6.012s) [186.819836] Starting dynamic subtest: vecs0 [192.826080] Dynamic subtest vecs0: SUCCESS (6.012s) [192.836524] Starting dynamic subtest: ccs0 [195.899963] Dynamic subtest ccs0: SUCCESS (3.071s) [195.902330] Subtest semaphore-busy: SUCCESS (22.217s) [196.019155] [031/154] (840s left) gem_busy (parallel) [196.207276] Starting subtest: parallel [196.209849] Starting dynamic subtest: rcs0 [198.273795] Dynamic subtest rcs0: SUCCESS (2.064s) [198.286658] Starting dynamic subtest: bcs0 [200.256047] Dynamic subtest bcs0: SUCCESS (1.977s) [200.268094] Starting dynamic subtest: vcs0 [202.305188] Dynamic subtest vcs0: SUCCESS (2.046s) [202.317806] Starting dynamic subtest: vcs1 [204.315062] Dynamic subtest vcs1: SUCCESS (1.978s) [204.327216] Starting dynamic subtest: vecs0 [206.273083] Dynamic subtest vecs0: SUCCESS (1.983s) [206.284755] Starting dynamic subtest: ccs0 [208.319634] Dynamic subtest ccs0: SUCCESS (2.044s) [208.322736] Subtest parallel: SUCCESS (12.112s) [208.557923] [032/154] (828s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc) [208.651899] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc [208.654758] Starting dynamic subtest: pipe-A-eDP-1 [208.679904] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [208.690810] Starting dynamic subtest: pipe-B-eDP-1 [208.711639] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [208.720255] Starting dynamic subtest: pipe-C-eDP-1 [208.740770] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [208.749357] Starting dynamic subtest: pipe-D-eDP-1 [208.770123] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [208.774258] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s) [210.927245] [033/154] (825s left) kms_chamelium_color (ctm-0-75) [211.029529] Subtest ctm-0-75: SKIP (0.000s) [211.072355] [034/154] (825s left) gem_ctx_engines (invalid-engines) [211.137102] Starting subtest: invalid-engines [211.142193] Subtest invalid-engines: SUCCESS (0.008s) [211.370506] [035/154] (825s left) api_intel_allocator (reserve-simple) [211.420343] Starting subtest: reserve-simple [211.423390] Subtest reserve-simple: SUCCESS (0.005s) [211.558029] [036/154] (825s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling) [211.645855] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling [211.650307] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s) [211.716243] [037/154] (825s left) syncobj_timeline (reset-signaled) [211.764176] Starting subtest: reset-signaled [211.766091] Subtest reset-signaled: SUCCESS (0.000s) [211.851943] [038/154] (824s left) gem_mmap_gtt (cpuset-big-copy-odd) [211.897777] Subtest cpuset-big-copy-odd: SKIP (0.000s) [211.952332] [039/154] (824s left) gem_exec_schedule (promotion) [212.023818] Starting subtest: promotion [212.026209] Starting dynamic subtest: rcs0 [212.130045] Dynamic subtest rcs0: SUCCESS (0.116s) [212.141906] Starting dynamic subtest: vcs0 [212.224763] Dynamic subtest vcs0: SUCCESS (0.093s) [212.235593] Starting dynamic subtest: vcs1 [212.310495] Dynamic subtest vcs1: SUCCESS (0.086s) [212.319259] Starting dynamic subtest: vecs0 [212.400845] Dynamic subtest vecs0: SUCCESS (0.089s) [212.409730] Starting dynamic subtest: ccs0 [212.488570] Dynamic subtest ccs0: SUCCESS (0.086s) [212.490691] Subtest promotion: SUCCESS (0.475s) [213.401349] [040/154] (823s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions) [213.529335] Starting subtest: cursorB-vs-flipA-atomic-transitions [213.533818] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s) [213.672087] [041/154] (823s left) api_intel_bb (object-noreloc-keep-cache-simple) [213.717721] Starting subtest: object-noreloc-keep-cache-simple [213.723482] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.007s) [213.861051] [042/154] (823s left) kms_atomic (plane-overlay-legacy) [213.944423] Starting subtest: plane-overlay-legacy [213.947071] Starting dynamic subtest: pipe-A-eDP-1 [214.332079] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.387s) [214.334268] Subtest plane-overlay-legacy: SUCCESS (0.388s) [215.156196] [043/154] (821s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff) [215.253803] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff [222.346399] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.098s) [222.479892] [044/154] (814s left) prime_mmap_kms (buffer-sharing) [222.577203] Starting subtest: buffer-sharing [223.011644] Subtest buffer-sharing: SUCCESS (0.437s) [223.833207] [045/154] (813s left) kms_frontbuffer_tracking (fbcpsrhdr-shrfb-scaledprimary) [223.927558] Starting subtest: fbcpsrhdr-shrfb-scaledprimary [223.931669] Subtest fbcpsrhdr-shrfb-scaledprimary: SKIP (0.000s) [224.034909] [046/154] (813s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-rte) [224.128576] Starting subtest: fbcpsrhdr-1p-rte [224.132542] Subtest fbcpsrhdr-1p-rte: SKIP (0.000s) [224.231460] [047/154] (812s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [224.330049] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu [224.334508] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [224.426970] [048/154] (812s left) kms_pm_backlight (bad-brightness) [224.513062] Starting subtest: bad-brightness [224.561464] Starting dynamic subtest: eDP-1 [224.869680] Dynamic subtest eDP-1: SUCCESS (0.307s) [224.871965] Subtest bad-brightness: SUCCESS (0.358s) [225.783647] [049/154] (811s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt) [225.883731] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt [225.888108] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [226.006837] [050/154] (811s left) gem_ctx_bad_destroy (invalid-pad) [226.070109] Starting subtest: invalid-pad [226.072389] Subtest invalid-pad: SUCCESS (0.000s) [226.142206] [051/154] (811s left) gem_mmap_offset (isolation) [226.199987] Starting subtest: isolation [226.217314] Subtest isolation: SUCCESS (0.005s) [226.322086] [052/154] (811s left) syncobj_timeline (invalid-wait-illegal-handle) [226.382316] Starting subtest: invalid-wait-illegal-handle [226.384594] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s) [226.488722] [053/154] (810s left) kms_busy (extended-modeset-hang-newfb-with-reset) [226.601066] Starting subtest: extended-modeset-hang-newfb-with-reset [226.603386] Starting dynamic subtest: pipe-A [240.543645] Dynamic subtest pipe-A: SUCCESS (13.942s) [240.552483] Starting dynamic subtest: pipe-D [256.110376] Dynamic subtest pipe-D: SUCCESS (15.565s) [256.112748] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (29.511s) [256.907458] [054/154] (780s left) i915_query (engine-info) [256.958101] Starting subtest: engine-info [256.960721] Subtest engine-info: SUCCESS (0.005s) [257.078391] [055/154] (780s left) kms_fbcon_fbt (psr) [257.127172] Starting subtest: psr [264.540537] Subtest psr: SUCCESS (7.408s) [264.621384] [056/154] (772s left) gem_ctx_persistence (legacy-engines-hostile-preempt) [264.680899] Starting subtest: legacy-engines-hostile-preempt [264.683085] Starting dynamic subtest: render [264.759862] Dynamic subtest render: SUCCESS (0.081s) [264.771458] Starting dynamic subtest: bsd1 [266.277997] Dynamic subtest bsd1: SUCCESS (1.514s) [266.288656] Starting dynamic subtest: bsd2 [268.281808] Dynamic subtest bsd2: SUCCESS (2.000s) [268.292584] Starting dynamic subtest: blt [268.344746] Dynamic subtest blt: SUCCESS (0.058s) [268.353601] Starting dynamic subtest: vebox [270.245429] Dynamic subtest vebox: SUCCESS (1.900s) [270.248069] Subtest legacy-engines-hostile-preempt: SUCCESS (5.567s) [270.376957] [057/154] (767s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-blt) [270.484090] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-blt [270.488281] Subtest hdr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [270.593832] [058/154] (767s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-mmap-cpu) [270.687530] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-mmap-cpu [270.691612] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [270.794476] [059/154] (766s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs) [270.882118] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs [270.884369] Starting dynamic subtest: pipe-A-eDP-1 [302.836557] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.851s) [302.847157] Starting dynamic subtest: pipe-B-eDP-1 [335.729574] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.723s) [335.739374] Starting dynamic subtest: pipe-C-eDP-1 [368.741644] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.687s) [368.751399] Starting dynamic subtest: pipe-D-eDP-1 [401.731676] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.664s) [401.734006] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (14.931s) [402.979361] [060/154] (634s left) prime_mmap (test_correct) [403.038810] Starting subtest: test_correct [403.041192] Starting dynamic subtest: test_correct-smem [403.070500] Dynamic subtest test_correct-smem: SUCCESS (0.034s) [403.073190] Subtest test_correct: SUCCESS (0.035s) [403.168020] [061/154] (634s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping) [403.272998] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping [403.277920] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.000s) [403.352818] [062/154] (634s left) dmabuf_sync_file (import-multiple-read-write) [403.421810] Starting subtest: import-multiple-read-write [403.425176] Subtest import-multiple-read-write: SUCCESS (0.003s) [403.481922] [063/154] (634s left) kms_big_fb (linear-16bpp-rotate-0) [403.598220] Starting subtest: linear-16bpp-rotate-0 [405.089990] Subtest linear-16bpp-rotate-0: SUCCESS (1.490s) [405.203618] [064/154] (632s left) kms_draw_crc (fill-fb) [405.307574] Starting subtest: fill-fb [405.758660] Subtest fill-fb: SUCCESS (0.454s) [405.865562] [065/154] (632s left) kms_flip (2x-blocking-absolute-wf_vblank) [405.954563] Starting subtest: 2x-blocking-absolute-wf_vblank [405.961853] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.010s) [406.074218] [066/154] (631s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff) [406.168726] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff [410.093274] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (3.926s) [411.291067] [067/154] (626s left) kms_lease (lease-invalid-crtc) [411.375253] Starting subtest: lease-invalid-crtc [411.378184] Starting dynamic subtest: pipe-A-eDP-1 [411.380462] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [411.390571] Starting dynamic subtest: pipe-B-eDP-1 [411.393276] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [411.403320] Starting dynamic subtest: pipe-C-eDP-1 [411.405673] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [411.415131] Starting dynamic subtest: pipe-D-eDP-1 [411.417527] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [411.419769] Subtest lease-invalid-crtc: SUCCESS (0.004s) [411.459266] [068/154] (626s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip) [411.560761] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip [412.675145] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.113s) [412.787310] [069/154] (625s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt) [412.885941] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt [412.890023] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [412.977046] [070/154] (625s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt) [413.078871] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt [413.083114] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [413.167935] [071/154] (625s left) kms_cursor_crc (cursor-random-32x10) [413.334884] Starting subtest: cursor-random-32x10 [413.382827] Subtest cursor-random-32x10: SKIP (0.042s) [413.646085] [072/154] (624s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff) [413.747089] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff [413.751620] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [413.831008] [073/154] (624s left) kms_rotation_crc (primary-y-tiled-reflect-x-0) [413.926565] Starting subtest: primary-y-tiled-reflect-x-0 [413.987520] Subtest primary-y-tiled-reflect-x-0: SKIP (0.060s) [414.091667] [074/154] (624s left) syncobj_eventfd (timeline-wait-before-signal) [414.143343] Starting subtest: timeline-wait-before-signal [414.173541] Subtest timeline-wait-before-signal: SUCCESS (0.032s) [414.265000] [075/154] (624s left) gem_exec_params (dr4-dirt) [414.323562] Starting subtest: DR4-dirt [414.325815] Subtest DR4-dirt: SUCCESS (0.000s) [414.417819] [076/154] (624s left) kms_chamelium_frames (dp-crc-fast) [414.811902] Subtest dp-crc-fast: SKIP (0.000s) [415.600733] [077/154] (622s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [415.708104] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip [415.713979] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s) [415.806284] [078/154] (622s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [415.913041] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu [415.917181] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [415.998641] [079/154] (622s left) gem_userptr_blits (invalid-null-pointer) [416.058291] Starting subtest: invalid-null-pointer [416.060545] Subtest invalid-null-pointer: SUCCESS (0.001s) [416.169529] [080/154] (622s left) kms_addfb_basic (framebuffer-vs-set-tiling) [416.220760] Starting subtest: framebuffer-vs-set-tiling [416.225121] Subtest framebuffer-vs-set-tiling: SKIP (0.000s) [416.375517] [081/154] (622s left) kms_frontbuffer_tracking (hdr-2p-pri-indfb-multidraw) [416.478024] Starting subtest: hdr-2p-pri-indfb-multidraw [416.483113] Subtest hdr-2p-pri-indfb-multidraw: SKIP (0.000s) [416.560653] [082/154] (622s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs) [416.653809] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs [416.656078] Starting dynamic subtest: pipe-A-eDP-1 [416.677095] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [416.687993] Starting dynamic subtest: pipe-B-eDP-1 [416.709701] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [416.719893] Starting dynamic subtest: pipe-C-eDP-1 [416.742364] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [416.755840] Starting dynamic subtest: pipe-D-eDP-1 [416.777907] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [416.782003] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.004s) [418.983328] [083/154] (619s left) kms_pm_dc (dc5-dpms-negative) [420.087385] Starting subtest: dc5-dpms-negative [420.092316] Subtest dc5-dpms-negative: SKIP (0.000s) [420.160781] [084/154] (618s left) sysfs_timeslice_duration (timeout) [420.215130] Starting subtest: timeout [420.218063] Starting dynamic subtest: vecs0 [430.207842] Dynamic subtest vecs0: SUCCESS (9.989s) [430.220368] Starting dynamic subtest: ccs0 [431.445482] Dynamic subtest ccs0: SUCCESS (1.233s) [431.456817] Starting dynamic subtest: vcs0 [441.206513] Dynamic subtest vcs0: SUCCESS (9.754s) [441.219008] Starting dynamic subtest: bcs0 [441.797447] Dynamic subtest bcs0: SUCCESS (0.588s) [441.809271] Starting dynamic subtest: rcs0 [443.016103] Dynamic subtest rcs0: SUCCESS (1.218s) [443.026414] Starting dynamic subtest: vcs1 [452.217132] Dynamic subtest vcs1: SUCCESS (9.191s) [452.220181] Subtest timeout: SUCCESS (31.985s) [452.292392] [085/154] (586s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-render) [452.411180] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-render [452.416867] Subtest hdr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [452.516765] [086/154] (586s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-render) [452.618930] Starting subtest: fbcpsrhdr-rgb101010-draw-render [452.623803] Subtest fbcpsrhdr-rgb101010-draw-render: SKIP (0.000s) [452.730053] [087/154] (586s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted) [452.782097] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted [452.882533] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.101s) [452.961609] [088/154] (585s left) syncobj_basic (test-valid-cycle) [453.010084] Starting subtest: test-valid-cycle [453.012910] Subtest test-valid-cycle: SUCCESS (0.000s) [453.105365] [089/154] (585s left) gem_exec_fence (syncobj-unused-fence) [453.548773] Starting subtest: syncobj-unused-fence [453.551543] Subtest syncobj-unused-fence: SUCCESS (0.005s) [455.227087] [090/154] (583s left) i915_drm_fdinfo (virtual-busy-idle-all) [455.267478] Starting subtest: virtual-busy-idle-all [455.272659] Subtest virtual-busy-idle-all: SKIP (0.000s) [455.333340] [091/154] (583s left) gem_pipe_control_store_loop (reused-buffer) [455.387119] Starting subtest: reused-buffer [457.544803] Subtest reused-buffer: SUCCESS (2.155s) [457.661704] [092/154] (581s left) gem_softpin (reverse) [457.721051] Starting subtest: reverse [457.726914] Subtest reverse: SUCCESS (0.009s) [457.838640] [093/154] (581s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt) [457.941029] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt [457.946046] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [458.028090] [094/154] (581s left) kms_flip (flip-vs-rmfb-interruptible) [458.132804] Starting subtest: flip-vs-rmfb-interruptible [458.135944] Starting dynamic subtest: A-eDP1 [466.790824] Dynamic subtest A-eDP1: SUCCESS (8.655s) [466.801603] Starting dynamic subtest: B-eDP1 [475.432855] Dynamic subtest B-eDP1: SUCCESS (8.635s) [475.446704] Starting dynamic subtest: C-eDP1 [484.051797] Dynamic subtest C-eDP1: SUCCESS (8.612s) [484.062257] Starting dynamic subtest: D-eDP1 [492.695517] Dynamic subtest D-eDP1: SUCCESS (8.637s) [492.700846] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.554s) [493.886086] [095/154] (545s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff) [494.000848] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff [501.062064] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.064s) [501.201052] [096/154] (538s left) kms_big_fb (y-tiled-8bpp-rotate-270) [501.303243] Starting subtest: y-tiled-8bpp-rotate-270 [501.309090] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s) [501.402350] [097/154] (537s left) gem_exec_fence (submit-chain) [501.577280] Starting subtest: submit-chain [501.597009] Subtest submit-chain: SUCCESS (0.020s) [503.262300] [098/154] (536s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-render) [503.371729] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-render [503.376814] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s) [503.486985] [099/154] (535s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs) [503.580981] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs [503.583882] Starting dynamic subtest: pipe-A-eDP-1 [503.607065] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [503.618011] Starting dynamic subtest: pipe-B-eDP-1 [503.640292] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [503.650432] Starting dynamic subtest: pipe-C-eDP-1 [503.673266] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [503.683237] Starting dynamic subtest: pipe-D-eDP-1 [503.706392] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [503.708657] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.005s) [505.881284] [100/154] (533s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-indfb-pgflip-blt) [505.995909] Starting subtest: fbcpsrhdr-1p-primscrn-indfb-pgflip-blt [506.000894] Subtest fbcpsrhdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [506.099330] [101/154] (533s left) gem_ctx_persistence (engines-hostile-preempt) [506.153257] Starting subtest: engines-hostile-preempt [506.156105] Starting dynamic subtest: rcs0 [506.232878] Dynamic subtest rcs0: SUCCESS (0.080s) [506.245371] Starting dynamic subtest: bcs0 [506.278178] Dynamic subtest bcs0: SUCCESS (0.043s) [506.288375] Starting dynamic subtest: vcs0 [508.215987] Dynamic subtest vcs0: SUCCESS (1.933s) [508.229322] Starting dynamic subtest: vcs1 [510.200952] Dynamic subtest vcs1: SUCCESS (1.982s) [510.215400] Starting dynamic subtest: vecs0 [512.187672] Dynamic subtest vecs0: SUCCESS (1.983s) [512.201248] Starting dynamic subtest: ccs0 [512.254346] Dynamic subtest ccs0: SUCCESS (0.065s) [512.257141] Subtest engines-hostile-preempt: SUCCESS (6.100s) [512.338354] [102/154] (527s left) kms_big_fb (x-tiled-16bpp-rotate-90) [512.446702] Starting subtest: x-tiled-16bpp-rotate-90 [512.466300] Subtest x-tiled-16bpp-rotate-90: SKIP (0.019s) [512.569280] [103/154] (527s left) i915_pm_rc6_residency (media-rc6-accuracy) [512.629889] Starting subtest: media-rc6-accuracy [512.635110] Subtest media-rc6-accuracy: SKIP (0.000s) [512.734543] [104/154] (526s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled) [512.791154] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled [512.796908] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s) [512.982801] [105/154] (526s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted) [513.034141] Starting subtest: etime-single-wait-all-available-unsubmitted [513.138423] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.105s) [513.229995] [106/154] (526s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-pwrite) [513.342141] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-pwrite [513.347085] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [513.425327] [107/154] (526s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc) [513.531578] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc [513.536536] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [513.636943] [108/154] (526s left) sw_sync (sync_multi_producer_single_consumer) [513.673086] Starting subtest: sync_multi_producer_single_consumer [514.749028] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s) [514.812638] [109/154] (525s left) kms_psr (psr-dpms) [514.906066] Starting subtest: psr-dpms [514.908717] Starting dynamic subtest: eDP-1 [517.916116] Dynamic subtest eDP-1: SUCCESS (3.007s) [517.918800] Subtest psr-dpms: SUCCESS (3.008s) [518.770528] [110/154] (521s left) gem_fence_thrash (bo-write-verify-none) [518.808553] Starting subtest: bo-write-verify-none [518.833565] Subtest bo-write-verify-none: SKIP (0.021s) [518.897962] [111/154] (521s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-shrfb-msflip-blt) [518.996040] Starting subtest: psrhdr-2p-primscrn-shrfb-msflip-blt [519.001111] Subtest psrhdr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [519.090429] [112/154] (520s left) i915_drm_fdinfo (virtual-busy) [519.136023] Starting subtest: virtual-busy [519.141030] Subtest virtual-busy: SKIP (0.000s) [519.211407] [113/154] (520s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-pwrite) [519.309168] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-pwrite [519.313580] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [519.406738] [114/154] (520s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-onoff) [519.501707] Starting subtest: psrhdr-2p-primscrn-spr-indfb-onoff [519.506258] Subtest psrhdr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [519.588987] [115/154] (520s left) kms_plane (plane-panning-bottom-right) [519.682075] Starting subtest: plane-panning-bottom-right [519.684792] Starting dynamic subtest: pipe-A [521.462014] Dynamic subtest pipe-A: SUCCESS (1.779s) [521.476072] Starting dynamic subtest: pipe-B [523.889875] Dynamic subtest pipe-B: SUCCESS (2.427s) [523.892698] Subtest plane-panning-bottom-right: SUCCESS (4.208s) [524.715312] [116/154] (515s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-mmap-gtt) [524.815118] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-mmap-gtt [524.819872] Subtest fbchdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [524.916288] [117/154] (515s left) kms_cursor_crc (cursor-onscreen-256x256) [525.173117] Starting subtest: cursor-onscreen-256x256 [525.179002] Starting dynamic subtest: pipe-A-eDP-1 [527.305636] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.125s) [527.335190] Starting dynamic subtest: pipe-D-eDP-1 [530.102924] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.776s) [530.105945] Subtest cursor-onscreen-256x256: SUCCESS (4.927s) [530.974314] [118/154] (509s left) gem_sync (basic-all) [531.046058] Starting subtest: basic-all [536.191568] Subtest basic-all: SUCCESS (5.153s) [536.382770] [119/154] (503s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc) [536.487859] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc [540.044839] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.561s) [541.272471] [120/154] (499s left) gen9_exec_parse (batch-zero-length) [541.325122] Subtest batch-zero-length: SKIP (0.000s) [541.398967] [121/154] (498s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-shrfb-msflip-blt) [541.490579] Starting subtest: psrhdr-1p-primscrn-shrfb-msflip-blt [541.495027] Subtest psrhdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [541.580482] [122/154] (498s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt) [541.679994] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt [541.685115] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [541.771405] [123/154] (498s left) kms_flip (2x-wf_vblank-ts-check-interruptible) [541.862389] Starting subtest: 2x-wf_vblank-ts-check-interruptible [541.874491] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.011s) [541.952888] [124/154] (498s left) prime_mmap (test_reprime) [542.011068] Starting subtest: test_reprime [542.013696] Starting dynamic subtest: test_reprime-smem [542.040894] Dynamic subtest test_reprime-smem: SUCCESS (0.033s) [542.043874] Subtest test_reprime: SUCCESS (0.034s) [542.142362] [125/154] (498s left) gem_render_copy (yf-tiled-ccs-to-x-tiled) [542.193631] Starting subtest: yf-tiled-ccs-to-x-tiled [542.198511] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s) [542.390632] [126/154] (498s left) kms_dirtyfb (default-dirtyfb-ioctl) [542.481259] Starting subtest: default-dirtyfb-ioctl [542.483981] Starting dynamic subtest: A-eDP-1 [544.094325] Dynamic subtest A-eDP-1: SUCCESS (1.613s) [544.097237] Subtest default-dirtyfb-ioctl: SUCCESS (1.614s) [544.901930] [127/154] (495s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff) [544.999149] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff [545.004126] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [545.100179] [128/154] (495s left) kms_psr (fbc-psr-sprite-mmap-cpu) [545.188191] Starting subtest: fbc-psr-sprite-mmap-cpu [545.191041] Starting dynamic subtest: eDP-1 [545.196020] Dynamic subtest eDP-1: SKIP (0.000s) [545.201131] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s) [545.268780] [129/154] (495s left) kms_vrr (flip-dpms) [545.368465] Starting subtest: flip-dpms [545.375659] Subtest flip-dpms: SKIP (0.000s) [545.443564] [130/154] (495s left) kms_draw_crc (draw-method-blt) [545.536184] Starting subtest: draw-method-blt [545.538774] Starting dynamic subtest: xrgb8888-untiled [545.766871] Dynamic subtest xrgb8888-untiled: SUCCESS (0.232s) [545.778180] Starting dynamic subtest: rgb565-untiled [545.999919] Dynamic subtest rgb565-untiled: SUCCESS (0.232s) [546.011130] Starting dynamic subtest: xrgb2101010-untiled [546.222860] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s) [546.234901] Starting dynamic subtest: xbgr16161616f-untiled [546.455965] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.233s) [546.467566] Starting dynamic subtest: xrgb8888-xtiled [546.578572] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s) [546.589875] Starting dynamic subtest: rgb565-xtiled [546.700797] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s) [546.711935] Starting dynamic subtest: xrgb2101010-xtiled [546.812079] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s) [546.824185] Starting dynamic subtest: xbgr16161616f-xtiled [546.922931] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.109s) [546.936882] Starting dynamic subtest: xrgb8888-4tiled [547.034717] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.110s) [547.046129] Starting dynamic subtest: rgb565-4tiled [547.156113] Dynamic subtest rgb565-4tiled: SUCCESS (0.121s) [547.169672] Starting dynamic subtest: xrgb2101010-4tiled [547.256660] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.098s) [547.267223] Starting dynamic subtest: xbgr16161616f-4tiled [547.378777] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.120s) [547.381130] Subtest draw-method-blt: SUCCESS (1.844s) [547.487801] [131/154] (493s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-mmap-wc) [547.577264] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-mmap-wc [547.581339] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [547.668357] [132/154] (493s left) syncobj_timeline (wait-all-complex) [547.723294] Starting subtest: wait-all-complex [547.940551] Subtest wait-all-complex: SUCCESS (0.217s) [548.019539] [133/154] (492s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-mmap-gtt) [548.119772] Starting subtest: fbchdr-rgb565-draw-mmap-gtt [548.124745] Subtest fbchdr-rgb565-draw-mmap-gtt: SKIP (0.000s) [548.218107] [134/154] (492s left) gem_lmem_swapping (parallel-multi) [548.258915] Subtest parallel-multi: SKIP (0.000s) [548.304955] [135/154] (492s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt) [548.396705] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt [548.401703] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s) [548.488063] [136/154] (492s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move) [548.594663] Starting subtest: fbc-2p-primscrn-cur-indfb-move [548.599838] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s) [548.682905] [137/154] (492s left) kms_big_fb (4-tiled-8bpp-rotate-90) [548.782071] Starting subtest: 4-tiled-8bpp-rotate-90 [548.803404] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.021s) [548.907695] [138/154] (492s left) kms_joiner (basic-big-joiner) [548.999083] Starting subtest: basic-big-joiner [549.003066] Subtest basic-big-joiner: SKIP (0.000s) [549.068660] [139/154] (492s left) syncobj_wait (wait-for-submit-snapshot) [549.120922] Starting subtest: wait-for-submit-snapshot [549.202978] Subtest wait-for-submit-snapshot: SUCCESS (0.083s) [549.287265] [140/154] (491s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf) [549.394063] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf [549.396480] Starting dynamic subtest: pipe-A-eDP-1 [549.493167] Dynamic subtest pipe-A-eDP-1: SKIP (0.103s) [549.504600] Starting dynamic subtest: pipe-B-eDP-1 [550.677631] Dynamic subtest pipe-B-eDP-1: SKIP (1.179s) [550.683034] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.285s) [551.857580] [141/154] (489s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-render) [551.958095] Starting subtest: psrhdr-rgb565-draw-render [551.963074] Subtest psrhdr-rgb565-draw-render: SKIP (0.000s) [552.045888] [142/154] (489s left) gem_exec_params (rel-constants-invalid-rel-gen5) [552.103138] Starting subtest: rel-constants-invalid-rel-gen5 [552.106064] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s) [552.205465] [143/154] (489s left) gem_exec_fence (basic-busy) [552.377840] Starting subtest: basic-busy [552.380629] Starting dynamic subtest: rcs0 [552.466611] Dynamic subtest rcs0: SUCCESS (0.088s) [552.480301] Starting dynamic subtest: bcs0 [552.531828] Dynamic subtest bcs0: SUCCESS (0.063s) [552.546496] Starting dynamic subtest: vcs0 [552.589267] Dynamic subtest vcs0: SUCCESS (0.055s) [552.602185] Starting dynamic subtest: vcs1 [552.650916] Dynamic subtest vcs1: SUCCESS (0.059s) [552.664678] Starting dynamic subtest: vecs0 [552.704344] Dynamic subtest vecs0: SUCCESS (0.051s) [552.718575] Starting dynamic subtest: ccs0 [552.758575] Dynamic subtest ccs0: SUCCESS (0.052s) [552.761578] Subtest basic-busy: SUCCESS (0.382s) [554.251336] [144/154] (487s left) gem_exec_schedule (pi-common) [554.421187] Starting subtest: pi-common [554.423769] Starting dynamic subtest: rcs0 [554.447608] Dynamic subtest rcs0: SUCCESS (0.028s) [554.462589] Starting dynamic subtest: bcs0 [554.475894] Dynamic subtest bcs0: SUCCESS (0.028s) [554.486153] Starting dynamic subtest: vcs0 [554.511060] Dynamic subtest vcs0: SUCCESS (0.034s) [554.521343] Starting dynamic subtest: vcs1 [554.544907] Dynamic subtest vcs1: SUCCESS (0.033s) [554.555280] Starting dynamic subtest: vecs0 [554.579106] Dynamic subtest vecs0: SUCCESS (0.033s) [554.589271] Starting dynamic subtest: ccs0 [554.614659] Dynamic subtest ccs0: SUCCESS (0.034s) [554.617071] Subtest pi-common: SUCCESS (0.196s) [554.842555] [145/154] (486s left) kms_psr (fbc-psr2-sprite-render) [554.937909] Starting subtest: fbc-psr2-sprite-render [554.940113] Starting dynamic subtest: eDP-1 [554.944962] Dynamic subtest eDP-1: SKIP (0.000s) [554.949559] Subtest fbc-psr2-sprite-render: SKIP (0.001s) [555.022899] [146/154] (486s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-move) [555.120767] Starting subtest: hdr-2p-scndscrn-cur-indfb-move [555.125969] Subtest hdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [555.217583] [147/154] (486s left) gem_pxp (create-regular-context-2) [555.347675] Starting subtest: create-regular-context-2 [555.350573] Subtest create-regular-context-2: SUCCESS (0.002s) [555.467637] [148/154] (486s left) kms_cursor_edge_walk (128x128-top-edge) [555.580760] Starting subtest: 128x128-top-edge [555.583644] Starting dynamic subtest: pipe-A-eDP-1 [559.036221] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.455s) [559.047418] Starting dynamic subtest: pipe-D-eDP-1 [562.168496] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.131s) [562.171063] Subtest 128x128-top-edge: SUCCESS (6.588s) [562.978155] [149/154] (478s left) prime_vgem (basic-fence-blt) [563.066239] Starting subtest: basic-fence-blt [563.145963] Subtest basic-fence-blt: SUCCESS (0.079s) [563.264739] [150/154] (478s left) perf (invalid-open-flags) [563.392130] Starting subtest: invalid-open-flags [563.394528] Subtest invalid-open-flags: SUCCESS (0.000s) [563.439678] [151/154] (478s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode) [563.830420] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s) [564.696331] [152/154] (477s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling) [564.783945] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling [564.788909] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s) [564.870898] [153/154] (476s left) kms_vblank (query-idle) [564.954081] Starting subtest: query-idle [564.956548] Starting dynamic subtest: pipe-A-eDP-1 [566.700987] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.747s) [566.719861] Starting dynamic subtest: pipe-D-eDP-1 [569.143266] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.439s) [569.146304] Subtest query-idle: SUCCESS (4.189s) [569.972081] [154/154] (471s left) gem_mmap_gtt (big-bo-tiledy) [570.035097] Subtest big-bo-tiledY: SKIP (0.000s) [570.096004] Closing watchdogs results: parsing output: 0/ for test: kms_prime results: parsing output: 1/ for test: kms_frontbuffer_tracking results: parsing output: 2/ for test: kms_cursor_legacy results: parsing output: 3/ for test: kms_color_pipeline results: parsing output: 4/ for test: prime_self_import results: parsing output: 5/ for test: kms_frontbuffer_tracking results: parsing output: 6/ for test: kms_content_protection results: parsing output: 7/ for test: kms_psr results: parsing output: 8/ for test: kms_psr results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: gem_tiled_partial_pwrite_pread results: parsing output: 11/ for test: gem_exec_store results: parsing output: 12/ for test: kms_frontbuffer_tracking results: parsing output: 13/ for test: kms_psr results: parsing output: 14/ for test: gen7_exec_parse results: parsing output: 15/ for test: kms_frontbuffer_tracking results: parsing output: 16/ for test: perf_pmu results: parsing output: 17/ for test: kms_plane_alpha_blend results: parsing output: 18/ for test: gem_exec_balancer results: parsing output: 19/ for test: gem_wait results: parsing output: 20/ for test: kms_frontbuffer_tracking results: parsing output: 21/ for test: kms_psr2_sf results: parsing output: 22/ for test: kms_async_flips results: parsing output: 23/ for test: kms_plane results: parsing output: 24/ for test: syncobj_wait results: parsing output: 25/ for test: kms_flip results: parsing output: 26/ for test: kms_frontbuffer_tracking results: parsing output: 27/ for test: gem_unfence_active_buffers results: parsing output: 28/ for test: gem_exec_reloc results: parsing output: 29/ for test: perf_pmu results: parsing output: 30/ for test: gem_busy results: parsing output: 31/ for test: kms_ccs results: parsing output: 32/ for test: kms_chamelium_color results: parsing output: 33/ for test: gem_ctx_engines results: parsing output: 34/ for test: api_intel_allocator results: parsing output: 35/ for test: kms_flip_scaled_crc results: parsing output: 36/ for test: syncobj_timeline results: parsing output: 37/ for test: gem_mmap_gtt results: parsing output: 38/ for test: gem_exec_schedule results: parsing output: 39/ for test: kms_cursor_legacy results: parsing output: 40/ for test: api_intel_bb results: parsing output: 41/ for test: kms_atomic results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: prime_mmap_kms results: parsing output: 44/ for test: kms_frontbuffer_tracking results: parsing output: 45/ for test: kms_frontbuffer_tracking results: parsing output: 46/ for test: kms_frontbuffer_tracking results: parsing output: 47/ for test: kms_pm_backlight results: parsing output: 48/ for test: kms_frontbuffer_tracking results: parsing output: 49/ for test: gem_ctx_bad_destroy results: parsing output: 50/ for test: gem_mmap_offset results: parsing output: 51/ for test: syncobj_timeline results: parsing output: 52/ for test: kms_busy results: parsing output: 53/ for test: i915_query results: parsing output: 54/ for test: kms_fbcon_fbt results: parsing output: 55/ for test: gem_ctx_persistence results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: kms_frontbuffer_tracking results: parsing output: 58/ for test: kms_ccs results: parsing output: 59/ for test: prime_mmap results: parsing output: 60/ for test: kms_plane results: parsing output: 61/ for test: dmabuf_sync_file results: parsing output: 62/ for test: kms_big_fb results: parsing output: 63/ for test: kms_draw_crc results: parsing output: 64/ for test: kms_flip results: parsing output: 65/ for test: kms_frontbuffer_tracking results: parsing output: 66/ for test: kms_lease results: parsing output: 67/ for test: kms_big_fb results: parsing output: 68/ for test: kms_frontbuffer_tracking results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: kms_cursor_crc results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: kms_rotation_crc results: parsing output: 73/ for test: syncobj_eventfd results: parsing output: 74/ for test: gem_exec_params results: parsing output: 75/ for test: kms_chamelium_frames results: parsing output: 76/ for test: kms_big_fb results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: gem_userptr_blits results: parsing output: 79/ for test: kms_addfb_basic results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: kms_ccs results: parsing output: 82/ for test: kms_pm_dc results: parsing output: 83/ for test: sysfs_timeslice_duration results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: kms_frontbuffer_tracking results: parsing output: 86/ for test: syncobj_wait results: parsing output: 87/ for test: syncobj_basic results: parsing output: 88/ for test: gem_exec_fence results: parsing output: 89/ for test: i915_drm_fdinfo results: parsing output: 90/ for test: gem_pipe_control_store_loop results: parsing output: 91/ for test: gem_softpin results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: kms_flip results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: kms_big_fb results: parsing output: 96/ for test: gem_exec_fence results: parsing output: 97/ for test: kms_frontbuffer_tracking results: parsing output: 98/ for test: kms_ccs results: parsing output: 99/ for test: kms_frontbuffer_tracking results: parsing output: 100/ for test: gem_ctx_persistence results: parsing output: 101/ for test: kms_big_fb results: parsing output: 102/ for test: i915_pm_rc6_residency results: parsing output: 103/ for test: gem_render_copy results: parsing output: 104/ for test: syncobj_timeline results: parsing output: 105/ for test: kms_frontbuffer_tracking results: parsing output: 106/ for test: kms_frontbuffer_tracking results: parsing output: 107/ for test: sw_sync results: parsing output: 108/ for test: kms_psr results: parsing output: 109/ for test: gem_fence_thrash results: parsing output: 110/ for test: kms_frontbuffer_tracking results: parsing output: 111/ for test: i915_drm_fdinfo results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: kms_plane results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: kms_cursor_crc results: parsing output: 117/ for test: gem_sync results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: gen9_exec_parse 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_flip results: parsing output: 123/ for test: prime_mmap results: parsing output: 124/ for test: gem_render_copy results: parsing output: 125/ for test: kms_dirtyfb results: parsing output: 126/ for test: kms_frontbuffer_tracking results: parsing output: 127/ for test: kms_psr results: parsing output: 128/ for test: kms_vrr results: parsing output: 129/ for test: kms_draw_crc results: parsing output: 130/ for test: kms_frontbuffer_tracking results: parsing output: 131/ for test: syncobj_timeline results: parsing output: 132/ for test: kms_frontbuffer_tracking results: parsing output: 133/ for test: gem_lmem_swapping results: parsing output: 134/ for test: kms_frontbuffer_tracking results: parsing output: 135/ for test: kms_frontbuffer_tracking results: parsing output: 136/ for test: kms_big_fb results: parsing output: 137/ for test: kms_joiner results: parsing output: 138/ for test: syncobj_wait results: parsing output: 139/ for test: kms_psr2_sf results: parsing output: 140/ for test: kms_frontbuffer_tracking results: parsing output: 141/ for test: gem_exec_params results: parsing output: 142/ for test: gem_exec_fence results: parsing output: 143/ for test: gem_exec_schedule results: parsing output: 144/ for test: kms_psr results: parsing output: 145/ for test: kms_frontbuffer_tracking results: parsing output: 146/ for test: gem_pxp results: parsing output: 147/ for test: kms_cursor_edge_walk results: parsing output: 148/ for test: prime_vgem results: parsing output: 149/ for test: perf results: parsing output: 150/ for test: kms_chamelium_hpd results: parsing output: 151/ for test: kms_flip_scaled_crc results: parsing output: 152/ for test: kms_vblank results: parsing output: 153/ for test: gem_mmap_gtt Done.