[59.194219] Initializing watchdogs [59.194267] /dev/watchdog0 [59.209347] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [59.213962] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.216527] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.220080] [001/133] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt) [59.350699] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt [63.877641] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.512s) [65.066724] [002/133] (954s left) syncobj_wait (single-wait-for-submit-submitted) [65.132618] Starting subtest: single-wait-for-submit-submitted [65.236474] Subtest single-wait-for-submit-submitted: SUCCESS (0.101s) [65.309436] [003/133] (954s left) kms_vblank (ts-continuation-modeset-hang) [65.410768] Starting subtest: ts-continuation-modeset-hang [65.413102] Starting dynamic subtest: pipe-A-eDP-1 [91.747117] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.312s) [91.759849] Starting dynamic subtest: pipe-D-eDP-1 [116.698752] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.946s) [116.701036] Subtest ts-continuation-modeset-hang: SUCCESS (51.261s) [117.488849] [004/133] (902s left) syncobj_timeline (multi-wait-all-available-submitted) [117.549023] Starting subtest: multi-wait-all-available-submitted [117.551285] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s) [117.662585] [005/133] (902s left) gem_mmap_gtt (basic-read-write) [117.708948] Subtest basic-read-write: SKIP (0.000s) [117.762311] [006/133] (902s left) kms_rotation_crc (primary-y-tiled-reflect-x-180) [117.858845] Starting subtest: primary-y-tiled-reflect-x-180 [117.918455] Subtest primary-y-tiled-reflect-x-180: SKIP (0.059s) [118.062768] [007/133] (901s left) gem_exec_schedule (u-semaphore-codependency) [118.141806] Starting subtest: u-semaphore-codependency [118.151991] Subtest u-semaphore-codependency: SUCCESS (0.015s) [118.489625] [008/133] (901s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier) [118.577033] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier [118.581458] Subtest pixel-format-4-tiled-bmg-ccs-modifier: SKIP (0.000s) [118.650467] [009/133] (901s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled) [118.708758] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled [118.811863] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.101s) [118.883065] [010/133] (901s left) kms_getfb (getfb2-handle-zero) [118.963961] Starting subtest: getfb2-handle-zero [118.966344] Subtest getfb2-handle-zero: SUCCESS (0.000s) [119.052188] [011/133] (901s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt) [119.156323] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt [119.160812] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [119.245060] [012/133] (900s left) kms_addfb_basic (bo-too-small) [119.345061] Starting subtest: bo-too-small [119.346913] Subtest bo-too-small: SUCCESS (0.000s) [119.449615] [013/133] (900s left) sysfs_defaults (readonly) [119.518901] Starting subtest: readonly [119.521297] Starting dynamic subtest: vecs0 [119.523704] Dynamic subtest vecs0: SUCCESS (0.000s) [119.533026] Starting dynamic subtest: ccs0 [119.535194] Dynamic subtest ccs0: SUCCESS (0.000s) [119.542449] Starting dynamic subtest: vcs0 [119.544662] Dynamic subtest vcs0: SUCCESS (0.000s) [119.551938] Starting dynamic subtest: bcs0 [119.554073] Dynamic subtest bcs0: SUCCESS (0.000s) [119.561687] Starting dynamic subtest: rcs0 [119.563863] Dynamic subtest rcs0: SUCCESS (0.000s) [119.571652] Starting dynamic subtest: vcs1 [119.573524] Dynamic subtest vcs1: SUCCESS (0.000s) [119.575396] Subtest readonly: SUCCESS (0.003s) [119.627718] [014/133] (900s left) gem_ctx_persistence (legacy-engines-queued) [119.694661] Starting subtest: legacy-engines-queued [119.697291] Starting dynamic subtest: render [119.747903] Dynamic subtest render: SUCCESS (0.053s) [119.757886] Starting dynamic subtest: bsd1 [120.888845] Dynamic subtest bsd1: SUCCESS (1.138s) [120.902400] Starting dynamic subtest: bsd2 [122.869241] Dynamic subtest bsd2: SUCCESS (1.978s) [122.883801] Starting dynamic subtest: blt [122.927748] Dynamic subtest blt: SUCCESS (0.058s) [122.937490] Starting dynamic subtest: vebox [124.855246] Dynamic subtest vebox: SUCCESS (1.924s) [124.857435] Subtest legacy-engines-queued: SUCCESS (5.160s) [124.945539] [015/133] (895s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled) [125.009439] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled [125.014136] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s) [125.194375] [016/133] (895s left) drm_buddy (drm_buddy) [125.235906] Starting subtest: drm_buddy [125.240490] Subtest drm_buddy: SKIP (0.000s) [125.287088] [017/133] (895s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers) [125.386731] Starting subtest: plane-upscale-factor-0-25-with-modifiers [125.388985] Starting dynamic subtest: pipe-A [125.722523] Dynamic subtest pipe-A: SUCCESS (0.338s) [125.731456] Starting dynamic subtest: pipe-B [127.087764] Dynamic subtest pipe-B: SUCCESS (1.365s) [127.096457] Starting dynamic subtest: pipe-C [128.511599] Dynamic subtest pipe-C: SUCCESS (1.423s) [128.520973] Starting dynamic subtest: pipe-D [129.949313] Dynamic subtest pipe-D: SUCCESS (1.437s) [129.951562] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.564s) [131.117297] [018/133] (889s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs) [131.218852] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs [131.221258] Starting dynamic subtest: pipe-A-eDP-1 [131.247674] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [131.257371] Starting dynamic subtest: pipe-B-eDP-1 [131.281742] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [131.288959] Starting dynamic subtest: pipe-C-eDP-1 [131.312806] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [131.320060] Starting dynamic subtest: pipe-D-eDP-1 [131.344138] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [131.348513] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.003s) [133.480008] [019/133] (886s left) kms_big_fb (linear-16bpp-rotate-0) [133.580543] Starting subtest: linear-16bpp-rotate-0 [134.970586] Subtest linear-16bpp-rotate-0: SUCCESS (1.391s) [135.088792] [020/133] (885s left) gem_eio (create) [135.318950] Starting subtest: create [135.624249] Subtest create: SUCCESS (0.305s) [135.733324] [021/133] (884s left) i915_pm_rpm (gem-execbuf) [137.254902] Starting subtest: gem-execbuf [137.257154] Starting dynamic subtest: smem0 [139.368150] Dynamic subtest smem0: SUCCESS (2.117s) [139.370466] Subtest gem-execbuf: SUCCESS (2.118s) [139.451161] [022/133] (881s left) gem_mmap_offset (clear) [139.510875] Starting subtest: clear [139.513348] Starting dynamic subtest: smem0 [163.368777] Dynamic subtest smem0: SUCCESS (23.853s) [163.371210] Subtest clear: SUCCESS (23.855s) [163.508176] [023/133] (857s left) gem_exec_params (readonly) [163.611791] Starting subtest: readonly [163.616628] Subtest readonly: SUCCESS (0.004s) [163.735421] [024/133] (856s left) kms_pipe_stress (stress-xrgb8888-yftiled) [163.839426] Starting subtest: stress-xrgb8888-yftiled [163.843936] Subtest stress-xrgb8888-yftiled: SKIP (0.000s) [163.907997] [025/133] (856s left) gem_exec_whisper (basic-contexts-all) [163.980489] Starting subtest: basic-contexts-all [175.863583] Subtest basic-contexts-all: SUCCESS (11.880s) [176.062523] [026/133] (844s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs) [176.172997] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs [176.175356] Starting dynamic subtest: pipe-A-eDP-1 [176.234675] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [176.244949] Starting dynamic subtest: pipe-B-eDP-1 [176.302581] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [176.313031] Starting dynamic subtest: pipe-C-eDP-1 [176.372154] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [176.382309] Starting dynamic subtest: pipe-D-eDP-1 [176.439654] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [176.444175] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.008s) [178.469483] [027/133] (842s left) syncobj_timeline (multi-wait-available-signaled) [178.541057] Starting subtest: multi-wait-available-signaled [178.543381] Subtest multi-wait-available-signaled: SUCCESS (0.000s) [178.634384] [028/133] (842s left) perf_pmu (invalid-open) [178.687946] Starting subtest: invalid-open [178.690462] Subtest invalid-open: SUCCESS (0.000s) [178.781989] [029/133] (842s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move) [178.892487] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move [178.896811] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [179.004135] [030/133] (841s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt) [179.112602] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt [179.116832] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [179.195630] [031/133] (841s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt) [179.293605] Starting subtest: psr-2p-primscrn-indfb-msflip-blt [179.297720] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [179.405242] [032/133] (841s left) kms_chamelium_frames (hdmi-crc-single) [179.774116] Subtest hdmi-crc-single: SKIP (0.000s) [180.589775] [033/133] (840s left) kms_prop_blob (invalid-set-prop) [180.652051] Starting subtest: invalid-set-prop [180.654086] Subtest invalid-set-prop: SUCCESS (0.000s) [180.742261] [034/133] (840s left) syncobj_timeline (single-wait-all-available-submitted) [180.803222] Starting subtest: single-wait-all-available-submitted [180.805561] Subtest single-wait-all-available-submitted: SUCCESS (0.000s) [180.904518] [035/133] (840s left) prime_vgem (basic-fence-flip) [181.049365] Starting subtest: basic-fence-flip [181.340054] Subtest basic-fence-flip: SUCCESS (0.289s) [181.441864] [FACT prime_vgem (basic-fence-flip)] new: kernel.kmod_is_loaded.vgem: true [181.445754] [036/133] (839s left) kms_universal_plane (cursor-fb-leak) [181.546869] Starting subtest: cursor-fb-leak [181.549354] Starting dynamic subtest: pipe-A-eDP-1 [181.900590] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.353s) [181.914359] Starting dynamic subtest: pipe-B-eDP-1 [183.243066] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.339s) [183.255067] Starting dynamic subtest: pipe-C-eDP-1 [184.639457] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.395s) [184.649718] Starting dynamic subtest: pipe-D-eDP-1 [185.971432] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.331s) [185.973931] Subtest cursor-fb-leak: SUCCESS (4.424s) [187.142579] [037/133] (834s left) gem_ppgtt (shrink-vs-evict-pinned) [187.203802] Starting subtest: shrink-vs-evict-pinned [192.878429] Subtest shrink-vs-evict-pinned: SUCCESS (5.672s) [192.969140] [038/133] (828s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt) [193.067976] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt [193.072604] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [193.175682] [039/133] (828s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu) [193.292868] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu [193.297131] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [193.395321] [040/133] (827s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc) [193.487123] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc [193.489453] Starting dynamic subtest: pipe-A-eDP-1 [193.512512] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [193.522093] Starting dynamic subtest: pipe-B-eDP-1 [193.543175] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [193.551146] Starting dynamic subtest: pipe-C-eDP-1 [193.571821] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [193.579676] Starting dynamic subtest: pipe-D-eDP-1 [193.600275] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [193.604479] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s) [195.793133] [041/133] (825s left) syncobj_wait (single-wait-all-for-submit-submitted) [195.856152] Starting subtest: single-wait-all-for-submit-submitted [195.964926] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.108s) [196.053382] [042/133] (825s left) kms_big_fb (4-tiled-64bpp-rotate-270) [196.164342] Starting subtest: 4-tiled-64bpp-rotate-270 [196.185150] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.020s) [196.311233] [043/133] (825s left) kms_big_fb (x-tiled-64bpp-rotate-180) [196.414637] Starting subtest: x-tiled-64bpp-rotate-180 [197.982620] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.568s) [198.164521] [044/133] (823s left) kms_big_fb (y-tiled-16bpp-rotate-180) [198.276518] Starting subtest: y-tiled-16bpp-rotate-180 [198.280737] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s) [198.401523] [045/133] (823s left) kms_flip (wf_vblank-ts-check) [198.488103] Starting subtest: wf_vblank-ts-check [198.490080] Starting dynamic subtest: A-eDP1 [207.434920] Dynamic subtest A-eDP1: SUCCESS (8.944s) [207.443939] Starting dynamic subtest: B-eDP1 [216.362835] Dynamic subtest B-eDP1: SUCCESS (8.925s) [216.374904] Starting dynamic subtest: C-eDP1 [225.294643] Dynamic subtest C-eDP1: SUCCESS (8.929s) [225.307755] Starting dynamic subtest: D-eDP1 [234.227578] Dynamic subtest D-eDP1: SUCCESS (8.932s) [234.233592] Subtest wf_vblank-ts-check: SUCCESS (35.742s) [235.451501] [046/133] (786s left) kms_frontbuffer_tracking (psr-2p-rte) [235.547169] Starting subtest: psr-2p-rte [235.551440] Subtest psr-2p-rte: SKIP (0.000s) [235.630408] [047/133] (785s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt) [235.738959] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt [235.743194] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [235.849482] [048/133] (785s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite) [235.938780] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite [243.199724] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (7.265s) [243.315527] [049/133] (778s left) prime_vgem (basic-gtt) [243.387190] Starting subtest: basic-gtt [243.391591] Subtest basic-gtt: SKIP (0.000s) [243.480252] [050/133] (778s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted) [243.532681] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted [243.636379] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.103s) [243.723899] [051/133] (778s left) api_intel_bb (misplaced-blitter) [243.778234] Starting subtest: misplaced-blitter [243.783175] Subtest misplaced-blitter: SUCCESS (0.006s) [243.909344] [052/133] (777s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb) [244.012678] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb [244.015019] Starting dynamic subtest: pipe-A-eDP-1 [250.813650] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.803s) [250.826806] Starting dynamic subtest: pipe-B-eDP-1 [257.900703] Dynamic subtest pipe-B-eDP-1: SUCCESS (7.085s) [257.902840] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.890s) [258.768536] [053/133] (763s left) kms_psr (pr-sprite-render) [258.874751] Starting subtest: pr-sprite-render [258.880042] Subtest pr-sprite-render: SKIP (0.000s) [258.962319] [054/133] (762s left) gem_exec_big (single) [259.024019] Starting subtest: single [263.645047] Subtest single: SUCCESS (4.618s) [263.945322] [055/133] (757s left) sw_sync (timeline_closed) [264.030107] Starting subtest: timeline_closed [264.032578] Subtest timeline_closed: SUCCESS (0.000s) [264.095063] [056/133] (757s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt) [264.208536] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt [264.212732] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [264.306646] [057/133] (757s left) kms_big_fb (yf-tiled-addfb) [264.409478] Starting subtest: yf-tiled-addfb [264.414093] Subtest yf-tiled-addfb: SKIP (0.000s) [264.520840] [058/133] (757s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw) [264.622366] Starting subtest: fbc-2p-pri-indfb-multidraw [264.626795] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s) [264.722080] [059/133] (757s left) kms_cursor_crc (cursor-rapid-movement-64x21) [264.931571] Starting subtest: cursor-rapid-movement-64x21 [264.978110] Subtest cursor-rapid-movement-64x21: SKIP (0.042s) [265.245664] [060/133] (756s left) prime_vgem (busy) [265.336263] Starting subtest: busy [265.338201] Starting dynamic subtest: rcs0 [265.399460] Dynamic subtest rcs0: SUCCESS (0.063s) [265.408499] Starting dynamic subtest: bcs0 [265.448138] Dynamic subtest bcs0: SUCCESS (0.047s) [265.456657] Starting dynamic subtest: vcs0 [265.498133] Dynamic subtest vcs0: SUCCESS (0.049s) [265.506960] Starting dynamic subtest: vcs1 [265.542950] Dynamic subtest vcs1: SUCCESS (0.044s) [265.550997] Starting dynamic subtest: vecs0 [265.588949] Dynamic subtest vecs0: SUCCESS (0.045s) [265.597141] Starting dynamic subtest: ccs0 [265.634988] Dynamic subtest ccs0: SUCCESS (0.046s) [265.636923] Subtest busy: SUCCESS (0.300s) [265.765264] [061/133] (756s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite) [265.854193] Starting subtest: fbcpsr-rgb565-draw-pwrite [273.008263] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (7.155s) [273.123457] [062/133] (749s left) kms_atomic_transition (plane-all-modeset-transition) [273.222074] Starting subtest: plane-all-modeset-transition [273.226099] Subtest plane-all-modeset-transition: SKIP (0.000s) [273.295364] [063/133] (748s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt) [273.385531] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt [280.705186] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.323s) [280.831770] [064/133] (741s left) kms_pm_rpm (package-g7) [283.094395] Starting subtest: package-g7 [283.099322] Subtest package-g7: SKIP (0.000s) [283.460374] [065/133] (738s left) gem_exec_reloc (basic-gtt) [283.511730] Subtest basic-gtt: SKIP (0.000s) [283.576259] [066/133] (738s left) gem_exec_params (secure-non-root) [283.633489] Starting subtest: secure-non-root [283.638053] Subtest secure-non-root: SKIP (0.000s) [283.757161] [067/133] (738s left) perf_pmu (busy-check-all) [283.812448] Starting subtest: busy-check-all [283.814610] Starting dynamic subtest: rcs0 [284.372680] Dynamic subtest rcs0: SUCCESS (0.561s) [284.384346] Starting dynamic subtest: bcs0 [284.922630] Dynamic subtest bcs0: SUCCESS (0.548s) [284.934784] Starting dynamic subtest: vcs0 [286.936063] Dynamic subtest vcs0: SUCCESS (2.009s) [286.948610] Starting dynamic subtest: vcs1 [288.921046] Dynamic subtest vcs1: SUCCESS (1.981s) [288.933829] Starting dynamic subtest: vecs0 [290.904277] Dynamic subtest vecs0: SUCCESS (1.979s) [290.916421] Starting dynamic subtest: ccs0 [291.460223] Dynamic subtest ccs0: SUCCESS (0.554s) [291.462753] Subtest busy-check-all: SUCCESS (7.651s) [291.565417] [068/133] (730s left) kms_rotation_crc (sprite-rotation-90-pos-100-0) [291.676072] Starting subtest: sprite-rotation-90-pos-100-0 [291.680748] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s) [291.752828] [069/133] (730s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs) [291.819461] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs [291.823530] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s) [292.003668] [070/133] (730s left) kms_atomic_transition (modeset-transition-fencing) [292.091802] Starting subtest: modeset-transition-fencing [292.094104] Starting dynamic subtest: 1x-outputs [302.913577] Dynamic subtest 1x-outputs: SUCCESS (10.819s) [302.916779] Subtest modeset-transition-fencing: SUCCESS (10.821s) [303.785523] [071/133] (718s left) kms_psr (fbc-pr-primary-mmap-gtt) [303.876886] Starting subtest: fbc-pr-primary-mmap-gtt [303.881252] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s) [303.954042] [072/133] (718s left) gem_spin_batch (spin-all) [304.006952] Starting subtest: spin-all [304.019483] Subtest spin-all: SUCCESS (0.011s) [305.920570] [073/133] (716s left) kms_color (invalid-gamma-lut-sizes) [306.023921] Starting subtest: invalid-gamma-lut-sizes [306.026171] Starting dynamic subtest: pipe-A [306.309431] Dynamic subtest pipe-A: SUCCESS (0.286s) [306.319251] Starting dynamic subtest: pipe-B [306.321374] Dynamic subtest pipe-B: SUCCESS (0.000s) [306.330459] Starting dynamic subtest: pipe-C [306.332752] Dynamic subtest pipe-C: SUCCESS (0.000s) [306.342198] Starting dynamic subtest: pipe-D [306.344409] Dynamic subtest pipe-D: SUCCESS (0.000s) [306.346352] Subtest invalid-gamma-lut-sizes: SUCCESS (0.290s) [307.110102] [074/133] (715s left) kms_lease (implicit-plane-lease) [307.205755] Starting subtest: implicit-plane-lease [307.207992] Subtest implicit-plane-lease: SUCCESS (0.003s) [307.305651] [075/133] (715s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions) [307.429307] Starting subtest: short-busy-flip-before-cursor-atomic-transitions [307.434187] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s) [307.572289] [076/133] (715s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt) [307.669650] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt [307.674058] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [307.778888] [077/133] (715s left) kms_setmode (clone-exclusive-crtc) [307.835161] Starting subtest: clone-exclusive-crtc [307.841651] Subtest clone-exclusive-crtc: SKIP (0.001s) [307.950483] [078/133] (714s left) kms_cursor_crc (cursor-onscreen-256x256) [308.172082] Starting subtest: cursor-onscreen-256x256 [308.173898] Starting dynamic subtest: pipe-A-eDP-1 [310.281110] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.105s) [310.310537] Starting dynamic subtest: pipe-D-eDP-1 [313.057781] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.753s) [313.059925] Subtest cursor-onscreen-256x256: SUCCESS (4.884s) [313.875639] [079/133] (709s left) kms_chamelium_hpd (dp-hpd-for-each-pipe) [314.254882] Subtest dp-hpd-for-each-pipe: SKIP (0.000s) [315.071291] [080/133] (707s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [315.170842] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip [316.017612] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.848s) [316.171929] [081/133] (706s left) syncobj_wait (single-wait-for-submit-signaled) [316.218260] Starting subtest: single-wait-for-submit-signaled [316.220228] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s) [316.315647] [082/133] (706s left) gem_eio (wait-immediate) [316.534602] Starting subtest: wait-immediate [316.898423] Subtest wait-immediate: SUCCESS (0.363s) [317.034789] [083/133] (706s left) gem_ctx_exec (basic-close-race) [317.092294] Starting subtest: basic-close-race [322.998669] Subtest basic-close-race: SUCCESS (5.904s) [323.131792] [084/133] (700s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs) [323.219666] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs [323.223966] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s) [324.312930] [085/133] (698s left) gem_lmem_swapping (heavy-verify-multi-ccs) [324.360079] Subtest heavy-verify-multi-ccs: SKIP (0.000s) [324.417639] [086/133] (698s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc) [324.532454] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc [324.536605] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [324.652949] [087/133] (698s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible) [324.750596] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible [324.762730] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.010s) [324.840084] [088/133] (698s left) gem_blits (basic) [324.898715] Starting subtest: basic [326.355964] Subtest basic: SUCCESS (1.457s) [326.487873] [089/133] (696s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa [326.545323] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled [326.652804] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.106s) [326.730360] [090/133] (696s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [326.831713] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt [326.836271] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [326.933810] [091/133] (696s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [327.025662] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu [334.082416] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.059s) [334.198026] [092/133] (689s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs) [334.297365] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs [334.299669] Starting dynamic subtest: pipe-A-eDP-1 [334.322883] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [334.333970] Starting dynamic subtest: pipe-B-eDP-1 [334.355244] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [334.363827] Starting dynamic subtest: pipe-C-eDP-1 [334.385307] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [334.393950] Starting dynamic subtest: pipe-D-eDP-1 [334.415756] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [334.420142] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.005s) [336.503998] [093/133] (687s left) gem_exec_fence (nb-await) [336.690340] Starting subtest: nb-await [336.692878] Starting dynamic subtest: rcs0 [336.756584] Dynamic subtest rcs0: SUCCESS (0.066s) [336.778929] Starting dynamic subtest: bcs0 [336.816235] Dynamic subtest bcs0: SUCCESS (0.058s) [336.828277] Starting dynamic subtest: vcs0 [336.874387] Dynamic subtest vcs0: SUCCESS (0.056s) [336.886020] Starting dynamic subtest: vcs1 [336.933565] Dynamic subtest vcs1: SUCCESS (0.058s) [336.945282] Starting dynamic subtest: vecs0 [336.994429] Dynamic subtest vecs0: SUCCESS (0.058s) [337.006886] Starting dynamic subtest: ccs0 [337.053857] Dynamic subtest ccs0: SUCCESS (0.057s) [337.057087] Subtest nb-await: SUCCESS (0.365s) [338.999087] [094/133] (684s left) sw_sync (sync_busy_fork_unixsocket) [339.040438] Starting subtest: sync_busy_fork_unixsocket [339.045393] Subtest sync_busy_fork_unixsocket: SUCCESS (0.008s) [339.109834] [095/133] (684s left) gem_userptr_blits (unsync-overlap) [339.176790] Subtest unsync-overlap: SKIP (0.000s) [339.308780] [096/133] (684s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible) [339.372138] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s) [339.442521] [097/133] (684s left) gem_mmap_gtt (basic-small-bo-tiledy) [339.496939] Subtest basic-small-bo-tiledY: SKIP (0.000s) [339.553197] [098/133] (684s left) gem_exec_flush (basic-uc-set-default) [339.621758] Starting subtest: basic-uc-set-default [345.087992] Subtest basic-uc-set-default: SUCCESS (5.466s) [345.273548] [099/133] (678s left) i915_suspend (fence-restore-untiled) [345.333196] Starting subtest: fence-restore-untiled [345.337617] Subtest fence-restore-untiled: SKIP (0.000s) [345.442912] [100/133] (678s left) kms_busy (basic-hang) [345.547950] Starting subtest: basic-hang [345.550159] Starting dynamic subtest: flip-pipe-A [346.182086] Dynamic subtest flip-pipe-A: SUCCESS (0.633s) [346.192561] Starting dynamic subtest: modeset-pipe-A [349.639420] Dynamic subtest modeset-pipe-A: SUCCESS (3.455s) [349.649911] Starting dynamic subtest: flip-pipe-D [350.864067] Dynamic subtest flip-pipe-D: SUCCESS (1.224s) [350.874597] Starting dynamic subtest: modeset-pipe-D [354.246315] Dynamic subtest modeset-pipe-D: SUCCESS (3.379s) [354.248630] Subtest basic-hang: SUCCESS (8.698s) [355.066740] [101/133] (668s left) kms_vblank (crtc-id) [355.158100] Starting subtest: crtc-id [355.159980] Starting dynamic subtest: pipe-A-eDP-1 [355.607087] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.448s) [355.621705] Starting dynamic subtest: pipe-D-eDP-1 [356.786267] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.178s) [356.788566] Subtest crtc-id: SUCCESS (1.630s) [357.621269] [102/133] (666s left) gem_ctx_isolation (nonpriv) [357.679780] Starting subtest: nonpriv [357.682195] Starting dynamic subtest: rcs0 [357.926316] Dynamic subtest rcs0: SUCCESS (0.246s) [357.936614] Starting dynamic subtest: bcs0 [358.174464] Dynamic subtest bcs0: SUCCESS (0.247s) [358.187180] Starting dynamic subtest: vcs0 [358.440176] Dynamic subtest vcs0: SUCCESS (0.265s) [358.452420] Starting dynamic subtest: vcs1 [360.100250] Dynamic subtest vcs1: SUCCESS (1.659s) [360.112273] Starting dynamic subtest: vecs0 [362.137872] Dynamic subtest vecs0: SUCCESS (2.037s) [362.149719] Starting dynamic subtest: ccs0 [364.200703] Dynamic subtest ccs0: SUCCESS (2.062s) [364.203035] Subtest nonpriv: SUCCESS (6.521s) [364.445047] [103/133] (659s left) syncobj_wait (multi-wait-all-submitted-signaled) [364.517761] Starting subtest: multi-wait-all-submitted-signaled [364.618943] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.102s) [364.699694] [104/133] (659s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling) [364.805838] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling [364.808126] Starting dynamic subtest: pipe-A-default-mode [365.982295] Dynamic subtest pipe-A-default-mode: SKIP (1.172s) [365.986717] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.174s) [366.124640] [105/133] (657s left) gem_exec_balancer (bonded-pair) [366.183563] Starting subtest: bonded-pair [366.188649] Subtest bonded-pair: SKIP (0.000s) [366.522359] [106/133] (657s left) kms_psr (psr-cursor-plane-move) [366.632126] Starting subtest: psr-cursor-plane-move [366.634406] Starting dynamic subtest: eDP-1 [368.347853] Dynamic subtest eDP-1: SUCCESS (1.715s) [368.350219] Subtest psr-cursor-plane-move: SUCCESS (1.716s) [369.207407] [107/133] (654s left) i915_drm_fdinfo (memory-info-resident) [369.250195] Starting subtest: memory-info-resident [369.252431] Starting dynamic subtest: smem0 [371.595461] Dynamic subtest smem0: SUCCESS (2.346s) [371.597552] Subtest memory-info-resident: SUCCESS (2.347s) [371.673807] [108/133] (652s left) kms_content_protection (lic-type-0-hdcp14) [371.836841] Starting subtest: lic-type-0-hdcp14 [371.840430] Subtest lic-type-0-hdcp14: SKIP (0.000s) [371.951732] [109/133] (652s left) kms_psr (fbc-psr2-sprite-mmap-cpu) [372.045260] Starting subtest: fbc-psr2-sprite-mmap-cpu [372.047199] Starting dynamic subtest: eDP-1 [372.050651] Dynamic subtest eDP-1: SKIP (0.000s) [372.054124] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s) [372.131978] [110/133] (652s left) i915_module_load (resize-bar) [372.166552] Starting subtest: resize-bar [372.174595] Subtest resize-bar: SKIP (0.007s) [372.217931] [111/133] (652s left) gem_wait (await) [372.281830] Starting subtest: await [372.283848] Starting dynamic subtest: all-engines [373.386962] Dynamic subtest all-engines: SUCCESS (1.104s) [373.403348] Starting dynamic subtest: rcs0 [374.444904] Dynamic subtest rcs0: SUCCESS (1.056s) [374.461348] Starting dynamic subtest: bcs0 [375.503221] Dynamic subtest bcs0: SUCCESS (1.056s) [375.520338] Starting dynamic subtest: vcs0 [376.558477] Dynamic subtest vcs0: SUCCESS (1.053s) [376.574617] Starting dynamic subtest: vcs1 [377.613761] Dynamic subtest vcs1: SUCCESS (1.052s) [377.630420] Starting dynamic subtest: vecs0 [378.666751] Dynamic subtest vecs0: SUCCESS (1.051s) [378.683276] Starting dynamic subtest: ccs0 [379.723040] Dynamic subtest ccs0: SUCCESS (1.053s) [379.725968] Subtest await: SUCCESS (7.441s) [379.923193] [112/133] (644s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt) [380.028707] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt [380.032811] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [380.141931] [113/133] (644s left) kms_cursor_edge_walk (128x128-left-edge) [380.230982] Starting subtest: 128x128-left-edge [380.233337] Starting dynamic subtest: pipe-A-eDP-1 [383.699661] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.468s) [383.710302] Starting dynamic subtest: pipe-D-eDP-1 [386.817048] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.116s) [386.819218] Subtest 128x128-left-edge: SUCCESS (6.586s) [387.632155] [114/133] (636s left) syncobj_basic (bad-pad-fd-to-handle) [387.690471] Starting subtest: bad-pad-fd-to-handle [387.692389] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s) [387.774134] [115/133] (636s left) kms_fence_pin_leak [387.968336] [116/133] (636s left) kms_pm_lpsp (kms-lpsp) [389.077142] Starting subtest: kms-lpsp [389.079439] Starting dynamic subtest: pipe-A-eDP-1 [389.225900] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.149s) [389.545716] Subtest kms-lpsp: SUCCESS (0.468s) [390.381590] [117/133] (634s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf) [390.491659] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf [390.493790] Starting dynamic subtest: pipe-A-eDP-1 [390.579451] Dynamic subtest pipe-A-eDP-1: SKIP (0.089s) [390.589177] Starting dynamic subtest: pipe-B-eDP-1 [391.748327] Dynamic subtest pipe-B-eDP-1: SKIP (1.167s) [391.752952] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.258s) [392.952381] [118/133] (631s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier) [393.050069] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier [393.054495] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (0.000s) [393.135881] [119/133] (631s left) kms_invalid_mode (bad-hsync-start) [393.232668] Starting subtest: bad-hsync-start [393.234857] Starting dynamic subtest: pipe-A-eDP-1 [393.531805] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.299s) [393.541487] Starting dynamic subtest: pipe-B-eDP-1 [393.543476] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [393.552744] Starting dynamic subtest: pipe-C-eDP-1 [393.555042] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [393.564176] Starting dynamic subtest: pipe-D-eDP-1 [393.566670] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [393.569063] Subtest bad-hsync-start: SUCCESS (0.305s) [394.373754] [120/133] (630s left) api_intel_allocator (simple-allocator) [394.428305] Starting subtest: simple-allocator [394.430946] Starting dynamic subtest: basic [394.433762] Dynamic subtest basic: SUCCESS (0.004s) [394.448199] Starting dynamic subtest: parallel-one [394.620066] Dynamic subtest parallel-one: SUCCESS (0.188s) [394.630109] Starting dynamic subtest: print [394.632383] Dynamic subtest print: SUCCESS (0.000s) [394.645850] Starting dynamic subtest: reuse [394.647816] Dynamic subtest reuse: SUCCESS (0.000s) [394.656595] Starting dynamic subtest: reserve [394.658525] Dynamic subtest reserve: SUCCESS (0.000s) [394.667370] Starting dynamic subtest: fork-reopen-allocator [394.669326] Dynamic subtest fork-reopen-allocator: SUCCESS (0.013s) [394.671340] Subtest simple-allocator: SUCCESS (0.211s) [394.744325] [121/133] (630s left) kms_dsc (dsc-with-bpc-formats) [394.830120] Starting subtest: dsc-with-bpc-formats [394.939538] Subtest dsc-with-bpc-formats: SKIP (0.003s) [394.980877] [122/133] (629s left) gem_sync (basic-store-each) [395.063900] Starting subtest: basic-store-each [397.391990] Subtest basic-store-each: SUCCESS (2.338s) [397.578512] [123/133] (627s left) gem_exec_schedule (implicit-read-write) [397.644900] Starting subtest: implicit-read-write [397.647335] Starting dynamic subtest: rcs0 [397.827217] Dynamic subtest rcs0: SUCCESS (0.189s) [397.840564] Starting dynamic subtest: vcs0 [397.929925] Dynamic subtest vcs0: SUCCESS (0.104s) [397.942994] Starting dynamic subtest: vcs1 [398.037921] Dynamic subtest vcs1: SUCCESS (0.107s) [398.050659] Starting dynamic subtest: vecs0 [398.138804] Dynamic subtest vecs0: SUCCESS (0.100s) [398.150809] Starting dynamic subtest: ccs0 [398.273384] Dynamic subtest ccs0: SUCCESS (0.134s) [398.276328] Subtest implicit-read-write: SUCCESS (0.638s) [399.047185] [124/133] (625s left) gem_lmem_swapping (verify) [399.090870] Subtest verify: SKIP (0.000s) [399.139363] [125/133] (625s left) gen9_exec_parse (bb-start-far) [399.214581] Subtest bb-start-far: SKIP (0.000s) [399.304269] [126/133] (625s left) kms_flip (2x-flip-vs-expired-vblank) [399.396653] Starting subtest: 2x-flip-vs-expired-vblank [399.405505] Subtest 2x-flip-vs-expired-vblank: SKIP (0.010s) [399.485705] [127/133] (625s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling) [399.575579] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling [399.579724] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s) [399.661128] [128/133] (625s left) kms_addfb_basic (master-rmfb) [399.712248] Starting subtest: master-rmfb [399.714167] Subtest master-rmfb: SUCCESS (0.001s) [399.847323] [129/133] (625s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers) [399.937715] Starting subtest: plane-downscale-factor-0-75-with-modifiers [399.939903] Starting dynamic subtest: pipe-A [400.321858] Dynamic subtest pipe-A: SUCCESS (0.386s) [400.331035] Starting dynamic subtest: pipe-B [401.775389] Dynamic subtest pipe-B: SUCCESS (1.452s) [401.785081] Starting dynamic subtest: pipe-C [403.246024] Dynamic subtest pipe-C: SUCCESS (1.467s) [403.256210] Starting dynamic subtest: pipe-D [404.656089] Dynamic subtest pipe-D: SUCCESS (1.412s) [404.658387] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.721s) [405.825229] [130/133] (619s left) kms_psr (psr-primary-mmap-gtt) [405.932666] Starting subtest: psr-primary-mmap-gtt [405.934857] Starting dynamic subtest: eDP-1 [407.321514] Dynamic subtest eDP-1: SKIP (1.386s) [407.326485] Subtest psr-primary-mmap-gtt: SKIP (1.388s) [407.481241] [131/133] (617s left) gem_exec_reloc (basic-gtt-cpu) [407.543062] Subtest basic-gtt-cpu: SKIP (0.000s) [407.624952] [132/133] (617s left) kms_flip (basic-flip-vs-wf_vblank) [407.719722] Starting subtest: basic-flip-vs-wf_vblank [407.721904] Starting dynamic subtest: A-eDP1 [409.595312] Dynamic subtest A-eDP1: SUCCESS (1.877s) [409.608509] Starting dynamic subtest: B-eDP1 [411.528457] Dynamic subtest B-eDP1: SUCCESS (1.930s) [411.543294] Starting dynamic subtest: C-eDP1 [413.448187] Dynamic subtest C-eDP1: SUCCESS (1.916s) [413.459614] Starting dynamic subtest: D-eDP1 [415.377391] Dynamic subtest D-eDP1: SUCCESS (1.928s) [415.382622] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.665s) [416.611777] [133/133] (608s left) gem_exec_params (batch-first) [416.669488] Starting subtest: batch-first [416.671576] Subtest batch-first: SUCCESS (0.006s) [416.799992] Closing watchdogs results: parsing output: 0/ for test: kms_frontbuffer_tracking results: parsing output: 1/ for test: syncobj_wait results: parsing output: 2/ for test: kms_vblank results: parsing output: 3/ for test: syncobj_timeline results: parsing output: 4/ for test: gem_mmap_gtt results: parsing output: 5/ for test: kms_rotation_crc results: parsing output: 6/ for test: gem_exec_schedule results: parsing output: 7/ for test: kms_plane results: parsing output: 8/ for test: syncobj_wait results: parsing output: 9/ for test: kms_getfb results: parsing output: 10/ for test: kms_frontbuffer_tracking results: parsing output: 11/ for test: kms_addfb_basic results: parsing output: 12/ for test: sysfs_defaults results: parsing output: 13/ for test: gem_ctx_persistence results: parsing output: 14/ for test: gem_render_copy results: parsing output: 15/ for test: drm_buddy results: parsing output: 16/ for test: kms_plane_scaling results: parsing output: 17/ for test: kms_ccs results: parsing output: 18/ for test: kms_big_fb results: parsing output: 19/ for test: gem_eio results: parsing output: 20/ for test: i915_pm_rpm results: parsing output: 21/ for test: gem_mmap_offset results: parsing output: 22/ for test: gem_exec_params results: parsing output: 23/ for test: kms_pipe_stress results: parsing output: 24/ for test: gem_exec_whisper results: parsing output: 25/ for test: kms_ccs results: parsing output: 26/ for test: syncobj_timeline results: parsing output: 27/ for test: perf_pmu results: parsing output: 28/ for test: kms_frontbuffer_tracking results: parsing output: 29/ for test: kms_frontbuffer_tracking results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: kms_chamelium_frames results: parsing output: 32/ for test: kms_prop_blob results: parsing output: 33/ for test: syncobj_timeline results: parsing output: 34/ for test: prime_vgem results: parsing output: 35/ for test: kms_universal_plane results: parsing output: 36/ for test: gem_ppgtt results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: kms_ccs results: parsing output: 40/ for test: syncobj_wait results: parsing output: 41/ for test: kms_big_fb results: parsing output: 42/ for test: kms_big_fb results: parsing output: 43/ for test: kms_big_fb results: parsing output: 44/ for test: kms_flip results: parsing output: 45/ for test: kms_frontbuffer_tracking results: parsing output: 46/ for test: kms_frontbuffer_tracking results: parsing output: 47/ for test: kms_frontbuffer_tracking results: parsing output: 48/ for test: prime_vgem results: parsing output: 49/ for test: syncobj_timeline results: parsing output: 50/ for test: api_intel_bb results: parsing output: 51/ for test: kms_psr2_sf results: parsing output: 52/ for test: kms_psr results: parsing output: 53/ for test: gem_exec_big results: parsing output: 54/ for test: sw_sync results: parsing output: 55/ for test: kms_frontbuffer_tracking results: parsing output: 56/ for test: kms_big_fb results: parsing output: 57/ for test: kms_frontbuffer_tracking results: parsing output: 58/ for test: kms_cursor_crc results: parsing output: 59/ for test: prime_vgem results: parsing output: 60/ for test: kms_frontbuffer_tracking results: parsing output: 61/ for test: kms_atomic_transition results: parsing output: 62/ for test: kms_frontbuffer_tracking results: parsing output: 63/ for test: kms_pm_rpm results: parsing output: 64/ for test: gem_exec_reloc results: parsing output: 65/ for test: gem_exec_params results: parsing output: 66/ for test: perf_pmu results: parsing output: 67/ for test: kms_rotation_crc results: parsing output: 68/ for test: gem_render_copy results: parsing output: 69/ for test: kms_atomic_transition results: parsing output: 70/ for test: kms_psr results: parsing output: 71/ for test: gem_spin_batch results: parsing output: 72/ for test: kms_color results: parsing output: 73/ for test: kms_lease results: parsing output: 74/ for test: kms_cursor_legacy results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: kms_setmode results: parsing output: 77/ for test: kms_cursor_crc results: parsing output: 78/ for test: kms_chamelium_hpd results: parsing output: 79/ for test: kms_big_fb results: parsing output: 80/ for test: syncobj_wait results: parsing output: 81/ for test: gem_eio results: parsing output: 82/ for test: gem_ctx_exec results: parsing output: 83/ for test: kms_ccs results: parsing output: 84/ for test: gem_lmem_swapping results: parsing output: 85/ for test: kms_frontbuffer_tracking results: parsing output: 86/ for test: kms_flip results: parsing output: 87/ for test: gem_blits results: parsing output: 88/ for test: syncobj_timeline results: parsing output: 89/ for test: kms_frontbuffer_tracking results: parsing output: 90/ for test: kms_frontbuffer_tracking results: parsing output: 91/ for test: kms_ccs results: parsing output: 92/ for test: gem_exec_fence results: parsing output: 93/ for test: sw_sync results: parsing output: 94/ for test: gem_userptr_blits results: parsing output: 95/ for test: gem_fenced_exec_thrash results: parsing output: 96/ for test: gem_mmap_gtt results: parsing output: 97/ for test: gem_exec_flush results: parsing output: 98/ for test: i915_suspend results: parsing output: 99/ for test: kms_busy results: parsing output: 100/ for test: kms_vblank results: parsing output: 101/ for test: gem_ctx_isolation results: parsing output: 102/ for test: syncobj_wait results: parsing output: 103/ for test: kms_flip_scaled_crc results: parsing output: 104/ for test: gem_exec_balancer results: parsing output: 105/ for test: kms_psr results: parsing output: 106/ for test: i915_drm_fdinfo results: parsing output: 107/ for test: kms_content_protection results: parsing output: 108/ for test: kms_psr results: parsing output: 109/ for test: i915_module_load results: parsing output: 110/ for test: gem_wait results: parsing output: 111/ for test: kms_frontbuffer_tracking results: parsing output: 112/ for test: kms_cursor_edge_walk results: parsing output: 113/ for test: syncobj_basic results: parsing output: 114/ for test: kms_fence_pin_leak results: parsing output: 115/ for test: kms_pm_lpsp results: parsing output: 116/ for test: kms_psr2_sf results: parsing output: 117/ for test: kms_plane results: parsing output: 118/ for test: kms_invalid_mode results: parsing output: 119/ for test: api_intel_allocator results: parsing output: 120/ for test: kms_dsc results: parsing output: 121/ for test: gem_sync results: parsing output: 122/ for test: gem_exec_schedule results: parsing output: 123/ for test: gem_lmem_swapping results: parsing output: 124/ for test: gen9_exec_parse results: parsing output: 125/ for test: kms_flip results: parsing output: 126/ for test: kms_flip_scaled_crc results: parsing output: 127/ for test: kms_addfb_basic results: parsing output: 128/ for test: kms_plane_scaling results: parsing output: 129/ for test: kms_psr results: parsing output: 130/ for test: gem_exec_reloc results: parsing output: 131/ for test: kms_flip results: parsing output: 132/ for test: gem_exec_params Done.