[59.774622] Initializing watchdogs [59.774737] /dev/watchdog0 [59.790038] [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] [59.794922] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.797179] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.800745] [001/133] (960s left) kms_cursor_crc (cursor-onscreen-512x512) [60.100454] Starting subtest: cursor-onscreen-512x512 [60.104687] Subtest cursor-onscreen-512x512: SKIP (0.001s) [60.264543] [002/133] (960s left) gem_exec_whisper (basic-queues-priority-all) [60.349221] Starting subtest: basic-queues-priority-all [82.113019] Subtest basic-queues-priority-all: SUCCESS (21.744s) [82.294600] [003/133] (938s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt) [82.399184] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt [82.403612] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [82.497232] [004/133] (937s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs) [82.590992] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs [82.595589] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s) [83.676609] [005/133] (936s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip) [83.781680] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip [83.785685] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [83.872131] [006/133] (936s left) gem_ctx_param (basic-default) [83.934603] Starting subtest: basic-default [83.937037] Subtest basic-default: SUCCESS (0.000s) [84.008182] [007/133] (936s left) kms_flip (bo-too-big-interruptible) [84.098666] Starting subtest: bo-too-big-interruptible [84.100932] Starting dynamic subtest: A-eDP1 [85.455605] Dynamic subtest A-eDP1: SUCCESS (1.354s) [85.465051] Starting dynamic subtest: B-eDP1 [86.768931] Dynamic subtest B-eDP1: SUCCESS (1.311s) [86.776697] Starting dynamic subtest: C-eDP1 [88.012983] Dynamic subtest C-eDP1: SUCCESS (1.243s) [88.022301] Starting dynamic subtest: D-eDP1 [89.280211] Dynamic subtest D-eDP1: SUCCESS (1.266s) [89.282493] Subtest bo-too-big-interruptible: SUCCESS (5.183s) [90.489878] [008/133] (930s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs) [90.598150] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs [90.599999] Starting dynamic subtest: pipe-A-eDP-1 [90.740554] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.135s) [90.749604] Starting dynamic subtest: pipe-B-eDP-1 [90.770013] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [90.777963] Starting dynamic subtest: pipe-C-eDP-1 [90.797420] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s) [90.806124] Starting dynamic subtest: pipe-D-eDP-1 [90.824939] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s) [90.827124] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.142s) [93.055417] [009/133] (927s left) kms_async_flips (alternate-sync-async-flip-atomic) [93.156058] Starting subtest: alternate-sync-async-flip-atomic [93.530457] Starting dynamic subtest: pipe-A-eDP-1 [96.361492] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.832s) [96.731444] Starting dynamic subtest: pipe-B-eDP-1 [99.489346] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.765s) [100.588514] Starting dynamic subtest: pipe-C-eDP-1 [102.871147] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.290s) [103.244090] Starting dynamic subtest: pipe-D-eDP-1 [106.005109] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.766s) [106.007059] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.848s) [107.167054] [010/133] (913s left) kms_cursor_edge_walk (64x64-top-bottom) [107.275974] Starting subtest: 64x64-top-bottom [107.278294] Starting dynamic subtest: pipe-A-eDP-1 [110.757059] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.481s) [110.769579] Starting dynamic subtest: pipe-D-eDP-1 [113.881872] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.123s) [113.884331] Subtest 64x64-top-bottom: SUCCESS (6.606s) [114.685074] [011/133] (905s left) gem_cs_tlb (engines) [114.743537] Starting subtest: engines [114.745733] Starting dynamic subtest: rcs0 [116.899676] Dynamic subtest rcs0: SUCCESS (2.153s) [116.909228] Starting dynamic subtest: bcs0 [119.051602] Dynamic subtest bcs0: SUCCESS (2.151s) [119.060305] Starting dynamic subtest: vcs0 [121.207659] Dynamic subtest vcs0: SUCCESS (2.154s) [121.216476] Starting dynamic subtest: vcs1 [123.359596] Dynamic subtest vcs1: SUCCESS (2.152s) [123.369852] Starting dynamic subtest: vecs0 [125.511749] Dynamic subtest vecs0: SUCCESS (2.152s) [125.521378] Starting dynamic subtest: ccs0 [127.665366] Dynamic subtest ccs0: SUCCESS (2.153s) [127.667230] Subtest engines: SUCCESS (12.918s) [127.772110] [012/133] (892s left) kms_color (legacy-gamma-reset) [127.858849] Starting subtest: legacy-gamma-reset [127.860743] Starting dynamic subtest: pipe-A-eDP-1 [128.230255] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.373s) [128.238517] Starting dynamic subtest: pipe-B-eDP-1 [128.243429] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.012s) [128.251257] Starting dynamic subtest: pipe-C-eDP-1 [128.255842] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.013s) [128.263434] Starting dynamic subtest: pipe-D-eDP-1 [128.268895] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.013s) [128.271255] Subtest legacy-gamma-reset: SUCCESS (0.412s) [129.020758] [013/133] (891s left) kms_vblank (query-idle-hang) [129.130232] Starting subtest: query-idle-hang [129.132630] Starting dynamic subtest: pipe-A-eDP-1 [155.672135] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.539s) [155.684826] Starting dynamic subtest: pipe-D-eDP-1 [180.695404] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.021s) [180.697324] Subtest query-idle-hang: SUCCESS (51.563s) [181.494298] [014/133] (839s left) kms_atomic (plane-overlay-legacy) [181.593619] Starting subtest: plane-overlay-legacy [181.596087] Starting dynamic subtest: pipe-A-eDP-1 [182.002455] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.409s) [182.004869] Subtest plane-overlay-legacy: SUCCESS (0.411s) [182.827727] [015/133] (837s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc) [182.919903] Starting subtest: fbcpsr-rgb565-draw-mmap-wc [189.699370] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.783s) [189.811008] [016/133] (831s left) gem_mmap_gtt (cpuset-basic-small-copy-xy) [189.873321] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s) [189.928920] [017/133] (830s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu) [190.030069] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu [197.140943] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.114s) [197.239420] [018/133] (823s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite) [197.345893] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite [197.350420] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [197.443265] [019/133] (823s left) gem_exec_whisper (basic-contexts) [197.523802] Starting subtest: basic-contexts [203.288052] Subtest basic-contexts: SUCCESS (5.762s) [203.483499] [020/133] (817s left) gem_busy (parallel) [203.668052] Starting subtest: parallel [203.670411] Starting dynamic subtest: rcs0 [204.886035] Dynamic subtest rcs0: SUCCESS (1.219s) [204.897467] Starting dynamic subtest: bcs0 [206.870202] Dynamic subtest bcs0: SUCCESS (1.982s) [206.881253] Starting dynamic subtest: vcs0 [208.917661] Dynamic subtest vcs0: SUCCESS (2.045s) [208.928550] Starting dynamic subtest: vcs1 [210.902247] Dynamic subtest vcs1: SUCCESS (1.983s) [210.913264] Starting dynamic subtest: vecs0 [212.886097] Dynamic subtest vecs0: SUCCESS (1.982s) [212.897306] Starting dynamic subtest: ccs0 [214.934096] Dynamic subtest ccs0: SUCCESS (2.046s) [214.936980] Subtest parallel: SUCCESS (11.268s) [215.173619] [021/133] (805s left) gem_exec_schedule (implicit-boths) [215.262641] Starting subtest: implicit-boths [215.264630] Starting dynamic subtest: rcs0 [215.443977] Dynamic subtest rcs0: SUCCESS (0.187s) [215.454934] Starting dynamic subtest: vcs0 [215.582191] Dynamic subtest vcs0: SUCCESS (0.140s) [215.593835] Starting dynamic subtest: vcs1 [215.701000] Dynamic subtest vcs1: SUCCESS (0.118s) [215.711729] Starting dynamic subtest: vecs0 [215.804087] Dynamic subtest vecs0: SUCCESS (0.102s) [215.814957] Starting dynamic subtest: ccs0 [215.923858] Dynamic subtest ccs0: SUCCESS (0.119s) [215.926988] Subtest implicit-boths: SUCCESS (0.670s) [216.999357] [022/133] (804s left) gem_render_copy_redux (flink) [217.054063] Starting subtest: flink [218.140839] Subtest flink: SUCCESS (1.090s) [218.265335] [023/133] (802s left) gem_exec_schedule (u-semaphore-codependency) [218.324431] Starting subtest: u-semaphore-codependency [218.343151] Subtest u-semaphore-codependency: SUCCESS (0.021s) [218.676194] [024/133] (802s left) kms_dsc (dsc-with-formats) [218.775919] Starting subtest: dsc-with-formats [218.814714] Subtest dsc-with-formats: SKIP (0.001s) [218.850651] [025/133] (802s left) kms_psr (psr-cursor-plane-onoff) [218.946953] Starting subtest: psr-cursor-plane-onoff [218.949281] Starting dynamic subtest: eDP-1 [220.645118] Dynamic subtest eDP-1: SUCCESS (1.698s) [220.647439] Subtest psr-cursor-plane-onoff: SUCCESS (1.699s) [221.518453] [026/133] (799s left) gem_exec_balancer (bonded-sync) [221.576754] Starting subtest: bonded-sync [221.581367] Subtest bonded-sync: SKIP (0.000s) [221.880486] [027/133] (799s left) kms_flip (2x-plain-flip) [221.965291] Starting subtest: 2x-plain-flip [221.976565] Subtest 2x-plain-flip: SKIP (0.011s) [222.051786] [028/133] (799s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner) [222.146717] Starting subtest: switch-modeset-ultra-joiner-big-joiner [222.150851] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s) [222.212933] [029/133] (799s left) gem_userptr_blits (readonly-pwrite-unsync) [222.288636] Subtest readonly-pwrite-unsync: SKIP (0.000s) [222.409818] [030/133] (798s left) kms_psr (fbc-psr-cursor-mmap-cpu) [222.501212] Starting subtest: fbc-psr-cursor-mmap-cpu [222.503447] Starting dynamic subtest: eDP-1 [222.507517] Dynamic subtest eDP-1: SKIP (0.000s) [222.511625] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.001s) [222.570210] [031/133] (798s left) syncobj_wait (invalid-signal-illegal-handle) [222.624828] Starting subtest: invalid-signal-illegal-handle [222.627252] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [222.722079] [032/133] (798s left) kms_psr (pr-primary-mmap-gtt) [222.804064] Starting subtest: pr-primary-mmap-gtt [222.807864] Subtest pr-primary-mmap-gtt: SKIP (0.000s) [222.872561] [033/133] (798s left) gem_exec_params (invalid-fence-in) [222.925274] Starting subtest: invalid-fence-in [222.927528] Subtest invalid-fence-in: SUCCESS (0.000s) [223.020696] [034/133] (798s left) gem_eio (hibernate) [223.273908] Starting subtest: hibernate [238.804357] Subtest hibernate: SUCCESS (15.528s) [248.931986] [035/133] (782s left) gem_ctx_param (invalid-get-no-zeromap) [249.026081] Starting subtest: invalid-get-no-zeromap [249.028337] Subtest invalid-get-no-zeromap: SUCCESS (0.001s) [249.139902] [036/133] (782s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite) [249.255307] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite [249.259821] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [249.347728] [037/133] (782s left) kms_dp_linktrain_fallback (dp-fallback) [249.439941] Starting subtest: dp-fallback [249.446668] Subtest dp-fallback: SKIP (0.000s) [249.519807] [038/133] (782s left) gem_exec_suspend (basic-s4-devices) [249.582960] Starting subtest: basic-S4-devices [249.585484] Starting dynamic subtest: smem [260.886091] Dynamic subtest smem: SUCCESS (11.302s) [260.888951] Subtest basic-S4-devices: SUCCESS (11.304s) [273.093814] [039/133] (770s left) syncobj_wait (single-wait-submitted) [273.165721] Starting subtest: single-wait-submitted [273.266232] Subtest single-wait-submitted: SUCCESS (0.101s) [273.344498] [040/133] (770s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [273.437362] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu [273.441717] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [273.531996] [041/133] (770s left) gem_exec_schedule (in-order) [273.605491] Starting subtest: in-order [273.607402] Starting dynamic subtest: rcs0 [273.707092] Dynamic subtest rcs0: SUCCESS (0.108s) [273.717282] Starting dynamic subtest: vcs0 [273.810371] Dynamic subtest vcs0: SUCCESS (0.102s) [273.823412] Starting dynamic subtest: vcs1 [273.902768] Dynamic subtest vcs1: SUCCESS (0.090s) [273.912610] Starting dynamic subtest: vecs0 [273.987743] Dynamic subtest vecs0: SUCCESS (0.083s) [274.000911] Starting dynamic subtest: ccs0 [274.076802] Dynamic subtest ccs0: SUCCESS (0.088s) [274.079263] Subtest in-order: SUCCESS (0.479s) [274.990746] [042/133] (768s left) prime_mmap_coherency (read) [275.051345] Starting subtest: read [280.424593] Subtest read: SUCCESS (5.374s) [280.548407] [043/133] (763s left) gem_close (many-handles-one-vma) [280.611429] Starting subtest: many-handles-one-vma [280.661822] Subtest many-handles-one-vma: SUCCESS (0.051s) [280.786273] [044/133] (763s left) core_getversion (all-cards) [280.828868] Starting subtest: all-cards [280.833470] Subtest all-cards: SUCCESS (0.009s) [280.884808] [045/133] (763s left) prime_busy (before-wait) [280.936126] Starting subtest: before-wait [280.941117] Starting dynamic subtest: rcs0 [280.982093] Dynamic subtest rcs0: SUCCESS (0.041s) [280.992754] Starting dynamic subtest: bcs0 [281.036933] Dynamic subtest bcs0: SUCCESS (0.055s) [281.047939] Starting dynamic subtest: vcs0 [281.078605] Dynamic subtest vcs0: SUCCESS (0.042s) [281.088505] Starting dynamic subtest: vcs1 [281.120773] Dynamic subtest vcs1: SUCCESS (0.042s) [281.130731] Starting dynamic subtest: vecs0 [281.162564] Dynamic subtest vecs0: SUCCESS (0.041s) [281.173658] Starting dynamic subtest: ccs0 [281.204657] Dynamic subtest ccs0: SUCCESS (0.042s) [281.313722] Subtest before-wait: SUCCESS (0.375s) [281.389904] [046/133] (762s left) gem_mmap_wc (fault-concurrent) [281.445916] Subtest fault-concurrent: SKIP (0.000s) [281.511173] [047/133] (762s left) gem_watchdog (default-virtual) [281.587183] Starting subtest: default-virtual [287.864840] Subtest default-virtual: SUCCESS (6.287s) [287.957172] [048/133] (756s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt) [288.062618] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt [288.066718] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [288.171523] [049/133] (756s left) kms_plane_scaling (invalid-num-scalers) [288.273996] Starting subtest: invalid-num-scalers [288.276155] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers [288.294247] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.020s) [288.304169] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers [288.331317] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.034s) [288.340904] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers [288.364394] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.033s) [288.373701] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers [288.397708] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.033s) [288.399936] Subtest invalid-num-scalers: SUCCESS (0.126s) [288.509403] [050/133] (755s left) gem_spin_batch (user-each) [288.583890] Starting subtest: user-each [291.855626] Subtest user-each: SUCCESS (3.264s) [293.917992] [051/133] (750s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier) [294.020980] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier [294.046678] Starting dynamic subtest: pipe-A-plane-0 [294.468562] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s) [294.479220] Starting dynamic subtest: pipe-A-plane-3 [294.735946] Dynamic subtest pipe-A-plane-3: SUCCESS (0.266s) [294.745194] Starting dynamic subtest: pipe-A-plane-5 [294.749865] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [295.847588] Starting dynamic subtest: pipe-B-plane-0 [296.294194] Dynamic subtest pipe-B-plane-0: SUCCESS (0.455s) [296.303538] Starting dynamic subtest: pipe-B-plane-3 [296.550064] Dynamic subtest pipe-B-plane-3: SUCCESS (0.254s) [296.559499] Starting dynamic subtest: pipe-B-plane-5 [296.563880] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [296.858529] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.838s) [297.719450] [052/133] (746s left) gem_eio (wait-immediate) [297.956664] Starting subtest: wait-immediate [298.300796] Subtest wait-immediate: SUCCESS (0.345s) [298.446872] [053/133] (745s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu) [298.559113] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu [298.563390] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [298.670888] [054/133] (745s left) gem_mmap_gtt (basic-write-gtt) [298.730086] Subtest basic-write-gtt: SKIP (0.000s) [298.793642] [055/133] (745s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling) [298.889570] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling [298.891465] Starting dynamic subtest: pipe-A-default-mode [301.673230] Dynamic subtest pipe-A-default-mode: SUCCESS (2.783s) [301.675734] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.785s) [302.508434] [056/133] (742s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf) [302.612023] Starting subtest: fbc-psr2-cursor-plane-update-sf [302.614336] Starting dynamic subtest: pipe-A-eDP-1 [302.688527] Dynamic subtest pipe-A-eDP-1: SKIP (0.078s) [302.699639] Starting dynamic subtest: pipe-B-eDP-1 [303.792539] Dynamic subtest pipe-B-eDP-1: SKIP (1.102s) [303.796465] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.183s) [304.985117] [057/133] (739s left) gem_ctx_param (invalid-ctx-get) [305.074732] Starting subtest: invalid-ctx-get [305.077090] Subtest invalid-ctx-get: SUCCESS (0.000s) [305.147178] [058/133] (739s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant) [305.235856] Starting subtest: coverage-vs-premult-vs-constant [305.525740] Starting dynamic subtest: pipe-A-eDP-1 [306.132591] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.605s) [306.142277] Starting dynamic subtest: pipe-D-eDP-1 [307.425655] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.293s) [307.428094] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.191s) [308.267837] [059/133] (736s left) kms_atomic_interruptible (legacy-setmode) [308.358877] Starting subtest: legacy-setmode [308.361161] Starting dynamic subtest: pipe-A-eDP-1 [315.245683] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.886s) [315.247983] Subtest legacy-setmode: SUCCESS (6.888s) [316.079606] [060/133] (728s left) api_intel_bb (object-reloc-purge-cache) [316.139393] Starting subtest: object-reloc-purge-cache [316.143805] Subtest object-reloc-purge-cache: SKIP (0.003s) [316.260273] [061/133] (728s left) kms_psr (psr-sprite-render) [316.351825] Starting subtest: psr-sprite-render [316.354080] Starting dynamic subtest: eDP-1 [318.072081] Dynamic subtest eDP-1: SUCCESS (1.719s) [318.074328] Subtest psr-sprite-render: SUCCESS (1.720s) [318.913641] [062/133] (725s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff) [319.014424] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff [322.914593] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.903s) [324.123884] [063/133] (720s left) kms_chamelium_hpd (vga-hpd-for-each-pipe) [324.503121] Subtest vga-hpd-for-each-pipe: SKIP (0.000s) [325.318579] [064/133] (719s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move) [325.413486] Starting subtest: fbc-2p-primscrn-spr-indfb-move [325.417733] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s) [325.515837] [065/133] (719s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format) [325.605923] Starting subtest: plane-upscale-20x20-with-pixel-format [325.608189] Starting dynamic subtest: pipe-A [326.665077] Dynamic subtest pipe-A: SUCCESS (1.061s) [326.675826] Starting dynamic subtest: pipe-B [328.766950] Dynamic subtest pipe-B: SUCCESS (2.101s) [328.776235] Starting dynamic subtest: pipe-C [329.958176] Dynamic subtest pipe-C: SUCCESS (1.189s) [329.974769] Starting dynamic subtest: pipe-D [331.176065] Dynamic subtest pipe-D: SUCCESS (1.216s) [331.178280] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.573s) [332.371459] [066/133] (712s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt) [332.480780] Starting subtest: fbc-rgb101010-draw-blt [337.095561] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.618s) [338.283186] [067/133] (706s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0) [338.382964] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0 [338.387568] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s) [338.479146] [068/133] (706s left) i915_drm_fdinfo (virtual-busy-hang) [338.528425] Starting subtest: virtual-busy-hang [338.532796] Subtest virtual-busy-hang: SKIP (0.000s) [338.593960] [069/133] (706s left) kms_pm_rpm (pc8-residency) [340.125813] Starting subtest: pc8-residency [340.130928] Subtest pc8-residency: SKIP (0.000s) [340.825010] [070/133] (704s left) i915_pm_rc6_residency (rc6-idle) [340.874319] Starting subtest: rc6-idle [340.911980] Starting dynamic subtest: gt0-rcs0 [365.191366] Dynamic subtest gt0-rcs0: SUCCESS (24.278s) [365.204050] Starting dynamic subtest: gt0-bcs0 [389.406561] Dynamic subtest gt0-bcs0: SUCCESS (24.212s) [389.416106] Starting dynamic subtest: gt0-ccs0 [413.702426] Dynamic subtest gt0-ccs0: SUCCESS (24.292s) [413.714908] Starting dynamic subtest: gt1-vcs0 [419.875608] Dynamic subtest gt1-vcs0: SUCCESS (6.169s) [419.888280] Starting dynamic subtest: gt1-vecs0 [426.046415] Dynamic subtest gt1-vecs0: SUCCESS (6.168s) [426.049026] Subtest rc6-idle: SUCCESS (85.171s) [426.127803] [071/133] (619s left) kms_cursor_legacy (flip-vs-cursor-varying-size) [426.249861] Starting subtest: flip-vs-cursor-varying-size [435.088862] Subtest flip-vs-cursor-varying-size: SUCCESS (8.839s) [435.936878] [072/133] (609s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180) [436.045905] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180 [437.003266] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.958s) [437.128972] [073/133] (608s left) prime_vgem (fence-write-hang) [437.291900] Subtest fence-write-hang: SKIP (0.000s) [437.405792] [FACT prime_vgem (fence-write-hang)] new: kernel.kmod_is_loaded.vgem: true [437.409193] [074/133] (607s left) kms_universal_plane (universal-plane-sanity) [437.503609] Starting subtest: universal-plane-sanity [437.505251] Starting dynamic subtest: pipe-A-eDP-1 [438.108739] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.603s) [438.119525] Starting dynamic subtest: pipe-B-eDP-1 [439.354060] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.244s) [439.364872] Starting dynamic subtest: pipe-C-eDP-1 [440.552700] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.197s) [440.563075] Starting dynamic subtest: pipe-D-eDP-1 [441.781705] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.230s) [441.784051] Subtest universal-plane-sanity: SUCCESS (4.280s) [442.646407] [075/133] (602s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt) [442.747827] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt [442.752023] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [442.846423] [076/133] (602s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc) [442.951956] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc [442.955970] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [443.052946] [077/133] (602s left) gen9_exec_parse (bb-start-param) [443.116576] Subtest bb-start-param: SKIP (0.000s) [443.189981] [078/133] (602s left) kms_ccs (random-ccs-data-yf-tiled-ccs) [443.280189] Starting subtest: random-ccs-data-yf-tiled-ccs [443.282353] Starting dynamic subtest: pipe-A-eDP-1 [443.306451] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [443.318877] Starting dynamic subtest: pipe-B-eDP-1 [443.341759] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [443.351834] Starting dynamic subtest: pipe-C-eDP-1 [443.374229] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [443.383045] Starting dynamic subtest: pipe-D-eDP-1 [443.405685] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [443.409793] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.005s) [445.596330] [079/133] (599s left) kms_content_protection (suspend-resume) [445.746213] Starting subtest: suspend-resume [445.750537] Subtest suspend-resume: SKIP (0.000s) [445.862166] [080/133] (599s left) kms_big_fb (x-tiled-16bpp-rotate-90) [445.964498] Starting subtest: x-tiled-16bpp-rotate-90 [445.984688] Subtest x-tiled-16bpp-rotate-90: SKIP (0.019s) [446.099399] [081/133] (599s left) gem_partial_pwrite_pread (reads-uncached) [446.161579] Subtest reads-uncached: SKIP (0.000s) [446.233474] [082/133] (599s left) sysfs_heartbeat_interval (precise) [446.301076] Starting subtest: precise [446.303382] Starting dynamic subtest: vecs0 [453.904328] Dynamic subtest vecs0: SUCCESS (7.603s) [453.916735] Starting dynamic subtest: ccs0 [455.047684] Dynamic subtest ccs0: SUCCESS (1.139s) [455.060664] Starting dynamic subtest: vcs0 [462.949387] Dynamic subtest vcs0: SUCCESS (7.902s) [462.962359] Starting dynamic subtest: bcs0 [465.884758] Dynamic subtest bcs0: SUCCESS (2.931s) [465.897190] Starting dynamic subtest: rcs0 [466.954866] Dynamic subtest rcs0: SUCCESS (1.071s) [466.967919] Starting dynamic subtest: vcs1 [474.900501] Dynamic subtest vcs1: SUCCESS (7.943s) [474.902995] Subtest precise: SUCCESS (28.601s) [474.995891] [083/133] (570s left) kms_psr (fbc-psr2-primary-page-flip) [475.103080] Starting subtest: fbc-psr2-primary-page-flip [475.105302] Starting dynamic subtest: eDP-1 [475.109358] Dynamic subtest eDP-1: SKIP (0.000s) [475.113423] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s) [475.180078] [084/133] (570s left) gem_mmap_offset (partial-remap) [475.242626] Starting subtest: partial-remap [475.244941] Starting dynamic subtest: smem0 [475.254166] Dynamic subtest smem0: SUCCESS (0.008s) [475.256339] Subtest partial-remap: SUCCESS (0.009s) [475.384296] [085/133] (570s left) syncobj_timeline (multi-wait-available-submitted) [475.447993] Starting subtest: multi-wait-available-submitted [475.450324] Subtest multi-wait-available-submitted: SUCCESS (0.001s) [475.542170] [086/133] (570s left) i915_query (hwconfig_table) [475.588835] Starting subtest: hwconfig_table [475.889363] Subtest hwconfig_table: SUCCESS (0.001s) [475.930422] [087/133] (569s left) gem_ctx_persistence (processes) [476.001891] Starting subtest: processes [477.920457] Subtest processes: SUCCESS (1.918s) [478.004575] [088/133] (567s left) kms_big_fb (4-tiled-64bpp-rotate-0) [478.114088] Starting subtest: 4-tiled-64bpp-rotate-0 [479.771419] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.657s) [479.939472] [089/133] (565s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render) [480.034643] Starting subtest: psr-rgb101010-draw-render [487.287880] Subtest psr-rgb101010-draw-render: SUCCESS (7.254s) [487.400043] [090/133] (558s left) gem_render_copy (yf-tiled-ccs-to-y-tiled) [487.461958] Starting subtest: yf-tiled-ccs-to-y-tiled [487.466257] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s) [487.659472] [091/133] (558s left) kms_cursor_crc (cursor-rapid-movement-512x512) [487.935822] Starting subtest: cursor-rapid-movement-512x512 [487.940391] Subtest cursor-rapid-movement-512x512: SKIP (0.001s) [488.096845] [092/133] (557s left) kms_pm_rpm (fences-dpms) [490.122911] Starting subtest: fences-dpms [490.128041] Subtest fences-dpms: SKIP (0.000s) [490.494274] [093/133] (555s left) kms_flip (plain-flip-ts-check-interruptible) [490.593402] Starting subtest: plain-flip-ts-check-interruptible [490.595804] Starting dynamic subtest: A-eDP1 [499.473532] Dynamic subtest A-eDP1: SUCCESS (8.879s) [499.485610] Starting dynamic subtest: B-eDP1 [508.309411] Dynamic subtest B-eDP1: SUCCESS (8.834s) [508.325506] Starting dynamic subtest: C-eDP1 [517.133647] Dynamic subtest C-eDP1: SUCCESS (8.822s) [517.146741] Starting dynamic subtest: D-eDP1 [525.961244] Dynamic subtest D-eDP1: SUCCESS (8.827s) [525.966671] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.370s) [527.145442] [094/133] (518s left) i915_pm_freq_api (freq-basic-api) [527.215784] Starting subtest: freq-basic-api [527.218169] Starting dynamic subtest: gt0 [527.220573] Dynamic subtest gt0: SUCCESS (0.002s) [527.233467] Starting dynamic subtest: gt1 [527.235303] Dynamic subtest gt1: SUCCESS (0.003s) [527.237144] Subtest freq-basic-api: SUCCESS (0.007s) [527.317941] [095/133] (518s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted) [527.443039] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted [527.576617] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.135s) [527.684056] [096/133] (518s left) perf_pmu (busy-accuracy-50) [527.726879] Starting subtest: busy-accuracy-50 [527.728682] Starting dynamic subtest: rcs0 [529.261838] Dynamic subtest rcs0: SUCCESS (1.532s) [529.274292] Starting dynamic subtest: bcs0 [530.804321] Dynamic subtest bcs0: SUCCESS (1.540s) [530.814567] Starting dynamic subtest: vcs0 [532.345456] Dynamic subtest vcs0: SUCCESS (1.538s) [532.355695] Starting dynamic subtest: vcs1 [533.890788] Dynamic subtest vcs1: SUCCESS (1.543s) [533.903456] Starting dynamic subtest: vecs0 [535.431470] Dynamic subtest vecs0: SUCCESS (1.538s) [535.443670] Starting dynamic subtest: ccs0 [536.976350] Dynamic subtest ccs0: SUCCESS (1.543s) [536.979516] Subtest busy-accuracy-50: SUCCESS (9.249s) [537.095146] [097/133] (509s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move) [537.194997] Starting subtest: psr-1p-primscrn-spr-indfb-move [544.748466] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.555s) [544.874647] [098/133] (501s left) gem_pipe_control_store_loop (reused-buffer) [544.939237] Starting subtest: reused-buffer [547.091022] Subtest reused-buffer: SUCCESS (2.151s) [547.233644] [099/133] (499s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs) [547.332231] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs [547.334576] Starting dynamic subtest: pipe-A-eDP-1 [547.853274] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.492s) [547.863971] Starting dynamic subtest: pipe-B-eDP-1 [549.341770] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.486s) [549.363924] Starting dynamic subtest: pipe-C-eDP-1 [550.731467] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.390s) [550.743779] Starting dynamic subtest: pipe-D-eDP-1 [552.091982] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.360s) [552.093958] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.733s) [553.232260] [100/133] (493s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic) [553.369765] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic [553.374288] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.002s) [553.528306] [101/133] (492s left) kms_chamelium_frames (dp-crc-single) [553.909916] Subtest dp-crc-single: SKIP (0.000s) [554.738546] [102/133] (491s left) gem_readwrite (read-bad-handle) [554.796629] Subtest read-bad-handle: SKIP (0.000s) [554.867268] [103/133] (491s left) gem_exec_fence (basic-await) [555.038886] Starting subtest: basic-await [555.041390] Starting dynamic subtest: rcs0 [555.114810] Dynamic subtest rcs0: SUCCESS (0.075s) [555.128221] Starting dynamic subtest: bcs0 [555.190318] Dynamic subtest bcs0: SUCCESS (0.074s) [555.203260] Starting dynamic subtest: vcs0 [555.264026] Dynamic subtest vcs0: SUCCESS (0.072s) [555.276790] Starting dynamic subtest: vcs1 [555.337712] Dynamic subtest vcs1: SUCCESS (0.071s) [555.350606] Starting dynamic subtest: vecs0 [555.410748] Dynamic subtest vecs0: SUCCESS (0.072s) [555.423607] Starting dynamic subtest: ccs0 [555.484593] Dynamic subtest ccs0: SUCCESS (0.072s) [555.487630] Subtest basic-await: SUCCESS (0.446s) [556.973843] [104/133] (489s left) kms_big_fb (yf-tiled-32bpp-rotate-90) [557.082976] Starting subtest: yf-tiled-32bpp-rotate-90 [557.087317] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s) [557.185974] [105/133] (489s left) gem_pxp (reject-modify-context-protection-off-1) [557.247304] Starting subtest: reject-modify-context-protection-off-1 [557.249732] Subtest reject-modify-context-protection-off-1: SUCCESS (0.001s) [557.365261] [106/133] (489s left) gem_exec_reloc (basic-cpu-noreloc) [557.427880] Subtest basic-cpu-noreloc: SKIP (0.000s) [557.502856] [107/133] (489s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite) [557.598623] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite [566.923462] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.326s) [567.064820] [108/133] (479s left) kms_rotation_crc (primary-x-tiled-reflect-x-180) [567.159647] Starting subtest: primary-x-tiled-reflect-x-180 [574.228822] Subtest primary-x-tiled-reflect-x-180: SUCCESS (7.072s) [575.448529] [109/133] (471s left) gem_exec_reloc (basic-write-wc-active) [575.518109] Subtest basic-write-wc-active: SKIP (0.000s) [575.594489] [110/133] (471s left) syncobj_timeline (wait-all-complex) [575.649986] Starting subtest: wait-all-complex [575.866412] Subtest wait-all-complex: SUCCESS (0.216s) [575.944538] [111/133] (470s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area) [576.039361] Starting subtest: psr2-plane-move-sf-dmg-area [576.041772] Starting dynamic subtest: pipe-A-eDP-1 [580.573074] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.535s) [580.584446] Starting dynamic subtest: pipe-B-eDP-1 [585.886257] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.313s) [585.888560] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.851s) [586.766141] [112/133] (460s left) gem_exec_fence (syncobj-timeline-invalid-flags) [587.320837] Starting subtest: syncobj-timeline-invalid-flags [587.323221] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s) [588.981671] [113/133] (458s left) perf (blocking) [589.125471] Starting subtest: blocking [589.127321] Starting dynamic subtest: 0-rcs0 [599.158991] Dynamic subtest 0-rcs0: SUCCESS (10.032s) [599.170710] Starting dynamic subtest: 1-vcs1 [609.179274] Dynamic subtest 1-vcs1: SUCCESS (10.019s) [609.181766] Subtest blocking: SUCCESS (20.053s) [609.230160] [114/133] (437s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted) [609.295425] Starting subtest: etime-multi-wait-for-submit-unsubmitted [609.402399] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.106s) [609.495276] [115/133] (437s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf) [609.604033] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf [609.608566] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [609.683564] [116/133] (437s left) kms_invalid_mode (bad-vsync-start) [609.783429] Starting subtest: bad-vsync-start [609.785756] Starting dynamic subtest: pipe-A-eDP-1 [610.069691] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s) [610.080683] Starting dynamic subtest: pipe-B-eDP-1 [610.082936] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [610.093054] Starting dynamic subtest: pipe-C-eDP-1 [610.094976] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [610.104241] Starting dynamic subtest: pipe-D-eDP-1 [610.106212] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [610.108120] Subtest bad-vsync-start: SUCCESS (0.293s) [610.892951] [117/133] (436s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff) [611.001976] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff [618.152137] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.154s) [618.313698] [118/133] (428s left) gem_exec_reloc (basic-gtt-wc) [618.380057] Subtest basic-gtt-wc: SKIP (0.000s) [618.463960] [119/133] (428s left) kms_plane_lowres (tiling-x) [618.547723] Starting subtest: tiling-x [618.549983] Starting dynamic subtest: pipe-A-eDP-1 [618.554379] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [618.855605] Starting dynamic subtest: pipe-B-eDP-1 [618.860228] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [618.870568] Starting dynamic subtest: pipe-C-eDP-1 [618.875224] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [618.885428] Starting dynamic subtest: pipe-D-eDP-1 [618.889542] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [618.893645] Subtest tiling-x: SKIP (0.306s) [619.674501] [120/133] (427s left) gem_ctx_shared (q-smoketest-all) [619.747388] Starting subtest: Q-smoketest-all [652.135751] Subtest Q-smoketest-all: SUCCESS (32.340s) [652.998539] [121/133] (394s left) gem_softpin (evict-snoop) [653.055966] Starting subtest: evict-snoop [653.060257] Subtest evict-snoop: SKIP (0.000s) [653.167483] [122/133] (394s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling) [653.264927] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling [653.269260] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s) [653.339978] [123/133] (394s left) syncobj_wait (multi-wait-submitted-signaled) [653.387597] Starting subtest: multi-wait-submitted-signaled [653.389989] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s) [653.473442] [124/133] (393s left) syncobj_wait (reset-unsignaled) [653.524714] Starting subtest: reset-unsignaled [653.526998] Subtest reset-unsignaled: SUCCESS (0.000s) [653.623763] [125/133] (393s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [653.715883] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [654.550340] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.837s) [654.747218] [126/133] (392s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs) [654.842968] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs [654.845264] Starting dynamic subtest: pipe-A-eDP-1 [654.867713] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [654.880026] Starting dynamic subtest: pipe-B-eDP-1 [654.900967] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [654.910391] Starting dynamic subtest: pipe-C-eDP-1 [654.931191] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [654.940841] Starting dynamic subtest: pipe-D-eDP-1 [654.963485] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [654.967756] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.004s) [657.115599] [127/133] (390s left) syncobj_wait (invalid-single-wait-unsubmitted) [657.172078] Starting subtest: invalid-single-wait-unsubmitted [657.174359] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s) [657.285064] [128/133] (390s left) perf_pmu (render-node-busy-idle) [657.353608] Starting subtest: render-node-busy-idle [657.356215] Starting dynamic subtest: rcs0 [658.041056] Dynamic subtest rcs0: SUCCESS (0.686s) [658.053996] Starting dynamic subtest: bcs0 [658.700671] Dynamic subtest bcs0: SUCCESS (0.657s) [658.713486] Starting dynamic subtest: vcs0 [659.925560] Dynamic subtest vcs0: SUCCESS (1.222s) [659.938846] Starting dynamic subtest: vcs1 [661.909851] Dynamic subtest vcs1: SUCCESS (1.981s) [661.923283] Starting dynamic subtest: vecs0 [663.894106] Dynamic subtest vecs0: SUCCESS (1.981s) [663.906512] Starting dynamic subtest: ccs0 [664.563683] Dynamic subtest ccs0: SUCCESS (0.668s) [664.566722] Subtest render-node-busy-idle: SUCCESS (7.210s) [664.677871] [129/133] (383s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted) [664.728686] Starting subtest: multi-wait-all-for-submit-available-submitted [664.730931] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s) [664.840585] [130/133] (382s left) prime_vgem (basic-fence-read) [664.910190] Starting subtest: basic-fence-read [664.931380] Subtest basic-fence-read: SKIP (0.019s) [665.039931] [131/133] (382s left) kms_addfb_basic (bad-pitch-65536) [665.095627] Starting subtest: bad-pitch-65536 [665.097957] Subtest bad-pitch-65536: SUCCESS (0.000s) [665.227835] [132/133] (382s left) kms_fbcon_fbt (psr-suspend) [665.283577] Starting subtest: psr-suspend [715.829723] Subtest psr-suspend: SUCCESS (20.587s) [720.942221] [133/133] (331s left) syncobj_eventfd (binary-wait-before-signal) [721.003571] Starting subtest: binary-wait-before-signal [721.033127] Subtest binary-wait-before-signal: SUCCESS (0.030s) [721.126792] Closing watchdogs results: parsing output: 0/ for test: kms_cursor_crc results: parsing output: 1/ for test: gem_exec_whisper results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: kms_ccs results: parsing output: 4/ for test: kms_big_fb results: parsing output: 5/ for test: gem_ctx_param results: parsing output: 6/ for test: kms_flip results: parsing output: 7/ for test: kms_ccs results: parsing output: 8/ for test: kms_async_flips results: parsing output: 9/ for test: kms_cursor_edge_walk results: parsing output: 10/ for test: gem_cs_tlb results: parsing output: 11/ for test: kms_color results: parsing output: 12/ for test: kms_vblank results: parsing output: 13/ for test: kms_atomic results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: gem_mmap_gtt results: parsing output: 16/ for test: kms_frontbuffer_tracking results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: gem_exec_whisper results: parsing output: 19/ for test: gem_busy results: parsing output: 20/ for test: gem_exec_schedule results: parsing output: 21/ for test: gem_render_copy_redux results: parsing output: 22/ for test: gem_exec_schedule results: parsing output: 23/ for test: kms_dsc results: parsing output: 24/ for test: kms_psr results: parsing output: 25/ for test: gem_exec_balancer results: parsing output: 26/ for test: kms_flip results: parsing output: 27/ for test: kms_joiner results: parsing output: 28/ for test: gem_userptr_blits results: parsing output: 29/ for test: kms_psr results: parsing output: 30/ for test: syncobj_wait results: parsing output: 31/ for test: kms_psr results: parsing output: 32/ for test: gem_exec_params results: parsing output: 33/ for test: gem_eio results: parsing output: 34/ for test: gem_ctx_param results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: kms_dp_linktrain_fallback results: parsing output: 37/ for test: gem_exec_suspend results: parsing output: 38/ for test: syncobj_wait results: parsing output: 39/ for test: kms_frontbuffer_tracking results: parsing output: 40/ for test: gem_exec_schedule results: parsing output: 41/ for test: prime_mmap_coherency results: parsing output: 42/ for test: gem_close results: parsing output: 43/ for test: core_getversion results: parsing output: 44/ for test: prime_busy results: parsing output: 45/ for test: gem_mmap_wc results: parsing output: 46/ for test: gem_watchdog results: parsing output: 47/ for test: kms_frontbuffer_tracking results: parsing output: 48/ for test: kms_plane_scaling results: parsing output: 49/ for test: gem_spin_batch results: parsing output: 50/ for test: kms_plane results: parsing output: 51/ for test: gem_eio results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: gem_mmap_gtt results: parsing output: 54/ for test: kms_flip_scaled_crc results: parsing output: 55/ for test: kms_psr2_sf results: parsing output: 56/ for test: gem_ctx_param results: parsing output: 57/ for test: kms_plane_alpha_blend results: parsing output: 58/ for test: kms_atomic_interruptible results: parsing output: 59/ for test: api_intel_bb results: parsing output: 60/ for test: kms_psr results: parsing output: 61/ for test: kms_frontbuffer_tracking results: parsing output: 62/ for test: kms_chamelium_hpd results: parsing output: 63/ for test: kms_frontbuffer_tracking results: parsing output: 64/ for test: kms_plane_scaling results: parsing output: 65/ for test: kms_frontbuffer_tracking results: parsing output: 66/ for test: kms_big_fb results: parsing output: 67/ for test: i915_drm_fdinfo results: parsing output: 68/ for test: kms_pm_rpm results: parsing output: 69/ for test: i915_pm_rc6_residency results: parsing output: 70/ for test: kms_cursor_legacy results: parsing output: 71/ for test: kms_big_fb results: parsing output: 72/ for test: prime_vgem results: parsing output: 73/ for test: kms_universal_plane results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: gen9_exec_parse results: parsing output: 77/ for test: kms_ccs results: parsing output: 78/ for test: kms_content_protection results: parsing output: 79/ for test: kms_big_fb results: parsing output: 80/ for test: gem_partial_pwrite_pread results: parsing output: 81/ for test: sysfs_heartbeat_interval results: parsing output: 82/ for test: kms_psr results: parsing output: 83/ for test: gem_mmap_offset results: parsing output: 84/ for test: syncobj_timeline results: parsing output: 85/ for test: i915_query results: parsing output: 86/ for test: gem_ctx_persistence results: parsing output: 87/ for test: kms_big_fb results: parsing output: 88/ for test: kms_frontbuffer_tracking results: parsing output: 89/ for test: gem_render_copy results: parsing output: 90/ for test: kms_cursor_crc results: parsing output: 91/ for test: kms_pm_rpm results: parsing output: 92/ for test: kms_flip results: parsing output: 93/ for test: i915_pm_freq_api results: parsing output: 94/ for test: gem_pxp results: parsing output: 95/ for test: perf_pmu results: parsing output: 96/ for test: kms_frontbuffer_tracking results: parsing output: 97/ for test: gem_pipe_control_store_loop results: parsing output: 98/ for test: kms_ccs results: parsing output: 99/ for test: kms_cursor_legacy results: parsing output: 100/ for test: kms_chamelium_frames results: parsing output: 101/ for test: gem_readwrite results: parsing output: 102/ for test: gem_exec_fence results: parsing output: 103/ for test: kms_big_fb results: parsing output: 104/ for test: gem_pxp results: parsing output: 105/ for test: gem_exec_reloc results: parsing output: 106/ for test: kms_frontbuffer_tracking results: parsing output: 107/ for test: kms_rotation_crc results: parsing output: 108/ for test: gem_exec_reloc results: parsing output: 109/ for test: syncobj_timeline results: parsing output: 110/ for test: kms_psr2_sf results: parsing output: 111/ for test: gem_exec_fence results: parsing output: 112/ for test: perf results: parsing output: 113/ for test: syncobj_timeline results: parsing output: 114/ for test: kms_psr2_sf results: parsing output: 115/ for test: kms_invalid_mode results: parsing output: 116/ for test: kms_frontbuffer_tracking results: parsing output: 117/ for test: gem_exec_reloc results: parsing output: 118/ for test: kms_plane_lowres results: parsing output: 119/ for test: gem_ctx_shared results: parsing output: 120/ for test: gem_softpin results: parsing output: 121/ for test: kms_flip_scaled_crc results: parsing output: 122/ for test: syncobj_wait results: parsing output: 123/ for test: syncobj_wait results: parsing output: 124/ for test: kms_big_fb results: parsing output: 125/ for test: kms_ccs results: parsing output: 126/ for test: syncobj_wait results: parsing output: 127/ for test: perf_pmu results: parsing output: 128/ for test: syncobj_timeline results: parsing output: 129/ for test: prime_vgem results: parsing output: 130/ for test: kms_addfb_basic results: parsing output: 131/ for test: kms_fbcon_fbt results: parsing output: 132/ for test: syncobj_eventfd Done.