[55.631874] Initializing watchdogs [55.631922] /dev/watchdog0 [55.645151] [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] [55.649913] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [55.652453] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [55.655842] [001/132] (960s left) gem_eio (kms) [55.880062] Starting subtest: kms [72.606887] Subtest kms: SUCCESS (16.666s) [72.734439] [FACT gem_eio (kms)] new: kernel.kmod_is_loaded.vgem: true [72.737488] [002/132] (943s left) gem_exec_reloc (basic-concurrent0) [72.799990] Subtest basic-concurrent0: SKIP (0.000s) [72.915187] [003/132] (943s left) api_intel_allocator (fork-simple-once) [72.967206] Starting subtest: fork-simple-once [72.978731] Subtest fork-simple-once: SUCCESS (0.014s) [73.090091] [004/132] (943s left) perf_pmu (busy-no-semaphores) [73.127262] Starting subtest: busy-no-semaphores [73.129522] Starting dynamic subtest: rcs0 [73.705560] Dynamic subtest rcs0: SUCCESS (0.577s) [73.716462] Starting dynamic subtest: bcs0 [74.253872] Dynamic subtest bcs0: SUCCESS (0.546s) [74.263699] Starting dynamic subtest: vcs0 [74.800981] Dynamic subtest vcs0: SUCCESS (0.546s) [74.812055] Starting dynamic subtest: vcs1 [76.438280] Dynamic subtest vcs1: SUCCESS (1.635s) [76.449209] Starting dynamic subtest: vecs0 [78.424456] Dynamic subtest vecs0: SUCCESS (1.983s) [78.436283] Starting dynamic subtest: ccs0 [80.408953] Dynamic subtest ccs0: SUCCESS (1.982s) [80.411668] Subtest busy-no-semaphores: SUCCESS (7.278s) [80.549326] [005/132] (935s left) kms_chamelium_color (ctm-green-to-red) [80.651967] Subtest ctm-green-to-red: SKIP (0.000s) [80.693620] [006/132] (935s left) kms_cursor_edge_walk (128x128-top-bottom) [80.786261] Starting subtest: 128x128-top-bottom [80.788626] Starting dynamic subtest: pipe-A-eDP-1 [84.231932] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.442s) [84.241854] Starting dynamic subtest: pipe-D-eDP-1 [87.373568] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.140s) [87.375805] Subtest 128x128-top-bottom: SUCCESS (6.584s) [88.181250] [007/132] (928s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy) [88.243832] Starting subtest: map-fixed-invalidate-overlap-busy [88.248700] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s) [88.381191] [008/132] (928s left) kms_plane_cursor (viewport) [88.468078] Starting subtest: viewport [88.472513] Starting dynamic subtest: pipe-A-eDP-1-size-64 [91.195144] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.727s) [91.255365] Starting dynamic subtest: pipe-A-eDP-1-size-128 [94.030781] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.783s) [94.090281] Starting dynamic subtest: pipe-A-eDP-1-size-256 [96.810126] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.727s) [97.162412] Starting dynamic subtest: pipe-B-eDP-1-size-64 [100.673991] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.519s) [100.730770] Starting dynamic subtest: pipe-B-eDP-1-size-128 [103.440742] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.715s) [103.499991] Starting dynamic subtest: pipe-B-eDP-1-size-256 [106.231619] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.737s) [106.578749] Starting dynamic subtest: pipe-C-eDP-1-size-64 [109.663188] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.093s) [109.700266] Starting dynamic subtest: pipe-C-eDP-1-size-128 [112.074773] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.380s) [112.111290] Starting dynamic subtest: pipe-C-eDP-1-size-256 [114.496393] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.391s) [114.828628] Starting dynamic subtest: pipe-D-eDP-1-size-64 [117.891993] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.073s) [117.929489] Starting dynamic subtest: pipe-D-eDP-1-size-128 [120.270590] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.346s) [120.308148] Starting dynamic subtest: pipe-D-eDP-1-size-256 [122.715189] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.413s) [123.035324] Subtest viewport: SUCCESS (34.564s) [123.905143] [009/132] (892s left) kms_pm_rpm (modeset-lpsp-stress-no-wait) [126.036710] Starting subtest: modeset-lpsp-stress-no-wait [135.704709] Subtest modeset-lpsp-stress-no-wait: SUCCESS (9.668s) [135.805406] [010/132] (880s left) gem_vm_create (execbuf) [135.863388] Starting subtest: execbuf [135.871795] Subtest execbuf: SUCCESS (0.008s) [136.032788] [011/132] (880s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt) [136.140542] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt [136.144999] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [136.251214] [012/132] (880s left) gem_lmem_swapping (heavy-random) [136.300242] Subtest heavy-random: SKIP (0.000s) [136.339730] [013/132] (880s left) kms_sharpness_filter (filter-formats) [136.434273] Starting subtest: filter-formats [136.472965] Subtest filter-formats: SKIP (0.003s) [136.524099] [014/132] (880s left) kms_joiner (invalid-modeset-big-joiner) [136.626959] Starting subtest: invalid-modeset-big-joiner [136.631175] Subtest invalid-modeset-big-joiner: SKIP (0.000s) [136.701690] [015/132] (880s left) kms_psr (fbc-psr-cursor-render) [136.799757] Starting subtest: fbc-psr-cursor-render [136.801651] Starting dynamic subtest: eDP-1 [136.805063] Dynamic subtest eDP-1: SKIP (0.000s) [136.808450] Subtest fbc-psr-cursor-render: SKIP (0.001s) [136.882611] [016/132] (879s left) gem_render_linear_blits (basic) [136.935135] Starting subtest: basic [136.953403] Subtest basic: SUCCESS (0.021s) [137.042739] [017/132] (879s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render) [137.134439] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render [141.615866] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.484s) [142.785466] [018/132] (874s left) gem_exec_fence (syncobj-timeline-export) [143.321397] Starting subtest: syncobj-timeline-export [143.351866] Subtest syncobj-timeline-export: SUCCESS (0.007s) [145.037449] [019/132] (871s left) kms_addfb_basic (bad-pitch-32) [145.090167] Starting subtest: bad-pitch-32 [145.092318] Subtest bad-pitch-32: SUCCESS (0.000s) [145.221506] [020/132] (871s left) gem_exec_schedule (preempt-contexts) [145.285950] Starting subtest: preempt-contexts [145.287922] Starting dynamic subtest: rcs0 [145.335585] Dynamic subtest rcs0: SUCCESS (0.057s) [145.343889] Starting dynamic subtest: bcs0 [145.399534] Dynamic subtest bcs0: SUCCESS (0.063s) [145.409585] Starting dynamic subtest: vcs0 [145.449946] Dynamic subtest vcs0: SUCCESS (0.049s) [145.458295] Starting dynamic subtest: vcs1 [145.501113] Dynamic subtest vcs1: SUCCESS (0.050s) [145.509823] Starting dynamic subtest: vecs0 [145.545798] Dynamic subtest vecs0: SUCCESS (0.044s) [145.554244] Starting dynamic subtest: ccs0 [145.599384] Dynamic subtest ccs0: SUCCESS (0.053s) [145.601684] Subtest preempt-contexts: SUCCESS (0.322s) [147.039570] [021/132] (869s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf) [152.022619] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf [152.024624] Starting dynamic subtest: pipe-A-eDP-1 [164.054252] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.029s) [164.062865] Starting dynamic subtest: pipe-B-eDP-1 [176.081971] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.027s) [176.084848] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (24.061s) [176.950848] [022/132] (840s left) i915_hangman (gt-engine-hang) [177.028918] Starting subtest: gt-engine-hang [177.030845] Starting dynamic subtest: rcs0 [178.866880] Dynamic subtest rcs0: SUCCESS (1.837s) [178.882395] Starting dynamic subtest: bcs0 [180.850079] Dynamic subtest bcs0: SUCCESS (1.981s) [180.861855] Starting dynamic subtest: vcs0 [182.899083] Dynamic subtest vcs0: SUCCESS (2.046s) [182.911362] Starting dynamic subtest: vcs1 [184.881553] Dynamic subtest vcs1: SUCCESS (1.980s) [184.892751] Starting dynamic subtest: vecs0 [186.866270] Dynamic subtest vecs0: SUCCESS (1.982s) [186.877871] Starting dynamic subtest: ccs0 [188.850709] Dynamic subtest ccs0: SUCCESS (1.981s) [188.854453] Subtest gt-engine-hang: SUCCESS (11.823s) [188.944095] [023/132] (828s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu) [189.038595] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu [189.043061] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [189.159483] [024/132] (827s left) gen9_exec_parse (valid-registers) [189.221802] Subtest valid-registers: SKIP (0.000s) [189.295795] [025/132] (827s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180) [189.396919] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180 [189.401457] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s) [189.528508] [026/132] (827s left) kms_rotation_crc (multiplane-rotation) [189.629371] Starting subtest: multiplane-rotation [196.887401] Subtest multiplane-rotation: SUCCESS (7.260s) [197.024602] [027/132] (820s left) kms_writeback (writeback-fb-id) [197.123547] Subtest writeback-fb-id: SKIP (0.000s) [197.167830] [028/132] (820s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc) [197.259178] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc [197.261205] Starting dynamic subtest: pipe-A-eDP-1 [197.278131] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [197.287705] Starting dynamic subtest: pipe-B-eDP-1 [197.303832] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [197.311475] Starting dynamic subtest: pipe-C-eDP-1 [197.327491] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [197.335101] Starting dynamic subtest: pipe-D-eDP-1 [197.351070] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [197.352847] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s) [199.427265] [029/132] (817s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers) [199.523192] Starting subtest: plane-scaler-unity-scaling-with-modifiers [199.525131] Starting dynamic subtest: pipe-A [199.883437] Dynamic subtest pipe-A: SUCCESS (0.362s) [199.891657] Starting dynamic subtest: pipe-B [201.309064] Dynamic subtest pipe-B: SUCCESS (1.424s) [201.320224] Starting dynamic subtest: pipe-C [202.737602] Dynamic subtest pipe-C: SUCCESS (1.428s) [202.746996] Starting dynamic subtest: pipe-D [204.170090] Dynamic subtest pipe-D: SUCCESS (1.432s) [204.172378] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.650s) [205.374871] [030/132] (811s left) syncobj_wait (multi-wait-for-submit-submitted-signaled) [205.433616] Starting subtest: multi-wait-for-submit-submitted-signaled [205.435504] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s) [205.553719] [031/132] (811s left) gem_exec_schedule (u-fairslice) [205.620772] Starting subtest: u-fairslice [205.623078] Starting dynamic subtest: rcs0 [207.635937] Dynamic subtest rcs0: SUCCESS (2.024s) [207.643737] Starting dynamic subtest: bcs0 [209.655645] Dynamic subtest bcs0: SUCCESS (2.016s) [209.669442] Starting dynamic subtest: vcs0 [211.675185] Dynamic subtest vcs0: SUCCESS (2.019s) [211.683897] Starting dynamic subtest: vcs1 [213.692643] Dynamic subtest vcs1: SUCCESS (2.019s) [213.703360] Starting dynamic subtest: vecs0 [215.713308] Dynamic subtest vecs0: SUCCESS (2.020s) [215.721025] Starting dynamic subtest: ccs0 [217.741024] Dynamic subtest ccs0: SUCCESS (2.024s) [217.743286] Subtest u-fairslice: SUCCESS (12.127s) [218.047640] [032/132] (799s left) gem_ctx_persistence (saturated-hostile-nopreempt) [218.108828] Starting subtest: saturated-hostile-nopreempt [218.111065] Starting dynamic subtest: rcs0 [218.199343] Dynamic subtest rcs0: SKIP (0.086s) [218.210177] Starting dynamic subtest: bcs0 [218.223863] Dynamic subtest bcs0: SKIP (0.023s) [218.232218] Starting dynamic subtest: vcs0 [218.249842] Dynamic subtest vcs0: SKIP (0.024s) [218.258154] Starting dynamic subtest: vcs1 [218.266059] Dynamic subtest vcs1: SKIP (0.014s) [218.274018] Starting dynamic subtest: vecs0 [218.286845] Dynamic subtest vecs0: SKIP (0.020s) [218.295508] Starting dynamic subtest: ccs0 [218.306456] Dynamic subtest ccs0: SKIP (0.019s) [218.310851] Subtest saturated-hostile-nopreempt: SKIP (0.196s) [218.393812] [033/132] (799s left) kms_cursor_crc (cursor-rapid-movement-512x512) [218.660918] Starting subtest: cursor-rapid-movement-512x512 [218.665195] Subtest cursor-rapid-movement-512x512: SKIP (0.001s) [218.827768] [034/132] (798s left) prime_vgem (coherency-blt) [218.907435] Starting subtest: coherency-blt [220.031741] Subtest coherency-blt: SUCCESS (1.123s) [220.173996] [035/132] (797s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs) [220.267634] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs [220.269930] Starting dynamic subtest: pipe-A-eDP-1 [220.293255] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [220.303057] Starting dynamic subtest: pipe-B-eDP-1 [220.324851] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [220.333532] Starting dynamic subtest: pipe-C-eDP-1 [220.355375] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [220.363607] Starting dynamic subtest: pipe-D-eDP-1 [220.385863] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [220.390820] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.004s) [222.443814] [036/132] (795s left) syncobj_timeline (single-wait-all-available-submitted) [222.498129] Starting subtest: single-wait-all-available-submitted [222.500393] Subtest single-wait-all-available-submitted: SUCCESS (0.000s) [222.628177] [037/132] (794s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs) [222.728221] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs [222.730102] Starting dynamic subtest: pipe-A-eDP-1 [223.939989] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.213s) [223.948563] Starting dynamic subtest: pipe-B-eDP-1 [226.260324] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.316s) [226.269490] Starting dynamic subtest: pipe-C-eDP-1 [228.574570] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.311s) [228.583888] Starting dynamic subtest: pipe-D-eDP-1 [230.821683] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.247s) [230.823962] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.094s) [231.969598] [038/132] (785s left) gem_exec_reloc (basic-cpu-read-noreloc) [232.032055] Subtest basic-cpu-read-noreloc: SKIP (0.000s) [232.122132] [039/132] (785s left) kms_chamelium_frames (dp-crc-multiple) [232.502308] Subtest dp-crc-multiple: SKIP (0.000s) [233.274161] [040/132] (784s left) gem_exec_create (forked) [233.337588] Starting subtest: forked [233.339857] Starting dynamic subtest: smem [253.909082] Dynamic subtest smem: SUCCESS (20.571s) [253.911841] Subtest forked: SUCCESS (20.574s) [254.102735] [041/132] (763s left) gem_workarounds (basic-read-context) [254.161424] Starting subtest: basic-read-context [254.178500] Subtest basic-read-context: SUCCESS (0.017s) [254.317594] [042/132] (763s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt) [254.416584] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt [254.421105] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [254.521823] [043/132] (763s left) gem_exec_store (basic) [254.586903] Starting subtest: basic [254.699141] Subtest basic: SUCCESS (0.112s) [254.905585] [044/132] (762s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0) [255.000221] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0 [255.990065] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (0.989s) [256.168050] [045/132] (761s left) gem_exec_reloc (basic-cpu-wc-active) [256.230797] Subtest basic-cpu-wc-active: SKIP (0.000s) [256.315183] [046/132] (761s left) kms_big_fb (x-tiled-16bpp-rotate-270) [256.408517] Starting subtest: x-tiled-16bpp-rotate-270 [256.429034] Subtest x-tiled-16bpp-rotate-270: SKIP (0.020s) [256.575324] [047/132] (761s left) syncobj_basic (create-signaled) [256.626423] Starting subtest: create-signaled [256.628613] Subtest create-signaled: SUCCESS (0.000s) [256.744991] [048/132] (761s left) gem_exec_balancer (busy) [256.807079] Starting subtest: busy [258.913951] Subtest busy: SUCCESS (2.104s) [259.291276] [049/132] (758s left) gem_exec_reloc (basic-write-wc-noreloc) [259.342652] Subtest basic-write-wc-noreloc: SKIP (0.000s) [259.434602] [050/132] (758s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render) [259.538916] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render [259.543429] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [259.669376] [051/132] (758s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt) [259.766617] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt [259.770683] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [259.894477] [052/132] (758s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt) [259.988646] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt [259.993075] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [260.111591] [053/132] (758s left) gem_mmap_gtt (medium-copy-odd) [260.167869] Subtest medium-copy-odd: SKIP (0.000s) [260.234156] [054/132] (758s left) kms_content_protection (lic-type-0) [260.381355] Starting subtest: lic-type-0 [260.385058] Subtest lic-type-0: SKIP (0.000s) [260.523928] [055/132] (757s left) syncobj_basic (bad-flags-fd-to-handle) [260.576090] Starting subtest: bad-flags-fd-to-handle [260.577963] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s) [260.703422] [056/132] (757s left) i915_query (query-regions-unallocated) [260.758941] Starting subtest: query-regions-unallocated [260.760579] Subtest query-regions-unallocated: SUCCESS (0.000s) [260.879245] [057/132] (757s left) gem_mmap_gtt (cpuset-basic-small-copy-xy) [260.930823] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s) [260.996756] [058/132] (757s left) gem_pipe_control_store_loop (fresh-buffer) [261.061622] Starting subtest: fresh-buffer [263.215082] Subtest fresh-buffer: SUCCESS (2.152s) [263.365874] [059/132] (755s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt) [263.463252] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt [263.467518] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [263.579436] [060/132] (754s left) gem_pxp (verify-pxp-stale-buf-execution) [263.707225] Starting subtest: verify-pxp-stale-buf-execution [264.767781] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.062s) [264.928937] [061/132] (753s left) gem_exec_reloc (basic-wc-gtt-active) [264.976071] Subtest basic-wc-gtt-active: SKIP (0.000s) [265.042385] [062/132] (753s left) gem_exec_params (dr1-dirt) [265.092295] Starting subtest: DR1-dirt [265.094578] Subtest DR1-dirt: SUCCESS (0.000s) [265.206550] [063/132] (753s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode) [265.602270] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s) [266.407364] [064/132] (752s left) kms_fb_coherency (memset-crc) [266.504235] Starting subtest: memset-crc [266.506482] Starting dynamic subtest: mmap-offset-wc [266.878106] Dynamic subtest mmap-offset-wc: SUCCESS (0.373s) [267.175709] Starting dynamic subtest: mmap-offset-uc [273.231686] Dynamic subtest mmap-offset-uc: SUCCESS (6.060s) [273.520657] Subtest memset-crc: SUCCESS (7.018s) [274.410073] [065/132] (744s left) gem_exec_schedule (smoketest-all) [274.488892] Starting subtest: smoketest-all [306.842868] Subtest smoketest-all: SUCCESS (32.308s) [308.018561] [066/132] (710s left) gen9_exec_parse (bb-large) [308.077166] Subtest bb-large: SKIP (0.000s) [308.151663] [067/132] (710s left) kms_flip (2x-plain-flip-interruptible) [308.242840] Starting subtest: 2x-plain-flip-interruptible [308.255703] Subtest 2x-plain-flip-interruptible: SKIP (0.011s) [308.373932] [068/132] (710s left) kms_psr (psr-basic) [308.462967] Starting subtest: psr-basic [308.465184] Starting dynamic subtest: eDP-1 [310.070404] Dynamic subtest eDP-1: SUCCESS (1.608s) [310.072815] Subtest psr-basic: SUCCESS (1.609s) [310.968848] [069/132] (707s left) kms_big_fb (4-tiled-8bpp-rotate-180) [311.061303] Starting subtest: 4-tiled-8bpp-rotate-180 [312.250766] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.190s) [312.408604] [070/132] (706s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt) [312.509354] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt [312.512859] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [312.647624] [071/132] (706s left) vgem_basic (dmabuf-fence) [312.688875] Starting subtest: dmabuf-fence [312.690879] Subtest dmabuf-fence: SUCCESS (0.001s) [312.777752] [072/132] (706s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt) [312.874074] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt [312.877575] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [313.007972] [073/132] (706s left) kms_atomic_transition (modeset-transition) [313.091689] Starting subtest: modeset-transition [313.093545] Starting dynamic subtest: 1x-outputs [323.895794] Dynamic subtest 1x-outputs: SUCCESS (10.805s) [323.898356] Subtest modeset-transition: SUCCESS (10.807s) [324.758507] [074/132] (694s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs) [324.858407] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs [324.860795] Starting dynamic subtest: pipe-A-eDP-1 [324.870013] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [324.879519] Starting dynamic subtest: pipe-B-eDP-1 [324.888575] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [324.896315] Starting dynamic subtest: pipe-C-eDP-1 [324.904380] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [324.912024] Starting dynamic subtest: pipe-D-eDP-1 [324.920336] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [324.924371] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.005s) [327.047327] [075/132] (692s left) gem_ctx_engines (execute-one) [327.104474] Starting subtest: execute-one [329.572061] Subtest execute-one: SUCCESS (2.468s) [329.940658] [076/132] (689s left) kms_cursor_crc (cursor-offscreen-32x10) [330.116859] Starting subtest: cursor-offscreen-32x10 [330.161547] Subtest cursor-offscreen-32x10: SKIP (0.039s) [330.482091] [077/132] (688s left) kms_setmode (clone-exclusive-crtc) [330.537743] Starting subtest: clone-exclusive-crtc [330.544252] Subtest clone-exclusive-crtc: SKIP (0.001s) [330.681117] [078/132] (688s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt) [330.787556] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt [330.791645] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [330.930081] [079/132] (688s left) gem_exec_params (cliprects_ptr-dirt) [330.991481] Starting subtest: cliprects_ptr-dirt [330.993358] Subtest cliprects_ptr-dirt: SUCCESS (0.000s) [331.112570] [080/132] (688s left) kms_flip (basic-flip-vs-wf_vblank) [331.208264] Starting subtest: basic-flip-vs-wf_vblank [331.210288] Starting dynamic subtest: A-eDP1 [333.170850] Dynamic subtest A-eDP1: SUCCESS (1.961s) [333.181829] Starting dynamic subtest: B-eDP1 [335.110752] Dynamic subtest B-eDP1: SUCCESS (1.937s) [335.122510] Starting dynamic subtest: C-eDP1 [337.034311] Dynamic subtest C-eDP1: SUCCESS (1.922s) [337.046798] Starting dynamic subtest: D-eDP1 [338.965710] Dynamic subtest D-eDP1: SUCCESS (1.928s) [338.968057] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.760s) [340.219052] [081/132] (679s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0) [340.318371] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0 [341.263481] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (0.945s) [341.396445] [082/132] (677s left) gem_exec_big (single) [341.451754] Starting subtest: single [343.832069] Subtest single: SUCCESS (2.380s) [344.034490] [083/132] (675s left) kms_fence_pin_leak [344.273389] [084/132] (675s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled) [344.341942] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled [344.344402] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.001s) [344.424419] [085/132] (675s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc) [344.521358] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc [344.523527] Starting dynamic subtest: pipe-A-eDP-1 [344.545138] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [344.554488] Starting dynamic subtest: pipe-B-eDP-1 [344.575315] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [344.583877] Starting dynamic subtest: pipe-C-eDP-1 [344.605157] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [344.614785] Starting dynamic subtest: pipe-D-eDP-1 [344.636768] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [344.640876] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [346.694905] [086/132] (672s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled) [346.752066] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled [346.754629] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.001s) [346.885438] [087/132] (672s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size) [347.006573] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size [355.965698] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (8.957s) [356.823862] [088/132] (662s left) i915_pm_rps (fence-order) [356.893651] Starting subtest: fence-order [359.866974] Subtest fence-order: SUCCESS (2.970s) [359.955406] [089/132] (659s left) perf_pmu (module-unload) [360.055906] Starting subtest: module-unload [368.910869] Subtest module-unload: FAIL (8.745s) [368.944742] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [368.945474] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true [368.948623] [090/132] (650s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [370.451297] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt [370.455411] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [370.539917] [FACT kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [370.541120] [FACT kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)] new: kernel.kmod_is_loaded.i915: true [370.545354] [091/132] (649s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible) [370.641800] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible [370.652332] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.010s) [370.775028] [092/132] (649s left) gem_basic (bad-close) [370.829990] Starting subtest: bad-close [370.834504] Subtest bad-close: SUCCESS (0.000s) [370.948574] [093/132] (648s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled) [370.997674] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled [371.104043] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.106s) [371.189753] [094/132] (648s left) gem_sync (basic-many-each) [371.259154] Starting subtest: basic-many-each [373.572807] Subtest basic-many-each: SUCCESS (2.323s) [373.784104] [095/132] (646s left) syncobj_timeline (wait-delayed-signal) [373.833912] Starting subtest: wait-delayed-signal [373.937347] Subtest wait-delayed-signal: SUCCESS (0.102s) [374.028714] [096/132] (645s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite) [374.129639] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite [381.509577] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.382s) [381.668754] [097/132] (638s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite) [381.766285] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite [381.770669] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [381.901997] [098/132] (638s left) gem_busy (extended) [382.082287] Starting subtest: extended [382.084246] Starting dynamic subtest: rcs0 [382.178493] Dynamic subtest rcs0: SUCCESS (0.099s) [382.189734] Starting dynamic subtest: bcs0 [382.220817] Dynamic subtest bcs0: SUCCESS (0.040s) [382.232637] Starting dynamic subtest: vcs0 [383.893064] Dynamic subtest vcs0: SUCCESS (1.668s) [383.904301] Starting dynamic subtest: vcs1 [385.877267] Dynamic subtest vcs1: SUCCESS (1.981s) [385.888612] Starting dynamic subtest: vecs0 [387.923926] Dynamic subtest vecs0: SUCCESS (2.044s) [387.935311] Starting dynamic subtest: ccs0 [387.968908] Dynamic subtest ccs0: SUCCESS (0.044s) [387.971436] Subtest extended: SUCCESS (5.891s) [388.211379] [099/132] (631s left) kms_psr (fbc-pr-cursor-mmap-cpu) [388.310793] Starting subtest: fbc-pr-cursor-mmap-cpu [388.314676] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s) [388.394550] [100/132] (631s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [388.488857] Starting subtest: compare-crc-sanitycheck-xr24 [388.491053] Starting dynamic subtest: pipe-A-eDP-1 [389.092178] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.602s) [389.105118] Starting dynamic subtest: pipe-B-eDP-1 [390.384679] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.289s) [390.393927] Starting dynamic subtest: pipe-C-eDP-1 [391.574034] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.187s) [391.583617] Starting dynamic subtest: pipe-D-eDP-1 [392.810902] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.237s) [392.813350] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.323s) [393.674234] [101/132] (626s left) gem_spin_batch (spin-all) [393.737067] Starting subtest: spin-all [393.750033] Subtest spin-all: SUCCESS (0.013s) [394.950077] [102/132] (625s left) gem_mmap_offset (clear) [395.003894] Starting subtest: clear [395.006512] Starting dynamic subtest: smem0 [420.280805] Dynamic subtest smem0: SUCCESS (25.272s) [420.282750] Subtest clear: SUCCESS (25.273s) [420.451546] [103/132] (599s left) api_intel_bb (destroy-bb) [420.543791] Starting subtest: destroy-bb [420.556717] Subtest destroy-bb: SUCCESS (0.014s) [420.718793] [104/132] (599s left) kms_cursor_legacy (forked-move) [420.857352] Starting subtest: forked-move [420.859254] Starting dynamic subtest: pipe-A [426.305670] Dynamic subtest pipe-A: SUCCESS (5.446s) [426.319128] Starting dynamic subtest: pipe-B [431.779254] Dynamic subtest pipe-B: SUCCESS (5.471s) [431.791551] Starting dynamic subtest: pipe-C [437.252753] Dynamic subtest pipe-C: SUCCESS (5.471s) [437.260935] Starting dynamic subtest: pipe-D [442.714629] Dynamic subtest pipe-D: SUCCESS (5.460s) [442.725728] Starting dynamic subtest: all-pipes [448.206738] Dynamic subtest all-pipes: SUCCESS (5.489s) [448.209251] Subtest forked-move: SUCCESS (27.347s) [448.374110] [105/132] (571s left) kms_psr (pr-primary-page-flip) [448.471917] Starting subtest: pr-primary-page-flip [448.475951] Subtest pr-primary-page-flip: SKIP (0.000s) [448.556356] [106/132] (571s left) gem_pxp (create-regular-context-2) [448.687687] Starting subtest: create-regular-context-2 [448.690374] Subtest create-regular-context-2: SUCCESS (0.002s) [448.827615] [107/132] (571s left) gem_mmap_gtt (big-copy-odd) [448.885042] Subtest big-copy-odd: SKIP (0.000s) [448.955779] [108/132] (571s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite) [449.053471] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite [456.480919] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.430s) [456.626333] [109/132] (563s left) gem_render_copy (y-tiled) [456.692017] Starting subtest: y-tiled [456.696533] Subtest y-tiled: SKIP (0.000s) [456.897744] [110/132] (563s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [456.997608] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [457.001596] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [457.118375] [111/132] (563s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75) [457.224703] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75 [457.226927] Starting dynamic subtest: pipe-A [457.246123] Dynamic subtest pipe-A: SKIP (0.018s) [457.256837] Starting dynamic subtest: pipe-B [457.280997] Dynamic subtest pipe-B: SKIP (0.033s) [457.289455] Starting dynamic subtest: pipe-C [457.311880] Dynamic subtest pipe-C: SKIP (0.030s) [457.320339] Starting dynamic subtest: pipe-D [457.340604] Dynamic subtest pipe-D: SKIP (0.029s) [457.344720] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.112s) [457.466463] [112/132] (563s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling) [457.554889] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling [457.557226] Starting dynamic subtest: pipe-A-default-mode [457.854826] Dynamic subtest pipe-A-default-mode: SKIP (0.296s) [457.859353] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.297s) [458.668467] [113/132] (561s left) kms_prop_blob (invalid-set-prop-any) [458.722171] Starting subtest: invalid-set-prop-any [458.724497] Subtest invalid-set-prop-any: SUCCESS (0.000s) [458.844818] [114/132] (561s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [458.958762] Starting subtest: basic-flip-before-cursor-varying-size [459.905225] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.947s) [460.799441] [115/132] (559s left) kms_flip (plain-flip-ts-check-interruptible) [460.899161] Starting subtest: plain-flip-ts-check-interruptible [460.901434] Starting dynamic subtest: A-eDP1 [469.774898] Dynamic subtest A-eDP1: SUCCESS (8.874s) [469.784550] Starting dynamic subtest: B-eDP1 [478.606583] Dynamic subtest B-eDP1: SUCCESS (8.830s) [478.617519] Starting dynamic subtest: C-eDP1 [487.418180] Dynamic subtest C-eDP1: SUCCESS (8.808s) [487.435251] Starting dynamic subtest: D-eDP1 [496.247166] Dynamic subtest D-eDP1: SUCCESS (8.826s) [496.249530] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.350s) [497.444879] [116/132] (523s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [497.554568] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt [497.558763] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [497.693972] [117/132] (523s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [497.793594] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt [497.797989] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [497.926919] [118/132] (522s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic) [498.049195] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic [498.053996] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s) [498.215638] [119/132] (522s left) vgem_basic (bad-flag) [498.256175] Starting subtest: bad-flag [498.258405] Subtest bad-flag: SUCCESS (0.000s) [498.336522] [120/132] (522s left) kms_vblank (query-forked) [498.413793] Starting subtest: query-forked [498.415725] Starting dynamic subtest: pipe-A-eDP-1 [500.221774] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.808s) [500.236532] Starting dynamic subtest: pipe-D-eDP-1 [502.764604] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.540s) [502.767021] Subtest query-forked: SUCCESS (4.352s) [503.610483] [121/132] (517s left) kms_big_fb (y-tiled-16bpp-rotate-180) [503.706785] Starting subtest: y-tiled-16bpp-rotate-180 [503.711030] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s) [503.805948] [122/132] (517s left) gem_exec_flush (basic-wb-rw-default) [503.863229] Starting subtest: basic-wb-rw-default [509.316488] Subtest basic-wb-rw-default: SUCCESS (5.454s) [509.512151] [123/132] (511s left) gem_render_copy (yf-tiled-to-vebox-x-tiled) [509.568407] Starting subtest: yf-tiled-to-vebox-x-tiled [509.572915] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s) [509.764503] [124/132] (511s left) kms_psr (fbc-psr-basic) [509.858925] Starting subtest: fbc-psr-basic [509.861286] Starting dynamic subtest: eDP-1 [509.865688] Dynamic subtest eDP-1: SKIP (0.000s) [509.870634] Subtest fbc-psr-basic: SKIP (0.001s) [509.945101] [125/132] (511s left) kms_async_flips (async-flip-hang) [510.038986] Starting subtest: async-flip-hang [510.417688] Starting dynamic subtest: pipe-A-eDP-1 [525.426916] Dynamic subtest pipe-A-eDP-1: SUCCESS (15.006s) [525.796884] Starting dynamic subtest: pipe-B-eDP-1 [541.360585] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.566s) [541.751906] Starting dynamic subtest: pipe-C-eDP-1 [557.358585] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.612s) [557.745846] Starting dynamic subtest: pipe-D-eDP-1 [573.358566] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.617s) [573.360943] Subtest async-flip-hang: SUCCESS (63.316s) [574.580127] [126/132] (446s left) kms_pm_rpm (legacy-planes) [576.110880] Starting subtest: legacy-planes [576.114055] Starting dynamic subtest: plane-43 [584.414156] Dynamic subtest plane-43: SUCCESS (8.303s) [584.425473] Starting dynamic subtest: plane-53 [592.684734] Dynamic subtest plane-53: SUCCESS (8.268s) [592.697787] Starting dynamic subtest: plane-63 [600.951693] Dynamic subtest plane-63: SUCCESS (8.263s) [600.962858] Starting dynamic subtest: plane-73 [609.253436] Dynamic subtest plane-73: SUCCESS (8.299s) [609.263905] Subtest legacy-planes: SUCCESS (33.144s) [609.637163] [127/132] (411s left) gem_ctx_isolation (dirty-create) [609.700628] Starting subtest: dirty-create [609.703158] Starting dynamic subtest: rcs0 [609.887639] Dynamic subtest rcs0: SUCCESS (0.187s) [609.897312] Starting dynamic subtest: bcs0 [610.098897] Dynamic subtest bcs0: SUCCESS (0.210s) [610.107474] Starting dynamic subtest: vcs0 [610.322318] Dynamic subtest vcs0: SUCCESS (0.222s) [610.330657] Starting dynamic subtest: vcs1 [612.114117] Dynamic subtest vcs1: SUCCESS (1.791s) [612.122523] Starting dynamic subtest: vecs0 [614.130281] Dynamic subtest vecs0: SUCCESS (2.015s) [614.139064] Starting dynamic subtest: ccs0 [616.126266] Dynamic subtest ccs0: SUCCESS (1.995s) [616.128712] Subtest dirty-create: SUCCESS (6.426s) [616.369447] [128/132] (404s left) kms_properties (plane-properties-atomic) [616.468836] Starting subtest: plane-properties-atomic [616.470721] Starting dynamic subtest: pipe-A-eDP-1 [617.020467] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.552s) [617.033628] Starting dynamic subtest: pipe-B-eDP-1 [618.295319] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.271s) [618.310276] Starting dynamic subtest: pipe-C-eDP-1 [619.520989] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.225s) [619.531867] Starting dynamic subtest: pipe-D-eDP-1 [620.751534] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.232s) [620.753786] Subtest plane-properties-atomic: SUCCESS (4.285s) [621.557895] [129/132] (399s left) kms_invalid_mode (bad-vtotal) [621.656665] Starting subtest: bad-vtotal [621.659086] Starting dynamic subtest: pipe-A-eDP-1 [621.945321] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s) [621.954068] Starting dynamic subtest: pipe-B-eDP-1 [621.956139] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [621.963642] Starting dynamic subtest: pipe-C-eDP-1 [621.965725] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [621.973391] Starting dynamic subtest: pipe-D-eDP-1 [621.975236] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [621.977033] Subtest bad-vtotal: SUCCESS (0.294s) [622.792748] [130/132] (398s left) dmabuf_sync_file (export-before-signal) [622.836674] Starting subtest: export-before-signal [622.838839] Subtest export-before-signal: SUCCESS (0.001s) [622.916100] [131/132] (398s left) gem_render_copy (linear) [622.979122] Starting subtest: linear [622.981501] Starting dynamic subtest: smem [623.017783] Dynamic subtest smem: SUCCESS (0.038s) [623.020104] Subtest linear: SUCCESS (0.039s) [623.279085] [132/132] (398s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite) [623.384948] Starting subtest: psr-rgb565-draw-pwrite [630.272219] Subtest psr-rgb565-draw-pwrite: SUCCESS (6.889s) [630.415406] Closing watchdogs results: parsing output: 0/ for test: gem_eio results: parsing output: 1/ for test: gem_exec_reloc results: parsing output: 2/ for test: api_intel_allocator results: parsing output: 3/ for test: perf_pmu results: parsing output: 4/ for test: kms_chamelium_color results: parsing output: 5/ for test: kms_cursor_edge_walk results: parsing output: 6/ for test: gem_userptr_blits results: parsing output: 7/ for test: kms_plane_cursor results: parsing output: 8/ for test: kms_pm_rpm results: parsing output: 9/ for test: gem_vm_create results: parsing output: 10/ for test: kms_frontbuffer_tracking results: parsing output: 11/ for test: gem_lmem_swapping results: parsing output: 12/ for test: kms_sharpness_filter results: parsing output: 13/ for test: kms_joiner results: parsing output: 14/ for test: kms_psr results: parsing output: 15/ for test: gem_render_linear_blits results: parsing output: 16/ for test: kms_frontbuffer_tracking results: parsing output: 17/ for test: gem_exec_fence results: parsing output: 18/ for test: kms_addfb_basic results: parsing output: 19/ for test: gem_exec_schedule results: parsing output: 20/ for test: kms_psr2_sf results: parsing output: 21/ for test: i915_hangman results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: gen9_exec_parse results: parsing output: 24/ for test: kms_big_fb results: parsing output: 25/ for test: kms_rotation_crc results: parsing output: 26/ for test: kms_writeback results: parsing output: 27/ for test: kms_ccs results: parsing output: 28/ for test: kms_plane_scaling results: parsing output: 29/ for test: syncobj_wait results: parsing output: 30/ for test: gem_exec_schedule results: parsing output: 31/ for test: gem_ctx_persistence results: parsing output: 32/ for test: kms_cursor_crc results: parsing output: 33/ for test: prime_vgem results: parsing output: 34/ for test: kms_ccs results: parsing output: 35/ for test: syncobj_timeline results: parsing output: 36/ for test: kms_ccs results: parsing output: 37/ for test: gem_exec_reloc results: parsing output: 38/ for test: kms_chamelium_frames results: parsing output: 39/ for test: gem_exec_create results: parsing output: 40/ for test: gem_workarounds results: parsing output: 41/ for test: kms_frontbuffer_tracking results: parsing output: 42/ for test: gem_exec_store results: parsing output: 43/ for test: kms_big_fb results: parsing output: 44/ for test: gem_exec_reloc results: parsing output: 45/ for test: kms_big_fb results: parsing output: 46/ for test: syncobj_basic results: parsing output: 47/ for test: gem_exec_balancer results: parsing output: 48/ for test: gem_exec_reloc results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: kms_frontbuffer_tracking results: parsing output: 51/ for test: kms_frontbuffer_tracking results: parsing output: 52/ for test: gem_mmap_gtt results: parsing output: 53/ for test: kms_content_protection results: parsing output: 54/ for test: syncobj_basic results: parsing output: 55/ for test: i915_query results: parsing output: 56/ for test: gem_mmap_gtt results: parsing output: 57/ for test: gem_pipe_control_store_loop results: parsing output: 58/ for test: kms_frontbuffer_tracking results: parsing output: 59/ for test: gem_pxp results: parsing output: 60/ for test: gem_exec_reloc results: parsing output: 61/ for test: gem_exec_params results: parsing output: 62/ for test: kms_chamelium_hpd results: parsing output: 63/ for test: kms_fb_coherency results: parsing output: 64/ for test: gem_exec_schedule results: parsing output: 65/ for test: gen9_exec_parse results: parsing output: 66/ for test: kms_flip results: parsing output: 67/ for test: kms_psr results: parsing output: 68/ for test: kms_big_fb results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: vgem_basic results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: kms_atomic_transition results: parsing output: 73/ for test: kms_ccs results: parsing output: 74/ for test: gem_ctx_engines results: parsing output: 75/ for test: kms_cursor_crc results: parsing output: 76/ for test: kms_setmode results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: gem_exec_params results: parsing output: 79/ for test: kms_flip results: parsing output: 80/ for test: kms_big_fb results: parsing output: 81/ for test: gem_exec_big results: parsing output: 82/ for test: kms_fence_pin_leak results: parsing output: 83/ for test: syncobj_timeline results: parsing output: 84/ for test: kms_ccs results: parsing output: 85/ for test: syncobj_timeline results: parsing output: 86/ for test: kms_cursor_legacy results: parsing output: 87/ for test: i915_pm_rps results: parsing output: 88/ for test: perf_pmu results: parsing output: 89/ for test: kms_frontbuffer_tracking results: parsing output: 90/ for test: kms_flip results: parsing output: 91/ for test: gem_basic results: parsing output: 92/ for test: syncobj_timeline results: parsing output: 93/ for test: gem_sync results: parsing output: 94/ for test: syncobj_timeline results: parsing output: 95/ for test: kms_frontbuffer_tracking results: parsing output: 96/ for test: kms_frontbuffer_tracking results: parsing output: 97/ for test: gem_busy results: parsing output: 98/ for test: kms_psr results: parsing output: 99/ for test: kms_pipe_crc_basic results: parsing output: 100/ for test: gem_spin_batch results: parsing output: 101/ for test: gem_mmap_offset results: parsing output: 102/ for test: api_intel_bb results: parsing output: 103/ for test: kms_cursor_legacy results: parsing output: 104/ for test: kms_psr results: parsing output: 105/ for test: gem_pxp results: parsing output: 106/ for test: gem_mmap_gtt results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: gem_render_copy results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: kms_plane_scaling results: parsing output: 111/ for test: kms_flip_scaled_crc results: parsing output: 112/ for test: kms_prop_blob results: parsing output: 113/ for test: kms_cursor_legacy results: parsing output: 114/ for test: kms_flip results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: kms_frontbuffer_tracking results: parsing output: 117/ for test: kms_cursor_legacy results: parsing output: 118/ for test: vgem_basic results: parsing output: 119/ for test: kms_vblank results: parsing output: 120/ for test: kms_big_fb results: parsing output: 121/ for test: gem_exec_flush results: parsing output: 122/ for test: gem_render_copy results: parsing output: 123/ for test: kms_psr results: parsing output: 124/ for test: kms_async_flips results: parsing output: 125/ for test: kms_pm_rpm results: parsing output: 126/ for test: gem_ctx_isolation results: parsing output: 127/ for test: kms_properties results: parsing output: 128/ for test: kms_invalid_mode results: parsing output: 129/ for test: dmabuf_sync_file results: parsing output: 130/ for test: gem_render_copy results: parsing output: 131/ for test: kms_frontbuffer_tracking Done.