[57.016724] Initializing watchdogs [57.016770] /dev/watchdog0 [57.031576] [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.035893] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.038083] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.041419] [001/156] (960s left) kms_psr (pr-primary-mmap-gtt) [57.164144] Starting subtest: pr-primary-mmap-gtt [57.168593] Subtest pr-primary-mmap-gtt: SKIP (0.000s) [57.233931] [002/156] (960s left) perf (enable-disable) [57.345980] Starting subtest: enable-disable [57.348185] Starting dynamic subtest: 0-rcs0 [59.622428] Dynamic subtest 0-rcs0: SUCCESS (2.309s) [59.630059] Starting dynamic subtest: 1-vcs0 [64.128282] Dynamic subtest 1-vcs0: SUCCESS (4.548s) [64.130955] Subtest enable-disable: SUCCESS (6.858s) [64.174282] [003/156] (953s left) kms_cursor_crc (cursor-offscreen-512x512) [64.455613] Starting subtest: cursor-offscreen-512x512 [64.460226] Subtest cursor-offscreen-512x512: SKIP (0.001s) [64.619757] [004/156] (953s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-move) [64.709444] Starting subtest: psrhdr-1p-primscrn-cur-indfb-move [64.713867] Subtest psrhdr-1p-primscrn-cur-indfb-move: SKIP (0.000s) [64.808188] [005/156] (952s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs) [64.905052] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs [64.907310] Starting dynamic subtest: pipe-A-eDP-1 [64.930439] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [64.941655] Starting dynamic subtest: pipe-B-eDP-1 [64.962957] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [64.970215] Starting dynamic subtest: pipe-C-eDP-1 [64.991083] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [64.998309] Starting dynamic subtest: pipe-D-eDP-1 [65.020275] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [65.024263] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.003s) [67.157343] [006/156] (950s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [67.271685] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [67.275618] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [67.378396] [007/156] (950s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render) [67.470680] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render [74.837929] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.393s) [74.996144] [008/156] (942s left) gem_ctx_persistence (saturated-hostile) [75.060941] Starting subtest: saturated-hostile [75.062973] Starting dynamic subtest: rcs0 [75.888455] Dynamic subtest rcs0: SUCCESS (0.831s) [75.899204] Starting dynamic subtest: bcs0 [76.685439] Dynamic subtest bcs0: SUCCESS (0.797s) [76.695790] Starting dynamic subtest: vcs0 [77.491206] Dynamic subtest vcs0: SUCCESS (0.806s) [77.501205] Starting dynamic subtest: vcs1 [78.282077] Dynamic subtest vcs1: SUCCESS (0.791s) [78.293114] Starting dynamic subtest: vecs0 [79.092950] Dynamic subtest vecs0: SUCCESS (0.811s) [79.104992] Starting dynamic subtest: ccs0 [79.931850] Dynamic subtest ccs0: SUCCESS (0.839s) [79.934808] Subtest saturated-hostile: SUCCESS (4.879s) [80.020026] [009/156] (937s left) kms_cursor_edge_walk (128x128-top-edge) [80.112247] Starting subtest: 128x128-top-edge [80.114670] Starting dynamic subtest: pipe-A-eDP-1 [83.586634] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.475s) [83.596495] Starting dynamic subtest: pipe-D-eDP-1 [86.726264] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.137s) [86.728196] Subtest 128x128-top-edge: SUCCESS (6.614s) [87.542045] [010/156] (930s left) gem_caching (writes) [87.591560] Subtest writes: SKIP (0.000s) [87.657180] [011/156] (930s left) api_intel_bb (object-noreloc-keep-cache-simple) [87.699746] Starting subtest: object-noreloc-keep-cache-simple [87.701966] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.004s) [87.807047] [012/156] (930s left) prime_vgem (basic-blt) [87.938633] Starting subtest: basic-blt [87.962814] Subtest basic-blt: SUCCESS (0.026s) [88.079457] [FACT prime_vgem (basic-blt)] new: kernel.kmod_is_loaded.vgem: true [88.082373] [013/156] (929s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt) [88.187215] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt [88.191383] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [88.267585] [014/156] (929s left) kms_pm_backlight (bad-brightness) [88.354580] Starting subtest: bad-brightness [88.406311] Starting dynamic subtest: eDP-1 [88.728625] Dynamic subtest eDP-1: SUCCESS (0.321s) [88.730944] Subtest bad-brightness: SUCCESS (0.374s) [89.587210] [015/156] (928s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot) [89.701263] Starting subtest: modeset-atomic-cursor-hotspot [89.705784] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s) [89.847492] [016/156] (928s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted) [89.899208] Starting subtest: etime-single-wait-all-for-submit-unsubmitted [90.002774] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.103s) [90.079362] [017/156] (928s left) kms_async_flips (async-flip-hang) [90.172267] Starting subtest: async-flip-hang [90.543901] Starting dynamic subtest: pipe-A-eDP-1 [105.855669] Dynamic subtest pipe-A-eDP-1: SUCCESS (15.310s) [106.239033] Starting dynamic subtest: pipe-B-eDP-1 [121.850879] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.616s) [122.223854] Starting dynamic subtest: pipe-C-eDP-1 [137.791694] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.568s) [138.169609] Starting dynamic subtest: pipe-D-eDP-1 [153.782544] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.619s) [153.784820] Subtest async-flip-hang: SUCCESS (63.610s) [155.041949] [018/156] (863s left) kms_cursor_crc (cursor-random-32x10) [155.212893] Starting subtest: cursor-random-32x10 [155.263816] Subtest cursor-random-32x10: SKIP (0.045s) [155.526552] [019/156] (862s left) syncobj_timeline (reset-signaled) [155.580189] Starting subtest: reset-signaled [155.582833] Subtest reset-signaled: SUCCESS (0.001s) [155.692023] [020/156] (862s left) kms_hdmi_inject (inject-audio) [156.024031] Starting subtest: inject-audio [156.321289] Subtest inject-audio: SUCCESS (0.299s) [156.905965] [021/156] (861s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu) [157.006085] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu [160.597421] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.599s) [161.773152] [022/156] (856s left) perf_pmu (busy) [161.814685] Starting subtest: busy [161.816896] Starting dynamic subtest: rcs0 [162.406188] Dynamic subtest rcs0: SUCCESS (0.592s) [162.417595] Starting dynamic subtest: bcs0 [162.969215] Dynamic subtest bcs0: SUCCESS (0.561s) [162.981088] Starting dynamic subtest: vcs0 [164.318239] Dynamic subtest vcs0: SUCCESS (1.347s) [164.331777] Starting dynamic subtest: vcs1 [166.302508] Dynamic subtest vcs1: SUCCESS (1.982s) [166.313883] Starting dynamic subtest: vecs0 [168.351732] Dynamic subtest vecs0: SUCCESS (2.048s) [168.362973] Starting dynamic subtest: ccs0 [168.913092] Dynamic subtest ccs0: SUCCESS (0.561s) [168.915743] Subtest busy: SUCCESS (7.100s) [169.036649] [023/156] (849s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling) [169.143789] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling [169.148050] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s) [169.228387] [024/156] (849s left) gen9_exec_parse (secure-batches) [169.287734] Subtest secure-batches: SKIP (0.000s) [169.359233] [025/156] (849s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-render) [169.456230] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-render [169.460112] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [169.546229] [026/156] (849s left) gem_mmap_gtt (cpuset-basic-small-copy-xy) [169.604071] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s) [169.661042] [027/156] (848s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt) [169.767694] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt [169.771749] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [169.876769] [028/156] (848s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt) [169.979826] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt [169.983508] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [170.092112] [029/156] (848s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-mmap-wc) [170.195086] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-mmap-wc [170.198492] Subtest psrhdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [170.300714] [030/156] (848s left) kms_plane (pixel-format-yf-tiled-modifier-source-clamping) [170.390311] Starting subtest: pixel-format-yf-tiled-modifier-source-clamping [170.393722] Subtest pixel-format-yf-tiled-modifier-source-clamping: SKIP (0.000s) [170.460907] [031/156] (848s left) kms_flip (flip-vs-panning) [170.564583] Starting subtest: flip-vs-panning [170.566579] Starting dynamic subtest: A-eDP1 [179.340225] Dynamic subtest A-eDP1: SUCCESS (8.775s) [179.351487] Starting dynamic subtest: B-eDP1 [188.041457] Dynamic subtest B-eDP1: SUCCESS (8.702s) [188.054048] Starting dynamic subtest: C-eDP1 [196.721456] Dynamic subtest C-eDP1: SUCCESS (8.679s) [196.729940] Starting dynamic subtest: D-eDP1 [205.425273] Dynamic subtest D-eDP1: SUCCESS (8.703s) [205.429532] Subtest flip-vs-panning: SUCCESS (34.869s) [206.649544] [032/156] (812s left) prime_vgem (basic-fence-read) [206.718750] Starting subtest: basic-fence-read [206.727492] Subtest basic-fence-read: SKIP (0.006s) [206.827704] [033/156] (812s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-pwrite) [206.927779] Starting subtest: fbcpsrhdr-rgb101010-draw-pwrite [206.932198] Subtest fbcpsrhdr-rgb101010-draw-pwrite: SKIP (0.000s) [207.006758] [034/156] (811s left) gem_mmap_gtt (hang) [207.064799] Subtest hang: SKIP (0.000s) [207.123093] [035/156] (811s left) kms_content_protection (atomic-dpms-hdcp14) [207.251091] Starting subtest: atomic-dpms-hdcp14 [207.255347] Subtest atomic-dpms-hdcp14: SKIP (0.000s) [207.389715] [036/156] (811s left) gem_exec_reloc (basic-wc-cpu-noreloc) [207.442617] Subtest basic-wc-cpu-noreloc: SKIP (0.000s) [207.511691] [037/156] (811s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt) [207.608265] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt [207.611850] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [207.698159] [038/156] (811s left) gem_ctx_shared (q-smoketest-all) [207.768179] Starting subtest: Q-smoketest-all [240.160765] Subtest Q-smoketest-all: SUCCESS (32.343s) [241.432826] [039/156] (777s left) gem_exec_params (invalid-bsd2-flag-on-vebox) [241.487964] Starting subtest: invalid-bsd2-flag-on-vebox [241.490375] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s) [241.585265] [040/156] (777s left) kms_pm_dc (dc6-dpms) [242.682822] Starting subtest: dc6-dpms [244.797825] Subtest dc6-dpms: SUCCESS (2.114s) [244.886893] [041/156] (774s left) gem_vm_create (execbuf) [244.950515] Starting subtest: execbuf [244.960251] Subtest execbuf: SUCCESS (0.010s) [245.083916] [042/156] (774s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [245.175973] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu [245.180087] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [245.290845] [043/156] (773s left) kms_big_fb (x-tiled-32bpp-rotate-180) [245.392967] Starting subtest: x-tiled-32bpp-rotate-180 [246.748964] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.357s) [246.892997] [044/156] (772s left) gem_exec_reloc (basic-cpu-gtt-noreloc) [246.946147] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s) [247.015750] [045/156] (772s left) syncobj_wait (invalid-single-wait-all-unsubmitted) [247.065716] Starting subtest: invalid-single-wait-all-unsubmitted [247.067641] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s) [247.169295] [046/156] (772s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs) [247.226230] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs [247.229864] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s) [247.425162] [047/156] (771s left) syncobj_basic (test-valid-cycle) [247.475212] Starting subtest: test-valid-cycle [247.477573] Subtest test-valid-cycle: SUCCESS (0.000s) [247.578912] [048/156] (771s left) kms_psr (fbc-psr2-primary-page-flip) [247.673161] Starting subtest: fbc-psr2-primary-page-flip [247.675441] Starting dynamic subtest: eDP-1 [247.679603] Dynamic subtest eDP-1: SKIP (0.000s) [247.683709] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s) [247.745128] [049/156] (771s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite) [247.845138] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite [247.849441] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [247.929949] [050/156] (771s left) kms_atomic_transition (plane-all-modeset-transition) [248.022281] Starting subtest: plane-all-modeset-transition [248.026269] Subtest plane-all-modeset-transition: SKIP (0.000s) [248.095767] [051/156] (771s left) gem_exec_whisper (basic-normal-all) [248.160321] Starting subtest: basic-normal-all [250.409612] Subtest basic-normal-all: SUCCESS (2.250s) [250.608137] [052/156] (769s left) i915_drm_fdinfo (virtual-busy-hang) [250.643526] Starting subtest: virtual-busy-hang [250.647869] Subtest virtual-busy-hang: SKIP (0.000s) [250.711997] [053/156] (768s left) gem_exec_flush (basic-uc-prw-default) [250.767284] Starting subtest: basic-uc-prw-default [256.261874] Subtest basic-uc-prw-default: SUCCESS (5.493s) [256.444908] [054/156] (763s left) gem_mmap_offset (blt-coherency) [256.495344] Starting subtest: blt-coherency [256.505100] Subtest blt-coherency: SUCCESS (0.011s) [256.618942] [055/156] (763s left) perf_pmu (most-busy-idle-check-all) [256.659118] Starting subtest: most-busy-idle-check-all [256.661305] Starting dynamic subtest: rcs0 [258.335092] Dynamic subtest rcs0: SUCCESS (1.675s) [258.345095] Starting dynamic subtest: bcs0 [260.319549] Dynamic subtest bcs0: SUCCESS (1.982s) [260.331095] Starting dynamic subtest: vcs0 [262.303223] Dynamic subtest vcs0: SUCCESS (1.981s) [262.315722] Starting dynamic subtest: vcs1 [264.350658] Dynamic subtest vcs1: SUCCESS (2.046s) [264.360453] Starting dynamic subtest: vecs0 [266.335080] Dynamic subtest vecs0: SUCCESS (1.983s) [266.347240] Starting dynamic subtest: ccs0 [268.319197] Dynamic subtest ccs0: SUCCESS (1.982s) [268.322206] Subtest most-busy-idle-check-all: SUCCESS (11.660s) [268.418210] [056/156] (751s left) syncobj_timeline (single-wait-for-submit-signaled) [268.479376] Starting subtest: single-wait-for-submit-signaled [268.481721] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s) [268.592889] [057/156] (751s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt) [268.692852] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt [268.697109] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [268.789453] [058/156] (751s left) kms_selftest (drm_damage_helper) [268.826112] Starting subtest: drm_damage_helper [268.870785] Starting dynamic subtest: drm_test_damage_iter_no_damage [268.964546] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.094s) [268.973192] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src [269.060748] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.095s) [269.075864] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved [269.161374] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.099s) [269.169832] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved [269.277541] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.113s) [269.285638] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible [269.362701] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.085s) [269.370858] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc [269.457549] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.094s) [269.467818] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb [269.547043] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.090s) [269.556901] Starting dynamic subtest: drm_test_damage_iter_simple_damage [269.651790] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.104s) [269.661685] Starting dynamic subtest: drm_test_damage_iter_single_damage [269.759706] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.108s) [269.770059] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src [269.846684] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.086s) [269.856551] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src [269.935749] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.089s) [269.945697] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src [270.017200] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.080s) [270.025221] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src [270.099627] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.083s) [270.108688] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src [270.196455] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.094s) [270.204873] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved [270.284086] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.087s) [270.292163] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved [270.373688] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.091s) [270.381859] Starting dynamic subtest: drm_test_damage_iter_damage [270.477275] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.102s) [270.485277] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect [270.562018] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.084s) [270.569948] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside [270.647744] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.086s) [270.655832] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved [270.738074] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.089s) [270.745958] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible [270.816656] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.079s) [270.818552] Subtest drm_damage_helper: SUCCESS (1.991s) [270.961989] [059/156] (748s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt) [271.057110] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt [271.060687] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [271.148091] [060/156] (748s left) kms_atomic_transition (plane-toggle-modeset-transition) [271.243113] Starting subtest: plane-toggle-modeset-transition [271.244899] Starting dynamic subtest: pipe-A-eDP-1 [284.661420] Dynamic subtest pipe-A-eDP-1: SUCCESS (13.418s) [284.673069] Starting dynamic subtest: pipe-B-eDP-1 [297.861608] Dynamic subtest pipe-B-eDP-1: SUCCESS (13.198s) [297.864070] Subtest plane-toggle-modeset-transition: SUCCESS (26.621s) [298.746243] [061/156] (721s left) kms_psr (fbc-pr-cursor-blt) [298.867126] Starting subtest: fbc-pr-cursor-blt [298.871658] Subtest fbc-pr-cursor-blt: SKIP (0.000s) [298.939349] [062/156] (721s left) i915_pm_rps (thresholds-idle-park) [298.995122] Starting subtest: thresholds-idle-park [298.999284] Subtest thresholds-idle-park: SKIP (0.000s) [299.067457] [063/156] (720s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [299.178702] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu [306.178372] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.006s) [306.295089] [064/156] (713s left) kms_tv_load_detect (load-detect) [306.348241] Subtest load-detect: SKIP (0.000s) [306.403705] [065/156] (713s left) syncobj_timeline (invalid-signal-illegal-handle) [306.458218] Starting subtest: invalid-signal-illegal-handle [306.460646] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [306.573851] [066/156] (713s left) gem_ctx_param (invalid-get-ringsize) [306.640221] Starting subtest: invalid-get-ringsize [306.642637] Subtest invalid-get-ringsize: SUCCESS (0.001s) [306.757352] [067/156] (713s left) kms_joiner (basic-force-big-joiner) [306.858486] Starting subtest: basic-force-big-joiner [306.862711] Subtest basic-force-big-joiner: SKIP (0.000s) [306.938340] [068/156] (713s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs) [307.033966] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs [307.038472] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s) [308.128834] [069/156] (712s left) kms_big_fb (4-tiled-32bpp-rotate-0) [308.233172] Starting subtest: 4-tiled-32bpp-rotate-0 [309.701677] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.469s) [309.836637] [070/156] (710s left) fbdev (unaligned-write) [309.885207] Starting subtest: unaligned-write [309.988059] Subtest unaligned-write: SUCCESS (0.101s) [310.051092] [071/156] (710s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling) [310.134034] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling [310.138184] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s) [310.205443] [072/156] (710s left) gem_exec_schedule (u-semaphore-codependency) [310.275239] Starting subtest: u-semaphore-codependency [310.280748] Subtest u-semaphore-codependency: SUCCESS (0.012s) [310.608818] [073/156] (709s left) kms_vblank (query-busy-hang) [310.711868] Starting subtest: query-busy-hang [310.714172] Starting dynamic subtest: pipe-A-eDP-1 [337.114969] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.402s) [337.129072] Starting dynamic subtest: pipe-D-eDP-1 [352.095137] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.979s) [352.097514] Subtest query-busy-hang: SUCCESS (41.387s) [352.931298] [074/156] (667s left) gem_mmap_gtt (basic-small-bo-tiledy) [352.981649] Subtest basic-small-bo-tiledY: SKIP (0.000s) [353.037137] [075/156] (667s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [353.144570] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu [353.148924] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [353.248737] [076/156] (667s left) gem_create (create-massive) [353.316173] Starting subtest: create-massive [353.318352] Subtest create-massive: SUCCESS (0.000s) [353.500509] [077/156] (667s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite) [353.589442] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite [360.426978] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.843s) [360.575213] [078/156] (660s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs) [360.678741] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs [360.681073] Starting dynamic subtest: pipe-A-eDP-1 [360.690253] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [360.700388] Starting dynamic subtest: pipe-B-eDP-1 [360.709158] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [360.718158] Starting dynamic subtest: pipe-C-eDP-1 [360.726169] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [360.734641] Starting dynamic subtest: pipe-D-eDP-1 [360.742872] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [360.746823] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.004s) [362.930841] [079/156] (657s left) i915_pm_rc6_residency (rc6-fence) [362.986948] Starting subtest: rc6-fence [363.011858] Starting dynamic subtest: gt0 [377.334986] Dynamic subtest gt0: SUCCESS (14.303s) [377.346518] Starting dynamic subtest: gt1 [392.288422] Dynamic subtest gt1: SUCCESS (14.969s) [392.291111] Subtest rc6-fence: SUCCESS (29.301s) [392.368216] [080/156] (628s left) gem_exec_fence (syncobj-invalid-wait) [392.817100] Starting subtest: syncobj-invalid-wait [392.819250] Subtest syncobj-invalid-wait: SUCCESS (0.000s) [394.421388] [081/156] (626s left) kms_vrr (flip-basic) [394.507929] Starting subtest: flip-basic [394.514615] Subtest flip-basic: SKIP (0.000s) [394.581192] [082/156] (626s left) i915_pm_freq_api (freq-suspend) [394.639997] Starting subtest: freq-suspend [394.642154] Starting dynamic subtest: gt0 [412.000597] Dynamic subtest gt0: SUCCESS (2.515s) [412.010972] Starting dynamic subtest: gt1 [428.994073] Dynamic subtest gt1: SUCCESS (1.609s) [428.998230] Subtest freq-suspend: SUCCESS (4.127s) [439.158683] [083/156] (591s left) dmabuf_sync_file (import-basic) [439.228609] Starting subtest: import-basic [439.230478] Subtest import-basic: SUCCESS (0.002s) [439.310663] [084/156] (591s left) kms_frontbuffer_tracking (psrhdr-2p-rte) [439.415175] Starting subtest: psrhdr-2p-rte [439.419434] Subtest psrhdr-2p-rte: SKIP (0.000s) [439.507971] [085/156] (591s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing) [439.597878] Starting subtest: plane-use-after-nonblocking-unbind-fencing [439.600087] Starting dynamic subtest: pipe-A-eDP-1 [439.656705] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s) [439.958033] Starting dynamic subtest: pipe-B-eDP-1 [440.740354] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.819s) [441.030387] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.482s) [441.843331] [086/156] (589s left) kms_vblank (crtc-id) [441.942916] Starting subtest: crtc-id [441.945198] Starting dynamic subtest: pipe-A-eDP-1 [442.399874] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.467s) [442.415651] Starting dynamic subtest: pipe-D-eDP-1 [443.485869] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.111s) [443.488200] Subtest crtc-id: SUCCESS (1.582s) [444.284307] [087/156] (586s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-shrfb-pgflip-blt) [444.383387] Starting subtest: fbcpsrhdr-1p-primscrn-shrfb-pgflip-blt [444.387532] Subtest fbcpsrhdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [444.491439] [088/156] (586s left) kms_lease (lessee-list) [444.578343] Starting subtest: lessee-list [444.580722] Starting dynamic subtest: pipe-A-eDP-1 [444.583033] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [444.592925] Starting dynamic subtest: pipe-B-eDP-1 [444.594990] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [444.604591] Starting dynamic subtest: pipe-C-eDP-1 [444.606642] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [444.616415] Starting dynamic subtest: pipe-D-eDP-1 [444.618524] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [444.620584] Subtest lessee-list: SUCCESS (0.009s) [444.683820] [089/156] (586s left) kms_psr (fbc-psr-primary-mmap-cpu) [444.770717] Starting subtest: fbc-psr-primary-mmap-cpu [444.772904] Starting dynamic subtest: eDP-1 [444.776644] Dynamic subtest eDP-1: SKIP (0.000s) [444.780604] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s) [444.846599] [090/156] (586s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt) [444.941431] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt [444.945588] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [445.031342] [091/156] (586s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render) [445.129217] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render [449.532254] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.467s) [450.706292] [092/156] (580s left) kms_big_fb (yf-tiled-32bpp-rotate-90) [450.813591] Starting subtest: yf-tiled-32bpp-rotate-90 [450.817695] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s) [450.911350] [093/156] (580s left) api_intel_bb (blit-reloc-purge-cache) [450.964894] Starting subtest: blit-reloc-purge-cache [450.969439] Subtest blit-reloc-purge-cache: SKIP (0.000s) [451.092395] [094/156] (580s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier) [451.183141] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier [451.187555] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (0.000s) [451.254565] [095/156] (580s left) kms_frontbuffer_tracking (hdr-rgb565-draw-blt) [451.347888] Starting subtest: hdr-rgb565-draw-blt [451.351924] Subtest hdr-rgb565-draw-blt: SKIP (0.000s) [451.458198] [096/156] (580s left) sysfs_heartbeat_interval (precise) [451.511851] Starting subtest: precise [451.514166] Starting dynamic subtest: vecs0 [459.562056] Dynamic subtest vecs0: SUCCESS (8.089s) [459.575912] Starting dynamic subtest: ccs0 [462.495777] Dynamic subtest ccs0: SUCCESS (2.936s) [462.507691] Starting dynamic subtest: vcs0 [470.509879] Dynamic subtest vcs0: SUCCESS (8.023s) [470.522333] Starting dynamic subtest: bcs0 [473.511859] Dynamic subtest bcs0: SUCCESS (3.002s) [473.527281] Starting dynamic subtest: rcs0 [474.625378] Dynamic subtest rcs0: SUCCESS (1.113s) [474.636484] Starting dynamic subtest: vcs1 [482.546127] Dynamic subtest vcs1: SUCCESS (7.921s) [482.548737] Subtest precise: SUCCESS (31.096s) [482.639842] [097/156] (548s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite) [482.748899] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite [492.240432] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.501s) [492.358347] [098/156] (539s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite) [492.472689] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite [492.476688] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [492.563038] [099/156] (539s left) gem_flink_race (flink_close) [492.599543] Starting subtest: flink_close [497.698741] Subtest flink_close: SUCCESS (5.085s) [497.762702] [100/156] (533s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-blt) [497.875361] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-blt [497.879906] Subtest fbchdr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [498.002155] [101/156] (533s left) gem_exercise_blt (fast-copy) [498.057389] Starting subtest: fast-copy [498.059906] Starting dynamic subtest: linear-smem-smem [498.081372] Dynamic subtest linear-smem-smem: SUCCESS (0.024s) [498.093134] Starting dynamic subtest: xmajor-smem-smem [498.100300] Dynamic subtest xmajor-smem-smem: SUCCESS (0.018s) [498.109983] Starting dynamic subtest: tile4-smem-smem [498.118883] Dynamic subtest tile4-smem-smem: SUCCESS (0.018s) [498.128779] Starting dynamic subtest: tile64-smem-smem [498.136046] Dynamic subtest tile64-smem-smem: SUCCESS (0.016s) [498.138471] Subtest fast-copy: SUCCESS (0.079s) [498.251313] [102/156] (533s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-pwrite) [498.356617] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-pwrite [498.360660] Subtest hdr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [498.458874] [103/156] (533s left) kms_addfb_basic (addfb25-bad-modifier) [498.553144] Starting subtest: addfb25-bad-modifier [498.555296] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [498.664936] [104/156] (533s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-mmap-cpu) [498.764092] Starting subtest: fbchdr-rgb101010-draw-mmap-cpu [498.767450] Subtest fbchdr-rgb101010-draw-mmap-cpu: SKIP (0.000s) [498.857651] [105/156] (533s left) kms_frontbuffer_tracking (basic) [498.957006] Starting subtest: basic [502.218619] Subtest basic: SUCCESS (3.269s) [502.312800] [106/156] (529s left) kms_chamelium_color (degamma) [502.406089] Subtest degamma: SKIP (0.000s) [502.451818] [107/156] (529s left) gem_exec_fence (syncobj-wait) [502.881784] Starting subtest: syncobj-wait [504.567658] Subtest syncobj-wait: SUCCESS (1.689s) [504.906679] [108/156] (527s left) kms_big_fb (yf-tiled-8bpp-rotate-90) [505.016483] Starting subtest: yf-tiled-8bpp-rotate-90 [505.020871] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s) [505.120862] [109/156] (526s left) kms_frontbuffer_tracking (hdr-2p-primscrn-indfb-msflip-blt) [505.216745] Starting subtest: hdr-2p-primscrn-indfb-msflip-blt [505.221198] Subtest hdr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [505.323271] [110/156] (526s left) gem_pxp (fail-invalid-protected-context) [505.438704] Starting subtest: fail-invalid-protected-context [505.441460] Subtest fail-invalid-protected-context: SUCCESS (0.000s) [505.554274] [111/156] (526s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation) [505.639089] Starting subtest: plane-scaler-unity-scaling-with-rotation [505.640949] Starting dynamic subtest: pipe-A [505.863974] Dynamic subtest pipe-A: SUCCESS (0.228s) [505.873642] Starting dynamic subtest: pipe-B [507.156687] Dynamic subtest pipe-B: SUCCESS (1.292s) [507.167814] Starting dynamic subtest: pipe-C [508.455626] Dynamic subtest pipe-C: SUCCESS (1.299s) [508.466057] Starting dynamic subtest: pipe-D [509.755124] Dynamic subtest pipe-D: SUCCESS (1.299s) [509.757483] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.121s) [510.904953] [112/156] (521s left) kms_chamelium_hpd (dp-hpd-fast) [511.288288] Subtest dp-hpd-fast: SKIP (0.000s) [512.088523] [113/156] (520s left) kms_hdr (bpc-switch-suspend) [512.173678] Starting subtest: bpc-switch-suspend [512.176105] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010 [533.157474] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SUCCESS (6.115s) [533.168036] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F [554.148268] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SUCCESS (6.037s) [554.150741] Subtest bpc-switch-suspend: SUCCESS (12.155s) [563.330558] [114/156] (478s left) vgem_basic (create) [563.388168] Starting subtest: create [563.390575] Subtest create: SUCCESS (0.000s) [563.444996] [115/156] (477s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-pgflip-blt) [563.539077] Starting subtest: psrhdr-2p-scndscrn-shrfb-pgflip-blt [563.543199] Subtest psrhdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [563.639410] [116/156] (477s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc) [563.723516] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc [563.725944] Starting dynamic subtest: pipe-A-eDP-1 [564.206710] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.473s) [564.217643] Starting dynamic subtest: pipe-B-eDP-1 [565.634245] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.469s) [565.646175] Starting dynamic subtest: pipe-C-eDP-1 [567.024777] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.427s) [567.037143] Starting dynamic subtest: pipe-D-eDP-1 [568.397126] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.400s) [568.399086] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.773s) [569.543201] [117/156] (471s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-pwrite) [569.639957] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-pwrite [569.643717] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [569.750104] [118/156] (471s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-blt) [569.846453] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-blt [569.850799] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [569.956741] [119/156] (471s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled) [570.005842] Starting subtest: yf-tiled-ccs-to-yf-tiled [570.010287] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s) [570.189089] [120/156] (471s left) gem_exec_basic (basic) [570.257255] Starting subtest: basic [570.259634] Starting dynamic subtest: rcs0-smem [570.262035] Dynamic subtest rcs0-smem: SUCCESS (0.003s) [570.274232] Starting dynamic subtest: bcs0-smem [570.276177] Dynamic subtest bcs0-smem: SUCCESS (0.002s) [570.285617] Starting dynamic subtest: vcs0-smem [570.287517] Dynamic subtest vcs0-smem: SUCCESS (0.002s) [570.298417] Starting dynamic subtest: vcs1-smem [570.300415] Dynamic subtest vcs1-smem: SUCCESS (0.001s) [570.309837] Starting dynamic subtest: vecs0-smem [570.311769] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [570.321240] Starting dynamic subtest: ccs0-smem [570.323152] Dynamic subtest ccs0-smem: SUCCESS (0.002s) [570.325076] Subtest basic: SUCCESS (0.015s) [571.417773] [121/156] (470s left) kms_big_fb (y-tiled-64bpp-rotate-270) [571.525259] Starting subtest: y-tiled-64bpp-rotate-270 [571.530296] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s) [571.624112] [122/156] (470s left) kms_psr (psr2-sprite-render) [571.715188] Starting subtest: psr2-sprite-render [571.717303] Starting dynamic subtest: eDP-1 [573.455639] Dynamic subtest eDP-1: SUCCESS (1.760s) [573.457931] Subtest psr2-sprite-render: SUCCESS (1.761s) [574.281619] [123/156] (467s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-blt) [574.388111] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-blt [574.392599] Subtest fbchdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [574.499686] [124/156] (467s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-render) [574.593805] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-render [574.598312] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [574.686795] [125/156] (467s left) kms_chamelium_audio (dp-audio) [575.067806] Subtest dp-audio: SKIP (0.000s) [575.860728] [126/156] (466s left) gem_spin_batch (resubmit-new) [575.920314] Starting subtest: resubmit-new [575.922781] Starting dynamic subtest: rcs0 [575.930562] Dynamic subtest rcs0: SUCCESS (0.010s) [575.942868] Starting dynamic subtest: bcs0 [575.944741] Dynamic subtest bcs0: SUCCESS (0.004s) [575.955119] Starting dynamic subtest: vcs0 [575.957273] Dynamic subtest vcs0: SUCCESS (0.005s) [575.967155] Starting dynamic subtest: vcs1 [575.969017] Dynamic subtest vcs1: SUCCESS (0.005s) [575.978353] Starting dynamic subtest: vecs0 [575.980289] Dynamic subtest vecs0: SUCCESS (0.006s) [575.989635] Starting dynamic subtest: ccs0 [575.991572] Dynamic subtest ccs0: SUCCESS (0.004s) [575.993457] Subtest resubmit-new: SUCCESS (0.038s) [577.431168] [127/156] (464s left) gem_exec_schedule (manyslice) [577.519179] Starting subtest: manyslice [577.521558] Starting dynamic subtest: rcs0 [583.201916] Dynamic subtest rcs0: SUCCESS (5.664s) [583.220460] Starting dynamic subtest: bcs0 [590.348294] Dynamic subtest bcs0: SUCCESS (7.162s) [590.360681] Starting dynamic subtest: vcs0 [596.382274] Dynamic subtest vcs0: SUCCESS (6.091s) [596.397865] Starting dynamic subtest: vcs1 [603.032882] Dynamic subtest vcs1: SUCCESS (6.592s) [603.043705] Starting dynamic subtest: vecs0 [608.114296] Dynamic subtest vecs0: SUCCESS (5.078s) [608.128036] Starting dynamic subtest: ccs0 [614.774933] Dynamic subtest ccs0: SUCCESS (6.709s) [614.777677] Subtest manyslice: SUCCESS (37.307s) [615.085355] [128/156] (426s left) syncobj_wait (wait-for-submit-snapshot) [615.135144] Starting subtest: wait-for-submit-snapshot [615.216588] Subtest wait-for-submit-snapshot: SUCCESS (0.082s) [615.300225] [129/156] (426s left) kms_frontbuffer_tracking (fbcpsrhdr-stridechange) [615.409774] Starting subtest: fbcpsrhdr-stridechange [615.413961] Subtest fbcpsrhdr-stridechange: SKIP (0.000s) [615.513820] [130/156] (426s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt) [615.620969] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt [622.296032] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.682s) [622.423075] [131/156] (419s left) kms_flip (absolute-wf_vblank-interruptible) [622.514818] Starting subtest: absolute-wf_vblank-interruptible [622.517053] Starting dynamic subtest: A-eDP1 [631.269405] Dynamic subtest A-eDP1: SUCCESS (8.718s) [631.282457] Starting dynamic subtest: B-eDP1 [639.960065] Dynamic subtest B-eDP1: SUCCESS (8.691s) [639.970952] Starting dynamic subtest: C-eDP1 [648.665066] Dynamic subtest C-eDP1: SUCCESS (8.695s) [648.678818] Starting dynamic subtest: D-eDP1 [657.362262] Dynamic subtest D-eDP1: SUCCESS (8.696s) [657.364389] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.814s) [658.489321] [132/156] (383s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-blt) [658.600242] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-blt [658.604677] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [658.709839] [133/156] (383s left) kms_frontbuffer_tracking (fbchdr-1p-indfb-fliptrack-mmap-gtt) [658.811813] Starting subtest: fbchdr-1p-indfb-fliptrack-mmap-gtt [658.816096] Subtest fbchdr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [658.918509] [134/156] (383s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf) [659.028082] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf [659.032166] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s) [659.100422] [135/156] (383s left) kms_atomic (plane-overlay-legacy) [659.194497] Starting subtest: plane-overlay-legacy [659.196878] Starting dynamic subtest: pipe-A-eDP-1 [659.584541] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.389s) [659.586800] Subtest plane-overlay-legacy: SUCCESS (0.391s) [660.399593] [136/156] (381s left) gem_basic (create-close) [660.470620] Starting subtest: create-close [660.475360] Subtest create-close: SUCCESS (0.000s) [660.569895] [137/156] (381s left) kms_pm_rpm (pm-caching) [662.494322] Starting subtest: pm-caching [662.499220] Subtest pm-caching: SKIP (0.000s) [662.878198] [138/156] (379s left) gem_exec_balancer (bonded-false-hang) [663.138849] Starting subtest: bonded-false-hang [663.144369] Subtest bonded-false-hang: SKIP (0.000s) [663.237504] [139/156] (379s left) kms_dsc (dsc-with-bpc-formats) [663.323114] Starting subtest: dsc-with-bpc-formats [663.434564] Subtest dsc-with-bpc-formats: SKIP (0.003s) [663.474922] [140/156] (378s left) gem_exec_params (no-bsd) [663.530279] Starting subtest: no-bsd [663.532680] Subtest no-bsd: SUCCESS (0.002s) [665.443955] [141/156] (377s left) syncobj_wait (invalid-multi-wait-all-unsubmitted) [665.501058] Starting subtest: invalid-multi-wait-all-unsubmitted [665.503065] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s) [665.597990] [142/156] (376s left) template (b) [665.655044] Starting subtest: B [665.657342] Subtest B: SUCCESS (0.000s) [665.765615] [143/156] (376s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-mmap-gtt) [665.870142] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-mmap-gtt [665.874359] Subtest hdr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [665.996307] [144/156] (376s left) gem_exec_params (invalid-ring2) [666.070481] Starting subtest: invalid-ring2 [666.072744] Subtest invalid-ring2: SUCCESS (0.000s) [666.185886] [145/156] (376s left) gem_flink_basic (flink-lifetime) [666.241407] Starting subtest: flink-lifetime [666.243601] Subtest flink-lifetime: SUCCESS (0.002s) [666.359375] [146/156] (376s left) kms_big_fb (linear-32bpp-rotate-180) [666.451573] Starting subtest: linear-32bpp-rotate-180 [668.020039] Subtest linear-32bpp-rotate-180: SUCCESS (1.568s) [668.168216] [147/156] (374s left) syncobj_wait (invalid-reset-bad-pad) [668.214295] Starting subtest: invalid-reset-bad-pad [668.216030] Subtest invalid-reset-bad-pad: SUCCESS (0.000s) [668.307885] [148/156] (374s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-mmap-gtt) [668.396266] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-mmap-gtt [668.399729] Subtest hdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [668.497425] [149/156] (374s left) kms_plane_alpha_blend (coverage-7efc) [668.587021] Starting subtest: coverage-7efc [668.887238] Starting dynamic subtest: pipe-A-eDP-1 [669.497778] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.609s) [669.526257] Starting dynamic subtest: pipe-D-eDP-1 [670.911642] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.391s) [670.913930] Subtest coverage-7efc: SUCCESS (2.324s) [671.787467] [150/156] (371s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled) [671.835822] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled [671.939417] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.103s) [672.032120] [151/156] (370s left) perf (blocking) [672.144173] Starting subtest: blocking [672.146585] Starting dynamic subtest: 0-rcs0 [682.212936] Dynamic subtest 0-rcs0: SUCCESS (10.017s) [682.225520] Starting dynamic subtest: 1-vecs0 [692.181515] Dynamic subtest 1-vecs0: SUCCESS (10.019s) [692.184194] Subtest blocking: SUCCESS (20.039s) [692.234143] [152/156] (350s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite) [692.339729] Starting subtest: fbcpsr-rgb101010-draw-pwrite [697.485294] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (5.151s) [697.576925] [153/156] (345s left) kms_frontbuffer_tracking (fbc-1p-rte) [697.681096] Starting subtest: fbc-1p-rte [703.116773] Subtest fbc-1p-rte: SUCCESS (5.442s) [704.309083] [154/156] (338s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area) [704.411399] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area [704.414098] Starting dynamic subtest: pipe-A-eDP-1 [704.517575] Dynamic subtest pipe-A-eDP-1: SKIP (0.110s) [704.532540] Starting dynamic subtest: pipe-B-eDP-1 [705.656826] Dynamic subtest pipe-B-eDP-1: SKIP (1.137s) [705.661577] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.251s) [706.906664] [155/156] (336s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip) [707.005683] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip [707.010214] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s) [707.112108] [156/156] (336s left) kms_color (ctm-green-to-red) [707.207790] Starting subtest: ctm-green-to-red [707.209663] Starting dynamic subtest: pipe-A-eDP-1 [707.881567] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.675s) [707.894052] Starting dynamic subtest: pipe-B-eDP-1 [709.233319] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.350s) [709.245083] Starting dynamic subtest: pipe-C-eDP-1 [710.625187] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.393s) [710.636511] Starting dynamic subtest: pipe-D-eDP-1 [711.972384] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.345s) [711.974587] Subtest ctm-green-to-red: SUCCESS (4.765s) [712.782909] Closing watchdogs results: parsing output: 0/ for test: kms_psr results: parsing output: 1/ for test: perf results: parsing output: 2/ for test: kms_cursor_crc results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: kms_ccs results: parsing output: 5/ for test: kms_frontbuffer_tracking results: parsing output: 6/ for test: kms_frontbuffer_tracking results: parsing output: 7/ for test: gem_ctx_persistence results: parsing output: 8/ for test: kms_cursor_edge_walk results: parsing output: 9/ for test: gem_caching results: parsing output: 10/ for test: api_intel_bb results: parsing output: 11/ for test: prime_vgem results: parsing output: 12/ for test: kms_frontbuffer_tracking results: parsing output: 13/ for test: kms_pm_backlight results: parsing output: 14/ for test: kms_cursor_legacy results: parsing output: 15/ for test: syncobj_timeline results: parsing output: 16/ for test: kms_async_flips results: parsing output: 17/ for test: kms_cursor_crc results: parsing output: 18/ for test: syncobj_timeline results: parsing output: 19/ for test: kms_hdmi_inject results: parsing output: 20/ for test: kms_frontbuffer_tracking results: parsing output: 21/ for test: perf_pmu results: parsing output: 22/ for test: kms_flip_scaled_crc results: parsing output: 23/ for test: gen9_exec_parse results: parsing output: 24/ for test: kms_frontbuffer_tracking results: parsing output: 25/ for test: gem_mmap_gtt results: parsing output: 26/ for test: kms_frontbuffer_tracking results: parsing output: 27/ for test: kms_frontbuffer_tracking results: parsing output: 28/ for test: kms_frontbuffer_tracking results: parsing output: 29/ for test: kms_plane results: parsing output: 30/ for test: kms_flip results: parsing output: 31/ for test: prime_vgem results: parsing output: 32/ for test: kms_frontbuffer_tracking results: parsing output: 33/ for test: gem_mmap_gtt results: parsing output: 34/ for test: kms_content_protection results: parsing output: 35/ for test: gem_exec_reloc results: parsing output: 36/ for test: kms_frontbuffer_tracking results: parsing output: 37/ for test: gem_ctx_shared results: parsing output: 38/ for test: gem_exec_params results: parsing output: 39/ for test: kms_pm_dc results: parsing output: 40/ for test: gem_vm_create results: parsing output: 41/ for test: kms_frontbuffer_tracking results: parsing output: 42/ for test: kms_big_fb results: parsing output: 43/ for test: gem_exec_reloc results: parsing output: 44/ for test: syncobj_wait results: parsing output: 45/ for test: gem_render_copy results: parsing output: 46/ for test: syncobj_basic results: parsing output: 47/ for test: kms_psr results: parsing output: 48/ for test: kms_frontbuffer_tracking results: parsing output: 49/ for test: kms_atomic_transition results: parsing output: 50/ for test: gem_exec_whisper results: parsing output: 51/ for test: i915_drm_fdinfo results: parsing output: 52/ for test: gem_exec_flush results: parsing output: 53/ for test: gem_mmap_offset results: parsing output: 54/ for test: perf_pmu results: parsing output: 55/ for test: syncobj_timeline results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: kms_selftest results: parsing output: 58/ for test: kms_frontbuffer_tracking results: parsing output: 59/ for test: kms_atomic_transition results: parsing output: 60/ for test: kms_psr results: parsing output: 61/ for test: i915_pm_rps results: parsing output: 62/ for test: kms_frontbuffer_tracking results: parsing output: 63/ for test: kms_tv_load_detect results: parsing output: 64/ for test: syncobj_timeline results: parsing output: 65/ for test: gem_ctx_param results: parsing output: 66/ for test: kms_joiner results: parsing output: 67/ for test: kms_ccs results: parsing output: 68/ for test: kms_big_fb results: parsing output: 69/ for test: fbdev results: parsing output: 70/ for test: kms_flip_scaled_crc results: parsing output: 71/ for test: gem_exec_schedule results: parsing output: 72/ for test: kms_vblank results: parsing output: 73/ for test: gem_mmap_gtt results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: gem_create results: parsing output: 76/ for test: kms_frontbuffer_tracking results: parsing output: 77/ for test: kms_ccs results: parsing output: 78/ for test: i915_pm_rc6_residency results: parsing output: 79/ for test: gem_exec_fence results: parsing output: 80/ for test: kms_vrr results: parsing output: 81/ for test: i915_pm_freq_api results: parsing output: 82/ for test: dmabuf_sync_file results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: kms_atomic_transition results: parsing output: 85/ for test: kms_vblank results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: kms_lease results: parsing output: 88/ for test: kms_psr results: parsing output: 89/ for test: kms_frontbuffer_tracking results: parsing output: 90/ for test: kms_frontbuffer_tracking results: parsing output: 91/ for test: kms_big_fb results: parsing output: 92/ for test: api_intel_bb results: parsing output: 93/ for test: kms_plane results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: sysfs_heartbeat_interval results: parsing output: 96/ for test: kms_frontbuffer_tracking results: parsing output: 97/ for test: kms_frontbuffer_tracking results: parsing output: 98/ for test: gem_flink_race results: parsing output: 99/ for test: kms_frontbuffer_tracking results: parsing output: 100/ for test: gem_exercise_blt results: parsing output: 101/ for test: kms_frontbuffer_tracking results: parsing output: 102/ for test: kms_addfb_basic results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: kms_chamelium_color results: parsing output: 106/ for test: gem_exec_fence results: parsing output: 107/ for test: kms_big_fb results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: gem_pxp results: parsing output: 110/ for test: kms_plane_scaling results: parsing output: 111/ for test: kms_chamelium_hpd results: parsing output: 112/ for test: kms_hdr results: parsing output: 113/ for test: vgem_basic results: parsing output: 114/ for test: kms_frontbuffer_tracking results: parsing output: 115/ for test: kms_ccs results: parsing output: 116/ for test: kms_frontbuffer_tracking results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: gem_render_copy results: parsing output: 119/ for test: gem_exec_basic results: parsing output: 120/ for test: kms_big_fb results: parsing output: 121/ for test: kms_psr results: parsing output: 122/ for test: kms_frontbuffer_tracking results: parsing output: 123/ for test: kms_frontbuffer_tracking results: parsing output: 124/ for test: kms_chamelium_audio results: parsing output: 125/ for test: gem_spin_batch results: parsing output: 126/ for test: gem_exec_schedule results: parsing output: 127/ for test: syncobj_wait results: parsing output: 128/ for test: kms_frontbuffer_tracking results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: kms_flip results: parsing output: 131/ for test: kms_frontbuffer_tracking results: parsing output: 132/ for test: kms_frontbuffer_tracking results: parsing output: 133/ for test: kms_psr2_sf results: parsing output: 134/ for test: kms_atomic results: parsing output: 135/ for test: gem_basic results: parsing output: 136/ for test: kms_pm_rpm results: parsing output: 137/ for test: gem_exec_balancer results: parsing output: 138/ for test: kms_dsc results: parsing output: 139/ for test: gem_exec_params results: parsing output: 140/ for test: syncobj_wait results: parsing output: 141/ for test: template results: parsing output: 142/ for test: kms_frontbuffer_tracking results: parsing output: 143/ for test: gem_exec_params results: parsing output: 144/ for test: gem_flink_basic results: parsing output: 145/ for test: kms_big_fb results: parsing output: 146/ for test: syncobj_wait results: parsing output: 147/ for test: kms_frontbuffer_tracking results: parsing output: 148/ for test: kms_plane_alpha_blend results: parsing output: 149/ for test: syncobj_timeline results: parsing output: 150/ for test: perf results: parsing output: 151/ for test: kms_frontbuffer_tracking results: parsing output: 152/ for test: kms_frontbuffer_tracking results: parsing output: 153/ for test: kms_psr2_sf results: parsing output: 154/ for test: kms_big_fb results: parsing output: 155/ for test: kms_color Done.