[60.938946] Initializing watchdogs [60.939015] /dev/watchdog0 [60.952263] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [60.956566] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [60.958541] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [60.961684] [001/129] (960s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs) [61.113971] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs [61.116335] Starting dynamic subtest: pipe-A-eDP-1 [61.138837] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [61.145611] Starting dynamic subtest: pipe-B-eDP-1 [61.166228] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [61.171819] Starting dynamic subtest: pipe-C-eDP-1 [61.193229] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [61.199240] Starting dynamic subtest: pipe-D-eDP-1 [61.221375] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [61.225485] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.002s) [63.275701] [002/129] (958s left) i915_pm_rps (min-max-config-idle) [63.342799] Starting subtest: min-max-config-idle [63.347454] Subtest min-max-config-idle: SKIP (0.000s) [63.410403] [003/129] (958s left) gem_partial_pwrite_pread (reads-uncached) [63.476646] Subtest reads-uncached: SKIP (0.000s) [63.551885] [004/129] (958s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt) [63.643488] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt [63.647598] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [63.748337] [005/129] (957s left) gem_lmem_swapping (heavy-verify-random-ccs) [63.787784] Subtest heavy-verify-random-ccs: SKIP (0.000s) [63.817465] [006/129] (957s left) kms_big_fb (4-tiled-8bpp-rotate-90) [63.911929] Starting subtest: 4-tiled-8bpp-rotate-90 [63.932848] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.020s) [64.036069] [007/129] (957s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted) [64.091866] Starting subtest: etime-single-wait-all-available-unsubmitted [64.195910] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.103s) [64.261603] [008/129] (957s left) gem_exec_create (basic) [64.323501] Starting subtest: basic [64.326043] Starting dynamic subtest: smem [67.954513] Dynamic subtest smem: SUCCESS (3.631s) [67.957563] Subtest basic: SUCCESS (3.631s) [68.128544] [009/129] (953s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb) [73.136265] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb [73.141087] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.002s) [73.966404] [010/129] (947s left) i915_module_load (reload-with-fault-injection) [74.000280] Starting subtest: reload-with-fault-injection [116.858536] Subtest reload-with-fault-injection: SUCCESS (42.862s) [116.879150] [FACT i915_module_load (reload-with-fault-injection)] deleted: kernel.kmod_is_loaded.i915: true [116.882167] [011/129] (904s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move) [118.476602] Starting subtest: fbc-1p-primscrn-spr-indfb-move [121.808204] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (3.336s) [121.947082] [FACT kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)] new: kernel.kmod_is_loaded.i915: true [121.947673] [FACT kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)] new: kernel.kmod_is_loaded.xe: true [121.950663] [012/129] (899s left) kms_cursor_crc (cursor-offscreen-256x256) [122.172246] Starting subtest: cursor-offscreen-256x256 [122.176345] Starting dynamic subtest: pipe-A-eDP-1 [124.161087] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.984s) [124.185682] Starting dynamic subtest: pipe-D-eDP-1 [126.821972] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.641s) [126.825021] Subtest cursor-offscreen-256x256: SUCCESS (4.648s) [127.632714] [013/129] (894s left) kms_cursor_crc (cursor-random-128x42) [127.827418] Starting subtest: cursor-random-128x42 [127.864900] Subtest cursor-random-128x42: SKIP (0.032s) [128.048519] [014/129] (893s left) kms_big_fb (x-tiled-64bpp-rotate-90) [128.148364] Starting subtest: x-tiled-64bpp-rotate-90 [128.167343] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s) [128.296849] [015/129] (893s left) gem_close_race (multigpu-basic-process) [128.366982] Starting subtest: multigpu-basic-process [128.371622] Subtest multigpu-basic-process: SKIP (0.000s) [128.604292] [016/129] (893s left) gem_exec_params (invalid-bsd-ring) [128.656147] Starting subtest: invalid-bsd-ring [128.658575] Subtest invalid-bsd-ring: SUCCESS (0.000s) [128.740438] [017/129] (893s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu) [128.847706] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu [128.851895] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [128.934118] [018/129] (893s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [129.030239] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu [129.034535] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [129.133179] [019/129] (892s left) kms_flip (2x-plain-flip) [129.237976] Starting subtest: 2x-plain-flip [129.248649] Subtest 2x-plain-flip: SKIP (0.010s) [129.318285] [020/129] (892s left) gem_exec_whisper (basic-contexts-priority-all) [129.380512] Starting subtest: basic-contexts-priority-all [151.800994] Subtest basic-contexts-priority-all: SUCCESS (22.415s) [151.979444] [021/129] (870s left) kms_big_fb (y-tiled-addfb-size-offset-overflow) [152.088412] Starting subtest: y-tiled-addfb-size-offset-overflow [152.092617] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s) [152.180697] [022/129] (869s left) kms_flip (2x-blocking-absolute-wf_vblank) [152.276900] Starting subtest: 2x-blocking-absolute-wf_vblank [152.287620] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.010s) [152.408365] [023/129] (869s left) gem_ctx_isolation (clean) [152.473203] Starting subtest: clean [152.475338] Starting dynamic subtest: rcs0 [152.562624] Dynamic subtest rcs0: SUCCESS (0.090s) [152.572732] Starting dynamic subtest: bcs0 [152.683368] Dynamic subtest bcs0: SUCCESS (0.120s) [152.692621] Starting dynamic subtest: vcs0 [152.798479] Dynamic subtest vcs0: SUCCESS (0.115s) [152.806110] Starting dynamic subtest: vcs1 [153.989731] Dynamic subtest vcs1: SUCCESS (1.190s) [154.000072] Starting dynamic subtest: vecs0 [155.980816] Dynamic subtest vecs0: SUCCESS (1.990s) [155.991095] Starting dynamic subtest: ccs0 [157.998691] Dynamic subtest ccs0: SUCCESS (2.018s) [158.001392] Subtest clean: SUCCESS (5.525s) [158.213624] [024/129] (863s left) gem_exec_reloc (basic-write-cpu-noreloc) [158.285510] Subtest basic-write-cpu-noreloc: SKIP (0.000s) [158.361157] [025/129] (863s left) syncobj_wait (invalid-wait-bad-flags) [158.417318] Starting subtest: invalid-wait-bad-flags [158.419607] Subtest invalid-wait-bad-flags: SUCCESS (0.000s) [158.507776] [026/129] (863s left) api_intel_bb (blit-reloc-purge-cache) [158.563117] Starting subtest: blit-reloc-purge-cache [158.568073] Subtest blit-reloc-purge-cache: SKIP (0.001s) [158.669280] [027/129] (863s left) perf_pmu (rc6-suspend) [158.708467] Starting subtest: rc6-suspend [181.509809] Subtest rc6-suspend: SUCCESS (7.508s) [182.370092] [028/129] (855s left) gem_exec_reloc (basic-active) [182.436599] Subtest basic-active: SKIP (0.000s) [182.509404] [029/129] (855s left) i915_query (query-topology-coherent-slice-mask) [182.564373] Starting subtest: query-topology-coherent-slice-mask [182.568042] Subtest query-topology-coherent-slice-mask: SKIP (0.000s) [182.641708] [030/129] (855s left) kms_cursor_crc (cursor-rapid-movement-32x32) [182.769607] Starting subtest: cursor-rapid-movement-32x32 [182.809614] Subtest cursor-rapid-movement-32x32: SKIP (0.035s) [183.081762] [031/129] (854s left) gem_exec_balancer (parallel) [183.335539] Starting subtest: parallel [184.110271] Subtest parallel: SUCCESS (0.776s) [185.301957] [032/129] (852s left) gem_softpin (zero) [185.361545] Starting subtest: zero [185.369608] Subtest zero: SUCCESS (0.008s) [185.494367] [033/129] (852s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move) [185.608033] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move [190.880051] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (5.279s) [191.055313] [034/129] (846s left) gem_exec_fence (syncobj-repeat) [191.561387] Starting subtest: syncobj-repeat [191.730113] Subtest syncobj-repeat: SUCCESS (0.167s) [193.289661] [FACT gem_exec_fence (syncobj-repeat)] new: kernel.kmod_is_loaded.vgem: true [193.293803] [035/129] (844s left) sysfs_heartbeat_interval (invalid) [193.355474] Starting subtest: invalid [193.357935] Starting dynamic subtest: vecs0 [193.360528] Dynamic subtest vecs0: SUCCESS (0.000s) [193.370079] Starting dynamic subtest: ccs0 [193.372033] Dynamic subtest ccs0: SUCCESS (0.000s) [193.379685] Starting dynamic subtest: vcs0 [193.381605] Dynamic subtest vcs0: SUCCESS (0.000s) [193.389169] Starting dynamic subtest: bcs0 [193.391115] Dynamic subtest bcs0: SUCCESS (0.000s) [193.399850] Starting dynamic subtest: rcs0 [193.402290] Dynamic subtest rcs0: SUCCESS (0.000s) [193.413380] Starting dynamic subtest: vcs1 [193.415420] Dynamic subtest vcs1: SUCCESS (0.000s) [193.417480] Subtest invalid: SUCCESS (0.003s) [193.450600] [036/129] (844s left) kms_psr (psr2-cursor-plane-move) [193.543059] Starting subtest: psr2-cursor-plane-move [193.545610] Starting dynamic subtest: eDP-1 [195.189595] Dynamic subtest eDP-1: SUCCESS (1.647s) [195.191810] Subtest psr2-cursor-plane-move: SUCCESS (1.647s) [195.965506] [037/129] (841s left) kms_psr (psr-cursor-mmap-cpu) [196.066263] Starting subtest: psr-cursor-mmap-cpu [196.068506] Starting dynamic subtest: eDP-1 [197.748179] Dynamic subtest eDP-1: SUCCESS (1.684s) [197.750574] Subtest psr-cursor-mmap-cpu: SUCCESS (1.685s) [198.607788] [038/129] (839s left) kms_pm_backlight (brightness-with-dpms) [198.711337] Starting subtest: brightness-with-dpms [198.777619] Starting dynamic subtest: eDP-1 [201.206926] Dynamic subtest eDP-1: SUCCESS (2.432s) [201.209396] Subtest brightness-with-dpms: SUCCESS (2.498s) [202.066214] [039/129] (835s left) i915_hangman (detector) [202.133600] Starting subtest: detector [202.135880] Starting dynamic subtest: rcs0 [214.225816] Dynamic subtest rcs0: SUCCESS (12.092s) [214.236930] Starting dynamic subtest: bcs0 [226.193111] Dynamic subtest bcs0: SUCCESS (11.966s) [226.204249] Starting dynamic subtest: vcs0 [238.162712] Dynamic subtest vcs0: SUCCESS (11.969s) [238.174471] Starting dynamic subtest: vcs1 [250.130145] Dynamic subtest vcs1: SUCCESS (11.967s) [250.142416] Starting dynamic subtest: vecs0 [261.138392] Dynamic subtest vecs0: SUCCESS (11.008s) [261.149623] Starting dynamic subtest: ccs0 [272.209695] Dynamic subtest ccs0: SUCCESS (11.072s) [272.212806] Subtest detector: SUCCESS (70.085s) [272.288975] [040/129] (765s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-blt) [272.402065] Starting subtest: fbc-1p-offscren-pri-indfb-draw-blt [275.554332] Subtest fbc-1p-offscren-pri-indfb-draw-blt: SUCCESS (3.156s) [275.698803] [041/129] (762s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc) [275.800456] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc [280.645241] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.845s) [280.761628] [042/129] (757s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite) [280.873604] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite [285.228138] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (4.363s) [285.353984] [043/129] (752s left) gem_exec_create (legacy) [285.428044] Starting subtest: legacy [285.430137] Starting dynamic subtest: smem [289.267102] Dynamic subtest smem: SUCCESS (3.836s) [289.270057] Subtest legacy: SUCCESS (3.837s) [289.443096] [044/129] (748s left) gem_pwrite (basic-exhaustion) [289.501361] Subtest basic-exhaustion: SKIP (0.000s) [289.569768] [045/129] (748s left) syncobj_wait (invalid-reset-one-illegal-handle) [289.626105] Starting subtest: invalid-reset-one-illegal-handle [289.628592] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s) [289.729051] [046/129] (748s left) gem_mmap_wc (write-prefaulted) [289.788378] Subtest write-prefaulted: SKIP (0.000s) [289.849589] [047/129] (748s left) gem_exec_balancer (bonded-chain) [289.922166] Starting subtest: bonded-chain [296.760373] Subtest bonded-chain: SUCCESS (6.835s) [297.073970] [048/129] (741s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0) [297.180717] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0 [298.135910] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (0.956s) [298.240756] [049/129] (740s left) gem_vm_create (isolation) [298.308120] Starting subtest: isolation [298.320110] Subtest isolation: SUCCESS (0.012s) [298.431993] [050/129] (739s left) gem_ctx_isolation (preservation-reset) [298.604004] Starting subtest: preservation-reset [298.606921] Starting dynamic subtest: rcs0 [298.982368] Dynamic subtest rcs0: SUCCESS (0.377s) [298.994101] Starting dynamic subtest: bcs0 [299.446383] Dynamic subtest bcs0: SUCCESS (0.465s) [299.457956] Starting dynamic subtest: vcs0 [299.877928] Dynamic subtest vcs0: SUCCESS (0.431s) [299.889615] Starting dynamic subtest: vcs1 [301.683788] Dynamic subtest vcs1: SUCCESS (1.804s) [301.699404] Starting dynamic subtest: vecs0 [303.668478] Dynamic subtest vecs0: SUCCESS (1.985s) [303.679553] Starting dynamic subtest: ccs0 [305.711645] Dynamic subtest ccs0: SUCCESS (2.042s) [305.714378] Subtest preservation-reset: SUCCESS (7.110s) [305.925042] [051/129] (732s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu) [306.028789] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu [310.500146] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (4.475s) [310.620252] [052/129] (727s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite) [310.724368] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite [316.049541] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (5.329s) [316.160686] [053/129] (722s left) kms_chamelium_color (ctm-green-to-red) [316.256479] Subtest ctm-green-to-red: SKIP (0.000s) [316.295839] [054/129] (722s left) gem_exec_schedule (preempt-other-chain) [316.371232] Starting subtest: preempt-other-chain [316.373807] Starting dynamic subtest: rcs0 [316.440232] Dynamic subtest rcs0: SUCCESS (0.076s) [316.455609] Starting dynamic subtest: bcs0 [316.514080] Dynamic subtest bcs0: SUCCESS (0.074s) [316.523989] Starting dynamic subtest: vcs0 [316.590715] Dynamic subtest vcs0: SUCCESS (0.075s) [316.604603] Starting dynamic subtest: vcs1 [316.663935] Dynamic subtest vcs1: SUCCESS (0.073s) [316.674709] Starting dynamic subtest: vecs0 [316.738412] Dynamic subtest vecs0: SUCCESS (0.075s) [316.751887] Starting dynamic subtest: ccs0 [316.816182] Dynamic subtest ccs0: SUCCESS (0.077s) [316.818474] Subtest preempt-other-chain: SUCCESS (0.453s) [318.360179] [055/129] (720s left) gem_readwrite (new-obj) [318.418885] Subtest new-obj: SKIP (0.000s) [318.481096] [056/129] (720s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size) [318.599397] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size [329.806192] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.205s) [330.650836] [057/129] (707s left) kms_rotation_crc (primary-x-tiled-reflect-x-0) [330.744721] Starting subtest: primary-x-tiled-reflect-x-0 [337.870070] Subtest primary-x-tiled-reflect-x-0: SUCCESS (7.127s) [339.093938] [058/129] (699s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc) [339.191652] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc [339.195803] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [339.303317] [059/129] (699s left) kms_fbcon_fbt (fbc-suspend) [339.372164] Starting subtest: fbc-suspend [386.442680] Subtest fbc-suspend: SUCCESS (17.653s) [386.515835] [060/129] (681s left) syncobj_timeline (wait-for-submit-delayed-submit) [386.574670] Starting subtest: wait-for-submit-delayed-submit [386.678524] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s) [386.749993] [061/129] (681s left) gem_linear_blits (basic) [387.189086] Starting subtest: basic [387.198044] Subtest basic: SUCCESS (0.010s) [387.342490] [062/129] (680s left) kms_vblank (wait-forked-hang) [387.493336] Starting subtest: wait-forked-hang [387.495747] Starting dynamic subtest: pipe-A-eDP-1 [414.456502] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.974s) [414.470427] Starting dynamic subtest: pipe-D-eDP-1 [439.394832] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.938s) [439.397021] Subtest wait-forked-hang: SUCCESS (51.917s) [440.196983] [063/129] (627s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0) [440.307749] Starting subtest: linear-max-hw-stride-64bpp-rotate-0 [441.531875] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.224s) [441.648924] [064/129] (626s left) kms_busy (extended-pageflip-hang-newfb) [441.751881] Starting subtest: extended-pageflip-hang-newfb [441.753911] Starting dynamic subtest: pipe-A [469.443416] Dynamic subtest pipe-A: SUCCESS (27.699s) [469.453761] Starting dynamic subtest: pipe-D [494.465666] Dynamic subtest pipe-D: SUCCESS (25.013s) [494.467867] Subtest extended-pageflip-hang-newfb: SUCCESS (52.716s) [495.332479] [065/129] (572s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt) [495.447850] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt [499.129500] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (3.686s) [499.274073] [066/129] (569s left) kms_rmfb (close-fd) [499.381926] Starting subtest: close-fd [499.383869] Starting dynamic subtest: pipe-A-eDP-1 [499.503668] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.118s) [499.514738] Starting dynamic subtest: pipe-B-eDP-1 [500.708321] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.203s) [500.719361] Starting dynamic subtest: pipe-C-eDP-1 [501.836392] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.120s) [501.847275] Starting dynamic subtest: pipe-D-eDP-1 [502.956436] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.127s) [502.958796] Subtest close-fd: SUCCESS (3.572s) [504.164526] [067/129] (564s left) gem_ppgtt (blt-vs-render-ctx0) [504.238515] Starting subtest: blt-vs-render-ctx0 [537.071486] Subtest blt-vs-render-ctx0: SUCCESS (32.831s) [537.205400] [068/129] (531s left) gem_flink_race (flink_name) [537.273081] Starting subtest: flink_name [542.668344] Subtest flink_name: SUCCESS (5.396s) [542.781377] [069/129] (525s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt) [542.901651] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt [542.905775] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s) [543.023532] [070/129] (525s left) debugfs_test (read_all_entries_display_off) [543.124180] Starting subtest: read_all_entries_display_off [544.216691] Subtest read_all_entries_display_off: SUCCESS (1.092s) [544.519144] [071/129] (523s left) gem_exec_schedule (submit-early-slice) [544.600392] Starting subtest: submit-early-slice [544.602336] Starting dynamic subtest: rcs0 [544.629395] Dynamic subtest rcs0: SUCCESS (0.037s) [544.639399] Starting dynamic subtest: bcs0 [544.663227] Dynamic subtest bcs0: SUCCESS (0.033s) [544.672386] Starting dynamic subtest: vcs0 [544.704005] Dynamic subtest vcs0: SUCCESS (0.040s) [544.714434] Starting dynamic subtest: vcs1 [544.745567] Dynamic subtest vcs1: SUCCESS (0.041s) [544.760009] Starting dynamic subtest: vecs0 [544.780287] Dynamic subtest vecs0: SUCCESS (0.034s) [544.791992] Starting dynamic subtest: ccs0 [544.815366] Dynamic subtest ccs0: SUCCESS (0.034s) [544.817650] Subtest submit-early-slice: SUCCESS (0.224s) [546.771796] [072/129] (521s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size) [546.900439] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size [547.892896] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.996s) [548.746661] [073/129] (519s left) gem_reg_read (bad-register) [548.798178] Starting subtest: bad-register [548.800699] Subtest bad-register: SUCCESS (0.000s) [548.878244] [074/129] (519s left) syncobj_wait (multi-wait-for-submit-unsubmitted) [548.945210] Starting subtest: multi-wait-for-submit-unsubmitted [549.052685] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.106s) [549.125627] [075/129] (519s left) api_intel_bb (offset-control) [549.178136] Starting subtest: offset-control [549.185572] Subtest offset-control: SUCCESS (0.010s) [549.315163] [076/129] (519s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling) [549.417626] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling [549.419900] Starting dynamic subtest: pipe-A-default-mode [549.705336] Dynamic subtest pipe-A-default-mode: SKIP (0.284s) [549.710017] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.285s) [550.564098] [077/129] (518s left) gem_userptr_blits (stress-mm-invalidate-close) [550.630946] Starting subtest: stress-mm-invalidate-close [552.782613] Subtest stress-mm-invalidate-close: SUCCESS (2.150s) [552.937721] [078/129] (515s left) kms_vblank (query-busy-hang) [553.031290] Starting subtest: query-busy-hang [553.033506] Starting dynamic subtest: pipe-A-eDP-1 [579.425512] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.397s) [579.439859] Starting dynamic subtest: pipe-D-eDP-1 [594.411851] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.988s) [594.414252] Subtest query-busy-hang: SUCCESS (41.389s) [595.205811] [079/129] (473s left) gem_exec_reloc (basic-wc-read-active) [595.271038] Subtest basic-wc-read-active: SKIP (0.000s) [595.329456] [080/129] (473s left) syncobj_eventfd (binary-wait) [595.386054] Starting subtest: binary-wait [595.393870] Subtest binary-wait: SUCCESS (0.010s) [595.501746] [081/129] (473s left) perf_pmu (busy-double-start) [595.543805] Starting subtest: busy-double-start [595.546075] Starting dynamic subtest: rcs0 [599.186285] Dynamic subtest rcs0: FAIL (3.590s) [599.196592] Starting dynamic subtest: bcs0 [602.697616] Dynamic subtest bcs0: SUCCESS (3.567s) [602.708126] Starting dynamic subtest: vcs0 [607.182659] Dynamic subtest vcs0: SUCCESS (4.483s) [607.195357] Starting dynamic subtest: vcs1 [611.188313] Dynamic subtest vcs1: SUCCESS (4.003s) [611.201072] Starting dynamic subtest: vecs0 [615.235947] Dynamic subtest vecs0: SUCCESS (4.045s) [615.248013] Starting dynamic subtest: ccs0 [618.871450] Dynamic subtest ccs0: FAIL (3.563s) [618.873817] Subtest busy-double-start: FAIL (23.258s) [618.909113] [082/129] (449s left) kms_addfb_basic (master-rmfb) [618.964291] Starting subtest: master-rmfb [618.966581] Subtest master-rmfb: SUCCESS (0.001s) [619.113559] [083/129] (449s left) gem_ctx_persistence (legacy-engines-queued) [619.185671] Starting subtest: legacy-engines-queued [619.188043] Starting dynamic subtest: render [619.305843] Dynamic subtest render: SUCCESS (0.119s) [619.318172] Starting dynamic subtest: bsd1 [620.625873] Dynamic subtest bsd1: SUCCESS (1.315s) [620.637055] Starting dynamic subtest: bsd2 [622.670846] Dynamic subtest bsd2: SUCCESS (2.040s) [622.683936] Starting dynamic subtest: blt [622.751225] Dynamic subtest blt: SUCCESS (0.079s) [622.764150] Starting dynamic subtest: vebox [624.656251] Dynamic subtest vebox: SUCCESS (1.900s) [624.659362] Subtest legacy-engines-queued: SUCCESS (5.469s) [624.729569] [084/129] (444s left) syncobj_timeline (multi-wait-for-submit-signaled) [624.780597] Starting subtest: multi-wait-for-submit-signaled [624.782863] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s) [624.895475] [085/129] (444s left) gem_mmap_gtt (fault-concurrent-x) [624.958963] Subtest fault-concurrent-X: SKIP (0.000s) [625.015428] [086/129] (443s left) gem_fenced_exec_thrash (no-spare-fences) [625.070545] Subtest no-spare-fences: SKIP (0.000s) [625.150951] [087/129] (443s left) i915_query (query-regions-sanity-check) [625.209931] Starting subtest: query-regions-sanity-check [625.224148] Subtest query-regions-sanity-check: SUCCESS (0.017s) [625.323390] [088/129] (443s left) syncobj_wait (wait-any-snapshot) [625.378822] Starting subtest: wait-any-snapshot [625.461099] Subtest wait-any-snapshot: SUCCESS (0.081s) [625.535683] [089/129] (443s left) kms_feature_discovery (psr2) [625.632594] Starting subtest: psr2 [625.634656] Subtest psr2: SUCCESS (0.000s) [625.698749] [090/129] (443s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs) [625.792092] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs [625.793986] Starting dynamic subtest: pipe-A-eDP-1 [658.487380] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.846s) [658.496911] Starting dynamic subtest: pipe-B-eDP-1 [691.402364] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.466s) [691.412577] Starting dynamic subtest: pipe-C-eDP-1 [724.390221] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.437s) [724.400201] Starting dynamic subtest: pipe-D-eDP-1 [757.392390] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.434s) [757.394940] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (13.188s) [758.603617] [091/129] (428s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc) [758.709791] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc [758.712333] Starting dynamic subtest: pipe-A-eDP-1 [758.737539] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [758.748214] Starting dynamic subtest: pipe-B-eDP-1 [758.773605] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [758.782845] Starting dynamic subtest: pipe-C-eDP-1 [758.808761] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [758.817937] Starting dynamic subtest: pipe-D-eDP-1 [758.844086] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [758.849030] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [760.859012] [092/129] (426s left) kms_getfb (getfb2-handle-not-fb) [760.923701] Starting subtest: getfb2-handle-not-fb [760.964428] Subtest getfb2-handle-not-fb: SUCCESS (0.042s) [761.053021] [093/129] (426s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render) [761.169738] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render [761.174783] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [761.255803] [094/129] (426s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render) [761.373141] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render [765.939209] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (4.571s) [766.051197] [095/129] (421s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format) [766.154327] Starting subtest: plane-scaler-unity-scaling-with-pixel-format [766.156694] Starting dynamic subtest: pipe-A [767.842521] Dynamic subtest pipe-A: SUCCESS (1.688s) [767.852298] Starting dynamic subtest: pipe-B [770.563651] Dynamic subtest pipe-B: SUCCESS (2.722s) [770.572487] Starting dynamic subtest: pipe-C [771.725088] Dynamic subtest pipe-C: SUCCESS (1.161s) [771.736946] Starting dynamic subtest: pipe-D [772.945750] Dynamic subtest pipe-D: SUCCESS (1.220s) [772.948967] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (6.795s) [774.107137] [096/129] (413s left) kms_psr (fbc-psr2-cursor-plane-onoff) [774.203782] Starting subtest: fbc-psr2-cursor-plane-onoff [774.206652] Starting dynamic subtest: eDP-1 [774.211944] Dynamic subtest eDP-1: SKIP (0.000s) [774.217542] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s) [774.272040] [097/129] (413s left) kms_multipipe_modeset (basic-max-pipe-crc-check) [774.376933] Starting subtest: basic-max-pipe-crc-check [774.382057] Subtest basic-max-pipe-crc-check: SKIP (0.000s) [774.420396] [098/129] (413s left) drm_fdinfo (busy) [774.463504] Starting subtest: busy [774.466203] Starting dynamic subtest: rcs0 [774.496332] Dynamic subtest rcs0: SKIP (0.032s) [774.506689] Starting dynamic subtest: bcs0 [774.511209] Dynamic subtest bcs0: SKIP (0.000s) [774.520620] Starting dynamic subtest: vcs0 [774.525573] Dynamic subtest vcs0: SKIP (0.000s) [774.534135] Starting dynamic subtest: vcs1 [774.538721] Dynamic subtest vcs1: SKIP (0.000s) [774.547779] Starting dynamic subtest: vecs0 [774.552704] Dynamic subtest vecs0: SKIP (0.000s) [774.561672] Starting dynamic subtest: ccs0 [774.566495] Dynamic subtest ccs0: SKIP (0.000s) [774.571474] Subtest busy: SKIP (0.037s) [774.603315] [099/129] (413s left) kms_joiner (basic-force-ultra-joiner) [774.721930] Starting subtest: basic-force-ultra-joiner [774.727079] Subtest basic-force-ultra-joiner: SKIP (0.000s) [774.781158] [100/129] (413s left) kms_chamelium_hpd (vga-hpd-fast) [775.168798] Subtest vga-hpd-fast: SKIP (0.000s) [776.011269] [101/129] (411s left) kms_psr (fbc-pr-suspend) [776.105488] Starting subtest: fbc-pr-suspend [776.110528] Subtest fbc-pr-suspend: SKIP (0.000s) [776.174151] [102/129] (411s left) gem_exec_params (invalid-bsd2-flag-on-render) [776.227060] Starting subtest: invalid-bsd2-flag-on-render [776.229714] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s) [776.325241] [103/129] (411s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs) [776.404953] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs [776.410915] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s) [776.585416] [104/129] (411s left) kms_plane (odd-panning) [776.686752] Starting subtest: odd-panning [776.689406] Starting dynamic subtest: pipe-A-eDP-1 [777.220703] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.533s) [777.223789] Subtest odd-panning: SUCCESS (0.534s) [778.061130] [105/129] (410s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling) [778.154642] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling [778.157345] Starting dynamic subtest: pipe-A-default-mode [780.858324] Dynamic subtest pipe-A-default-mode: SUCCESS (2.704s) [780.861021] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.705s) [781.637274] [106/129] (406s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted) [781.712948] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted [781.817309] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.104s) [781.891566] [107/129] (406s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render) [782.002625] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render [782.007851] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [782.102167] [108/129] (406s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc) [782.207825] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc [786.769861] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (4.568s) [786.876671] [109/129] (401s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [786.993540] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [786.998657] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [787.085632] [110/129] (401s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render) [787.196904] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render [787.201841] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [787.313962] [111/129] (401s left) kms_rotation_crc (sprite-rotation-180) [787.419800] Starting subtest: sprite-rotation-180 [792.582694] Subtest sprite-rotation-180: SUCCESS (5.161s) [793.753498] [112/129] (394s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size) [793.873779] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size [802.117579] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (8.241s) [802.981130] [113/129] (385s left) kms_dither (fb-8bpc-vs-panel-6bpc) [803.073382] Starting subtest: fb-8bpc-vs-panel-6bpc [803.075659] Starting dynamic subtest: pipe-A-eDP-1 [804.461718] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.385s) [804.463966] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.386s) [805.246827] [114/129] (383s left) kms_pipe_crc_basic (read-crc) [805.358593] Starting subtest: read-crc [805.361088] Starting dynamic subtest: pipe-A-eDP-1 [806.049252] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.687s) [806.059897] Starting dynamic subtest: pipe-B-eDP-1 [807.405796] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.355s) [807.416200] Starting dynamic subtest: pipe-C-eDP-1 [808.691849] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.284s) [808.702914] Starting dynamic subtest: pipe-D-eDP-1 [810.051792] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.360s) [810.054849] Subtest read-crc: SUCCESS (4.692s) [810.858603] [115/129] (377s left) kms_chamelium_hpd (dp-hpd-for-each-pipe) [811.235621] Subtest dp-hpd-for-each-pipe: SKIP (0.000s) [812.060235] [116/129] (376s left) gem_render_copy (x-tiled-to-vebox-y-tiled) [812.127203] Starting subtest: x-tiled-to-vebox-y-tiled [812.132893] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s) [812.310581] [117/129] (376s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf) [817.329771] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf [817.332703] Starting dynamic subtest: pipe-A-eDP-1 [818.130662] Dynamic subtest pipe-A-eDP-1: SKIP (0.796s) [818.141548] Starting dynamic subtest: pipe-B-eDP-1 [819.256614] Dynamic subtest pipe-B-eDP-1: SKIP (1.124s) [819.262141] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.923s) [820.429853] [118/129] (368s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs) [820.525476] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs [820.527840] Starting dynamic subtest: pipe-A-eDP-1 [820.586851] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [820.595907] Starting dynamic subtest: pipe-B-eDP-1 [820.657507] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [820.670194] Starting dynamic subtest: pipe-C-eDP-1 [820.733403] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [820.742531] Starting dynamic subtest: pipe-D-eDP-1 [820.803110] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [820.807359] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.008s) [822.680439] [119/129] (365s left) syncobj_wait (signal) [822.742811] Starting subtest: signal [822.745943] Subtest signal: SUCCESS (0.000s) [822.842620] [120/129] (365s left) gem_userptr_blits (usage-restrictions) [822.904355] Starting subtest: usage-restrictions [822.906532] Subtest usage-restrictions: SUCCESS (0.000s) [823.048712] [121/129] (365s left) kms_flip (nonblocking-read) [823.147614] Starting subtest: nonblocking-read [823.149936] Subtest nonblocking-read: SUCCESS (0.000s) [823.267054] [122/129] (365s left) gem_mmap_gtt (basic-write-read) [823.330800] Subtest basic-write-read: SKIP (0.000s) [823.394062] [123/129] (365s left) kms_scaling_modes (scaling-mode-none) [823.493797] Starting subtest: scaling-mode-none [823.496570] Starting dynamic subtest: pipe-A-eDP-1 [823.609380] Dynamic subtest pipe-A-eDP-1: SKIP (0.114s) [823.620681] Starting dynamic subtest: pipe-B-eDP-1 [823.662561] Dynamic subtest pipe-B-eDP-1: SKIP (0.052s) [823.672422] Starting dynamic subtest: pipe-C-eDP-1 [823.708632] Dynamic subtest pipe-C-eDP-1: SKIP (0.045s) [823.719751] Starting dynamic subtest: pipe-D-eDP-1 [823.755586] Dynamic subtest pipe-D-eDP-1: SKIP (0.046s) [823.759701] Subtest scaling-mode-none: SKIP (0.264s) [823.883481] [124/129] (364s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt) [823.984698] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt [823.989530] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [824.073344] [125/129] (364s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow) [824.172393] Starting subtest: yf-tiled-addfb-size-offset-overflow [824.176899] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s) [824.273420] [126/129] (364s left) kms_dirtyfb (default-dirtyfb-ioctl) [824.368735] Starting subtest: default-dirtyfb-ioctl [824.370555] Starting dynamic subtest: A-eDP-1 [825.989742] Dynamic subtest A-eDP-1: SUCCESS (1.623s) [825.992571] Subtest default-dirtyfb-ioctl: SUCCESS (1.624s) [826.801402] [127/129] (362s left) drm_fdinfo (virtual-busy) [826.841926] Starting subtest: virtual-busy [826.847819] Subtest virtual-busy: SKIP (0.000s) [826.898525] [128/129] (362s left) syncobj_timeline (multi-wait-available-signaled) [826.946686] Starting subtest: multi-wait-available-signaled [826.949484] Subtest multi-wait-available-signaled: SUCCESS (0.000s) [827.053393] [129/129] (361s left) kms_psr (pr-cursor-plane-onoff) [827.158711] Starting subtest: pr-cursor-plane-onoff [827.163846] Subtest pr-cursor-plane-onoff: SKIP (0.000s) [827.225263] Closing watchdogs Done.