[56.632940] Initializing watchdogs
[56.633089]   /dev/watchdog0
[56.648415] [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]
[56.653034] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.656226] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.659747] [001/133] (960s left) kms_psr (fbc-psr2-dpms)
[56.785884] Starting subtest: fbc-psr2-dpms
[56.788270] Starting dynamic subtest: eDP-1
[56.792686] Dynamic subtest eDP-1: SKIP (0.000s)
[56.797370] Subtest fbc-psr2-dpms: SKIP (0.000s)
[56.868860] [002/133] (960s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[56.966223] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[58.023248] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.058s)
[58.151542] [003/133] (959s left) i915_pm_freq_api (freq-basic-api)
[58.216769] Starting subtest: freq-basic-api
[58.219145] Starting dynamic subtest: gt0
[58.221418] Dynamic subtest gt0: SUCCESS (0.002s)
[58.230915] Starting dynamic subtest: gt1
[58.233114] Dynamic subtest gt1: SUCCESS (0.003s)
[58.235214] Subtest freq-basic-api: SUCCESS (0.005s)
[58.312731] [004/133] (958s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[58.410157] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[65.380334] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.973s)
[65.548101] [005/133] (951s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[65.646564] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[73.017091] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.376s)
[73.127531] [006/133] (944s left) kms_psr (psr-primary-mmap-gtt)
[73.227792] Starting subtest: psr-primary-mmap-gtt
[73.230136] Starting dynamic subtest: eDP-1
[74.695085] Dynamic subtest eDP-1: SKIP (1.462s)
[74.700091] Subtest psr-primary-mmap-gtt: SKIP (1.463s)
[74.849657] [007/133] (942s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[74.909502] Starting subtest: single-wait-for-submit-available-signaled
[74.911967] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.001s)
[75.024861] [008/133] (942s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[75.084984] Starting subtest: invalid-multi-wait-all-unsubmitted
[75.087341] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[75.191248] [009/133] (942s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[75.304972] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[75.309104] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[75.407884] [010/133] (942s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[75.496073] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[75.500615] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[75.566792] [011/133] (941s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[75.664694] Starting subtest: fbc-2p-pri-indfb-multidraw
[75.669069] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[75.742506] [012/133] (941s left) i915_query (query-topology-kernel-writes)
[75.800085] Starting subtest: query-topology-kernel-writes
[75.801738] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[75.909725] [013/133] (941s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier)
[76.014059] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier
[76.017866] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (0.000s)
[76.115088] [014/133] (941s left) kms_hdr (brightness-with-hdr)
[76.205053] Starting subtest: brightness-with-hdr
[76.210561] Subtest brightness-with-hdr: SKIP (0.000s)
[76.272554] [015/133] (941s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[76.380912] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[76.390075] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[76.464329] [016/133] (941s left) gen9_exec_parse (allowed-single)
[76.525156] Subtest allowed-single: SKIP (0.000s)
[76.591646] [017/133] (941s left) kms_psr (pr-basic)
[76.682098] Starting subtest: pr-basic
[76.685807] Subtest pr-basic: SKIP (0.000s)
[76.753476] [018/133] (941s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[76.852821] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[81.307543] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.455s)
[82.442807] [019/133] (935s left) kms_chamelium_color (ctm-negative)
[82.539396] Subtest ctm-negative: SKIP (0.000s)
[82.584406] [020/133] (935s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[82.679357] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[82.683350] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[82.793661] [021/133] (935s left) kms_psr (psr2-cursor-render)
[82.886428] Starting subtest: psr2-cursor-render
[82.888680] Starting dynamic subtest: eDP-1
[84.623663] Dynamic subtest eDP-1: SUCCESS (1.735s)
[84.626075] Subtest psr2-cursor-render: SUCCESS (1.736s)
[85.503530] [022/133] (932s left) gem_userptr_blits (huge-split)
[85.578408] Starting subtest: huge-split
[85.589436] Subtest huge-split: SUCCESS (0.012s)
[85.703552] [023/133] (932s left) gem_exec_balancer (parallel-keep-submit-fence)
[85.966762] Starting subtest: parallel-keep-submit-fence
[87.110252] Subtest parallel-keep-submit-fence: SUCCESS (1.143s)
[87.224887] [024/133] (930s left) kms_big_fb (linear-64bpp-rotate-0)
[87.328670] Starting subtest: linear-64bpp-rotate-0
[89.075417] Subtest linear-64bpp-rotate-0: SUCCESS (1.747s)
[89.216146] [025/133] (928s left) i915_pm_rps (thresholds-idle)
[89.280519] Starting subtest: thresholds-idle
[89.284991] Subtest thresholds-idle: SKIP (0.001s)
[89.383629] [026/133] (928s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[89.479501] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[89.482950] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[89.594377] [027/133] (928s left) i915_pm_rpm (system-suspend-execbuf)
[91.120518] Starting subtest: system-suspend-execbuf
[149.516291] Subtest system-suspend-execbuf: SUCCESS (42.981s)
[149.896125] [028/133] (868s left) perf (invalid-oa-exponent)
[150.029325] Starting subtest: invalid-oa-exponent
[150.043191] Subtest invalid-oa-exponent: SUCCESS (0.013s)
[150.087201] [029/133] (868s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[150.181023] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[150.183322] Starting dynamic subtest: pipe-A-default-mode
[151.343696] Dynamic subtest pipe-A-default-mode: SKIP (1.161s)
[151.347934] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.162s)
[151.487388] [030/133] (866s left) kms_cursor_crc (cursor-offscreen-max-size)
[151.784866] Starting subtest: cursor-offscreen-max-size
[151.791649] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[151.916609] [031/133] (866s left) kms_prime (d3hot)
[151.999170] Subtest D3hot: SKIP (0.000s)
[152.142883] [FACT kms_prime (d3hot)] new: kernel.kmod_is_loaded.vgem: true
[152.146845] [032/133] (866s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[152.241530] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[152.244806] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[152.319587] [033/133] (866s left) i915_drm_fdinfo (most-busy-check-all)
[152.358681] Starting subtest: most-busy-check-all
[152.362794] Starting dynamic subtest: rcs0
[152.366508] Dynamic subtest rcs0: SKIP (0.004s)
[152.374895] Starting dynamic subtest: bcs0
[152.378205] Dynamic subtest bcs0: SKIP (0.000s)
[152.386026] Starting dynamic subtest: vcs0
[152.389466] Dynamic subtest vcs0: SKIP (0.000s)
[152.397229] Starting dynamic subtest: vcs1
[152.400488] Dynamic subtest vcs1: SKIP (0.000s)
[152.408071] Starting dynamic subtest: vecs0
[152.411434] Dynamic subtest vecs0: SKIP (0.001s)
[152.419032] Starting dynamic subtest: ccs0
[152.422503] Dynamic subtest ccs0: SKIP (0.001s)
[152.426075] Subtest most-busy-check-all: SKIP (0.010s)
[152.461276] [034/133] (865s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[152.559731] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[152.561748] Starting dynamic subtest: pipe-A-eDP-1
[152.582510] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[152.599463] Starting dynamic subtest: pipe-B-eDP-1
[152.617233] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[152.625775] Starting dynamic subtest: pipe-C-eDP-1
[152.642864] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[152.652900] Starting dynamic subtest: pipe-D-eDP-1
[152.671090] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[152.674636] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[154.862601] [035/133] (863s left) kms_addfb_basic (bad-pitch-32)
[154.918181] Starting subtest: bad-pitch-32
[154.920037] Subtest bad-pitch-32: SUCCESS (0.000s)
[155.042713] [036/133] (863s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[155.133548] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[161.972215] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.840s)
[162.099686] [037/133] (856s left) gem_ctx_exec (basic-close-race)
[162.155040] Starting subtest: basic-close-race
[167.811973] Subtest basic-close-race: SUCCESS (5.656s)
[167.938668] [038/133] (850s left) syncobj_timeline (multi-wait-all-available-signaled)
[167.992048] Starting subtest: multi-wait-all-available-signaled
[167.994417] Subtest multi-wait-all-available-signaled: SUCCESS (0.000s)
[168.107473] [039/133] (850s left) syncobj_wait (multi-wait-all-signaled)
[168.171262] Starting subtest: multi-wait-all-signaled
[168.173565] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[168.267740] [040/133] (850s left) kms_plane_scaling (planes-scaler-unity-scaling)
[168.366581] Starting subtest: planes-scaler-unity-scaling
[168.368546] Starting dynamic subtest: pipe-A
[168.436586] Dynamic subtest pipe-A: SUCCESS (0.071s)
[168.447709] Starting dynamic subtest: pipe-B
[169.611051] Dynamic subtest pipe-B: SUCCESS (1.173s)
[169.621530] Starting dynamic subtest: pipe-C
[170.710205] Dynamic subtest pipe-C: SUCCESS (1.098s)
[170.720064] Starting dynamic subtest: pipe-D
[171.842040] Dynamic subtest pipe-D: SUCCESS (1.131s)
[171.844212] Subtest planes-scaler-unity-scaling: SUCCESS (3.478s)
[173.005344] [041/133] (845s left) gem_exec_params (no-vebox)
[173.068772] Starting subtest: no-vebox
[173.073732] Subtest no-vebox: SUCCESS (0.003s)
[174.427395] [042/133] (844s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[174.528805] Starting subtest: read-crc-frame-sequence
[174.531110] Starting dynamic subtest: pipe-A-eDP-1
[175.252617] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.723s)
[175.264768] Starting dynamic subtest: pipe-B-eDP-1
[176.597273] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.343s)
[176.606738] Starting dynamic subtest: pipe-C-eDP-1
[177.974052] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.375s)
[177.983208] Starting dynamic subtest: pipe-D-eDP-1
[179.322016] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.346s)
[179.324274] Subtest read-crc-frame-sequence: SUCCESS (4.792s)
[180.139003] [043/133] (838s left) gem_ctx_shared (detached-shared-gtt)
[180.199233] Starting subtest: detached-shared-gtt
[182.350745] Subtest detached-shared-gtt: SUCCESS (2.151s)
[182.729916] [044/133] (836s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[182.837758] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[182.840038] Starting dynamic subtest: pipe-A-default-mode
[185.565136] Dynamic subtest pipe-A-default-mode: SUCCESS (2.727s)
[185.567420] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.729s)
[186.422006] [045/133] (832s left) kms_dp_link_training (uhbr-mst)
[186.509346] Starting subtest: uhbr-mst
[186.517632] Subtest uhbr-mst: SKIP (0.000s)
[186.592747] [046/133] (832s left) kms_cursor_edge_walk (128x128-top-edge)
[186.690102] Starting subtest: 128x128-top-edge
[186.692371] Starting dynamic subtest: pipe-A-eDP-1
[190.170263] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.479s)
[190.179679] Starting dynamic subtest: pipe-D-eDP-1
[193.287050] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.116s)
[193.289380] Subtest 128x128-top-edge: SUCCESS (6.597s)
[194.100339] [047/133] (824s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[194.204185] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[194.208847] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[195.338403] [048/133] (823s left) kms_lease (page-flip-implicit-plane)
[195.442825] Starting subtest: page-flip-implicit-plane
[195.445142] Starting dynamic subtest: pipe-A-eDP-1
[195.928058] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.483s)
[195.937882] Starting dynamic subtest: pipe-B-eDP-1
[197.075073] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.145s)
[197.085061] Starting dynamic subtest: pipe-C-eDP-1
[198.186469] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.112s)
[198.196696] Starting dynamic subtest: pipe-D-eDP-1
[199.324246] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.135s)
[199.326475] Subtest page-flip-implicit-plane: SUCCESS (3.881s)
[200.147164] [049/133] (818s left) gem_exec_reloc (basic-write-cpu-active)
[200.212865] Subtest basic-write-cpu-active: SKIP (0.000s)
[200.283365] [050/133] (818s left) kms_invalid_mode (bad-vsync-start)
[200.378695] Starting subtest: bad-vsync-start
[200.380951] Starting dynamic subtest: pipe-A-eDP-1
[200.664855] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[200.673284] Starting dynamic subtest: pipe-B-eDP-1
[200.675581] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[200.684124] Starting dynamic subtest: pipe-C-eDP-1
[200.686352] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[200.694795] Starting dynamic subtest: pipe-D-eDP-1
[200.696709] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[200.698641] Subtest bad-vsync-start: SUCCESS (0.294s)
[201.486224] [051/133] (817s left) kms_flip (flip-vs-fences-interruptible)
[201.589791] Starting subtest: flip-vs-fences-interruptible
[201.594025] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[201.679068] [052/133] (817s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[201.783314] Starting subtest: sprite-rotation-90-pos-100-0
[201.787281] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[201.856143] [053/133] (817s left) gem_exec_whisper (basic-sync-all)
[201.912819] Starting subtest: basic-sync-all
[208.597007] Subtest basic-sync-all: SUCCESS (6.681s)
[208.784357] [054/133] (810s left) gem_ctx_exec (basic-norecovery)
[208.857696] Starting subtest: basic-norecovery
[209.246597] Subtest basic-norecovery: SUCCESS (0.388s)
[209.393105] [055/133] (809s left) gem_exec_schedule (lateslice)
[209.461863] Starting subtest: lateslice
[209.464183] Starting dynamic subtest: rcs0
[209.482951] Dynamic subtest rcs0: SUCCESS (0.027s)
[209.494150] Starting dynamic subtest: bcs0
[209.507615] Dynamic subtest bcs0: SUCCESS (0.024s)
[209.516726] Starting dynamic subtest: vcs0
[209.530708] Dynamic subtest vcs0: SUCCESS (0.023s)
[209.539876] Starting dynamic subtest: vcs1
[209.553303] Dynamic subtest vcs1: SUCCESS (0.022s)
[209.562375] Starting dynamic subtest: vecs0
[209.574518] Dynamic subtest vecs0: SUCCESS (0.021s)
[209.583664] Starting dynamic subtest: ccs0
[209.599740] Dynamic subtest ccs0: SUCCESS (0.024s)
[209.602427] Subtest lateslice: SUCCESS (0.144s)
[211.429073] [056/133] (807s left) sysfs_timeslice_duration (idempotent)
[211.484888] Starting subtest: idempotent
[211.487122] Starting dynamic subtest: vecs0
[211.489413] Dynamic subtest vecs0: SUCCESS (0.000s)
[211.499899] Starting dynamic subtest: ccs0
[211.501752] Dynamic subtest ccs0: SUCCESS (0.000s)
[211.510127] Starting dynamic subtest: vcs0
[211.511960] Dynamic subtest vcs0: SUCCESS (0.000s)
[211.520745] Starting dynamic subtest: bcs0
[211.522933] Dynamic subtest bcs0: SUCCESS (0.000s)
[211.532072] Starting dynamic subtest: rcs0
[211.533894] Dynamic subtest rcs0: SUCCESS (0.000s)
[211.542450] Starting dynamic subtest: vcs1
[211.544684] Dynamic subtest vcs1: SUCCESS (0.000s)
[211.546781] Subtest idempotent: SUCCESS (0.006s)
[211.592779] [057/133] (807s left) gem_sync (basic-all)
[211.664906] Starting subtest: basic-all
[215.176540] Subtest basic-all: SUCCESS (3.521s)
[215.363849] [058/133] (804s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[215.451764] Starting subtest: fbc-psr-sprite-mmap-cpu
[215.454039] Starting dynamic subtest: eDP-1
[215.458113] Dynamic subtest eDP-1: SKIP (0.000s)
[215.462146] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s)
[215.526679] [059/133] (803s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc)
[215.617805] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc
[215.620120] Starting dynamic subtest: pipe-A-eDP-1
[215.643075] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[215.655124] Starting dynamic subtest: pipe-B-eDP-1
[215.675685] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[215.684656] Starting dynamic subtest: pipe-C-eDP-1
[215.706751] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[215.715720] Starting dynamic subtest: pipe-D-eDP-1
[215.737975] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[215.742098] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[217.961268] [060/133] (801s left) gem_exec_flush (basic-wb-set-default)
[218.027687] Starting subtest: basic-wb-set-default
[223.483707] Subtest basic-wb-set-default: SUCCESS (5.457s)
[223.683077] [061/133] (795s left) kms_content_protection (lic-type-0)
[223.840343] Starting subtest: lic-type-0
[223.844721] Subtest lic-type-0: SKIP (0.000s)
[223.980617] [062/133] (795s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[224.073833] Starting subtest: primary-x-tiled-reflect-x-0
[231.079294] Subtest primary-x-tiled-reflect-x-0: SUCCESS (7.006s)
[232.245939] [063/133] (787s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[232.364663] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[232.369239] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[232.465362] [064/133] (787s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[232.569455] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[232.573746] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[232.679785] [065/133] (787s left) gem_exec_schedule (semaphore-power)
[232.867912] Subtest semaphore-power: SKIP (0.000s)
[233.047435] [066/133] (786s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[233.103658] Starting subtest: y-tiled-ccs-to-x-tiled
[233.108278] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[233.285895] [067/133] (786s left) gem_ctx_param (basic-default)
[233.333020] Starting subtest: basic-default
[233.335706] Subtest basic-default: SUCCESS (0.000s)
[233.407918] [068/133] (786s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[233.526397] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[234.503883] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.976s)
[235.384744] [069/133] (784s left) gem_ctx_persistence (heartbeat-hostile)
[235.459543] Starting subtest: heartbeat-hostile
[235.464305] Subtest heartbeat-hostile: SKIP (0.000s)
[235.584523] [070/133] (784s left) gem_exec_params (invalid-batch-start-offset)
[235.644694] Starting subtest: invalid-batch-start-offset
[235.650419] Subtest invalid-batch-start-offset: SUCCESS (0.002s)
[235.770809] [071/133] (784s left) kms_selftest (drm_cmdline_parser)
[235.808225] Starting subtest: drm_cmdline_parser
[235.841729] Starting dynamic subtest: drm_test_cmdline_force_d_only
[235.947555] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.103s)
[235.958324] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[236.038020] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.092s)
[236.049100] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[236.132358] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.091s)
[236.143249] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[236.241035] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.108s)
[236.251731] Starting dynamic subtest: drm_test_cmdline_force_e_only
[236.349109] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.107s)
[236.359825] Starting dynamic subtest: drm_test_cmdline_res
[236.457109] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.108s)
[236.467853] Starting dynamic subtest: drm_test_cmdline_res_vesa
[236.555047] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.097s)
[236.564225] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[236.649695] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.093s)
[236.659039] Starting dynamic subtest: drm_test_cmdline_res_rblank
[236.744675] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.092s)
[236.753709] Starting dynamic subtest: drm_test_cmdline_res_bpp
[236.836967] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.090s)
[236.846322] Starting dynamic subtest: drm_test_cmdline_res_refresh
[236.932476] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.096s)
[236.942060] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[237.022453] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.090s)
[237.031480] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[237.113428] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.088s)
[237.122517] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[237.214412] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.099s)
[237.225220] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[237.320523] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.107s)
[237.331014] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[237.419371] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.097s)
[237.429650] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[237.545112] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.122s)
[237.556310] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[237.643156] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.098s)
[237.653750] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[237.734066] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.089s)
[237.745438] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[237.840035] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.105s)
[237.850428] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[237.918965] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.078s)
[237.928219] Starting dynamic subtest: drm_test_cmdline_name
[238.000048] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.080s)
[238.010097] Starting dynamic subtest: drm_test_cmdline_name_bpp
[238.075785] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.074s)
[238.085842] Starting dynamic subtest: drm_test_cmdline_name_option
[238.164040] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.088s)
[238.174001] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[238.274087] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.107s)
[238.284286] Starting dynamic subtest: drm_test_cmdline_rotate_0
[238.381080] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.107s)
[238.391659] Starting dynamic subtest: drm_test_cmdline_rotate_90
[238.482148] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.099s)
[238.492602] Starting dynamic subtest: drm_test_cmdline_rotate_180
[238.593181] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.111s)
[238.601627] Starting dynamic subtest: drm_test_cmdline_rotate_270
[238.698146] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.104s)
[238.706824] Starting dynamic subtest: drm_test_cmdline_hmirror
[238.799813] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.100s)
[238.808621] Starting dynamic subtest: drm_test_cmdline_vmirror
[238.909866] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.108s)
[238.918816] Starting dynamic subtest: drm_test_cmdline_margin_options
[239.009260] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.098s)
[239.019318] Starting dynamic subtest: drm_test_cmdline_multiple_options
[239.102227] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.092s)
[239.111231] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[239.195301] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.093s)
[239.205309] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[239.275298] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.078s)
[239.284908] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[239.380198] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.104s)
[239.389159] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[239.463265] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.083s)
[239.473200] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[239.541240] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.076s)
[239.549845] Starting dynamic subtest: drm_test_cmdline_invalid
[239.637872] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.098s)
[239.646964] Starting dynamic subtest: drm_test_cmdline_tv_options
[239.738641] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.098s)
[239.740560] Subtest drm_cmdline_parser: SUCCESS (3.931s)
[239.902247] [072/133] (780s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[240.017368] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[240.021231] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[240.162308] [073/133] (779s left) gem_eio (wait-1us)
[240.388254] Starting subtest: wait-1us
[240.765594] Subtest wait-1us: SUCCESS (0.378s)
[240.939268] [074/133] (779s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[240.992645] Starting subtest: etime-multi-wait-all-available-unsubmitted
[241.096410] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.101s)
[241.185658] [075/133] (778s left) kms_async_flips (crc-atomic)
[241.270478] Starting subtest: crc-atomic
[241.647237] Starting dynamic subtest: pipe-A-eDP-1
[244.592333] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.941s)
[244.970685] Starting dynamic subtest: pipe-B-eDP-1
[247.922505] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.960s)
[248.292628] Starting dynamic subtest: pipe-C-eDP-1
[251.230832] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.948s)
[251.599668] Starting dynamic subtest: pipe-D-eDP-1
[254.456542] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.865s)
[254.458827] Subtest crc-atomic: SUCCESS (13.187s)
[255.624064] [076/133] (764s left) kms_addfb_basic (bad-pitch-0)
[255.688759] Starting subtest: bad-pitch-0
[255.691049] Subtest bad-pitch-0: SUCCESS (0.000s)
[255.817315] [077/133] (764s left) gem_spin_batch (spin-all)
[255.881880] Starting subtest: spin-all
[255.895156] Subtest spin-all: SUCCESS (0.012s)
[257.338643] [078/133] (762s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[257.451901] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[264.495688] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.046s)
[264.618397] [079/133] (755s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[264.707796] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[264.710037] Starting dynamic subtest: pipe-A-eDP-1
[264.852856] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.137s)
[264.863537] Starting dynamic subtest: pipe-B-eDP-1
[264.883217] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[264.892680] Starting dynamic subtest: pipe-C-eDP-1
[264.911112] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[264.920026] Starting dynamic subtest: pipe-D-eDP-1
[264.938723] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[264.940580] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.148s)
[267.097040] [080/133] (753s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[267.179023] Starting subtest: mixed-tiled-to-y-tiled-ccs
[267.183775] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[267.363307] [081/133] (752s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[267.466349] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[268.534977] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.069s)
[268.650345] [082/133] (751s left) gem_mmap_offset (blt-coherency)
[268.698996] Starting subtest: blt-coherency
[268.704760] Subtest blt-coherency: SUCCESS (0.008s)
[268.813388] [083/133] (751s left) sw_sync (sync_busy_fork)
[268.848231] Starting subtest: sync_busy_fork
[269.863215] Subtest sync_busy_fork: SUCCESS (1.013s)
[269.941179] [084/133] (750s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[270.056701] Starting subtest: cursor-vs-flip-atomic-transitions
[300.453852] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (30.393s)
[301.324362] [085/133] (719s left) vgem_basic (mmap)
[301.372201] Starting subtest: mmap
[301.379525] Subtest mmap: SUCCESS (0.009s)
[301.441987] [086/133] (719s left) gem_pwrite (basic-random)
[301.495966] Subtest basic-random: SKIP (0.000s)
[301.552997] [087/133] (719s left) gem_mmap_gtt (cpuset-medium-copy)
[301.605041] Subtest cpuset-medium-copy: SKIP (0.000s)
[301.678064] [088/133] (718s left) perf_pmu (busy-check-all)
[301.712933] Starting subtest: busy-check-all
[301.715213] Starting dynamic subtest: rcs0
[302.276802] Dynamic subtest rcs0: SUCCESS (0.565s)
[302.289946] Starting dynamic subtest: bcs0
[302.827730] Dynamic subtest bcs0: SUCCESS (0.549s)
[302.843288] Starting dynamic subtest: vcs0
[304.331181] Dynamic subtest vcs0: SUCCESS (1.500s)
[304.344850] Starting dynamic subtest: vcs1
[306.316278] Dynamic subtest vcs1: SUCCESS (1.982s)
[306.329116] Starting dynamic subtest: vecs0
[308.300252] Dynamic subtest vecs0: SUCCESS (1.980s)
[308.312839] Starting dynamic subtest: ccs0
[308.856821] Dynamic subtest ccs0: SUCCESS (0.555s)
[308.859853] Subtest busy-check-all: SUCCESS (7.146s)
[308.981963] [089/133] (711s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[309.097479] Starting subtest: y-tiled-addfb-size-offset-overflow
[309.101972] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[309.196141] [090/133] (711s left) gem_exec_schedule (wide)
[309.366155] Starting subtest: wide
[309.368362] Starting dynamic subtest: rcs0
[319.533181] Dynamic subtest rcs0: SUCCESS (10.167s)
[319.548368] Starting dynamic subtest: vcs0
[329.732935] Dynamic subtest vcs0: SUCCESS (10.198s)
[329.745801] Starting dynamic subtest: vcs1
[339.531375] Dynamic subtest vcs1: SUCCESS (9.797s)
[339.543421] Starting dynamic subtest: vecs0
[352.280307] Dynamic subtest vecs0: SUCCESS (12.747s)
[352.292391] Starting dynamic subtest: ccs0
[365.720764] Dynamic subtest ccs0: SUCCESS (13.438s)
[365.723800] Subtest wide: SUCCESS (56.352s)
[367.470509] [091/133] (653s left) kms_fb_coherency (memset-crc)
[367.563405] Starting subtest: memset-crc
[367.565664] Starting dynamic subtest: mmap-offset-wc
[367.985464] Dynamic subtest mmap-offset-wc: SUCCESS (0.422s)
[368.276175] Starting dynamic subtest: mmap-offset-uc
[373.704949] Dynamic subtest mmap-offset-uc: SUCCESS (5.435s)
[373.984787] Subtest memset-crc: SUCCESS (6.421s)
[374.860837] [092/133] (645s left) kms_chamelium_edid (dp-edid-read)
[375.257347] Subtest dp-edid-read: SKIP (0.000s)
[376.080893] [093/133] (644s left) kms_color (legacy-gamma-reset)
[376.177596] Starting subtest: legacy-gamma-reset
[376.179605] Starting dynamic subtest: pipe-A-eDP-1
[376.566550] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.390s)
[376.576240] Starting dynamic subtest: pipe-B-eDP-1
[376.578431] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.012s)
[376.587993] Starting dynamic subtest: pipe-C-eDP-1
[376.592878] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.012s)
[376.602409] Starting dynamic subtest: pipe-D-eDP-1
[376.604285] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.012s)
[376.606566] Subtest legacy-gamma-reset: SUCCESS (0.429s)
[377.438959] [094/133] (643s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[377.544111] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[377.546310] Starting dynamic subtest: pipe-A-eDP-1
[377.642564] Dynamic subtest pipe-A-eDP-1: SKIP (0.101s)
[377.653888] Starting dynamic subtest: pipe-B-eDP-1
[378.810599] Dynamic subtest pipe-B-eDP-1: SKIP (1.167s)
[378.815276] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.271s)
[379.999732] [095/133] (640s left) kms_pm_dc (dc6-dpms)
[381.096682] Starting subtest: dc6-dpms
[383.171349] Subtest dc6-dpms: SUCCESS (2.073s)
[383.302032] [096/133] (637s left) api_intel_allocator (alloc-simple)
[383.360070] Starting subtest: alloc-simple
[383.362273] Subtest alloc-simple: SUCCESS (0.003s)
[383.484135] [097/133] (637s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[383.579360] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[383.583481] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[383.677413] [098/133] (637s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[383.801324] Starting subtest: flip-vs-cursor-crc-atomic
[384.529643] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.726s)
[385.372154] [099/133] (635s left) perf_pmu (most-busy-idle-check-all)
[385.415876] Starting subtest: most-busy-idle-check-all
[385.418106] Starting dynamic subtest: rcs0
[387.340815] Dynamic subtest rcs0: SUCCESS (1.925s)
[387.352973] Starting dynamic subtest: bcs0
[389.323459] Dynamic subtest bcs0: SUCCESS (1.980s)
[389.336372] Starting dynamic subtest: vcs0
[391.308885] Dynamic subtest vcs0: SUCCESS (1.982s)
[391.322337] Starting dynamic subtest: vcs1
[393.292313] Dynamic subtest vcs1: SUCCESS (1.980s)
[393.305818] Starting dynamic subtest: vecs0
[395.340595] Dynamic subtest vecs0: SUCCESS (2.045s)
[395.354021] Starting dynamic subtest: ccs0
[397.325326] Dynamic subtest ccs0: SUCCESS (1.981s)
[397.328383] Subtest most-busy-idle-check-all: SUCCESS (11.911s)
[397.454376] [100/133] (623s left) kms_plane_cursor (overlay)
[397.551068] Starting subtest: overlay
[397.555603] Starting dynamic subtest: pipe-A-eDP-1-size-64
[400.048756] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.498s)
[400.113725] Starting dynamic subtest: pipe-A-eDP-1-size-128
[402.828204] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.727s)
[402.887431] Starting dynamic subtest: pipe-A-eDP-1-size-256
[405.462041] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.582s)
[405.809625] Starting dynamic subtest: pipe-B-eDP-1-size-64
[409.088466] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.289s)
[409.151696] Starting dynamic subtest: pipe-B-eDP-1-size-128
[411.656867] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.515s)
[411.718170] Starting dynamic subtest: pipe-B-eDP-1-size-256
[414.334914] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.627s)
[414.686243] Starting dynamic subtest: pipe-C-eDP-1-size-64
[417.569226] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.895s)
[417.615085] Starting dynamic subtest: pipe-C-eDP-1-size-128
[419.869454] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.270s)
[419.907689] Starting dynamic subtest: pipe-C-eDP-1-size-256
[422.080247] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.180s)
[422.409686] Starting dynamic subtest: pipe-D-eDP-1-size-64
[425.312065] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.914s)
[425.351497] Starting dynamic subtest: pipe-D-eDP-1-size-128
[427.512293] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.170s)
[427.550844] Starting dynamic subtest: pipe-D-eDP-1-size-256
[429.735582] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.192s)
[430.055707] Subtest overlay: SUCCESS (32.505s)
[430.897566] [101/133] (590s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[431.006238] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[434.747006] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.744s)
[435.903117] [102/133] (585s left) kms_addfb_basic (legacy-format)
[435.952477] Starting subtest: legacy-format
[435.980237] Subtest legacy-format: SUCCESS (0.024s)
[436.138839] [103/133] (585s left) kms_atomic_transition (plane-all-modeset-transition)
[436.228160] Starting subtest: plane-all-modeset-transition
[436.232292] Subtest plane-all-modeset-transition: SKIP (0.000s)
[436.310966] [104/133] (585s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[436.416135] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[436.419774] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[436.519547] [105/133] (584s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[436.620191] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[436.624559] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[436.724599] [106/133] (584s left) kms_vblank (wait-forked-hang)
[436.816542] Starting subtest: wait-forked-hang
[436.818738] Starting dynamic subtest: pipe-A-eDP-1
[463.050756] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.231s)
[463.066380] Starting dynamic subtest: pipe-D-eDP-1
[488.141835] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.088s)
[488.144032] Subtest wait-forked-hang: SUCCESS (51.324s)
[488.941561] [107/133] (532s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[488.993507] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[488.997826] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[489.175324] [108/133] (532s left) syncobj_timeline (multi-wait-available-signaled)
[489.228091] Starting subtest: multi-wait-available-signaled
[489.230224] Subtest multi-wait-available-signaled: SUCCESS (0.000s)
[489.327184] [109/133] (532s left) kms_big_fb (4-tiled-addfb)
[489.417722] Starting subtest: 4-tiled-addfb
[489.420029] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[489.522429] [110/133] (532s left) gem_ccs (block-copy-uncompressed)
[489.579332] Starting subtest: block-copy-uncompressed
[489.581598] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[489.602106] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.022s)
[489.613908] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[489.619485] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[489.630100] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[489.636728] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[489.646144] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[489.653412] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[489.655648] Subtest block-copy-uncompressed: SUCCESS (0.075s)
[489.769194] [111/133] (531s left) kms_cursor_crc (cursor-random-32x32)
[489.912658] Starting subtest: cursor-random-32x32
[489.995208] Subtest cursor-random-32x32: SKIP (0.079s)
[490.282781] [112/133] (531s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[490.368238] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[490.371616] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[490.469514] [113/133] (531s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[490.560251] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[490.563894] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[490.657295] [114/133] (531s left) syncobj_basic (bad-pad-fd-to-handle)
[490.705014] Starting subtest: bad-pad-fd-to-handle
[490.706726] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[490.793006] [115/133] (531s left) gem_exec_balancer (invalid-bonds)
[490.846391] Starting subtest: invalid-bonds
[490.850463] Subtest invalid-bonds: SKIP (0.000s)
[491.141440] [116/133] (530s left) core_getversion (basic)
[491.173065] Starting subtest: basic
[491.177399] Subtest basic: SUCCESS (0.000s)
[491.240553] [117/133] (530s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[491.334338] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[491.338746] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[491.432929] [118/133] (530s left) gem_caching (writes)
[491.490851] Subtest writes: SKIP (0.000s)
[491.559088] [119/133] (530s left) kms_chamelium_hpd (common-hpd-after-suspend)
[491.936793] Subtest common-hpd-after-suspend: SKIP (0.000s)
[492.752003] [120/133] (529s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[492.874286] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[492.878720] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[493.025127] [121/133] (529s left) kms_psr (fbc-pr-no-drrs)
[493.124828] Starting subtest: fbc-pr-no-drrs
[493.129190] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[493.199304] [122/133] (528s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[493.302702] Starting subtest: yf-tiled-8bpp-rotate-180
[493.307206] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[493.390082] [123/133] (528s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt)
[493.483606] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt
[493.487713] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[493.585558] [124/133] (528s left) gem_exec_reloc (basic-gtt-wc-active)
[493.641579] Subtest basic-gtt-wc-active: SKIP (0.000s)
[493.707217] [125/133] (528s left) kms_prop_blob (blob-multiple)
[493.755209] Starting subtest: blob-multiple
[493.757056] Subtest blob-multiple: SUCCESS (0.002s)
[493.866766] [126/133] (528s left) vgem_basic (create)
[493.906289] Starting subtest: create
[493.907915] Subtest create: SUCCESS (0.000s)
[493.963901] [127/133] (528s left) prime_busy (after)
[494.021172] Starting subtest: after
[494.026535] Starting dynamic subtest: rcs0
[494.061380] Dynamic subtest rcs0: SUCCESS (0.035s)
[494.072804] Starting dynamic subtest: bcs0
[494.113651] Dynamic subtest bcs0: SUCCESS (0.051s)
[494.123989] Starting dynamic subtest: vcs0
[494.153058] Dynamic subtest vcs0: SUCCESS (0.039s)
[494.162793] Starting dynamic subtest: vcs1
[494.194175] Dynamic subtest vcs1: SUCCESS (0.040s)
[494.203888] Starting dynamic subtest: vecs0
[494.234451] Dynamic subtest vecs0: SUCCESS (0.039s)
[494.243920] Starting dynamic subtest: ccs0
[494.276430] Dynamic subtest ccs0: SUCCESS (0.041s)
[494.385363] Subtest after: SUCCESS (0.362s)
[494.479020] [128/133] (527s left) api_intel_bb (simple-bb-ctx)
[494.540035] Starting subtest: simple-bb-ctx
[494.549201] Subtest simple-bb-ctx: SUCCESS (0.011s)
[494.671803] [129/133] (527s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[494.772155] Starting subtest: psr-2p-primscrn-spr-indfb-move
[494.776379] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[494.876414] [130/133] (527s left) kms_setmode (invalid-clone-single-crtc-stealing)
[494.938018] Starting subtest: invalid-clone-single-crtc-stealing
[494.944229] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[495.027627] [131/133] (527s left) syncobj_basic (create-signaled)
[495.074836] Starting subtest: create-signaled
[495.076684] Subtest create-signaled: SUCCESS (0.000s)
[495.165592] [132/133] (527s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[495.734876] Starting subtest: syncobj-stationary-timeline-chain-engines
[495.855750] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.122s)
[497.459547] [133/133] (525s left) kms_flip (basic-flip-vs-modeset)
[497.557122] Starting subtest: basic-flip-vs-modeset
[497.559590] Starting dynamic subtest: A-eDP1
[500.169818] Dynamic subtest A-eDP1: SUCCESS (2.611s)
[500.180915] Starting dynamic subtest: B-eDP1
[502.332540] Dynamic subtest B-eDP1: SUCCESS (2.164s)
[502.345673] Starting dynamic subtest: C-eDP1
[504.486707] Dynamic subtest C-eDP1: SUCCESS (2.153s)
[504.497695] Starting dynamic subtest: D-eDP1
[506.653414] Dynamic subtest D-eDP1: SUCCESS (2.162s)
[506.655827] Subtest basic-flip-vs-modeset: SUCCESS (9.100s)
[507.453131] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: i915_pm_freq_api
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_psr
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_plane
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: i915_query
results: parsing output: 12/ for test: kms_plane
results: parsing output: 13/ for test: kms_hdr
results: parsing output: 14/ for test: kms_flip
results: parsing output: 15/ for test: gen9_exec_parse
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_chamelium_color
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: gem_userptr_blits
results: parsing output: 22/ for test: gem_exec_balancer
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: i915_pm_rps
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: i915_pm_rpm
results: parsing output: 27/ for test: perf
results: parsing output: 28/ for test: kms_flip_scaled_crc
results: parsing output: 29/ for test: kms_cursor_crc
results: parsing output: 30/ for test: kms_prime
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: i915_drm_fdinfo
results: parsing output: 33/ for test: kms_ccs
results: parsing output: 34/ for test: kms_addfb_basic
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: gem_ctx_exec
results: parsing output: 37/ for test: syncobj_timeline
results: parsing output: 38/ for test: syncobj_wait
results: parsing output: 39/ for test: kms_plane_scaling
results: parsing output: 40/ for test: gem_exec_params
results: parsing output: 41/ for test: kms_pipe_crc_basic
results: parsing output: 42/ for test: gem_ctx_shared
results: parsing output: 43/ for test: kms_flip_scaled_crc
results: parsing output: 44/ for test: kms_dp_link_training
results: parsing output: 45/ for test: kms_cursor_edge_walk
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: kms_lease
results: parsing output: 48/ for test: gem_exec_reloc
results: parsing output: 49/ for test: kms_invalid_mode
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: kms_rotation_crc
results: parsing output: 52/ for test: gem_exec_whisper
results: parsing output: 53/ for test: gem_ctx_exec
results: parsing output: 54/ for test: gem_exec_schedule
results: parsing output: 55/ for test: sysfs_timeslice_duration
results: parsing output: 56/ for test: gem_sync
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: kms_ccs
results: parsing output: 59/ for test: gem_exec_flush
results: parsing output: 60/ for test: kms_content_protection
results: parsing output: 61/ for test: kms_rotation_crc
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: gem_exec_schedule
results: parsing output: 65/ for test: gem_render_copy
results: parsing output: 66/ for test: gem_ctx_param
results: parsing output: 67/ for test: kms_cursor_legacy
results: parsing output: 68/ for test: gem_ctx_persistence
results: parsing output: 69/ for test: gem_exec_params
results: parsing output: 70/ for test: kms_selftest
results: parsing output: 71/ for test: kms_cursor_legacy
results: parsing output: 72/ for test: gem_eio
results: parsing output: 73/ for test: syncobj_timeline
results: parsing output: 74/ for test: kms_async_flips
results: parsing output: 75/ for test: kms_addfb_basic
results: parsing output: 76/ for test: gem_spin_batch
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: gem_render_copy
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: gem_mmap_offset
results: parsing output: 82/ for test: sw_sync
results: parsing output: 83/ for test: kms_cursor_legacy
results: parsing output: 84/ for test: vgem_basic
results: parsing output: 85/ for test: gem_pwrite
results: parsing output: 86/ for test: gem_mmap_gtt
results: parsing output: 87/ for test: perf_pmu
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: gem_exec_schedule
results: parsing output: 90/ for test: kms_fb_coherency
results: parsing output: 91/ for test: kms_chamelium_edid
results: parsing output: 92/ for test: kms_color
results: parsing output: 93/ for test: kms_psr2_sf
results: parsing output: 94/ for test: kms_pm_dc
results: parsing output: 95/ for test: api_intel_allocator
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: perf_pmu
results: parsing output: 99/ for test: kms_plane_cursor
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_addfb_basic
results: parsing output: 102/ for test: kms_atomic_transition
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_vblank
results: parsing output: 106/ for test: gem_render_copy
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: gem_ccs
results: parsing output: 110/ for test: kms_cursor_crc
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: syncobj_basic
results: parsing output: 114/ for test: gem_exec_balancer
results: parsing output: 115/ for test: core_getversion
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: gem_caching
results: parsing output: 118/ for test: kms_chamelium_hpd
results: parsing output: 119/ for test: kms_cursor_legacy
results: parsing output: 120/ for test: kms_psr
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gem_exec_reloc
results: parsing output: 124/ for test: kms_prop_blob
results: parsing output: 125/ for test: vgem_basic
results: parsing output: 126/ for test: prime_busy
results: parsing output: 127/ for test: api_intel_bb
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_setmode
results: parsing output: 130/ for test: syncobj_basic
results: parsing output: 131/ for test: gem_exec_fence
results: parsing output: 132/ for test: kms_flip
Done.