[57.474609] Initializing watchdogs [57.474656] /dev/watchdog0 [57.489456] [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] [57.494056] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.496350] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.500350] [001/133] (960s left) kms_cursor_crc (cursor-rapid-movement-256x85) [57.776190] Starting subtest: cursor-rapid-movement-256x85 [57.833407] Subtest cursor-rapid-movement-256x85: SKIP (0.051s) [57.981537] [002/133] (960s left) i915_query (hwconfig_table) [58.033054] Starting subtest: hwconfig_table [58.335966] Subtest hwconfig_table: SUCCESS (0.001s) [58.370429] [003/133] (959s left) gem_exec_params (larger-than-life-batch) [58.419350] Starting subtest: larger-than-life-batch [60.863952] Subtest larger-than-life-batch: SUCCESS (2.439s) [61.967512] [004/133] (956s left) kms_async_flips (test-time-stamp) [62.114677] Starting subtest: test-time-stamp [62.499623] Starting dynamic subtest: pipe-A-eDP-1 [63.277780] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.777s) [63.655550] Starting dynamic subtest: pipe-B-eDP-1 [64.416907] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.764s) [64.809492] Starting dynamic subtest: pipe-C-eDP-1 [65.565968] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.761s) [65.929702] Starting dynamic subtest: pipe-D-eDP-1 [66.695523] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.771s) [66.698040] Subtest test-time-stamp: SUCCESS (4.575s) [67.868094] [005/133] (950s left) gem_exec_flush (basic-uc-prw-default) [67.941956] Starting subtest: basic-uc-prw-default [73.428435] Subtest basic-uc-prw-default: SUCCESS (5.484s) [73.617879] [006/133] (944s left) gem_mmap (short-mmap) [73.680158] Subtest short-mmap: SKIP (0.000s) [73.742425] [007/133] (944s left) kms_prop_blob (invalid-get-prop) [73.789367] Starting subtest: invalid-get-prop [73.791682] Subtest invalid-get-prop: SUCCESS (0.000s) [73.881848] [008/133] (944s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs) [73.977902] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs [73.980275] Starting dynamic subtest: pipe-A-eDP-1 [73.989545] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [73.999150] Starting dynamic subtest: pipe-B-eDP-1 [74.009030] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [74.016832] Starting dynamic subtest: pipe-C-eDP-1 [74.025426] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [74.033198] Starting dynamic subtest: pipe-D-eDP-1 [74.042070] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [74.048350] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.003s) [76.236999] [009/133] (942s left) kms_psr (fbc-psr-dpms) [76.339686] Starting subtest: fbc-psr-dpms [76.342044] Starting dynamic subtest: eDP-1 [76.346218] Dynamic subtest eDP-1: SKIP (0.000s) [76.350368] Subtest fbc-psr-dpms: SKIP (0.000s) [76.413313] [010/133] (941s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt) [76.510654] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt [83.935060] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.424s) [84.065489] [011/133] (934s left) i915_pm_rpm (gem-evict-pwrite) [86.016110] Starting subtest: gem-evict-pwrite [86.021051] Subtest gem-evict-pwrite: SKIP (0.000s) [86.381670] [012/133] (932s left) kms_chamelium_color (ctm-blue-to-red) [86.473259] Subtest ctm-blue-to-red: SKIP (0.000s) [86.519518] [013/133] (931s left) syncobj_wait (invalid-single-wait-all-unsubmitted) [86.596620] Starting subtest: invalid-single-wait-all-unsubmitted [86.599051] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s) [86.672438] [014/133] (931s left) kms_addfb_basic (bad-pitch-0) [86.721418] Starting subtest: bad-pitch-0 [86.723567] Subtest bad-pitch-0: SUCCESS (0.000s) [86.844648] [015/133] (931s left) kms_frontbuffer_tracking (fbcpsr-suspend) [86.937505] Starting subtest: fbcpsr-suspend [127.861642] Subtest fbcpsr-suspend: SUCCESS (10.502s) [127.973782] [016/133] (890s left) kms_flip (flip-vs-expired-vblank) [128.082209] Starting subtest: flip-vs-expired-vblank [128.084507] Starting dynamic subtest: A-eDP1 [136.764346] Dynamic subtest A-eDP1: SUCCESS (8.643s) [136.776386] Starting dynamic subtest: B-eDP1 [145.428729] Dynamic subtest B-eDP1: SUCCESS (8.647s) [145.440321] Starting dynamic subtest: C-eDP1 [154.064133] Dynamic subtest C-eDP1: SUCCESS (8.627s) [154.072876] Starting dynamic subtest: D-eDP1 [162.701773] Dynamic subtest D-eDP1: SUCCESS (8.645s) [162.704457] Subtest flip-vs-expired-vblank: SUCCESS (34.571s) [163.873862] [017/133] (854s left) kms_color_pipeline (plane-ctm3x4) [163.976274] Starting subtest: plane-ctm3x4 [164.122449] Starting dynamic subtest: pipe-A-plane-0 [164.266609] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s) [164.276405] Starting dynamic subtest: pipe-A-plane-1 [164.434174] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s) [164.448355] Starting dynamic subtest: pipe-A-plane-2 [164.577213] Dynamic subtest pipe-A-plane-2: SUCCESS (0.143s) [165.763844] Starting dynamic subtest: pipe-B-plane-0 [165.900701] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s) [165.910562] Starting dynamic subtest: pipe-B-plane-1 [166.034023] Dynamic subtest pipe-B-plane-1: SUCCESS (0.133s) [166.042887] Starting dynamic subtest: pipe-B-plane-2 [166.167094] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s) [167.374064] Starting dynamic subtest: pipe-C-plane-0 [167.477785] Dynamic subtest pipe-C-plane-0: SUCCESS (0.111s) [167.487720] Starting dynamic subtest: pipe-C-plane-1 [167.588563] Dynamic subtest pipe-C-plane-1: SUCCESS (0.111s) [167.597764] Starting dynamic subtest: pipe-C-plane-2 [167.699574] Dynamic subtest pipe-C-plane-2: SUCCESS (0.111s) [168.909420] Starting dynamic subtest: pipe-D-plane-0 [169.023820] Dynamic subtest pipe-D-plane-0: SUCCESS (0.122s) [169.033504] Starting dynamic subtest: pipe-D-plane-1 [169.134795] Dynamic subtest pipe-D-plane-1: SUCCESS (0.111s) [169.144308] Starting dynamic subtest: pipe-D-plane-2 [169.245589] Dynamic subtest pipe-D-plane-2: SUCCESS (0.110s) [169.538106] Subtest plane-ctm3x4: SUCCESS (5.566s) [170.392701] [018/133] (848s left) gem_exec_schedule (preempt-hang) [170.579546] Starting subtest: preempt-hang [170.582331] Starting dynamic subtest: rcs0 [170.849167] Dynamic subtest rcs0: SUCCESS (0.269s) [170.860993] Starting dynamic subtest: bcs0 [171.081531] Dynamic subtest bcs0: SUCCESS (0.231s) [171.093140] Starting dynamic subtest: vcs0 [171.292205] Dynamic subtest vcs0: SUCCESS (0.212s) [171.305056] Starting dynamic subtest: vcs1 [171.500262] Dynamic subtest vcs1: SUCCESS (0.207s) [171.509182] Starting dynamic subtest: vecs0 [171.714012] Dynamic subtest vecs0: SUCCESS (0.212s) [171.723006] Starting dynamic subtest: ccs0 [171.944611] Dynamic subtest ccs0: SUCCESS (0.229s) [171.947033] Subtest preempt-hang: SUCCESS (1.366s) [172.407521] [019/133] (846s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping) [172.498234] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping [172.502607] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s) [172.575745] [020/133] (846s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size) [172.700551] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size [204.740003] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (32.040s) [205.625851] [021/133] (813s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180) [205.748354] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180 [206.728141] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.980s) [206.863747] [022/133] (811s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format) [206.948496] Starting subtest: plane-scaler-unity-scaling-with-pixel-format [206.950863] Starting dynamic subtest: pipe-A [208.163635] Dynamic subtest pipe-A: SUCCESS (1.217s) [208.172711] Starting dynamic subtest: pipe-B [210.467622] Dynamic subtest pipe-B: SUCCESS (2.302s) [210.478491] Starting dynamic subtest: pipe-C [211.716076] Dynamic subtest pipe-C: SUCCESS (1.247s) [211.725728] Starting dynamic subtest: pipe-D [212.943536] Dynamic subtest pipe-D: SUCCESS (1.226s) [212.945784] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.996s) [214.144935] [023/133] (804s left) prime_vgem (basic-fence-mmap) [214.270254] Starting subtest: basic-fence-mmap [214.275068] Subtest basic-fence-mmap: SKIP (0.000s) [214.359031] [FACT prime_vgem (basic-fence-mmap)] new: kernel.kmod_is_loaded.vgem: true [214.362631] [024/133] (804s left) gem_ctx_isolation (nonpriv-switch) [214.419827] Starting subtest: nonpriv-switch [214.422205] Starting dynamic subtest: rcs0 [214.716353] Dynamic subtest rcs0: SUCCESS (0.296s) [214.727731] Starting dynamic subtest: bcs0 [215.013121] Dynamic subtest bcs0: SUCCESS (0.296s) [215.025045] Starting dynamic subtest: vcs0 [215.281793] Dynamic subtest vcs0: SUCCESS (0.268s) [215.292573] Starting dynamic subtest: vcs1 [216.589898] Dynamic subtest vcs1: SUCCESS (1.307s) [216.600379] Starting dynamic subtest: vecs0 [218.617178] Dynamic subtest vecs0: SUCCESS (2.026s) [218.627562] Starting dynamic subtest: ccs0 [220.628410] Dynamic subtest ccs0: SUCCESS (2.010s) [220.630897] Subtest nonpriv-switch: SUCCESS (6.208s) [220.887366] [025/133] (798s left) kms_big_fb (x-tiled-32bpp-rotate-270) [220.996505] Starting subtest: x-tiled-32bpp-rotate-270 [221.020740] Subtest x-tiled-32bpp-rotate-270: SKIP (0.021s) [221.122397] [026/133] (797s left) gem_exec_balancer (persistence) [221.384706] Starting subtest: persistence [222.310067] Subtest persistence: SUCCESS (0.925s) [222.442771] [027/133] (796s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled) [222.502882] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [222.505307] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s) [222.592499] [028/133] (796s left) gem_eio (in-flight-contexts-immediate) [222.822008] Starting subtest: in-flight-contexts-immediate [236.339295] Subtest in-flight-contexts-immediate: SUCCESS (13.517s) [236.505132] [029/133] (782s left) gem_ctx_bad_destroy (invalid-pad) [236.565406] Starting subtest: invalid-pad [236.567702] Subtest invalid-pad: SUCCESS (0.000s) [236.636394] [030/133] (782s left) kms_flip (bo-too-big-interruptible) [236.723246] Starting subtest: bo-too-big-interruptible [236.725477] Starting dynamic subtest: A-eDP1 [237.988962] Dynamic subtest A-eDP1: SUCCESS (1.265s) [238.001165] Starting dynamic subtest: B-eDP1 [239.235641] Dynamic subtest B-eDP1: SUCCESS (1.244s) [239.247211] Starting dynamic subtest: C-eDP1 [240.573807] Dynamic subtest C-eDP1: SUCCESS (1.337s) [240.585241] Starting dynamic subtest: D-eDP1 [241.815892] Dynamic subtest D-eDP1: SUCCESS (1.240s) [241.821516] Subtest bo-too-big-interruptible: SUCCESS (5.096s) [243.033852] [031/133] (776s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff) [243.137827] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff [243.141986] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [243.251886] [032/133] (775s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt) [243.345098] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt [243.349636] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [243.451570] [033/133] (775s left) kms_lease (lease-unleased-crtc) [243.538217] Starting subtest: lease-unleased-crtc [243.540508] Starting dynamic subtest: pipe-A-eDP-1 [243.826909] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.290s) [243.836967] Starting dynamic subtest: pipe-B-eDP-1 [244.582980] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.750s) [244.595166] Starting dynamic subtest: pipe-C-eDP-1 [244.597092] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s) [244.606586] Starting dynamic subtest: pipe-D-eDP-1 [244.608708] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s) [244.610831] Subtest lease-unleased-crtc: SUCCESS (1.054s) [244.949896] [034/133] (774s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling) [245.051541] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling [245.053796] Starting dynamic subtest: pipe-A-default-mode [246.214998] Dynamic subtest pipe-A-default-mode: SKIP (1.160s) [246.219438] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.161s) [246.360302] [035/133] (773s left) kms_content_protection (lic-type-1) [246.501618] Starting subtest: lic-type-1 [246.506327] Subtest lic-type-1: SKIP (0.000s) [246.624328] [036/133] (772s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc) [246.715548] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc [246.717801] Starting dynamic subtest: pipe-A-eDP-1 [246.726868] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [246.738000] Starting dynamic subtest: pipe-B-eDP-1 [246.747046] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [246.757827] Starting dynamic subtest: pipe-C-eDP-1 [246.766197] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [246.775153] Starting dynamic subtest: pipe-D-eDP-1 [246.783609] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [246.787643] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s) [248.964999] [037/133] (770s left) gen9_exec_parse (valid-registers) [249.031222] Subtest valid-registers: SKIP (0.000s) [249.107776] [038/133] (770s left) gem_exec_balancer (nohangcheck) [249.389875] Starting subtest: nohangcheck [250.313385] Subtest nohangcheck: SUCCESS (0.923s) [250.441800] [039/133] (769s left) kms_psr (fbc-pr-cursor-render) [250.532274] Starting subtest: fbc-pr-cursor-render [250.536676] Subtest fbc-pr-cursor-render: SKIP (0.000s) [250.605789] [040/133] (768s left) gem_exec_whisper (basic-sync) [250.665291] Starting subtest: basic-sync [258.894288] Subtest basic-sync: SUCCESS (8.228s) [259.090990] [041/133] (760s left) kms_scaling_modes (scaling-mode-full) [259.178812] Starting subtest: scaling-mode-full [259.180795] Starting dynamic subtest: pipe-A-eDP-1 [259.282532] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.105s) [259.295147] Starting dynamic subtest: pipe-B-eDP-1 [260.477139] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.191s) [260.487558] Starting dynamic subtest: pipe-C-eDP-1 [261.586276] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.108s) [261.596380] Starting dynamic subtest: pipe-D-eDP-1 [262.724915] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.137s) [262.727292] Subtest scaling-mode-full: SUCCESS (3.549s) [263.896919] [042/133] (755s left) syncobj_timeline (transfer-timeline-point) [263.953540] Starting subtest: transfer-timeline-point [263.955754] Subtest transfer-timeline-point: SUCCESS (0.001s) [264.064430] [043/133] (755s left) syncobj_timeline (device-signal-unordered) [264.123868] Starting subtest: device-signal-unordered [264.126126] Subtest device-signal-unordered: SUCCESS (0.000s) [264.217949] [044/133] (755s left) kms_draw_crc (draw-method-render) [264.306565] Starting subtest: draw-method-render [264.308458] Starting dynamic subtest: xrgb8888-untiled [264.559558] Dynamic subtest xrgb8888-untiled: SUCCESS (0.255s) [264.570019] Starting dynamic subtest: rgb565-untiled [264.793065] Dynamic subtest rgb565-untiled: SUCCESS (0.233s) [264.803092] Starting dynamic subtest: xrgb2101010-untiled [265.059382] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.266s) [265.068764] Starting dynamic subtest: xbgr16161616f-untiled [265.303949] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.244s) [265.318174] Starting dynamic subtest: xrgb8888-xtiled [265.426276] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s) [265.436234] Starting dynamic subtest: rgb565-xtiled [265.559495] Dynamic subtest rgb565-xtiled: SUCCESS (0.132s) [265.569003] Starting dynamic subtest: xrgb2101010-xtiled [265.681687] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s) [265.691239] Starting dynamic subtest: xbgr16161616f-xtiled [265.803952] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.122s) [265.813150] Starting dynamic subtest: xrgb8888-4tiled [265.937379] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.133s) [265.947522] Starting dynamic subtest: rgb565-4tiled [266.059767] Dynamic subtest rgb565-4tiled: SUCCESS (0.122s) [266.070355] Starting dynamic subtest: xrgb2101010-4tiled [266.181851] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.121s) [266.191328] Starting dynamic subtest: xbgr16161616f-4tiled [266.315403] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.132s) [266.317209] Subtest draw-method-render: SUCCESS (2.011s) [266.434800] [045/133] (753s left) gem_pxp (reject-modify-context-protection-off-2) [266.561250] Starting subtest: reject-modify-context-protection-off-2 [266.563592] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s) [266.666158] [046/133] (753s left) gem_mmap_gtt (isolation) [266.714243] Subtest isolation: SKIP (0.000s) [266.767284] [047/133] (753s left) prime_mmap_coherency (read) [266.815429] Starting subtest: read [272.193866] Subtest read: SUCCESS (5.375s) [272.324132] [048/133] (747s left) gem_softpin (evict-snoop) [272.392408] Starting subtest: evict-snoop [272.397035] Subtest evict-snoop: SKIP (0.000s) [272.513272] [049/133] (747s left) kms_selftest (drm_format_helper) [272.561365] Starting subtest: drm_format_helper [272.623186] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8 [272.723963] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.099s) [272.734699] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332 [272.810213] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.087s) [272.820074] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565 [272.918584] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.105s) [272.927619] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555 [273.021604] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.104s) [273.032618] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555 [273.115889] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.093s) [273.125236] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551 [273.231783] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.114s) [273.241178] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888 [273.330965] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.098s) [273.339663] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888 [273.431017] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.100s) [273.439722] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888 [273.522171] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.090s) [273.531186] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010 [273.617393] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.096s) [273.626488] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010 [273.715904] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.095s) [273.724660] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono [273.820014] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.106s) [273.829169] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab [273.935828] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.112s) [273.944662] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888 [274.033198] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.096s) [274.041907] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888 [274.120396] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.089s) [274.135306] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset [274.231087] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.107s) [274.240982] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy [274.337577] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.106s) [274.339525] Subtest drm_format_helper: SUCCESS (1.774s) [274.517152] [050/133] (745s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing) [274.614044] Starting subtest: plane-all-transition-nonblocking-fencing [274.616403] Starting dynamic subtest: pipe-A-eDP-1 [277.108334] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s) [277.434226] Starting dynamic subtest: pipe-B-eDP-1 [280.623116] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.200s) [280.922540] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.307s) [281.748673] [051/133] (738s left) gen9_exec_parse (batch-invalid-length) [281.829905] Subtest batch-invalid-length: SKIP (0.000s) [281.896564] [052/133] (738s left) kms_hdr (bpc-switch-dpms) [281.992621] Starting subtest: bpc-switch-dpms [283.015541] Starting dynamic subtest: pipe-A-eDP-1 [287.554651] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.541s) [287.556995] Subtest bpc-switch-dpms: SUCCESS (5.564s) [287.667052] [053/133] (732s left) kms_big_fb (yf-tiled-64bpp-rotate-90) [287.762987] Starting subtest: yf-tiled-64bpp-rotate-90 [287.767571] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s) [287.861477] [054/133] (732s left) kms_vblank (ts-continuation-dpms-suspend) [287.964995] Starting subtest: ts-continuation-dpms-suspend [287.966960] Starting dynamic subtest: pipe-A-eDP-1 [304.776516] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.922s) [304.792025] Starting dynamic subtest: pipe-D-eDP-1 [322.764210] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.479s) [322.767004] Subtest ts-continuation-dpms-suspend: SUCCESS (4.405s) [323.573061] [055/133] (696s left) kms_psr (pr-cursor-render) [323.667626] Starting subtest: pr-cursor-render [323.671641] Subtest pr-cursor-render: SKIP (0.000s) [323.755014] [056/133] (696s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt) [323.851909] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt [323.856000] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [323.951155] [057/133] (696s left) gem_readwrite (new-obj) [324.016630] Subtest new-obj: SKIP (0.000s) [324.075224] [058/133] (696s left) kms_rotation_crc (primary-y-tiled-reflect-x-180) [324.179710] Starting subtest: primary-y-tiled-reflect-x-180 [324.256702] Subtest primary-y-tiled-reflect-x-180: SKIP (0.075s) [324.372495] [059/133] (695s left) kms_cursor_crc (cursor-sliding-256x256) [324.611760] Starting subtest: cursor-sliding-256x256 [324.615788] Starting dynamic subtest: pipe-A-eDP-1 [327.868070] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.237s) [327.898397] Starting dynamic subtest: pipe-D-eDP-1 [331.777714] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.874s) [331.780189] Subtest cursor-sliding-256x256: SUCCESS (7.138s) [332.675064] [060/133] (687s left) perf (gen12-invalid-class-instance) [332.833121] Starting subtest: gen12-invalid-class-instance [332.845144] Subtest gen12-invalid-class-instance: SUCCESS (0.011s) [332.894147] [061/133] (687s left) kms_cursor_legacy (cursorb-vs-flipb-legacy) [333.023968] Starting subtest: cursorB-vs-flipB-legacy [333.028472] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s) [333.171539] [062/133] (687s left) gem_mmap_gtt (cpuset-basic-small-copy-odd) [333.231061] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s) [333.295744] [063/133] (687s left) kms_psr (fbc-pr-sprite-blt) [333.390566] Starting subtest: fbc-pr-sprite-blt [333.394627] Subtest fbc-pr-sprite-blt: SKIP (0.000s) [333.478154] [064/133] (687s left) kms_busy (extended-modeset-hang-newfb) [333.599342] Starting subtest: extended-modeset-hang-newfb [333.603753] Starting dynamic subtest: pipe-A [368.597797] Dynamic subtest pipe-A: SUCCESS (34.976s) [368.607947] Starting dynamic subtest: pipe-D [391.556244] Dynamic subtest pipe-D: SUCCESS (22.954s) [391.558422] Subtest extended-modeset-hang-newfb: SUCCESS (57.936s) [392.356501] [065/133] (628s left) perf_pmu (busy-idle-no-semaphores) [392.405929] Starting subtest: busy-idle-no-semaphores [392.408518] Starting dynamic subtest: rcs0 [393.059291] Dynamic subtest rcs0: SUCCESS (0.653s) [393.072172] Starting dynamic subtest: bcs0 [393.710939] Dynamic subtest bcs0: SUCCESS (0.649s) [393.727795] Starting dynamic subtest: vcs0 [394.362478] Dynamic subtest vcs0: SUCCESS (0.649s) [394.375119] Starting dynamic subtest: vcs1 [396.330722] Dynamic subtest vcs1: SUCCESS (1.966s) [396.343514] Starting dynamic subtest: vecs0 [398.315168] Dynamic subtest vecs0: SUCCESS (1.981s) [398.328093] Starting dynamic subtest: ccs0 [400.298798] Dynamic subtest ccs0: SUCCESS (1.980s) [400.301440] Subtest busy-idle-no-semaphores: SUCCESS (7.892s) [400.420714] [066/133] (620s left) gem_softpin (invalid) [400.491140] Starting subtest: invalid [400.500822] Subtest invalid: SUCCESS (0.010s) [400.621627] [067/133] (620s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf) [400.724945] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf [400.727300] Starting dynamic subtest: pipe-A-eDP-1 [411.729789] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.006s) [411.742375] Starting dynamic subtest: pipe-B-eDP-1 [423.470325] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.736s) [423.472481] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (22.746s) [424.318465] [068/133] (596s left) kms_cursor_crc (cursor-size-change) [424.409350] Starting subtest: cursor-size-change [424.411629] Starting dynamic subtest: pipe-A-eDP-1 [425.230734] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.821s) [425.241304] Starting dynamic subtest: pipe-D-eDP-1 [426.667642] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.434s) [426.669837] Subtest cursor-size-change: SUCCESS (2.258s) [427.482735] [069/133] (593s left) kms_chamelium_hpd (vga-hpd-after-suspend) [427.876811] Subtest vga-hpd-after-suspend: SKIP (0.000s) [428.690927] [070/133] (592s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc) [428.804630] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc [428.809246] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [428.924927] [071/133] (591s left) kms_flip (2x-plain-flip) [429.010275] Starting subtest: 2x-plain-flip [429.022082] Subtest 2x-plain-flip: SKIP (0.011s) [429.116131] [072/133] (591s left) kms_chamelium_frames (dp-crc-multiple) [429.501505] Subtest dp-crc-multiple: SKIP (0.000s) [430.318710] [073/133] (590s left) api_intel_bb (render-ccs) [430.383954] Starting subtest: render-ccs [430.736342] Subtest render-ccs: SUCCESS (0.353s) [430.837948] [074/133] (590s left) syncobj_timeline (invalid-query-one-illegal-handle) [430.903006] Starting subtest: invalid-query-one-illegal-handle [430.905330] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s) [430.998747] [075/133] (590s left) kms_pm_rpm (cursor-dpms) [432.830724] Starting subtest: cursor-dpms [432.835217] Subtest cursor-dpms: SKIP (0.000s) [433.294954] [076/133] (587s left) kms_force_connector_basic (force-load-detect) [433.368013] Starting subtest: force-load-detect [433.372402] Subtest force-load-detect: SKIP (0.000s) [433.481712] [077/133] (587s left) kms_rmfb (close-fd) [433.584117] Starting subtest: close-fd [433.586391] Starting dynamic subtest: pipe-A-eDP-1 [433.692884] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.108s) [433.704673] Starting dynamic subtest: pipe-B-eDP-1 [434.845828] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.152s) [434.859308] Starting dynamic subtest: pipe-C-eDP-1 [436.069981] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.221s) [436.080047] Starting dynamic subtest: pipe-D-eDP-1 [437.191081] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.119s) [437.193350] Subtest close-fd: SUCCESS (3.607s) [438.397143] [078/133] (582s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation) [438.490908] Starting subtest: plane-upscale-factor-0-25-with-rotation [438.493166] Starting dynamic subtest: pipe-A [438.715554] Dynamic subtest pipe-A: SUCCESS (0.227s) [438.725814] Starting dynamic subtest: pipe-B [439.973596] Dynamic subtest pipe-B: SUCCESS (1.257s) [439.989074] Starting dynamic subtest: pipe-C [441.313783] Dynamic subtest pipe-C: SUCCESS (1.339s) [441.327349] Starting dynamic subtest: pipe-D [442.646633] Dynamic subtest pipe-D: SUCCESS (1.332s) [442.648912] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.159s) [443.822429] [079/133] (577s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt) [443.924007] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt [443.928568] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [444.037437] [080/133] (577s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen) [444.138653] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen [444.143075] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [444.244001] [081/133] (577s left) kms_pm_rpm (system-suspend-modeset) [445.772718] Starting subtest: system-suspend-modeset [465.751871] Subtest system-suspend-modeset: SUCCESS (4.588s) [466.128633] [082/133] (555s left) kms_pipe_crc_basic (nonblocking-crc) [466.230055] Starting subtest: nonblocking-crc [466.232512] Starting dynamic subtest: pipe-A-eDP-1 [466.977445] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.745s) [466.988751] Starting dynamic subtest: pipe-B-eDP-1 [468.443147] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.456s) [468.454373] Starting dynamic subtest: pipe-C-eDP-1 [469.822739] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.372s) [469.833539] Starting dynamic subtest: pipe-D-eDP-1 [471.168593] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.339s) [471.171022] Subtest nonblocking-crc: SUCCESS (4.918s) [471.981224] [083/133] (549s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt) [472.084096] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt [472.088241] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [472.187456] [084/133] (549s left) syncobj_timeline (etime-single-wait-available-unsubmitted) [472.243949] Starting subtest: etime-single-wait-available-unsubmitted [472.353873] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.107s) [472.434960] [085/133] (549s left) kms_cursor_crc (cursor-onscreen-512x512) [472.710936] Starting subtest: cursor-onscreen-512x512 [472.715755] Subtest cursor-onscreen-512x512: SKIP (0.001s) [472.861361] [086/133] (548s left) gem_exec_params (cliprects_ptr-dirt) [472.919468] Starting subtest: cliprects_ptr-dirt [472.921811] Subtest cliprects_ptr-dirt: SUCCESS (0.000s) [473.025856] [087/133] (548s left) gem_eio (wait-wedge-1us) [473.244785] Starting subtest: wait-wedge-1us [475.172456] Subtest wait-wedge-1us: SUCCESS (1.925s) [475.312179] [088/133] (546s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping) [475.399545] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping [475.403622] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping: SKIP (0.000s) [475.476210] [089/133] (546s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite) [475.572732] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite [475.576786] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [475.677472] [090/133] (546s left) gem_exec_reloc (basic-cpu-read-active) [475.742866] Subtest basic-cpu-read-active: SKIP (0.000s) [475.838759] [091/133] (545s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt) [475.945376] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt [475.949800] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [476.052971] [092/133] (545s left) gem_vm_create (invalid-create) [476.104637] Starting subtest: invalid-create [476.109188] Subtest invalid-create: SUCCESS (0.002s) [476.213539] [093/133] (545s left) kms_flip (flip-vs-dpms-on-nop-interruptible) [476.315843] Starting subtest: flip-vs-dpms-on-nop-interruptible [476.319958] Starting dynamic subtest: A-eDP1 [478.202454] Dynamic subtest A-eDP1: SUCCESS (1.867s) [478.214544] Starting dynamic subtest: B-eDP1 [480.025711] Dynamic subtest B-eDP1: SUCCESS (1.833s) [480.041763] Starting dynamic subtest: C-eDP1 [481.847980] Dynamic subtest C-eDP1: SUCCESS (1.817s) [481.858475] Starting dynamic subtest: D-eDP1 [483.680738] Dynamic subtest D-eDP1: SUCCESS (1.829s) [483.686830] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.356s) [484.865726] [094/133] (537s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc) [484.954204] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc [484.956360] Starting dynamic subtest: pipe-A-eDP-1 [484.976289] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [484.986851] Starting dynamic subtest: pipe-B-eDP-1 [485.005635] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [485.015348] Starting dynamic subtest: pipe-C-eDP-1 [485.034126] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [485.044677] Starting dynamic subtest: pipe-D-eDP-1 [485.063123] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [485.064906] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s) [487.163844] [095/133] (534s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt) [487.267751] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt [487.271755] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [487.369386] [096/133] (534s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite) [487.492536] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite [494.626567] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.131s) [494.755971] [097/133] (527s left) gem_exec_reloc (basic-gtt-cpu) [494.824207] Subtest basic-gtt-cpu: SKIP (0.000s) [494.889621] [098/133] (527s left) kms_cursor_legacy (flip-vs-cursor-atomic) [495.012961] Starting subtest: flip-vs-cursor-atomic [502.548083] Subtest flip-vs-cursor-atomic: SUCCESS (7.536s) [503.370998] [099/133] (518s left) kms_addfb_basic (basic-x-tiled-legacy) [503.420449] Starting subtest: basic-x-tiled-legacy [503.424913] Subtest basic-x-tiled-legacy: SKIP (0.000s) [503.558015] [100/133] (518s left) gem_basic (create-close) [503.610851] Starting subtest: create-close [503.614868] Subtest create-close: SUCCESS (0.000s) [503.709849] [101/133] (518s left) fbdev (pan) [503.751218] Starting subtest: pan [503.779510] Subtest pan: SUCCESS (0.030s) [503.852218] [102/133] (518s left) gem_ringfill (basic-all) [509.081530] Starting subtest: basic-all [510.239241] Subtest basic-all: SUCCESS (1.157s) [510.369767] [103/133] (511s left) kms_dp_aux_dev (basic) [510.418251] Starting subtest: basic [510.641095] Subtest basic: SUCCESS (0.223s) [510.716734] [104/133] (511s left) gem_exec_reloc (basic-gtt) [510.766369] Subtest basic-gtt: SKIP (0.000s) [510.846934] [105/133] (511s left) gem_exec_store (basic) [510.906254] Starting subtest: basic [510.999337] Subtest basic: SUCCESS (0.094s) [511.185880] [106/133] (511s left) gem_ctx_shared (detached-shared-gtt) [511.254973] Starting subtest: detached-shared-gtt [513.409840] Subtest detached-shared-gtt: SUCCESS (2.154s) [513.758273] [107/133] (508s left) gem_softpin (evict-prime-sanity-check) [513.823123] Starting subtest: evict-prime-sanity-check [513.825566] Starting dynamic subtest: rcs0 [514.969739] Dynamic subtest rcs0: SUCCESS (1.145s) [514.986174] Starting dynamic subtest: bcs0 [516.089540] Dynamic subtest bcs0: SUCCESS (1.116s) [516.104886] Starting dynamic subtest: vcs0 [518.029376] Dynamic subtest vcs0: SUCCESS (1.936s) [518.042475] Starting dynamic subtest: vcs1 [520.083405] Dynamic subtest vcs1: SUCCESS (2.051s) [520.095452] Starting dynamic subtest: vecs0 [522.003801] Dynamic subtest vecs0: SUCCESS (1.917s) [522.016624] Starting dynamic subtest: ccs0 [523.112241] Dynamic subtest ccs0: SUCCESS (1.107s) [523.122877] Starting dynamic subtest: all [524.242429] Dynamic subtest all: SUCCESS (1.128s) [524.245226] Subtest evict-prime-sanity-check: SUCCESS (10.417s) [524.325151] [108/133] (498s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs) [524.414187] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs [524.416455] Starting dynamic subtest: pipe-A-eDP-1 [524.438256] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [524.449786] Starting dynamic subtest: pipe-B-eDP-1 [524.470398] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [524.480563] Starting dynamic subtest: pipe-C-eDP-1 [524.501369] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [524.511255] Starting dynamic subtest: pipe-D-eDP-1 [524.532840] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [524.537211] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.004s) [526.665788] [109/133] (495s left) kms_psr (psr-basic) [526.768651] Starting subtest: psr-basic [526.770937] Starting dynamic subtest: eDP-1 [528.333267] Dynamic subtest eDP-1: SUCCESS (1.565s) [528.335813] Subtest psr-basic: SUCCESS (1.566s) [529.211180] [110/133] (493s left) core_getversion (basic) [529.249983] Starting subtest: basic [529.254085] Subtest basic: SUCCESS (0.000s) [529.311229] [111/133] (493s left) gem_softpin (overlap) [529.365560] Starting subtest: overlap [530.301899] Subtest overlap: SUCCESS (0.934s) [530.419051] [112/133] (492s left) gem_mmap_wc (bad-offset) [530.467531] Subtest bad-offset: SKIP (0.000s) [530.524883] [113/133] (492s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [530.616382] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip [530.620885] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s) [530.714886] [114/133] (492s left) gem_exec_suspend (basic-s4-devices) [530.782276] Starting subtest: basic-S4-devices [530.784769] Starting dynamic subtest: smem [541.077304] Dynamic subtest smem: SUCCESS (10.289s) [541.080828] Subtest basic-S4-devices: SUCCESS (10.290s) [548.308304] [115/133] (481s left) kms_joiner (invalid-modeset-force-ultra-joiner) [548.418680] Starting subtest: invalid-modeset-force-ultra-joiner [548.422973] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s) [548.485570] [116/133] (481s left) prime_self_import (basic-llseek-bad) [548.521741] Starting subtest: basic-llseek-bad [548.543585] Subtest basic-llseek-bad: SUCCESS (0.021s) [548.639495] [117/133] (481s left) vgem_basic (bad-handle) [548.687307] Starting subtest: bad-handle [548.689531] Subtest bad-handle: SUCCESS (0.000s) [548.745281] [118/133] (481s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [548.839815] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu [548.843912] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [548.937926] [119/133] (481s left) api_intel_allocator (reloc-allocator) [548.987436] Starting subtest: reloc-allocator [548.989813] Starting dynamic subtest: basic [548.991714] Dynamic subtest basic: SUCCESS (0.003s) [549.005858] Starting dynamic subtest: parallel-one [549.008239] Dynamic subtest parallel-one: SUCCESS (0.005s) [549.018945] Starting dynamic subtest: print [549.020805] Dynamic subtest print: SUCCESS (0.000s) [549.030901] Starting dynamic subtest: reuse [549.032816] Dynamic subtest reuse: SUCCESS (0.000s) [549.042675] Starting dynamic subtest: fork-reopen-allocator [549.044551] Dynamic subtest fork-reopen-allocator: SUCCESS (0.010s) [549.046448] Subtest reloc-allocator: SUCCESS (0.023s) [549.122466] [120/133] (480s left) gem_ctx_persistence (many-contexts) [549.175413] Starting subtest: many-contexts [594.363554] Subtest many-contexts: SUCCESS (45.179s) [594.447249] [121/133] (435s left) gem_exec_schedule (submit-golden-slice) [594.528109] Starting subtest: submit-golden-slice [594.530261] Starting dynamic subtest: rcs0 [594.584555] Dynamic subtest rcs0: SUCCESS (0.061s) [594.601181] Starting dynamic subtest: bcs0 [594.647855] Dynamic subtest bcs0: SUCCESS (0.062s) [594.661789] Starting dynamic subtest: vcs0 [594.703028] Dynamic subtest vcs0: SUCCESS (0.054s) [594.720035] Starting dynamic subtest: vcs1 [594.767029] Dynamic subtest vcs1: SUCCESS (0.063s) [594.780307] Starting dynamic subtest: vecs0 [594.816665] Dynamic subtest vecs0: SUCCESS (0.049s) [594.828874] Starting dynamic subtest: ccs0 [594.860073] Dynamic subtest ccs0: SUCCESS (0.043s) [594.862283] Subtest submit-golden-slice: SUCCESS (0.338s) [596.142747] [122/133] (434s left) kms_big_fb (linear-32bpp-rotate-180) [596.251750] Starting subtest: linear-32bpp-rotate-180 [597.780304] Subtest linear-32bpp-rotate-180: SUCCESS (1.527s) [597.912924] [123/133] (432s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move) [598.009767] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move [598.013126] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [598.105557] [124/133] (432s left) gem_exec_fence (parallel) [598.268798] Starting subtest: parallel [598.271324] Starting dynamic subtest: rcs0 [600.421367] Dynamic subtest rcs0: SUCCESS (2.153s) [600.433047] Starting dynamic subtest: bcs0 [602.576054] Dynamic subtest bcs0: SUCCESS (2.153s) [602.588537] Starting dynamic subtest: vcs0 [604.729173] Dynamic subtest vcs0: SUCCESS (2.152s) [604.743069] Starting dynamic subtest: vcs1 [606.882410] Dynamic subtest vcs1: SUCCESS (2.151s) [606.895613] Starting dynamic subtest: vecs0 [609.033613] Dynamic subtest vecs0: SUCCESS (2.150s) [609.045673] Starting dynamic subtest: ccs0 [611.182948] Dynamic subtest ccs0: SUCCESS (2.148s) [611.185006] Subtest parallel: SUCCESS (12.912s) [612.149619] [125/133] (418s left) kms_big_fb (4-tiled-8bpp-rotate-270) [612.260454] Starting subtest: 4-tiled-8bpp-rotate-270 [612.280439] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.020s) [612.399579] [126/133] (417s left) kms_properties (invalid-properties-legacy) [612.498592] Starting subtest: invalid-properties-legacy [612.606842] Subtest invalid-properties-legacy: SUCCESS (0.109s) [612.681792] [127/133] (417s left) prime_vgem (basic-blt) [612.760283] Starting subtest: basic-blt [612.788328] Subtest basic-blt: SUCCESS (0.027s) [612.918661] [128/133] (417s left) gem_compute (compute-square) [612.977583] Starting subtest: compute-square [612.984256] Subtest compute-square: SUCCESS (0.009s) [613.100056] [129/133] (417s left) gem_bad_reloc (negative-reloc-bltcopy) [613.167667] Subtest negative-reloc-bltcopy: SKIP (0.000s) [613.232644] [130/133] (417s left) gem_exec_create (basic) [613.302184] Starting subtest: basic [613.304651] Starting dynamic subtest: smem [617.045138] Dynamic subtest smem: SUCCESS (3.740s) [617.048076] Subtest basic: SUCCESS (3.742s) [617.246724] [131/133] (413s left) gem_request_retire (retire-vma-not-inactive) [617.314097] Starting subtest: retire-vma-not-inactive [617.379828] Subtest retire-vma-not-inactive: SUCCESS (0.063s) [617.507697] [132/133] (413s left) i915_hangman (engine-engine-error) [617.587521] Starting subtest: engine-engine-error [617.589867] Starting dynamic subtest: rcs0 [619.059230] Dynamic subtest rcs0: SUCCESS (1.469s) [619.073100] Starting dynamic subtest: bcs0 [621.042959] Dynamic subtest bcs0: SUCCESS (1.981s) [621.056540] Starting dynamic subtest: vcs0 [623.027019] Dynamic subtest vcs0: SUCCESS (1.981s) [623.043351] Starting dynamic subtest: vcs1 [625.011084] Dynamic subtest vcs1: SUCCESS (1.981s) [625.025116] Starting dynamic subtest: vecs0 [627.059949] Dynamic subtest vecs0: SUCCESS (2.046s) [627.073686] Starting dynamic subtest: ccs0 [629.043707] Dynamic subtest ccs0: SUCCESS (1.980s) [629.046696] Subtest engine-engine-error: SUCCESS (11.455s) [629.139954] [133/133] (401s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite) [629.249113] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite [629.253447] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [629.352116] Closing watchdogs results: parsing output: 0/ for test: kms_cursor_crc results: parsing output: 1/ for test: i915_query results: parsing output: 2/ for test: gem_exec_params results: parsing output: 3/ for test: kms_async_flips results: parsing output: 4/ for test: gem_exec_flush results: parsing output: 5/ for test: gem_mmap results: parsing output: 6/ for test: kms_prop_blob results: parsing output: 7/ for test: kms_ccs results: parsing output: 8/ for test: kms_psr results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: i915_pm_rpm results: parsing output: 11/ for test: kms_chamelium_color results: parsing output: 12/ for test: syncobj_wait results: parsing output: 13/ for test: kms_addfb_basic results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: kms_flip results: parsing output: 16/ for test: kms_color_pipeline results: parsing output: 17/ for test: gem_exec_schedule results: parsing output: 18/ for test: kms_plane results: parsing output: 19/ for test: kms_cursor_legacy results: parsing output: 20/ for test: kms_big_fb results: parsing output: 21/ for test: kms_plane_scaling results: parsing output: 22/ for test: prime_vgem results: parsing output: 23/ for test: gem_ctx_isolation results: parsing output: 24/ for test: kms_big_fb results: parsing output: 25/ for test: gem_exec_balancer results: parsing output: 26/ for test: syncobj_timeline results: parsing output: 27/ for test: gem_eio results: parsing output: 28/ for test: gem_ctx_bad_destroy results: parsing output: 29/ for test: kms_flip results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: kms_frontbuffer_tracking results: parsing output: 32/ for test: kms_lease results: parsing output: 33/ for test: kms_flip_scaled_crc results: parsing output: 34/ for test: kms_content_protection results: parsing output: 35/ for test: kms_ccs results: parsing output: 36/ for test: gen9_exec_parse results: parsing output: 37/ for test: gem_exec_balancer results: parsing output: 38/ for test: kms_psr results: parsing output: 39/ for test: gem_exec_whisper results: parsing output: 40/ for test: kms_scaling_modes results: parsing output: 41/ for test: syncobj_timeline results: parsing output: 42/ for test: syncobj_timeline results: parsing output: 43/ for test: kms_draw_crc results: parsing output: 44/ for test: gem_pxp results: parsing output: 45/ for test: gem_mmap_gtt results: parsing output: 46/ for test: prime_mmap_coherency results: parsing output: 47/ for test: gem_softpin results: parsing output: 48/ for test: kms_selftest results: parsing output: 49/ for test: kms_atomic_transition results: parsing output: 50/ for test: gen9_exec_parse results: parsing output: 51/ for test: kms_hdr results: parsing output: 52/ for test: kms_big_fb results: parsing output: 53/ for test: kms_vblank results: parsing output: 54/ for test: kms_psr results: parsing output: 55/ for test: kms_frontbuffer_tracking results: parsing output: 56/ for test: gem_readwrite results: parsing output: 57/ for test: kms_rotation_crc results: parsing output: 58/ for test: kms_cursor_crc results: parsing output: 59/ for test: perf results: parsing output: 60/ for test: kms_cursor_legacy results: parsing output: 61/ for test: gem_mmap_gtt results: parsing output: 62/ for test: kms_psr results: parsing output: 63/ for test: kms_busy results: parsing output: 64/ for test: perf_pmu results: parsing output: 65/ for test: gem_softpin results: parsing output: 66/ for test: kms_psr2_sf results: parsing output: 67/ for test: kms_cursor_crc results: parsing output: 68/ for test: kms_chamelium_hpd results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: kms_flip results: parsing output: 71/ for test: kms_chamelium_frames results: parsing output: 72/ for test: api_intel_bb results: parsing output: 73/ for test: syncobj_timeline results: parsing output: 74/ for test: kms_pm_rpm results: parsing output: 75/ for test: kms_force_connector_basic results: parsing output: 76/ for test: kms_rmfb results: parsing output: 77/ for test: kms_plane_scaling results: parsing output: 78/ for test: kms_frontbuffer_tracking results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: kms_pm_rpm results: parsing output: 81/ for test: kms_pipe_crc_basic results: parsing output: 82/ for test: kms_frontbuffer_tracking results: parsing output: 83/ for test: syncobj_timeline results: parsing output: 84/ for test: kms_cursor_crc results: parsing output: 85/ for test: gem_exec_params results: parsing output: 86/ for test: gem_eio results: parsing output: 87/ for test: kms_plane results: parsing output: 88/ for test: kms_frontbuffer_tracking results: parsing output: 89/ for test: gem_exec_reloc results: parsing output: 90/ for test: kms_frontbuffer_tracking results: parsing output: 91/ for test: gem_vm_create results: parsing output: 92/ for test: kms_flip results: parsing output: 93/ for test: kms_ccs results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: kms_frontbuffer_tracking results: parsing output: 96/ for test: gem_exec_reloc results: parsing output: 97/ for test: kms_cursor_legacy results: parsing output: 98/ for test: kms_addfb_basic results: parsing output: 99/ for test: gem_basic results: parsing output: 100/ for test: fbdev results: parsing output: 101/ for test: gem_ringfill results: parsing output: 102/ for test: kms_dp_aux_dev results: parsing output: 103/ for test: gem_exec_reloc results: parsing output: 104/ for test: gem_exec_store results: parsing output: 105/ for test: gem_ctx_shared results: parsing output: 106/ for test: gem_softpin results: parsing output: 107/ for test: kms_ccs results: parsing output: 108/ for test: kms_psr results: parsing output: 109/ for test: core_getversion results: parsing output: 110/ for test: gem_softpin results: parsing output: 111/ for test: gem_mmap_wc results: parsing output: 112/ for test: kms_big_fb results: parsing output: 113/ for test: gem_exec_suspend results: parsing output: 114/ for test: kms_joiner results: parsing output: 115/ for test: prime_self_import results: parsing output: 116/ for test: vgem_basic results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: api_intel_allocator results: parsing output: 119/ for test: gem_ctx_persistence results: parsing output: 120/ for test: gem_exec_schedule 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_fence results: parsing output: 124/ for test: kms_big_fb results: parsing output: 125/ for test: kms_properties results: parsing output: 126/ for test: prime_vgem results: parsing output: 127/ for test: gem_compute results: parsing output: 128/ for test: gem_bad_reloc results: parsing output: 129/ for test: gem_exec_create results: parsing output: 130/ for test: gem_request_retire results: parsing output: 131/ for test: i915_hangman results: parsing output: 132/ for test: kms_frontbuffer_tracking Done.