[56.602302] Initializing watchdogs [56.602349] /dev/watchdog0 [56.616604] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [56.621115] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [56.623615] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [56.626895] [001/130] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc) [56.751744] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc [63.729796] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.043s) [63.838319] [002/130] (953s left) api_intel_allocator (two-level-inception) [63.901077] Starting subtest: two-level-inception [69.286619] Subtest two-level-inception: SUCCESS (5.405s) [69.457182] [003/130] (947s left) syncobj_timeline (wait-for-submit-delayed-submit) [69.536310] Starting subtest: wait-for-submit-delayed-submit [69.639267] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s) [69.725597] [004/130] (947s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling) [69.831099] Starting subtest: planes-downscale-factor-0-75-unity-scaling [69.833427] Starting dynamic subtest: pipe-A [69.897520] Dynamic subtest pipe-A: SUCCESS (0.068s) [69.907546] Starting dynamic subtest: pipe-B [71.090867] Dynamic subtest pipe-B: SUCCESS (1.195s) [71.101068] Starting dynamic subtest: pipe-C [72.195909] Dynamic subtest pipe-C: SUCCESS (1.106s) [72.205642] Starting dynamic subtest: pipe-D [73.308205] Dynamic subtest pipe-D: SUCCESS (1.114s) [73.310547] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.486s) [74.593525] [005/130] (942s left) kms_properties (connector-properties-atomic) [74.703232] Starting subtest: connector-properties-atomic [74.705159] Starting dynamic subtest: pipe-A-eDP-1 [82.560372] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.862s) [82.569630] Starting dynamic subtest: pipe-None-DP-1 [82.573695] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s) [82.580456] Starting dynamic subtest: pipe-None-HDMI-A-1 [82.584514] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s) [82.591397] Starting dynamic subtest: pipe-None-DP-2 [82.595350] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s) [82.601786] Starting dynamic subtest: pipe-None-HDMI-A-2 [82.605656] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s) [82.612260] Starting dynamic subtest: pipe-None-DP-3 [82.616106] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s) [82.622653] Starting dynamic subtest: pipe-None-DP-4 [82.627190] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s) [82.629580] Subtest connector-properties-atomic: SUCCESS (7.871s) [83.416922] [006/130] (933s left) gen3_mixed_blits [83.531241] [007/130] (933s left) gem_madvise (dontneed-before-pwrite) [83.566426] Starting subtest: dontneed-before-pwrite [83.587244] Subtest dontneed-before-pwrite: SKIP (0.019s) [83.649404] [008/130] (933s left) gem_ctx_isolation (dirty-create) [83.722076] Starting subtest: dirty-create [83.724556] Starting dynamic subtest: rcs0 [84.059545] Dynamic subtest rcs0: SUCCESS (0.338s) [84.067518] Starting dynamic subtest: bcs0 [84.293317] Dynamic subtest bcs0: SUCCESS (0.233s) [84.305831] Starting dynamic subtest: vcs0 [84.521486] Dynamic subtest vcs0: SUCCESS (0.228s) [84.530924] Starting dynamic subtest: vcs1 [86.491492] Dynamic subtest vcs1: SUCCESS (1.969s) [86.501568] Starting dynamic subtest: vecs0 [88.510487] Dynamic subtest vecs0: SUCCESS (2.018s) [88.520597] Starting dynamic subtest: ccs0 [90.502652] Dynamic subtest ccs0: SUCCESS (1.992s) [90.505092] Subtest dirty-create: SUCCESS (6.782s) [90.745187] [009/130] (926s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled) [90.811146] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled [90.913977] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.102s) [90.988182] [010/130] (926s left) kms_content_protection (lic-type-0) [91.139719] Starting subtest: lic-type-0 [91.144178] Subtest lic-type-0: SKIP (0.000s) [91.260486] [011/130] (926s left) kms_ccs (crc-primary-basic-yf-tiled-ccs) [91.351941] Starting subtest: crc-primary-basic-yf-tiled-ccs [91.354397] Starting dynamic subtest: pipe-A-eDP-1 [91.377859] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [91.388033] Starting dynamic subtest: pipe-B-eDP-1 [91.410073] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [91.417404] Starting dynamic subtest: pipe-C-eDP-1 [91.439206] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [91.446305] Starting dynamic subtest: pipe-D-eDP-1 [91.468538] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [91.472638] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.004s) [93.592648] [012/130] (924s left) kms_psr (psr-sprite-plane-move) [93.692248] Starting subtest: psr-sprite-plane-move [93.694400] Starting dynamic subtest: eDP-1 [95.421627] Dynamic subtest eDP-1: SUCCESS (1.730s) [95.424042] Subtest psr-sprite-plane-move: SUCCESS (1.731s) [96.242044] [013/130] (921s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs) [96.336277] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs [96.338553] Starting dynamic subtest: pipe-A-eDP-1 [96.361298] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [96.369632] Starting dynamic subtest: pipe-B-eDP-1 [96.391347] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [96.398718] Starting dynamic subtest: pipe-C-eDP-1 [96.420490] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [96.427855] Starting dynamic subtest: pipe-D-eDP-1 [96.451406] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [96.455568] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.004s) [98.624235] [014/130] (919s left) gem_readwrite (write-bad-handle) [98.675580] Subtest write-bad-handle: SKIP (0.000s) [98.727230] [015/130] (919s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs) [98.829869] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs [98.832164] Starting dynamic subtest: pipe-A-eDP-1 [98.854511] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [98.862382] Starting dynamic subtest: pipe-B-eDP-1 [98.883953] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [98.891387] Starting dynamic subtest: pipe-C-eDP-1 [98.912281] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [98.919347] Starting dynamic subtest: pipe-D-eDP-1 [98.940545] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [98.944494] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.003s) [100.984756] [016/130] (916s left) gem_fence_thrash (bo-write-verify-threaded-none) [101.033292] Starting subtest: bo-write-verify-threaded-none [101.052965] Subtest bo-write-verify-threaded-none: SKIP (0.018s) [101.114422] [017/130] (916s left) gem_exec_whisper (basic-queues-priority-all) [101.180763] Starting subtest: basic-queues-priority-all [123.430692] Subtest basic-queues-priority-all: SUCCESS (22.248s) [123.626250] [018/130] (894s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode) [124.009834] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s) [124.791926] [019/130] (893s left) syncobj_timeline (multi-wait-signaled) [124.847849] Starting subtest: multi-wait-signaled [124.850195] Subtest multi-wait-signaled: SUCCESS (0.000s) [124.942620] [020/130] (892s left) kms_big_fb (linear-addfb) [125.039635] Starting subtest: linear-addfb [125.041925] Subtest linear-addfb: SUCCESS (0.000s) [125.137391] [021/130] (892s left) kms_flip (basic-plain-flip) [125.235467] Starting subtest: basic-plain-flip [125.237952] Starting dynamic subtest: A-eDP1 [126.932581] Dynamic subtest A-eDP1: SUCCESS (1.696s) [126.942926] Starting dynamic subtest: B-eDP1 [128.576840] Dynamic subtest B-eDP1: SUCCESS (1.643s) [128.589313] Starting dynamic subtest: C-eDP1 [130.276573] Dynamic subtest C-eDP1: SUCCESS (1.698s) [130.284880] Starting dynamic subtest: D-eDP1 [131.917471] Dynamic subtest D-eDP1: SUCCESS (1.640s) [131.922096] Subtest basic-plain-flip: SUCCESS (6.687s) [133.077054] [022/130] (884s left) kms_color (invalid-ctm-matrix-sizes) [133.174456] Starting subtest: invalid-ctm-matrix-sizes [133.176624] Starting dynamic subtest: pipe-A [133.178885] Dynamic subtest pipe-A: SUCCESS (0.002s) [133.187052] Starting dynamic subtest: pipe-B [133.188944] Dynamic subtest pipe-B: SUCCESS (0.003s) [133.196653] Starting dynamic subtest: pipe-C [133.199061] Dynamic subtest pipe-C: SUCCESS (0.003s) [133.207311] Starting dynamic subtest: pipe-D [133.209636] Dynamic subtest pipe-D: SUCCESS (0.004s) [133.211504] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.013s) [133.265715] [023/130] (884s left) kms_cursor_edge_walk (128x128-left-edge) [133.364386] Starting subtest: 128x128-left-edge [133.366787] Starting dynamic subtest: pipe-A-eDP-1 [136.835326] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.470s) [136.843720] Starting dynamic subtest: pipe-D-eDP-1 [139.966709] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.130s) [139.969041] Subtest 128x128-left-edge: SUCCESS (6.602s) [140.777113] [024/130] (877s left) syncobj_timeline (etime-single-wait-submitted) [140.829810] Starting subtest: etime-single-wait-submitted [140.938649] Subtest etime-single-wait-submitted: SUCCESS (0.107s) [141.015576] [025/130] (877s left) gem_exec_params (larger-than-life-batch) [141.064904] Starting subtest: larger-than-life-batch [143.204936] Subtest larger-than-life-batch: SUCCESS (2.139s) [144.378186] [026/130] (873s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc) [144.522375] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc [148.532427] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (4.013s) [149.677401] [027/130] (868s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy) [149.779387] Starting subtest: fbcpsr-modesetfrombusy [155.961645] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.186s) [156.100394] [028/130] (862s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling) [156.212125] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling [156.214129] Starting dynamic subtest: pipe-A-default-mode [158.997588] Dynamic subtest pipe-A-default-mode: SUCCESS (2.785s) [158.999739] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.786s) [159.830306] [029/130] (858s left) gem_eio (wait-wedge-10ms) [160.067726] Starting subtest: wait-wedge-10ms [161.351684] Subtest wait-wedge-10ms: SUCCESS (1.284s) [161.490810] [030/130] (856s left) kms_selftest (drm_plane_helper) [161.541365] Starting subtest: drm_plane_helper [161.579925] Starting dynamic subtest: drm_test_check_plane_state [161.661553] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.083s) [161.672161] Starting dynamic subtest: drm_test_check_invalid_plane_state [161.768765] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.104s) [161.771125] Subtest drm_plane_helper: SUCCESS (0.230s) [161.941498] [031/130] (856s left) gem_mmap_offset (partial-mmap) [161.999967] Starting subtest: partial-mmap [162.002310] Starting dynamic subtest: smem0 [162.004678] Dynamic subtest smem0: SUCCESS (0.004s) [162.006917] Subtest partial-mmap: SUCCESS (0.004s) [162.127822] [032/130] (856s left) gem_mmap_gtt (basic-write-read) [162.183025] Subtest basic-write-read: SKIP (0.000s) [162.249328] [033/130] (856s left) kms_cdclk (plane-scaling) [162.340199] Starting subtest: plane-scaling [162.342521] Starting dynamic subtest: pipe-A-eDP-1 [162.626978] Dynamic subtest pipe-A-eDP-1: SKIP (0.286s) [162.640526] Starting dynamic subtest: pipe-B-eDP-1 [162.645030] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [162.654410] Starting dynamic subtest: pipe-C-eDP-1 [162.658960] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [162.668135] Starting dynamic subtest: pipe-D-eDP-1 [162.672164] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [162.676187] Subtest plane-scaling: SKIP (0.293s) [163.456400] [034/130] (855s left) gem_exec_flush (basic-batch-kernel-default-uc) [163.534223] Starting subtest: basic-batch-kernel-default-uc [170.758495] Subtest basic-batch-kernel-default-uc: SUCCESS (7.224s) [170.945285] [035/130] (847s left) gem_pxp (verify-pxp-execution-after-suspend-resume) [171.063731] Starting subtest: verify-pxp-execution-after-suspend-resume [178.218364] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.156s) [178.357614] [036/130] (840s left) kms_chamelium_frames (hdmi-crc-single) [178.755744] Subtest hdmi-crc-single: SKIP (0.000s) [179.561526] [037/130] (839s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [179.664876] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip [180.489665] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.826s) [180.637205] [038/130] (838s left) kms_flip (modeset-vs-vblank-race-interruptible) [180.733642] Starting subtest: modeset-vs-vblank-race-interruptible [180.736056] Starting dynamic subtest: A-eDP1 [185.430352] Dynamic subtest A-eDP1: SUCCESS (4.696s) [185.445213] Starting dynamic subtest: B-eDP1 [190.074191] Dynamic subtest B-eDP1: SUCCESS (4.640s) [190.086845] Starting dynamic subtest: C-eDP1 [194.615403] Dynamic subtest C-eDP1: SUCCESS (4.539s) [194.629389] Starting dynamic subtest: D-eDP1 [199.164523] Dynamic subtest D-eDP1: SUCCESS (4.546s) [199.166953] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.434s) [200.321438] [039/130] (818s left) kms_cursor_legacy (forked-bo) [200.453983] Starting subtest: forked-bo [200.456280] Starting dynamic subtest: pipe-A [205.946238] Dynamic subtest pipe-A: SUCCESS (5.463s) [205.961232] Starting dynamic subtest: pipe-B [211.396163] Dynamic subtest pipe-B: SUCCESS (5.472s) [211.408799] Starting dynamic subtest: pipe-C [216.874789] Dynamic subtest pipe-C: SUCCESS (5.478s) [216.886743] Starting dynamic subtest: pipe-D [222.339084] Dynamic subtest pipe-D: SUCCESS (5.462s) [222.352682] Starting dynamic subtest: all-pipes [227.829607] Dynamic subtest all-pipes: SUCCESS (5.489s) [227.832066] Subtest forked-bo: SUCCESS (27.375s) [227.969261] [040/130] (790s left) kms_rotation_crc (primary-y-tiled-reflect-x-90) [228.066544] Starting subtest: primary-y-tiled-reflect-x-90 [228.070813] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s) [228.137360] [041/130] (790s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner) [228.239808] Starting subtest: switch-modeset-ultra-joiner-big-joiner [228.244204] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s) [228.315091] [042/130] (790s left) kms_pipe_stress (stress-xrgb8888-4tiled) [228.406207] Starting subtest: stress-xrgb8888-4tiled [234.303363] Subtest stress-xrgb8888-4tiled: SUCCESS (5.898s) [234.359976] [043/130] (784s left) gem_exec_balancer (bonded-semaphore) [234.427677] Starting subtest: bonded-semaphore [234.431260] Subtest bonded-semaphore: SKIP (0.000s) [234.732032] [044/130] (784s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt) [234.832689] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt [234.837170] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [234.938251] [045/130] (783s left) gem_spin_batch (resubmit) [235.009425] Starting subtest: resubmit [235.011399] Starting dynamic subtest: rcs0 [235.016670] Dynamic subtest rcs0: SUCCESS (0.010s) [235.028174] Starting dynamic subtest: bcs0 [235.030262] Dynamic subtest bcs0: SUCCESS (0.003s) [235.039698] Starting dynamic subtest: vcs0 [235.041792] Dynamic subtest vcs0: SUCCESS (0.003s) [235.050873] Starting dynamic subtest: vcs1 [235.053054] Dynamic subtest vcs1: SUCCESS (0.003s) [235.062240] Starting dynamic subtest: vecs0 [235.064409] Dynamic subtest vecs0: SUCCESS (0.004s) [235.073980] Starting dynamic subtest: ccs0 [235.076147] Dynamic subtest ccs0: SUCCESS (0.003s) [235.078253] Subtest resubmit: SUCCESS (0.029s) [235.266253] [046/130] (783s left) gem_render_copy (y-tiled-to-vebox-y-tiled) [235.328610] Starting subtest: y-tiled-to-vebox-y-tiled [235.333064] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s) [235.509454] [047/130] (783s left) i915_pm_rc6_residency (rc6-accuracy) [235.563089] Starting subtest: rc6-accuracy [235.565373] Starting dynamic subtest: gt0 [238.734705] Dynamic subtest gt0: SUCCESS (3.168s) [238.747518] Starting dynamic subtest: gt1 [241.906449] Dynamic subtest gt1: SUCCESS (3.169s) [241.909052] Subtest rc6-accuracy: SUCCESS (6.343s) [241.981287] [048/130] (777s left) kms_psr (psr-cursor-mmap-gtt) [242.078089] Starting subtest: psr-cursor-mmap-gtt [242.080423] Starting dynamic subtest: eDP-1 [243.817793] Dynamic subtest eDP-1: SUCCESS (1.739s) [243.820090] Subtest psr-cursor-mmap-gtt: SUCCESS (1.739s) [244.684374] [049/130] (774s left) gem_ctx_exec (basic) [244.734919] Starting subtest: basic [244.740059] Subtest basic: SUCCESS (0.007s) [244.849357] [050/130] (774s left) kms_invalid_mode (int-max-clock) [244.936313] Starting subtest: int-max-clock [244.938596] Starting dynamic subtest: pipe-A-eDP-1 [245.224298] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s) [245.234779] Starting dynamic subtest: pipe-B-eDP-1 [245.237038] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [245.246737] Starting dynamic subtest: pipe-C-eDP-1 [245.248655] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [245.257773] Starting dynamic subtest: pipe-D-eDP-1 [245.259673] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [245.261622] Subtest int-max-clock: SUCCESS (0.292s) [246.029879] [051/130] (773s left) gem_exec_reloc (basic-wc-gtt) [246.085259] Subtest basic-wc-gtt: SKIP (0.000s) [246.156798] [052/130] (773s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier) [246.248217] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier [246.252282] Subtest pixel-format-4-tiled-bmg-ccs-modifier: SKIP (0.000s) [246.326310] [053/130] (772s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt) [246.425086] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt [253.870168] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.450s) [253.983146] [054/130] (765s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy) [254.053336] Starting subtest: map-fixed-invalidate-overlap-busy [254.057658] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s) [254.181877] [055/130] (765s left) kms_psr (pr-primary-mmap-cpu) [254.268754] Starting subtest: pr-primary-mmap-cpu [254.273214] Subtest pr-primary-mmap-cpu: SKIP (0.000s) [254.345636] [056/130] (765s left) gem_mmap_wc (write-gtt-read-wc) [254.409752] Subtest write-gtt-read-wc: SKIP (0.000s) [254.462924] [057/130] (764s left) syncobj_timeline (invalid-transfer-bad-pad) [254.526965] Starting subtest: invalid-transfer-bad-pad [254.528887] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s) [254.619578] [058/130] (764s left) kms_psr (fbc-psr2-cursor-mmap-cpu) [254.719703] Starting subtest: fbc-psr2-cursor-mmap-cpu [254.721796] Starting dynamic subtest: eDP-1 [254.725684] Dynamic subtest eDP-1: SKIP (0.000s) [254.729629] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s) [254.791658] [059/130] (764s left) gem_exec_reloc (basic-write-gtt) [254.859806] Subtest basic-write-gtt: SKIP (0.000s) [254.938107] [060/130] (764s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt) [255.033896] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt [255.037513] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [255.146648] [061/130] (764s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt) [255.237931] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt [259.747294] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.511s) [260.878922] [062/130] (758s left) gem_exec_balancer (parallel-keep-submit-fence) [261.139743] Starting subtest: parallel-keep-submit-fence [262.269491] Subtest parallel-keep-submit-fence: SUCCESS (1.129s) [262.389958] [063/130] (757s left) gem_ctx_persistence (legacy-engines-hostile) [262.448518] Starting subtest: legacy-engines-hostile [262.450904] Starting dynamic subtest: render [262.496542] Dynamic subtest render: SUCCESS (0.047s) [262.508997] Starting dynamic subtest: bsd1 [262.614652] Dynamic subtest bsd1: SUCCESS (0.117s) [262.638480] Starting dynamic subtest: bsd2 [262.692832] Dynamic subtest bsd2: SUCCESS (0.075s) [262.707753] Starting dynamic subtest: blt [262.829846] Dynamic subtest blt: SUCCESS (0.134s) [262.846226] Starting dynamic subtest: vebox [262.956091] Dynamic subtest vebox: SUCCESS (0.123s) [262.958807] Subtest legacy-engines-hostile: SUCCESS (0.508s) [263.046763] [064/130] (756s left) kms_busy (extended-pageflip-hang-newfb) [263.136737] Starting subtest: extended-pageflip-hang-newfb [263.139050] Starting dynamic subtest: pipe-A [289.049691] Dynamic subtest pipe-A: SUCCESS (25.912s) [289.061244] Starting dynamic subtest: pipe-D [304.142981] Dynamic subtest pipe-D: SUCCESS (15.090s) [304.145407] Subtest extended-pageflip-hang-newfb: SUCCESS (41.007s) [305.024972] [065/130] (714s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0) [305.123642] Starting subtest: linear-max-hw-stride-32bpp-rotate-0 [306.270772] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.146s) [306.391692] [066/130] (713s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite) [306.482889] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite [306.486642] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [306.592846] [067/130] (713s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [306.694850] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s) [306.813980] [068/130] (713s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt) [306.909082] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt [313.640067] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.732s) [313.752414] [069/130] (706s left) gem_basic (multigpu-create-close) [313.811096] Starting subtest: multigpu-create-close [313.815240] Subtest multigpu-create-close: SKIP (0.000s) [313.900934] [070/130] (706s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling) [314.002870] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling [314.007347] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s) [314.094423] [071/130] (705s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt) [314.192138] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt [314.196365] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [314.274458] [072/130] (705s left) kms_atomic (plane-invalid-params-fence) [314.377136] Starting subtest: plane-invalid-params-fence [314.379498] Starting dynamic subtest: pipe-A-eDP-1 [314.748717] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.372s) [314.751078] Subtest plane-invalid-params-fence: SUCCESS (0.374s) [315.583456] [073/130] (704s left) kms_atomic_transition (plane-all-modeset-transition-fencing) [315.668312] Starting subtest: plane-all-modeset-transition-fencing [315.672301] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s) [315.739450] [074/130] (704s left) kms_vblank (query-forked-busy) [315.831752] Starting subtest: query-forked-busy [315.834049] Starting dynamic subtest: pipe-A-eDP-1 [317.705094] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.873s) [317.721264] Starting dynamic subtest: pipe-D-eDP-1 [320.297160] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.587s) [320.299521] Subtest query-forked-busy: SUCCESS (4.465s) [321.151123] [075/130] (698s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite) [321.276910] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite [321.281046] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [321.372069] [076/130] (698s left) kms_flip (2x-flip-vs-expired-vblank) [321.467815] Starting subtest: 2x-flip-vs-expired-vblank [321.493303] Subtest 2x-flip-vs-expired-vblank: SKIP (0.024s) [321.595470] [077/130] (698s left) kms_atomic_interruptible (universal-setplane-cursor) [321.679971] Starting subtest: universal-setplane-cursor [321.682313] Starting dynamic subtest: pipe-A-eDP-1 [329.079646] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.396s) [329.081921] Subtest universal-setplane-cursor: SUCCESS (7.399s) [329.921336] [078/130] (690s left) kms_plane (plane-position-covered) [330.017775] Starting subtest: plane-position-covered [330.568601] Starting dynamic subtest: pipe-A-plane-1 [331.840637] Dynamic subtest pipe-A-plane-1: SUCCESS (1.273s) [331.850854] Starting dynamic subtest: pipe-A-plane-2 [333.153559] Dynamic subtest pipe-A-plane-2: SUCCESS (1.313s) [333.164904] Starting dynamic subtest: pipe-A-plane-3 [334.378966] Dynamic subtest pipe-A-plane-3: SUCCESS (1.222s) [334.390725] Starting dynamic subtest: pipe-A-plane-4 [335.602722] Dynamic subtest pipe-A-plane-4: SUCCESS (1.222s) [335.615082] Starting dynamic subtest: pipe-A-plane-5 [335.625260] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s) [336.790655] Starting dynamic subtest: pipe-B-plane-1 [338.054849] Dynamic subtest pipe-B-plane-1: SUCCESS (1.272s) [338.065382] Starting dynamic subtest: pipe-B-plane-2 [339.303125] Dynamic subtest pipe-B-plane-2: SUCCESS (1.248s) [339.314559] Starting dynamic subtest: pipe-B-plane-3 [340.536801] Dynamic subtest pipe-B-plane-3: SUCCESS (1.231s) [340.547784] Starting dynamic subtest: pipe-B-plane-4 [341.801065] Dynamic subtest pipe-B-plane-4: SUCCESS (1.265s) [341.811249] Starting dynamic subtest: pipe-B-plane-5 [341.825556] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s) [341.827748] Subtest plane-position-covered: SUCCESS (11.807s) [342.680967] [079/130] (677s left) kms_cursor_crc (cursor-offscreen-max-size) [342.986916] Starting subtest: cursor-offscreen-max-size [342.993308] Subtest cursor-offscreen-max-size: SKIP (0.000s) [343.111595] [080/130] (677s left) syncobj_wait (single-wait-submitted) [343.164198] Starting subtest: single-wait-submitted [343.273227] Subtest single-wait-submitted: SUCCESS (0.108s) [343.397283] [081/130] (676s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc) [343.489274] Starting subtest: fbc-rgb565-draw-mmap-wc [347.478192] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (3.992s) [348.666592] [082/130] (671s left) gem_exec_params (cliprects-invalid) [348.715136] Starting subtest: cliprects-invalid [348.717390] Subtest cliprects-invalid: SUCCESS (0.000s) [348.806508] [083/130] (671s left) gem_mmap_gtt (cpuset-big-copy) [348.858505] Subtest cpuset-big-copy: SKIP (0.000s) [348.922165] [084/130] (671s left) perf_pmu (busy-accuracy-50) [348.967941] Starting subtest: busy-accuracy-50 [348.970291] Starting dynamic subtest: rcs0 [350.504317] Dynamic subtest rcs0: SUCCESS (1.533s) [350.516562] Starting dynamic subtest: bcs0 [352.049320] Dynamic subtest bcs0: SUCCESS (1.544s) [352.060668] Starting dynamic subtest: vcs0 [353.592292] Dynamic subtest vcs0: SUCCESS (1.541s) [353.603502] Starting dynamic subtest: vcs1 [355.133462] Dynamic subtest vcs1: SUCCESS (1.540s) [355.145058] Starting dynamic subtest: vecs0 [356.677254] Dynamic subtest vecs0: SUCCESS (1.541s) [356.687483] Starting dynamic subtest: ccs0 [358.228673] Dynamic subtest ccs0: SUCCESS (1.548s) [358.230983] Subtest busy-accuracy-50: SUCCESS (9.259s) [358.346555] [085/130] (662s left) gem_mmap_gtt (fault-concurrent) [358.412726] Subtest fault-concurrent: SKIP (0.000s) [358.472373] [086/130] (662s left) kms_psr2_sf (pr-cursor-plane-update-sf) [358.565072] Starting subtest: pr-cursor-plane-update-sf [358.569066] Subtest pr-cursor-plane-update-sf: SKIP (0.000s) [358.634192] [087/130] (661s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt) [358.726614] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt [358.731055] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [358.819462] [088/130] (661s left) sw_sync (sync_expired_merge) [358.860848] Starting subtest: sync_expired_merge [359.935228] Subtest sync_expired_merge: SUCCESS (1.074s) [359.996635] [089/130] (660s left) kms_big_fb (yf-tiled-8bpp-rotate-90) [360.091573] Starting subtest: yf-tiled-8bpp-rotate-90 [360.095765] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s) [360.192128] [090/130] (660s left) kms_psr (fbc-pr-cursor-plane-move) [360.283873] Starting subtest: fbc-pr-cursor-plane-move [360.287966] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s) [360.367516] [091/130] (660s left) i915_drm_fdinfo (isolation) [360.413820] Starting subtest: isolation [360.415678] Starting dynamic subtest: rcs0 [360.433030] Dynamic subtest rcs0: SKIP (0.020s) [360.444470] Starting dynamic subtest: bcs0 [360.455825] Dynamic subtest bcs0: SKIP (0.022s) [360.466154] Starting dynamic subtest: vcs0 [360.470121] Dynamic subtest vcs0: SKIP (0.000s) [360.480369] Starting dynamic subtest: vcs1 [360.484696] Dynamic subtest vcs1: SKIP (0.000s) [360.494694] Starting dynamic subtest: vecs0 [360.498685] Dynamic subtest vecs0: SKIP (0.000s) [360.508048] Starting dynamic subtest: ccs0 [360.511975] Dynamic subtest ccs0: SKIP (0.000s) [360.515923] Subtest isolation: SKIP (0.048s) [360.551561] [092/130] (660s left) kms_frontbuffer_tracking (fbcpsr-tiling-4) [360.651447] Starting subtest: fbcpsr-tiling-4 [367.647044] Subtest fbcpsr-tiling-4: SUCCESS (6.997s) [367.770437] [093/130] (653s left) prime_vgem (busy) [367.918809] Starting subtest: busy [367.921150] Starting dynamic subtest: rcs0 [367.960827] Dynamic subtest rcs0: SUCCESS (0.042s) [367.971168] Starting dynamic subtest: bcs0 [368.015682] Dynamic subtest bcs0: SUCCESS (0.054s) [368.026195] Starting dynamic subtest: vcs0 [368.063163] Dynamic subtest vcs0: SUCCESS (0.047s) [368.073158] Starting dynamic subtest: vcs1 [368.108364] Dynamic subtest vcs1: SUCCESS (0.044s) [368.118886] Starting dynamic subtest: vecs0 [368.153484] Dynamic subtest vecs0: SUCCESS (0.045s) [368.163722] Starting dynamic subtest: ccs0 [368.199547] Dynamic subtest ccs0: SUCCESS (0.045s) [368.201693] Subtest busy: SUCCESS (0.281s) [368.338999] [FACT prime_vgem (busy)] new: kernel.kmod_is_loaded.vgem: true [368.342468] [094/130] (652s left) kms_hdr (bpc-switch-suspend) [368.435081] Starting subtest: bpc-switch-suspend [369.462572] Starting dynamic subtest: pipe-A-eDP-1 [389.011188] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.644s) [389.013444] Subtest bpc-switch-suspend: SUCCESS (5.671s) [389.118627] [095/130] (631s left) kms_cursor_crc (cursor-random-128x128) [389.368555] Starting subtest: cursor-random-128x128 [389.373145] Starting dynamic subtest: pipe-A-eDP-1 [392.694350] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.383s) [392.737150] Starting dynamic subtest: pipe-D-eDP-1 [396.652708] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.971s) [396.654832] Subtest cursor-random-128x128: SUCCESS (7.391s) [397.513715] [096/130] (623s left) core_debugfs (read-all-entries) [397.572788] Starting subtest: read-all-entries [397.670908] Subtest read-all-entries: SUCCESS (0.100s) [397.737912] [097/130] (623s left) gem_partial_pwrite_pread (writes-after-reads) [397.800264] Subtest writes-after-reads: SKIP (0.000s) [397.880890] [098/130] (623s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render) [397.978206] Starting subtest: fbc-rgb101010-draw-render [402.591346] Subtest fbc-rgb101010-draw-render: SUCCESS (4.642s) [403.767828] [099/130] (617s left) perf_pmu (gt-awake) [403.810316] Starting subtest: gt-awake [412.236308] Subtest gt-awake: SUCCESS (8.445s) [412.328056] [100/130] (608s left) kms_prop_blob (blob-prop-lifetime) [412.387852] Starting subtest: blob-prop-lifetime [412.390128] Subtest blob-prop-lifetime: SUCCESS (0.001s) [412.487338] [101/130] (608s left) kms_pm_rpm (cursor) [414.272089] Starting subtest: cursor [414.277130] Subtest cursor: SKIP (0.000s) [414.769072] [102/130] (606s left) gen9_exec_parse (secure-batches) [414.830900] Subtest secure-batches: SKIP (0.000s) [414.891112] [103/130] (606s left) kms_big_fb (4-tiled-32bpp-rotate-180) [415.000384] Starting subtest: 4-tiled-32bpp-rotate-180 [416.388195] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.390s) [416.525435] [104/130] (604s left) kms_dp_link_training (uhbr-sst) [416.631316] Starting subtest: uhbr-sst [416.638105] Subtest uhbr-sst: SKIP (0.000s) [416.718356] [105/130] (604s left) syncobj_timeline (single-wait-available-submitted) [416.763001] Starting subtest: single-wait-available-submitted [416.765067] Subtest single-wait-available-submitted: SUCCESS (0.000s) [416.858880] [106/130] (604s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs) [416.942690] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs [416.946465] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s) [418.088491] [107/130] (603s left) gem_softpin (evict-active) [418.150279] Starting subtest: evict-active [418.156212] Subtest evict-active: SUCCESS (0.005s) [418.258454] [108/130] (603s left) drm_mm (drm_mm) [418.296834] Starting subtest: drm_mm [418.334580] Starting dynamic subtest: drm_test_mm_init [418.440521] Dynamic subtest drm_test_mm_init: SUCCESS (0.106s) [418.450509] Starting dynamic subtest: drm_test_mm_debug [418.539207] Dynamic subtest drm_test_mm_debug: SUCCESS (0.097s) [418.550107] Starting dynamic subtest: drm_test_mm_align32 [418.636563] Dynamic subtest drm_test_mm_align32: SUCCESS (0.100s) [418.646593] Starting dynamic subtest: drm_test_mm_align64 [418.765464] Dynamic subtest drm_test_mm_align64: SUCCESS (0.125s) [418.776684] Starting dynamic subtest: drm_test_mm_lowest [418.877465] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.111s) [418.888621] Starting dynamic subtest: drm_test_mm_highest [418.978477] Dynamic subtest drm_test_mm_highest: SUCCESS (0.100s) [418.980653] Subtest drm_mm: SUCCESS (0.682s) [419.135945] [109/130] (602s left) prime_mmap (test_refcounting) [419.195860] Starting subtest: test_refcounting [419.198134] Starting dynamic subtest: test_refcounting-smem [419.224801] Dynamic subtest test_refcounting-smem: SUCCESS (0.030s) [419.227184] Subtest test_refcounting: SUCCESS (0.031s) [419.337513] [110/130] (602s left) kms_flip (wf_vblank-ts-check) [419.423773] Starting subtest: wf_vblank-ts-check [419.426046] Starting dynamic subtest: A-eDP1 [428.338098] Dynamic subtest A-eDP1: SUCCESS (8.910s) [428.350029] Starting dynamic subtest: B-eDP1 [437.273154] Dynamic subtest B-eDP1: SUCCESS (8.933s) [437.288422] Starting dynamic subtest: C-eDP1 [446.198658] Dynamic subtest C-eDP1: SUCCESS (8.924s) [446.210309] Starting dynamic subtest: D-eDP1 [455.131692] Dynamic subtest D-eDP1: SUCCESS (8.935s) [455.136759] Subtest wf_vblank-ts-check: SUCCESS (35.712s) [456.364724] [111/130] (565s left) gem_exec_whisper (basic-fds) [456.431295] Starting subtest: basic-fds [462.428122] Subtest basic-fds: SUCCESS (5.996s) [462.612433] [112/130] (559s left) gem_userptr_blits (userfault) [462.677693] Starting subtest: userfault [462.680095] Subtest userfault: SUCCESS (0.007s) [462.799806] [113/130] (558s left) kms_big_fb (y-tiled-64bpp-rotate-0) [462.903794] Starting subtest: y-tiled-64bpp-rotate-0 [462.907871] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s) [463.000984] [114/130] (558s left) i915_drm_fdinfo (virtual-idle) [463.048846] Starting subtest: virtual-idle [466.086916] Subtest virtual-idle: SUCCESS (3.036s) [466.173668] [115/130] (555s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite) [466.270935] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite [466.274929] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [466.357946] [116/130] (555s left) gem_create (create-size-update) [466.416295] Starting subtest: create-size-update [466.418155] Subtest create-size-update: SUCCESS (0.000s) [466.636862] [117/130] (555s left) kms_psr (fbc-psr-basic) [466.725621] Starting subtest: fbc-psr-basic [466.727898] Starting dynamic subtest: eDP-1 [466.732063] Dynamic subtest eDP-1: SKIP (0.000s) [466.736229] Subtest fbc-psr-basic: SKIP (0.001s) [466.800337] [118/130] (555s left) gem_exec_fence (parallel) [466.974360] Starting subtest: parallel [466.977284] Starting dynamic subtest: rcs0 [469.122947] Dynamic subtest rcs0: SUCCESS (2.150s) [469.133926] Starting dynamic subtest: bcs0 [471.276235] Dynamic subtest bcs0: SUCCESS (2.153s) [471.288578] Starting dynamic subtest: vcs0 [473.427565] Dynamic subtest vcs0: SUCCESS (2.151s) [473.439614] Starting dynamic subtest: vcs1 [475.579524] Dynamic subtest vcs1: SUCCESS (2.152s) [475.591888] Starting dynamic subtest: vecs0 [477.727655] Dynamic subtest vecs0: SUCCESS (2.148s) [477.742722] Starting dynamic subtest: ccs0 [479.875483] Dynamic subtest ccs0: SUCCESS (2.148s) [479.877496] Subtest parallel: SUCCESS (12.908s) [480.522625] [119/130] (541s left) i915_suspend (sysfs-reader) [480.592514] Starting subtest: sysfs-reader [498.879313] Subtest sysfs-reader: SUCCESS (3.135s) [498.945270] [120/130] (523s left) gem_ppgtt (shrink-vs-evict-pinned) [499.009483] Starting subtest: shrink-vs-evict-pinned [504.358373] Subtest shrink-vs-evict-pinned: SUCCESS (5.438s) [504.447653] [121/130] (517s left) gem_mmap_wc (copy) [504.520035] Subtest copy: SKIP (0.000s) [504.620531] [122/130] (517s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc) [504.731653] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc [508.360983] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.666s) [509.511267] [123/130] (512s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier) [509.620227] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier [509.647223] Starting dynamic subtest: pipe-A-plane-0 [509.934116] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s) [509.947440] Starting dynamic subtest: pipe-A-plane-3 [510.168656] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s) [510.183463] Starting dynamic subtest: pipe-A-plane-5 [510.188065] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [511.282114] Starting dynamic subtest: pipe-B-plane-0 [511.569938] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s) [511.581633] Starting dynamic subtest: pipe-B-plane-3 [511.802029] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s) [511.813025] Starting dynamic subtest: pipe-B-plane-5 [511.817472] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [512.123796] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.518s) [512.959583] [124/130] (509s left) syncobj_wait (invalid-reset-zero-handles) [513.013724] Starting subtest: invalid-reset-zero-handles [513.016004] Subtest invalid-reset-zero-handles: SUCCESS (0.000s) [513.106257] [125/130] (509s left) gem_exec_schedule (preemptive-hang) [513.281146] Starting subtest: preemptive-hang [513.283609] Starting dynamic subtest: rcs0 [522.489346] Dynamic subtest rcs0: SUCCESS (9.234s) [522.500246] Starting dynamic subtest: bcs0 [531.570979] Dynamic subtest bcs0: SUCCESS (9.083s) [531.584376] Starting dynamic subtest: vcs0 [540.534018] Dynamic subtest vcs0: SUCCESS (8.958s) [540.547117] Starting dynamic subtest: vcs1 [549.491344] Dynamic subtest vcs1: SUCCESS (8.958s) [549.504857] Starting dynamic subtest: vecs0 [558.510300] Dynamic subtest vecs0: SUCCESS (9.018s) [558.523223] Starting dynamic subtest: ccs0 [567.542083] Dynamic subtest ccs0: SUCCESS (9.032s) [567.544469] Subtest preemptive-hang: SUCCESS (54.294s) [567.793944] [126/130] (454s left) vgem_slow (nohang) [567.842811] Starting subtest: nohang [577.896515] Subtest nohang: SUCCESS (10.057s) [577.966970] [127/130] (444s left) gem_flink_race (flink_name) [577.999631] Starting subtest: flink_name [583.400337] Subtest flink_name: SUCCESS (5.393s) [583.507190] [128/130] (438s left) kms_addfb_basic (bad-pitch-32) [583.558958] Starting subtest: bad-pitch-32 [583.561532] Subtest bad-pitch-32: SUCCESS (0.000s) [583.685811] [129/130] (438s left) kms_addfb_basic (unused-pitches) [583.732207] Starting subtest: unused-pitches [583.734448] Subtest unused-pitches: SUCCESS (0.000s) [583.872185] [130/130] (438s left) gem_exec_schedule (submit-late-slice) [583.957756] Starting subtest: submit-late-slice [583.959702] Starting dynamic subtest: rcs0 [583.991872] Dynamic subtest rcs0: SUCCESS (0.037s) [584.004455] Starting dynamic subtest: bcs0 [584.020356] Dynamic subtest bcs0: SUCCESS (0.028s) [584.039544] Starting dynamic subtest: vcs0 [584.056189] Dynamic subtest vcs0: SUCCESS (0.034s) [584.071938] Starting dynamic subtest: vcs1 [584.090040] Dynamic subtest vcs1: SUCCESS (0.032s) [584.106161] Starting dynamic subtest: vecs0 [584.120775] Dynamic subtest vecs0: SUCCESS (0.030s) [584.131832] Starting dynamic subtest: ccs0 [584.149758] Dynamic subtest ccs0: SUCCESS (0.028s) [584.151981] Subtest submit-late-slice: SUCCESS (0.196s) [585.445498] Closing watchdogs results: parsing output: 0/ for test: kms_frontbuffer_tracking results: parsing output: 1/ for test: api_intel_allocator results: parsing output: 2/ for test: syncobj_timeline results: parsing output: 3/ for test: kms_plane_scaling results: parsing output: 4/ for test: kms_properties results: parsing output: 5/ for test: gen3_mixed_blits results: parsing output: 6/ for test: gem_madvise results: parsing output: 7/ for test: gem_ctx_isolation results: parsing output: 8/ for test: syncobj_timeline results: parsing output: 9/ for test: kms_content_protection results: parsing output: 10/ for test: kms_ccs results: parsing output: 11/ for test: kms_psr results: parsing output: 12/ for test: kms_ccs results: parsing output: 13/ for test: gem_readwrite results: parsing output: 14/ for test: kms_ccs results: parsing output: 15/ for test: gem_fence_thrash results: parsing output: 16/ for test: gem_exec_whisper results: parsing output: 17/ for test: kms_chamelium_hpd results: parsing output: 18/ for test: syncobj_timeline results: parsing output: 19/ for test: kms_big_fb results: parsing output: 20/ for test: kms_flip results: parsing output: 21/ for test: kms_color results: parsing output: 22/ for test: kms_cursor_edge_walk results: parsing output: 23/ for test: syncobj_timeline results: parsing output: 24/ for test: gem_exec_params results: parsing output: 25/ for test: kms_frontbuffer_tracking results: parsing output: 26/ for test: kms_frontbuffer_tracking results: parsing output: 27/ for test: kms_flip_scaled_crc results: parsing output: 28/ for test: gem_eio results: parsing output: 29/ for test: kms_selftest results: parsing output: 30/ for test: gem_mmap_offset results: parsing output: 31/ for test: gem_mmap_gtt results: parsing output: 32/ for test: kms_cdclk results: parsing output: 33/ for test: gem_exec_flush results: parsing output: 34/ for test: gem_pxp results: parsing output: 35/ for test: kms_chamelium_frames results: parsing output: 36/ for test: kms_big_fb results: parsing output: 37/ for test: kms_flip results: parsing output: 38/ for test: kms_cursor_legacy results: parsing output: 39/ for test: kms_rotation_crc results: parsing output: 40/ for test: kms_joiner results: parsing output: 41/ for test: kms_pipe_stress results: parsing output: 42/ for test: gem_exec_balancer results: parsing output: 43/ for test: kms_frontbuffer_tracking results: parsing output: 44/ for test: gem_spin_batch results: parsing output: 45/ for test: gem_render_copy results: parsing output: 46/ for test: i915_pm_rc6_residency results: parsing output: 47/ for test: kms_psr results: parsing output: 48/ for test: gem_ctx_exec results: parsing output: 49/ for test: kms_invalid_mode results: parsing output: 50/ for test: gem_exec_reloc results: parsing output: 51/ for test: kms_plane results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: gem_userptr_blits results: parsing output: 54/ for test: kms_psr results: parsing output: 55/ for test: gem_mmap_wc results: parsing output: 56/ for test: syncobj_timeline results: parsing output: 57/ for test: kms_psr results: parsing output: 58/ for test: gem_exec_reloc results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: kms_frontbuffer_tracking results: parsing output: 61/ for test: gem_exec_balancer results: parsing output: 62/ for test: gem_ctx_persistence results: parsing output: 63/ for test: kms_busy results: parsing output: 64/ for test: kms_big_fb results: parsing output: 65/ for test: kms_frontbuffer_tracking results: parsing output: 66/ for test: kms_addfb_basic results: parsing output: 67/ for test: kms_frontbuffer_tracking results: parsing output: 68/ for test: gem_basic results: parsing output: 69/ for test: kms_flip_scaled_crc results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: kms_atomic results: parsing output: 72/ for test: kms_atomic_transition results: parsing output: 73/ for test: kms_vblank results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: kms_flip results: parsing output: 76/ for test: kms_atomic_interruptible results: parsing output: 77/ for test: kms_plane results: parsing output: 78/ for test: kms_cursor_crc results: parsing output: 79/ for test: syncobj_wait results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: gem_exec_params results: parsing output: 82/ for test: gem_mmap_gtt results: parsing output: 83/ for test: perf_pmu results: parsing output: 84/ for test: gem_mmap_gtt results: parsing output: 85/ for test: kms_psr2_sf results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: sw_sync results: parsing output: 88/ for test: kms_big_fb results: parsing output: 89/ for test: kms_psr results: parsing output: 90/ for test: i915_drm_fdinfo results: parsing output: 91/ for test: kms_frontbuffer_tracking results: parsing output: 92/ for test: prime_vgem results: parsing output: 93/ for test: kms_hdr results: parsing output: 94/ for test: kms_cursor_crc results: parsing output: 95/ for test: core_debugfs results: parsing output: 96/ for test: gem_partial_pwrite_pread results: parsing output: 97/ for test: kms_frontbuffer_tracking results: parsing output: 98/ for test: perf_pmu results: parsing output: 99/ for test: kms_prop_blob results: parsing output: 100/ for test: kms_pm_rpm results: parsing output: 101/ for test: gen9_exec_parse results: parsing output: 102/ for test: kms_big_fb results: parsing output: 103/ for test: kms_dp_link_training results: parsing output: 104/ for test: syncobj_timeline results: parsing output: 105/ for test: kms_ccs results: parsing output: 106/ for test: gem_softpin results: parsing output: 107/ for test: drm_mm results: parsing output: 108/ for test: prime_mmap results: parsing output: 109/ for test: kms_flip results: parsing output: 110/ for test: gem_exec_whisper results: parsing output: 111/ for test: gem_userptr_blits results: parsing output: 112/ for test: kms_big_fb results: parsing output: 113/ for test: i915_drm_fdinfo results: parsing output: 114/ for test: kms_frontbuffer_tracking results: parsing output: 115/ for test: gem_create results: parsing output: 116/ for test: kms_psr results: parsing output: 117/ for test: gem_exec_fence results: parsing output: 118/ for test: i915_suspend results: parsing output: 119/ for test: gem_ppgtt results: parsing output: 120/ for test: gem_mmap_wc results: parsing output: 121/ for test: kms_frontbuffer_tracking results: parsing output: 122/ for test: kms_plane results: parsing output: 123/ for test: syncobj_wait results: parsing output: 124/ for test: gem_exec_schedule results: parsing output: 125/ for test: vgem_slow results: parsing output: 126/ for test: gem_flink_race results: parsing output: 127/ for test: kms_addfb_basic results: parsing output: 128/ for test: kms_addfb_basic results: parsing output: 129/ for test: gem_exec_schedule Done.