[60.293952] Initializing watchdogs
[60.293998]   /dev/watchdog0
[60.307786] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[60.312832] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.315395] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.318802] [001/156] (960s left) gem_exec_flush (basic-wb-rw-default)
[60.403159] Starting subtest: basic-wb-rw-default
[65.799197] Subtest basic-wb-rw-default: SUCCESS (5.462s)
[65.998696] [002/156] (954s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[66.256251] Starting subtest: parallel-dmabuf-import-out-fence
[67.322182] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.074s)
[67.443040] [003/156] (953s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[67.534981] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[67.539238] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s)
[67.601803] [004/156] (953s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[67.688168] Starting subtest: fbc-pr-cursor-mmap-gtt
[67.692563] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[67.768489] [005/156] (953s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-pwrite)
[67.868956] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-pwrite
[67.873142] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[67.979834] [006/156] (953s left) kms_chamelium_hpd (dp-hpd-fast)
[68.365215] Subtest dp-hpd-fast: SKIP (0.000s)
[69.145493] [007/156] (951s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[69.200039] Starting subtest: etime-multi-wait-available-unsubmitted
[69.306082] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.106s)
[69.391961] [008/156] (951s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[69.443935] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[69.509909] [009/156] (951s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[69.604773] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[69.608926] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[69.689532] [010/156] (951s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-onoff)
[69.782500] Starting subtest: fbchdr-1p-primscrn-spr-indfb-onoff
[69.787101] Subtest fbchdr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[69.870950] [011/156] (951s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[69.979198] Starting subtest: flip-vs-cursor-busy-crc-legacy
[70.725425] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.746s)
[71.586219] [012/156] (949s left) gem_mmap_gtt (close-race)
[71.639113] Subtest close-race: SKIP (0.000s)
[71.699141] [013/156] (949s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[71.789910] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[71.792412] Starting dynamic subtest: pipe-A-default-mode
[72.952204] Dynamic subtest pipe-A-default-mode: SKIP (1.162s)
[72.957073] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.163s)
[73.248946] [014/156] (948s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[73.372870] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-mmap-wc
[73.377272] Subtest hdr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[73.576990] [015/156] (947s left) gem_ctx_engines (execute-oneforall)
[73.636211] Starting subtest: execute-oneforall
[74.154095] Subtest execute-oneforall: SUCCESS (0.518s)
[75.368191] [016/156] (946s left) template (b)
[75.420962] Starting subtest: B
[75.423306] Subtest B: SUCCESS (0.000s)
[75.569288] [017/156] (945s left) kms_content_protection (lic-type-0)
[75.718692] Starting subtest: lic-type-0
[75.723337] Subtest lic-type-0: SKIP (0.000s)
[75.845087] [018/156] (945s left) gem_ctx_persistence (processes)
[75.895658] Starting subtest: processes
[77.321451] Subtest processes: SUCCESS (1.428s)
[77.396160] [019/156] (944s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-pwrite)
[77.498759] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-pwrite
[77.503229] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[77.601171] [020/156] (943s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[77.707295] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[77.711639] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[77.806896] [021/156] (943s left) api_intel_bb (delta-check)
[77.862134] Starting subtest: delta-check
[77.867344] Subtest delta-check: SUCCESS (0.007s)
[77.998980] [022/156] (943s left) perf (invalid-remove-userspace-config)
[78.104285] Starting subtest: invalid-remove-userspace-config
[78.110783] Subtest invalid-remove-userspace-config: SUCCESS (0.009s)
[78.146217] [023/156] (943s left) gem_ctx_shared (q-independent)
[78.219980] Starting subtest: Q-independent
[78.222324] Starting dynamic subtest: rcs0
[78.288681] Dynamic subtest rcs0: SUCCESS (0.071s)
[78.300720] Starting dynamic subtest: vcs0
[78.332752] Dynamic subtest vcs0: SUCCESS (0.045s)
[78.342567] Starting dynamic subtest: vcs1
[78.381356] Dynamic subtest vcs1: SUCCESS (0.048s)
[78.391813] Starting dynamic subtest: vecs0
[78.419500] Dynamic subtest vecs0: SUCCESS (0.038s)
[78.427894] Starting dynamic subtest: ccs0
[78.465895] Dynamic subtest ccs0: SUCCESS (0.046s)
[78.467972] Subtest Q-independent: SUCCESS (0.249s)
[80.411345] [024/156] (941s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[80.516422] Starting subtest: plane-use-after-nonblocking-unbind
[80.519310] Starting dynamic subtest: pipe-A-eDP-1
[80.576835] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s)
[80.873231] Starting dynamic subtest: pipe-B-eDP-1
[81.697415] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.832s)
[81.987963] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.474s)
[82.859502] [025/156] (938s left) kms_big_fb (linear-64bpp-rotate-90)
[82.963136] Starting subtest: linear-64bpp-rotate-90
[82.982279] Subtest linear-64bpp-rotate-90: SKIP (0.019s)
[83.092962] [026/156] (938s left) kms_scaling_modes (scaling-mode-center)
[83.184662] Starting subtest: scaling-mode-center
[83.186783] Starting dynamic subtest: pipe-A-eDP-1
[83.276523] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.093s)
[83.285219] Starting dynamic subtest: pipe-B-eDP-1
[84.481507] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.203s)
[84.491284] Starting dynamic subtest: pipe-C-eDP-1
[85.704905] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.222s)
[85.716868] Starting dynamic subtest: pipe-D-eDP-1
[86.830685] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.124s)
[86.833189] Subtest scaling-mode-center: SUCCESS (3.648s)
[87.989416] [027/156] (933s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[88.088227] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[88.092909] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[88.173523] [028/156] (933s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[88.220807] Starting subtest: invalid-smem-bo-on-discrete
[88.225381] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[88.343899] [029/156] (933s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[88.435734] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[88.440384] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[89.533645] [030/156] (932s left) gem_ctx_persistence (engines-mixed-process)
[89.585717] Starting subtest: engines-mixed-process
[89.588058] Starting dynamic subtest: rcs0
[91.241699] Dynamic subtest rcs0: SUCCESS (1.656s)
[91.250232] Starting dynamic subtest: bcs0
[93.329683] Dynamic subtest bcs0: SUCCESS (2.088s)
[93.339294] Starting dynamic subtest: vcs0
[95.312050] Dynamic subtest vcs0: SUCCESS (1.981s)
[95.321528] Starting dynamic subtest: vcs1
[97.297119] Dynamic subtest vcs1: SUCCESS (1.983s)
[97.309481] Starting dynamic subtest: vecs0
[99.337906] Dynamic subtest vecs0: SUCCESS (2.039s)
[99.347280] Starting dynamic subtest: ccs0
[101.335891] Dynamic subtest ccs0: SUCCESS (1.996s)
[101.338401] Subtest engines-mixed-process: SUCCESS (11.750s)
[101.427669] [031/156] (920s left) i915_pm_rpm (debugfs-forcewake-user)
[103.463914] Starting subtest: debugfs-forcewake-user
[114.852263] Subtest debugfs-forcewake-user: SUCCESS (11.390s)
[115.254952] [032/156] (906s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[115.357115] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-mmap-gtt
[115.361728] Subtest fbchdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[115.460985] [033/156] (906s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[115.510807] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[115.515300] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[115.705204] [034/156] (906s left) syncobj_timeline (invalid-query-bad-pad)
[115.757125] Starting subtest: invalid-query-bad-pad
[115.759587] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[115.858210] [035/156] (906s left) kms_cursor_crc (cursor-random-64x64)
[116.037563] Starting subtest: cursor-random-64x64
[116.042498] Starting dynamic subtest: pipe-A-eDP-1
[119.397904] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.354s)
[119.424909] Starting dynamic subtest: pipe-D-eDP-1
[123.520683] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.101s)
[123.523244] Subtest cursor-random-64x64: SUCCESS (7.480s)
[124.335334] [036/156] (897s left) gen3_render_tiledy_blits
[124.445911] [037/156] (897s left) kms_ccs (random-ccs-data-4-tiled-lnl-ccs)
[124.534622] Starting subtest: random-ccs-data-4-tiled-lnl-ccs
[124.539148] Subtest random-ccs-data-4-tiled-lnl-ccs: SKIP (0.000s)
[125.655824] [038/156] (896s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[125.781484] Starting subtest: flip-vs-cursor-atomic-transitions
[133.728777] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.952s)
[134.593098] [039/156] (887s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[134.700567] Starting subtest: y-tiled-8bpp-rotate-0
[134.705027] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[134.795950] [040/156] (887s left) gem_render_copy (y-tiled-ccs-to-linear)
[134.848591] Starting subtest: y-tiled-ccs-to-linear
[134.852991] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[135.042970] [041/156] (887s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[135.137029] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb
[135.141266] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[135.209882] [042/156] (887s left) syncobj_timeline (reset-signaled)
[135.261099] Starting subtest: reset-signaled
[135.263076] Subtest reset-signaled: SUCCESS (0.000s)
[135.353570] [043/156] (887s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[135.454083] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[135.458278] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[135.547422] [044/156] (886s left) gen9_exec_parse (basic-rejected-ctx-param)
[135.607627] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[135.677581] [045/156] (886s left) api_intel_bb (purge-bb)
[135.722053] Starting subtest: purge-bb
[135.724343] Subtest purge-bb: SUCCESS (0.004s)
[135.852938] [046/156] (886s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[135.951792] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[136.929731] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.979s)
[137.065113] [047/156] (885s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[137.156731] Starting subtest: x-tiled-8bpp-rotate-180
[138.404537] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.248s)
[138.534034] [048/156] (884s left) kms_cursor_crc (cursor-random-128x128)
[138.750114] Starting subtest: cursor-random-128x128
[138.754234] Starting dynamic subtest: pipe-A-eDP-1
[142.108644] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.353s)
[142.134739] Starting dynamic subtest: pipe-D-eDP-1
[146.149464] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.019s)
[146.151692] Subtest cursor-random-128x128: SUCCESS (7.397s)
[146.977881] [049/156] (875s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[147.075261] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[147.079603] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[147.174276] [050/156] (875s left) kms_getfb (getfb2-handle-not-fb)
[147.258364] Starting subtest: getfb2-handle-not-fb
[147.260758] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[147.356037] [051/156] (875s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-move)
[147.448187] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-move
[147.452379] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[147.542727] [052/156] (875s left) kms_display_modes (extended-mode-basic)
[147.631781] Starting subtest: extended-mode-basic
[147.636140] Subtest extended-mode-basic: SKIP (0.000s)
[147.681056] [053/156] (875s left) kms_psr (psr-primary-mmap-cpu)
[147.777448] Starting subtest: psr-primary-mmap-cpu
[147.779888] Starting dynamic subtest: eDP-1
[149.495998] Dynamic subtest eDP-1: SUCCESS (1.718s)
[149.498526] Subtest psr-primary-mmap-cpu: SUCCESS (1.719s)
[150.359223] [054/156] (872s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[150.459049] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[150.581795] [055/156] (872s left) gem_exec_store (basic)
[150.649113] Starting subtest: basic
[150.771238] Subtest basic: SUCCESS (0.123s)
[150.965195] [056/156] (872s left) fbdev (read)
[151.005649] Starting subtest: read
[151.616127] Subtest read: SUCCESS (0.609s)
[151.673862] [057/156] (871s left) gem_mmap (short-mmap)
[151.728530] Subtest short-mmap: SKIP (0.000s)
[151.791973] [058/156] (871s left) i915_drm_fdinfo (busy-idle-check-all)
[151.827053] Starting subtest: busy-idle-check-all
[151.829664] Starting dynamic subtest: rcs0
[151.834734] Dynamic subtest rcs0: SKIP (0.004s)
[151.848919] Starting dynamic subtest: bcs0
[151.853471] Dynamic subtest bcs0: SKIP (0.000s)
[151.861961] Starting dynamic subtest: vcs0
[151.866475] Dynamic subtest vcs0: SKIP (0.000s)
[151.876636] Starting dynamic subtest: vcs1
[151.880787] Dynamic subtest vcs1: SKIP (0.000s)
[151.888799] Starting dynamic subtest: vecs0
[151.892888] Dynamic subtest vecs0: SKIP (0.000s)
[151.901600] Starting dynamic subtest: ccs0
[151.905649] Dynamic subtest ccs0: SKIP (0.000s)
[151.909722] Subtest busy-idle-check-all: SKIP (0.008s)
[151.944805] [059/156] (871s left) kms_frontbuffer_tracking (hdr-2p-primscrn-indfb-pgflip-blt)
[152.080050] Starting subtest: hdr-2p-primscrn-indfb-pgflip-blt
[152.084449] Subtest hdr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[152.173409] [060/156] (870s left) gem_ctx_bad_destroy (invalid-ctx)
[152.229963] Starting subtest: invalid-ctx
[152.232232] Subtest invalid-ctx: SUCCESS (0.000s)
[152.309894] [061/156] (870s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[152.399752] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[159.695128] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.300s)
[159.827413] [062/156] (863s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[159.941830] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[159.946256] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[160.049085] [063/156] (863s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[160.147840] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[167.042413] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.900s)
[167.174256] [064/156] (856s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[167.300127] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[174.190818] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.899s)
[174.327952] [065/156] (848s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[174.435491] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[174.440046] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[174.548262] [066/156] (848s left) perf_pmu (all-busy-check-all)
[174.590983] Starting subtest: all-busy-check-all
[176.319351] Subtest all-busy-check-all: SUCCESS (1.727s)
[176.423170] [067/156] (846s left) kms_busy (basic)
[176.527255] Starting subtest: basic
[176.529830] Starting dynamic subtest: flip
[177.110374] Dynamic subtest flip: SUCCESS (0.583s)
[177.120069] Starting dynamic subtest: modeset
[180.586580] Dynamic subtest modeset: SUCCESS (3.472s)
[180.589079] Subtest basic: SUCCESS (4.058s)
[181.393778] [068/156] (842s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-render)
[181.498886] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-render
[181.503110] Subtest hdr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[181.590921] [069/156] (841s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[181.711295] Starting subtest: flip-vs-cursor-atomic
[189.201171] Subtest flip-vs-cursor-atomic: SUCCESS (7.490s)
[190.014853] [070/156] (833s left) gem_mmap_gtt (basic-small-copy-xy)
[190.076978] Subtest basic-small-copy-XY: SKIP (0.000s)
[190.134526] [071/156] (833s left) gem_exec_balancer (full-pulse)
[190.183469] Starting subtest: full-pulse
[195.144341] Subtest full-pulse: SUCCESS (4.961s)
[195.478918] [072/156] (828s left) gem_render_copy (y-tiled-to-vebox-linear)
[195.536253] Starting subtest: y-tiled-to-vebox-linear
[195.540764] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[195.734616] [073/156] (827s left) kms_atomic (test-only)
[195.824029] Starting subtest: test-only
[195.869286] Starting dynamic subtest: pipe-A-eDP-1
[198.368632] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.500s)
[198.370769] Subtest test-only: SUCCESS (2.546s)
[199.228669] [074/156] (824s left) gem_exec_schedule (lateslice)
[199.299770] Starting subtest: lateslice
[199.301991] Starting dynamic subtest: rcs0
[199.311859] Dynamic subtest rcs0: SUCCESS (0.022s)
[199.322161] Starting dynamic subtest: bcs0
[199.329904] Dynamic subtest bcs0: SUCCESS (0.017s)
[199.338814] Starting dynamic subtest: vcs0
[199.349751] Dynamic subtest vcs0: SUCCESS (0.019s)
[199.358561] Starting dynamic subtest: vcs1
[199.367453] Dynamic subtest vcs1: SUCCESS (0.017s)
[199.376609] Starting dynamic subtest: vecs0
[199.387050] Dynamic subtest vecs0: SUCCESS (0.019s)
[199.396617] Starting dynamic subtest: ccs0
[199.405864] Dynamic subtest ccs0: SUCCESS (0.018s)
[199.408290] Subtest lateslice: SUCCESS (0.117s)
[201.357949] [075/156] (822s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[201.449609] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[201.453574] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[201.550041] [076/156] (822s left) perf_pmu (semaphore-wait)
[201.589358] Starting subtest: semaphore-wait
[201.591603] Starting dynamic subtest: rcs0
[202.101372] Dynamic subtest rcs0: SUCCESS (0.513s)
[202.112684] Starting dynamic subtest: bcs0
[202.614596] Dynamic subtest bcs0: SUCCESS (0.510s)
[202.627120] Starting dynamic subtest: vcs0
[203.128721] Dynamic subtest vcs0: SUCCESS (0.510s)
[203.140863] Starting dynamic subtest: vcs1
[203.641483] Dynamic subtest vcs1: SUCCESS (0.509s)
[203.653325] Starting dynamic subtest: vecs0
[204.154712] Dynamic subtest vecs0: SUCCESS (0.510s)
[204.166562] Starting dynamic subtest: ccs0
[204.673504] Dynamic subtest ccs0: SUCCESS (0.515s)
[204.676671] Subtest semaphore-wait: SUCCESS (3.087s)
[204.791426] [077/156] (819s left) kms_frontbuffer_tracking (hdr-suspend)
[204.891924] Starting subtest: hdr-suspend
[204.896145] Subtest hdr-suspend: SKIP (0.000s)
[204.984965] [078/156] (818s left) sysfs_preempt_timeout (invalid)
[205.039098] Starting subtest: invalid
[205.041436] Starting dynamic subtest: vecs0
[205.043873] Dynamic subtest vecs0: SUCCESS (0.000s)
[205.053046] Starting dynamic subtest: ccs0
[205.054985] Dynamic subtest ccs0: SUCCESS (0.000s)
[205.063575] Starting dynamic subtest: vcs0
[205.065529] Dynamic subtest vcs0: SUCCESS (0.000s)
[205.073924] Starting dynamic subtest: bcs0
[205.075876] Dynamic subtest bcs0: SUCCESS (0.000s)
[205.084241] Starting dynamic subtest: rcs0
[205.086174] Dynamic subtest rcs0: SUCCESS (0.001s)
[205.094604] Starting dynamic subtest: vcs1
[205.096611] Dynamic subtest vcs1: SUCCESS (0.001s)
[205.098984] Subtest invalid: SUCCESS (0.009s)
[205.156905] [079/156] (818s left) kms_plane_alpha_blend (alpha-opaque-fb)
[205.254265] Starting subtest: alpha-opaque-fb
[205.533092] Starting dynamic subtest: pipe-A-eDP-1
[206.135013] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.600s)
[206.144651] Starting dynamic subtest: pipe-D-eDP-1
[207.471065] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.336s)
[207.473500] Subtest alpha-opaque-fb: SUCCESS (2.218s)
[208.294422] [080/156] (815s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[208.355972] Starting subtest: y-tiled-ccs-to-y-tiled
[208.360214] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[208.539863] [081/156] (815s left) dmabuf_sync_file (import-basic)
[208.646424] Starting subtest: import-basic
[208.648482] Subtest import-basic: SUCCESS (0.001s)
[208.711883] [FACT dmabuf_sync_file (import-basic)] new: kernel.kmod_is_loaded.vgem: true
[208.715476] [082/156] (815s left) kms_flip (flip-vs-wf_vblank-interruptible)
[208.816533] Starting subtest: flip-vs-wf_vblank-interruptible
[208.819416] Starting dynamic subtest: A-eDP1
[210.726224] Dynamic subtest A-eDP1: SUCCESS (1.908s)
[210.736802] Starting dynamic subtest: B-eDP1
[212.667044] Dynamic subtest B-eDP1: SUCCESS (1.940s)
[212.677521] Starting dynamic subtest: C-eDP1
[214.599592] Dynamic subtest C-eDP1: SUCCESS (1.931s)
[214.609970] Starting dynamic subtest: D-eDP1
[216.530788] Dynamic subtest D-eDP1: SUCCESS (1.930s)
[216.533190] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.717s)
[217.757122] [083/156] (806s left) kms_selftest (drm_plane_helper)
[217.797170] Starting subtest: drm_plane_helper
[217.805903] Starting dynamic subtest: drm_test_check_plane_state
[217.923443] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.117s)
[217.932651] Starting dynamic subtest: drm_test_check_invalid_plane_state
[218.023303] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.098s)
[218.025483] Subtest drm_plane_helper: SUCCESS (0.226s)
[218.169947] [084/156] (805s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[218.265673] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[218.268084] Starting dynamic subtest: pipe-A-eDP-1
[218.291184] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[218.303307] Starting dynamic subtest: pipe-B-eDP-1
[218.325590] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[218.334673] Starting dynamic subtest: pipe-C-eDP-1
[218.356574] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[218.365566] Starting dynamic subtest: pipe-D-eDP-1
[218.387853] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[218.392106] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[220.521555] [085/156] (803s left) kms_flip (flip-vs-expired-vblank)
[220.611493] Starting subtest: flip-vs-expired-vblank
[220.613466] Starting dynamic subtest: A-eDP1
[229.324270] Dynamic subtest A-eDP1: SUCCESS (8.714s)
[229.333441] Starting dynamic subtest: B-eDP1
[238.053134] Dynamic subtest B-eDP1: SUCCESS (8.727s)
[238.062962] Starting dynamic subtest: C-eDP1
[246.679781] Dynamic subtest C-eDP1: SUCCESS (8.625s)
[246.690547] Starting dynamic subtest: D-eDP1
[255.320990] Dynamic subtest D-eDP1: SUCCESS (8.639s)
[255.323442] Subtest flip-vs-expired-vblank: SUCCESS (34.714s)
[256.504593] [086/156] (767s left) kms_properties (colorop-properties-legacy)
[256.597405] Starting subtest: colorop-properties-legacy
[256.599811] Starting dynamic subtest: pipe-A-eDP-1
[256.986222] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.388s)
[256.999297] Starting dynamic subtest: pipe-B-eDP-1
[258.079489] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.091s)
[258.089905] Starting dynamic subtest: pipe-C-eDP-1
[259.209062] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.130s)
[259.219822] Starting dynamic subtest: pipe-D-eDP-1
[260.255568] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.045s)
[260.257988] Subtest colorop-properties-legacy: SUCCESS (3.659s)
[261.148166] [087/156] (763s left) gem_lmem_swapping (basic)
[261.193119] Subtest basic: SKIP (0.000s)
[261.234270] [088/156] (762s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[261.321611] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[261.324199] Starting dynamic subtest: pipe-A-eDP-1
[261.348092] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[261.358393] Starting dynamic subtest: pipe-B-eDP-1
[261.380285] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[261.389566] Starting dynamic subtest: pipe-C-eDP-1
[261.412522] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[261.421522] Starting dynamic subtest: pipe-D-eDP-1
[261.444112] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[261.448252] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[263.622012] [089/156] (760s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[263.717112] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[263.718950] Starting dynamic subtest: pipe-A-eDP-1
[264.528470] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.804s)
[264.539117] Starting dynamic subtest: pipe-B-eDP-1
[266.065715] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.535s)
[266.076121] Starting dynamic subtest: pipe-C-eDP-1
[267.554073] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.488s)
[267.568709] Starting dynamic subtest: pipe-D-eDP-1
[269.083321] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.527s)
[269.085574] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.358s)
[270.263638] [090/156] (754s left) kms_psr (fbc-psr-primary-render)
[270.360266] Starting subtest: fbc-psr-primary-render
[270.362633] Starting dynamic subtest: eDP-1
[270.366831] Dynamic subtest eDP-1: SKIP (0.000s)
[270.371102] Subtest fbc-psr-primary-render: SKIP (0.001s)
[270.434306] [091/156] (753s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[270.552557] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[288.821184] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (18.269s)
[289.694919] [092/156] (734s left) gem_linear_blits (basic)
[290.115308] Starting subtest: basic
[290.120841] Subtest basic: SUCCESS (0.010s)
[290.259064] [093/156] (734s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[290.393064] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[291.116054] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.726s)
[291.291281] [094/156] (733s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[291.384754] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[291.389129] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[291.481051] [095/156] (733s left) sw_sync (timeline_closed_signaled)
[291.518901] Starting subtest: timeline_closed_signaled
[291.521173] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[291.582760] [096/156] (732s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[291.673766] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[291.677725] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[291.769506] [097/156] (732s left) gem_workarounds (basic-read)
[291.837668] Starting subtest: basic-read
[291.847812] Subtest basic-read: SUCCESS (0.009s)
[291.991973] [098/156] (732s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[292.093067] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[292.096534] Subtest hdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[292.191228] [099/156] (732s left) i915_pm_rps (thresholds-idle-park)
[292.257473] Starting subtest: thresholds-idle-park
[292.261532] Subtest thresholds-idle-park: SKIP (0.001s)
[292.384881] [100/156] (732s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-mmap-wc)
[292.481519] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-mmap-wc
[292.485053] Subtest fbchdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[292.584931] [101/156] (732s left) syncobj_wait (wait-all-complex)
[292.653978] Starting subtest: wait-all-complex
[292.868040] Subtest wait-all-complex: SUCCESS (0.213s)
[292.959497] [102/156] (731s left) gem_exec_params (larger-than-life-batch)
[293.017461] Starting subtest: larger-than-life-batch
[295.071292] Subtest larger-than-life-batch: SUCCESS (2.052s)
[296.367672] [103/156] (728s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[296.508148] Starting subtest: fbcpsr-suspend
[336.839992] Subtest fbcpsr-suspend: SUCCESS (10.211s)
[336.983842] [104/156] (687s left) kms_frontbuffer_tracking (fbcpsrhdr-shrfb-scaledprimary)
[337.095979] Starting subtest: fbcpsrhdr-shrfb-scaledprimary
[337.100032] Subtest fbcpsrhdr-shrfb-scaledprimary: SKIP (0.000s)
[337.196557] [105/156] (687s left) gem_exec_schedule (u-submit-golden-slice)
[337.264155] Starting subtest: u-submit-golden-slice
[337.266599] Starting dynamic subtest: rcs0
[337.293056] Dynamic subtest rcs0: SUCCESS (0.034s)
[337.305042] Starting dynamic subtest: bcs0
[337.321960] Dynamic subtest bcs0: SUCCESS (0.029s)
[337.332558] Starting dynamic subtest: vcs0
[337.352757] Dynamic subtest vcs0: SUCCESS (0.031s)
[337.363113] Starting dynamic subtest: vcs1
[337.390381] Dynamic subtest vcs1: SUCCESS (0.038s)
[337.401535] Starting dynamic subtest: vecs0
[337.420895] Dynamic subtest vecs0: SUCCESS (0.030s)
[337.431544] Starting dynamic subtest: ccs0
[337.447353] Dynamic subtest ccs0: SUCCESS (0.027s)
[337.449606] Subtest u-submit-golden-slice: SUCCESS (0.194s)
[338.633978] [106/156] (686s left) perf (rc6-disable)
[338.729031] Starting subtest: rc6-disable
[338.905007] Subtest rc6-disable: SUCCESS (0.183s)
[338.959800] [107/156] (686s left) gem_mmap_wc (pf-nonblock)
[339.022655] Subtest pf-nonblock: SKIP (0.000s)
[339.086455] [108/156] (685s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[339.185234] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[343.162453] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (4.063s)
[344.296562] [109/156] (680s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[344.401612] Starting subtest: fbcpsr-indfb-scaledprimary
[350.121972] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.778s)
[350.252685] [110/156] (674s left) kms_draw_crc (draw-method-blt)
[350.350564] Starting subtest: draw-method-blt
[350.352777] Starting dynamic subtest: xrgb8888-untiled
[350.591283] Dynamic subtest xrgb8888-untiled: SUCCESS (0.244s)
[350.603482] Starting dynamic subtest: rgb565-untiled
[350.823467] Dynamic subtest rgb565-untiled: SUCCESS (0.231s)
[350.834701] Starting dynamic subtest: xrgb2101010-untiled
[351.044890] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[351.058068] Starting dynamic subtest: xbgr16161616f-untiled
[351.242925] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.199s)
[351.253930] Starting dynamic subtest: xrgb8888-xtiled
[351.364565] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[351.375248] Starting dynamic subtest: rgb565-xtiled
[351.474979] Dynamic subtest rgb565-xtiled: SUCCESS (0.111s)
[351.485483] Starting dynamic subtest: xrgb2101010-xtiled
[351.574309] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.099s)
[351.585055] Starting dynamic subtest: xbgr16161616f-xtiled
[351.673577] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.099s)
[351.686365] Starting dynamic subtest: xrgb8888-4tiled
[351.795286] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.121s)
[351.805503] Starting dynamic subtest: rgb565-4tiled
[351.905930] Dynamic subtest rgb565-4tiled: SUCCESS (0.111s)
[351.917945] Starting dynamic subtest: xrgb2101010-4tiled
[352.005573] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.099s)
[352.018231] Starting dynamic subtest: xbgr16161616f-4tiled
[352.116004] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.110s)
[352.118099] Subtest draw-method-blt: SUCCESS (1.778s)
[352.226007] [111/156] (672s left) gem_exec_gttfill (basic)
[352.284604] Starting subtest: basic
[354.557025] Subtest basic: SUCCESS (2.283s)
[354.743384] [112/156] (670s left) kms_flip (flip-vs-modeset-vs-hang)
[354.902662] Starting subtest: flip-vs-modeset-vs-hang
[354.904818] Starting dynamic subtest: A-eDP1
[406.051126] Dynamic subtest A-eDP1: SUCCESS (51.147s)
[406.064511] Starting dynamic subtest: D-eDP1
[456.036111] Dynamic subtest D-eDP1: SUCCESS (49.979s)
[456.039237] Subtest flip-vs-modeset-vs-hang: SUCCESS (101.134s)
[456.442606] [113/156] (568s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-pwrite)
[456.543995] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-pwrite
[456.548299] Subtest psrhdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[456.637121] [114/156] (568s left) perf (global-sseu-config)
[456.749229] Starting subtest: global-sseu-config
[456.753423] Subtest global-sseu-config: SKIP (0.000s)
[456.798593] [115/156] (568s left) kms_flip (nonexisting-fb)
[456.890604] Starting subtest: nonexisting-fb
[456.892972] Starting dynamic subtest: A-eDP1
[458.028212] Dynamic subtest A-eDP1: SUCCESS (1.136s)
[458.041117] Starting dynamic subtest: B-eDP1
[459.150704] Dynamic subtest B-eDP1: SUCCESS (1.121s)
[459.164195] Starting dynamic subtest: C-eDP1
[460.286609] Dynamic subtest C-eDP1: SUCCESS (1.134s)
[460.298449] Starting dynamic subtest: D-eDP1
[461.424421] Dynamic subtest D-eDP1: SUCCESS (1.137s)
[461.426826] Subtest nonexisting-fb: SUCCESS (4.537s)
[462.597042] [116/156] (562s left) i915_module_load (reload-no-display)
[462.634512] Starting subtest: reload-no-display
[467.096767] Subtest reload-no-display: SUCCESS (4.461s)
[467.126646] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[467.127347] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[467.130500] [117/156] (558s left) syncobj_basic (bad-pad-fd-to-handle)
[468.682205] Starting subtest: bad-pad-fd-to-handle
[468.685124] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[468.755804] [FACT syncobj_basic (bad-pad-fd-to-handle)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[468.757201] [FACT syncobj_basic (bad-pad-fd-to-handle)] new: kernel.kmod_is_loaded.i915: true
[468.760895] [118/156] (556s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[468.874440] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-mmap-wc
[468.878677] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[468.975574] [119/156] (556s left) vgem_basic (mmap)
[469.023958] Starting subtest: mmap
[469.029808] Subtest mmap: SUCCESS (0.007s)
[469.080147] [120/156] (556s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-pwrite)
[469.184670] Starting subtest: hdr-rgb101010-draw-pwrite
[469.188742] Subtest hdr-rgb101010-draw-pwrite: SKIP (0.000s)
[469.286018] [121/156] (556s left) kms_prop_blob (invalid-get-prop-any)
[469.356957] Starting subtest: invalid-get-prop-any
[469.359363] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[469.472952] [122/156] (556s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[469.559328] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[469.562596] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[469.661012] [123/156] (556s left) syncobj_timeline (multi-wait-available-signaled)
[469.719138] Starting subtest: multi-wait-available-signaled
[469.721803] Subtest multi-wait-available-signaled: SUCCESS (0.001s)
[469.811938] [124/156] (555s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[469.900923] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[469.902917] Starting dynamic subtest: pipe-A
[469.920826] Dynamic subtest pipe-A: SKIP (0.017s)
[469.930441] Starting dynamic subtest: pipe-B
[469.954275] Dynamic subtest pipe-B: SKIP (0.034s)
[469.963666] Starting dynamic subtest: pipe-C
[469.989325] Dynamic subtest pipe-C: SKIP (0.033s)
[469.998579] Starting dynamic subtest: pipe-D
[470.021829] Dynamic subtest pipe-D: SKIP (0.033s)
[470.024961] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.120s)
[470.110809] [125/156] (555s left) gem_mmap_offset (clear-via-pagefault)
[470.165712] Starting subtest: clear-via-pagefault
[470.167681] Starting dynamic subtest: smem0
[501.270424] Dynamic subtest smem0: SUCCESS (31.104s)
[501.273087] Subtest clear-via-pagefault: SUCCESS (31.106s)
[501.386980] [126/156] (524s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[501.485365] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[501.523067] Starting dynamic subtest: pipe-A-plane-0
[501.800604] Dynamic subtest pipe-A-plane-0: SUCCESS (0.277s)
[501.810781] Starting dynamic subtest: pipe-A-plane-3
[502.011526] Dynamic subtest pipe-A-plane-3: SUCCESS (0.210s)
[503.132626] Starting dynamic subtest: pipe-B-plane-0
[503.412800] Dynamic subtest pipe-B-plane-0: SUCCESS (0.289s)
[503.422987] Starting dynamic subtest: pipe-B-plane-3
[503.623980] Dynamic subtest pipe-B-plane-3: SUCCESS (0.210s)
[503.948177] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.462s)
[504.806584] [127/156] (521s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[505.360006] Starting subtest: syncobj-timeline-multiple-ext-nodes
[505.362169] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.004s)
[506.645771] [128/156] (519s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[506.750895] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[506.754961] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[506.855406] [129/156] (519s left) gen7_exec_parse (basic-allocation)
[506.912412] Subtest basic-allocation: SKIP (0.000s)
[506.974991] [130/156] (518s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[507.055606] Starting subtest: fbc-psr2-cursor-plane-onoff
[507.057946] Starting dynamic subtest: eDP-1
[507.062331] Dynamic subtest eDP-1: SKIP (0.000s)
[507.066797] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s)
[507.129927] [131/156] (518s left) kms_cursor_crc (cursor-sliding-32x10)
[507.302459] Starting subtest: cursor-sliding-32x10
[507.352881] Subtest cursor-sliding-32x10: SKIP (0.045s)
[507.635228] [132/156] (518s left) kms_pm_rpm (legacy-planes)
[509.771670] Starting subtest: legacy-planes
[509.774111] Starting dynamic subtest: plane-65
[518.199353] Dynamic subtest plane-65: SUCCESS (8.431s)
[518.213201] Starting dynamic subtest: plane-95
[526.520650] Dynamic subtest plane-95: SUCCESS (8.319s)
[526.533702] Starting dynamic subtest: plane-125
[534.851977] Dynamic subtest plane-125: SUCCESS (8.331s)
[534.865126] Starting dynamic subtest: plane-135
[543.126531] Dynamic subtest plane-135: SUCCESS (8.274s)
[543.130042] Subtest legacy-planes: SUCCESS (33.365s)
[543.532334] [133/156] (482s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[543.633076] Starting subtest: invalid-modeset-force-ultra-joiner
[543.637217] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[543.714173] [134/156] (482s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-fullscreen)
[543.817473] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-fullscreen
[543.821855] Subtest fbchdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[543.908803] [135/156] (482s left) kms_flip (plain-flip-fb-recreate-interruptible)
[543.996731] Starting subtest: plain-flip-fb-recreate-interruptible
[543.999017] Starting dynamic subtest: A-eDP1
[552.911214] Dynamic subtest A-eDP1: SUCCESS (8.915s)
[552.928918] Starting dynamic subtest: B-eDP1
[561.718563] Dynamic subtest B-eDP1: SUCCESS (8.804s)
[561.732425] Starting dynamic subtest: C-eDP1
[570.543052] Dynamic subtest C-eDP1: SUCCESS (8.820s)
[570.553407] Starting dynamic subtest: D-eDP1
[579.380065] Dynamic subtest D-eDP1: SUCCESS (8.834s)
[579.385852] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.385s)
[580.577488] [136/156] (445s left) prime_vgem (shrink)
[580.659840] Starting subtest: shrink
[580.672835] Subtest shrink: SUCCESS (0.013s)
[580.798638] [137/156] (445s left) kms_panel_fitting (legacy)
[580.892511] Starting subtest: legacy
[580.894746] Starting dynamic subtest: pipe-A-eDP-1
[581.401991] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.511s)
[581.431334] Starting dynamic subtest: pipe-B-eDP-1
[583.024893] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.603s)
[583.056097] Starting dynamic subtest: pipe-C-eDP-1
[584.582891] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.538s)
[584.611816] Starting dynamic subtest: pipe-D-eDP-1
[586.108329] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.506s)
[586.110590] Subtest legacy: SUCCESS (5.218s)
[587.376038] [138/156] (438s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[587.495246] Starting subtest: 2x-cursor-vs-flip-legacy
[587.499687] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[587.637472] [139/156] (438s left) kms_color (invalid-ctm-matrix-sizes)
[587.738207] Starting subtest: invalid-ctm-matrix-sizes
[587.740692] Starting dynamic subtest: pipe-A
[587.742984] Dynamic subtest pipe-A: SUCCESS (0.002s)
[587.754113] Starting dynamic subtest: pipe-B
[587.756420] Dynamic subtest pipe-B: SUCCESS (0.003s)
[587.767646] Starting dynamic subtest: pipe-C
[587.769552] Dynamic subtest pipe-C: SUCCESS (0.003s)
[587.779560] Starting dynamic subtest: pipe-D
[587.781846] Dynamic subtest pipe-D: SUCCESS (0.003s)
[587.784118] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.015s)
[587.842287] [140/156] (438s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-blt)
[587.943582] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-blt
[587.947908] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[588.027387] [141/156] (438s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[588.127002] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[588.130999] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[588.218737] [142/156] (438s left) kms_addfb_basic (no-handle)
[588.264823] Starting subtest: no-handle
[588.266807] Subtest no-handle: SUCCESS (0.000s)
[588.385560] [143/156] (438s left) kms_plane_lowres (tiling-yf)
[588.480865] Starting subtest: tiling-yf
[588.484468] Subtest tiling-yf: SKIP (0.000s)
[588.568094] [144/156] (438s left) gem_spin_batch (legacy-resubmit)
[588.625934] Starting subtest: legacy-resubmit
[588.627973] Starting dynamic subtest: default
[588.632595] Dynamic subtest default: SUCCESS (0.006s)
[588.647728] Starting dynamic subtest: render
[588.649725] Dynamic subtest render: SUCCESS (0.001s)
[588.659557] Starting dynamic subtest: bsd
[588.661597] Dynamic subtest bsd: SUCCESS (0.003s)
[588.671722] Starting dynamic subtest: bsd1
[588.673644] Dynamic subtest bsd1: SUCCESS (0.001s)
[588.683130] Starting dynamic subtest: bsd2
[588.685327] Dynamic subtest bsd2: SUCCESS (0.002s)
[588.694683] Starting dynamic subtest: blt
[588.696446] Dynamic subtest blt: SUCCESS (0.003s)
[588.705717] Starting dynamic subtest: vebox
[588.707440] Dynamic subtest vebox: SUCCESS (0.002s)
[588.709148] Subtest legacy-resubmit: SUCCESS (0.024s)
[588.889247] [145/156] (437s left) kms_psr (pr-primary-mmap-gtt)
[588.975036] Starting subtest: pr-primary-mmap-gtt
[588.978539] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[589.046476] [146/156] (437s left) kms_vblank (ts-continuation-dpms-suspend)
[589.138898] Starting subtest: ts-continuation-dpms-suspend
[589.140554] Starting dynamic subtest: pipe-A-eDP-1
[606.873176] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.849s)
[606.890560] Starting dynamic subtest: pipe-D-eDP-1
[624.852436] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.626s)
[624.854651] Subtest ts-continuation-dpms-suspend: SUCCESS (4.478s)
[625.706926] [147/156] (400s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-pwrite)
[625.814416] Starting subtest: fbcpsrhdr-rgb565-draw-pwrite
[625.818601] Subtest fbcpsrhdr-rgb565-draw-pwrite: SKIP (0.000s)
[625.916891] [148/156] (400s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[626.016594] Starting subtest: plane-downscale-factor-0-75-with-rotation
[626.018747] Starting dynamic subtest: pipe-A
[626.247034] Dynamic subtest pipe-A: SUCCESS (0.242s)
[626.257751] Starting dynamic subtest: pipe-B
[627.526995] Dynamic subtest pipe-B: SUCCESS (1.324s)
[627.539938] Starting dynamic subtest: pipe-C
[628.811488] Dynamic subtest pipe-C: SUCCESS (1.322s)
[628.821776] Starting dynamic subtest: pipe-D
[630.115933] Dynamic subtest pipe-D: SUCCESS (1.335s)
[630.118200] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.227s)
[631.268264] [149/156] (395s left) vgem_basic (create)
[631.308367] Starting subtest: create
[631.310531] Subtest create: SUCCESS (0.000s)
[631.364213] [150/156] (395s left) kms_flip (2x-flip-vs-fences)
[631.458139] Starting subtest: 2x-flip-vs-fences
[631.462462] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[631.578482] [151/156] (395s left) gem_exec_flush (basic-wb-set-default)
[631.638179] Starting subtest: basic-wb-set-default
[637.019416] Subtest basic-wb-set-default: SUCCESS (5.453s)
[637.207429] [152/156] (389s left) kms_pipe_crc_basic (hang-read-crc)
[637.316004] Starting subtest: hang-read-crc
[637.318297] Starting dynamic subtest: pipe-A-eDP-1
[639.349992] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.050s)
[639.360966] Starting dynamic subtest: pipe-B-eDP-1
[642.111636] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.775s)
[642.123383] Starting dynamic subtest: pipe-C-eDP-1
[644.822414] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.722s)
[644.836269] Starting dynamic subtest: pipe-D-eDP-1
[647.490015] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.674s)
[647.492196] Subtest hang-read-crc: SUCCESS (10.226s)
[648.320408] [153/156] (378s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[648.421717] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[652.903287] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.496s)
[654.100497] [154/156] (372s left) syncobj_timeline (wait-all-for-submit-snapshot)
[654.160828] Starting subtest: wait-all-for-submit-snapshot
[654.242933] Subtest wait-all-for-submit-snapshot: SUCCESS (0.083s)
[654.326342] [155/156] (372s left) prime_vgem (basic-fence-mmap)
[654.393002] Starting subtest: basic-fence-mmap
[654.397383] Subtest basic-fence-mmap: SKIP (0.000s)
[654.488603] [156/156] (372s left) kms_chamelium_frames (dp-frame-dump)
[654.878938] Subtest dp-frame-dump: SKIP (0.000s)
[655.695697] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_flush
results: parsing output: 1/ for test: gem_exec_balancer
results: parsing output: 2/ for test: kms_flip_scaled_crc
results: parsing output: 3/ for test: kms_psr
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_chamelium_hpd
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: gem_fenced_exec_thrash
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_cursor_legacy
results: parsing output: 11/ for test: gem_mmap_gtt
results: parsing output: 12/ for test: kms_flip_scaled_crc
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_ctx_engines
results: parsing output: 15/ for test: template
results: parsing output: 16/ for test: kms_content_protection
results: parsing output: 17/ for test: gem_ctx_persistence
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: api_intel_bb
results: parsing output: 21/ for test: perf
results: parsing output: 22/ for test: gem_ctx_shared
results: parsing output: 23/ for test: kms_atomic_transition
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: kms_scaling_modes
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_addfb_basic
results: parsing output: 28/ for test: kms_ccs
results: parsing output: 29/ for test: gem_ctx_persistence
results: parsing output: 30/ for test: i915_pm_rpm
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_render_copy
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: kms_cursor_crc
results: parsing output: 35/ for test: gen3_render_tiledy_blits
results: parsing output: 36/ for test: kms_ccs
results: parsing output: 37/ for test: kms_cursor_legacy
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: gem_render_copy
results: parsing output: 40/ for test: kms_psr2_sf
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gen9_exec_parse
results: parsing output: 44/ for test: api_intel_bb
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: kms_cursor_crc
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_getfb
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_display_modes
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: kms_addfb_basic
results: parsing output: 54/ for test: gem_exec_store
results: parsing output: 55/ for test: fbdev
results: parsing output: 56/ for test: gem_mmap
results: parsing output: 57/ for test: i915_drm_fdinfo
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_ctx_bad_destroy
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: perf_pmu
results: parsing output: 66/ for test: kms_busy
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_cursor_legacy
results: parsing output: 69/ for test: gem_mmap_gtt
results: parsing output: 70/ for test: gem_exec_balancer
results: parsing output: 71/ for test: gem_render_copy
results: parsing output: 72/ for test: kms_atomic
results: parsing output: 73/ for test: gem_exec_schedule
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: perf_pmu
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: sysfs_preempt_timeout
results: parsing output: 78/ for test: kms_plane_alpha_blend
results: parsing output: 79/ for test: gem_render_copy
results: parsing output: 80/ for test: dmabuf_sync_file
results: parsing output: 81/ for test: kms_flip
results: parsing output: 82/ for test: kms_selftest
results: parsing output: 83/ for test: kms_ccs
results: parsing output: 84/ for test: kms_flip
results: parsing output: 85/ for test: kms_properties
results: parsing output: 86/ for test: gem_lmem_swapping
results: parsing output: 87/ for test: kms_ccs
results: parsing output: 88/ for test: kms_ccs
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: kms_cursor_legacy
results: parsing output: 91/ for test: gem_linear_blits
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: sw_sync
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_workarounds
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: i915_pm_rps
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: syncobj_wait
results: parsing output: 101/ for test: gem_exec_params
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_exec_schedule
results: parsing output: 105/ for test: perf
results: parsing output: 106/ for test: gem_mmap_wc
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_draw_crc
results: parsing output: 110/ for test: gem_exec_gttfill
results: parsing output: 111/ for test: kms_flip
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: perf
results: parsing output: 114/ for test: kms_flip
results: parsing output: 115/ for test: i915_module_load
results: parsing output: 116/ for test: syncobj_basic
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: vgem_basic
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_prop_blob
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: kms_plane_scaling
results: parsing output: 124/ for test: gem_mmap_offset
results: parsing output: 125/ for test: kms_plane
results: parsing output: 126/ for test: gem_exec_fence
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: gen7_exec_parse
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: kms_cursor_crc
results: parsing output: 131/ for test: kms_pm_rpm
results: parsing output: 132/ for test: kms_joiner
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: kms_flip
results: parsing output: 135/ for test: prime_vgem
results: parsing output: 136/ for test: kms_panel_fitting
results: parsing output: 137/ for test: kms_cursor_legacy
results: parsing output: 138/ for test: kms_color
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: kms_addfb_basic
results: parsing output: 142/ for test: kms_plane_lowres
results: parsing output: 143/ for test: gem_spin_batch
results: parsing output: 144/ for test: kms_psr
results: parsing output: 145/ for test: kms_vblank
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: kms_plane_scaling
results: parsing output: 148/ for test: vgem_basic
results: parsing output: 149/ for test: kms_flip
results: parsing output: 150/ for test: gem_exec_flush
results: parsing output: 151/ for test: kms_pipe_crc_basic
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: parsing output: 153/ for test: syncobj_timeline
results: parsing output: 154/ for test: prime_vgem
results: parsing output: 155/ for test: kms_chamelium_frames
Done.