[56.379316] Initializing watchdogs [56.379387] /dev/watchdog0 [56.394642] [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.399212] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [56.402412] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [56.405831] [001/155] (960s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-mmap-wc) [56.538626] Starting subtest: fbcpsrhdr-rgb101010-draw-mmap-wc [56.542641] Subtest fbcpsrhdr-rgb101010-draw-mmap-wc: SKIP (0.000s) [56.652492] [002/155] (960s left) gem_mmap_gtt (basic-write) [56.699649] Subtest basic-write: SKIP (0.000s) [56.751160] [003/155] (960s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs) [56.835602] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs [56.840186] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s) [58.006814] [004/155] (959s left) kms_big_fb (yf-tiled-64bpp-rotate-180) [58.118512] Starting subtest: yf-tiled-64bpp-rotate-180 [58.122808] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s) [58.212667] [005/155] (958s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip) [58.311523] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip [58.315748] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [58.399388] [006/155] (958s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-mmap-wc) [58.502570] Starting subtest: psrhdr-rgb565-draw-mmap-wc [58.506951] Subtest psrhdr-rgb565-draw-mmap-wc: SKIP (0.000s) [58.607435] [007/155] (958s left) kms_big_fb (4-tiled-8bpp-rotate-180) [58.706231] Starting subtest: 4-tiled-8bpp-rotate-180 [59.984048] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.270s) [60.120508] [008/155] (957s left) gem_mmap_offset (basic-uaf) [60.170539] Starting subtest: basic-uaf [60.172454] Subtest basic-uaf: SUCCESS (0.001s) [60.272232] [009/155] (956s left) kms_psr (fbc-pr-cursor-plane-move) [60.361531] Starting subtest: fbc-pr-cursor-plane-move [60.365049] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s) [60.441361] [010/155] (956s left) gen9_exec_parse (shadow-peek) [60.494157] Subtest shadow-peek: SKIP (0.000s) [60.582574] [011/155] (956s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling) [60.684090] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling [60.687601] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s) [60.757982] [012/155] (956s left) syncobj_timeline (wait-all-for-submit-delayed-submit) [60.812291] Starting subtest: wait-all-for-submit-delayed-submit [60.918480] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.104s) [61.022925] [013/155] (956s left) kms_rotation_crc (primary-y-tiled-reflect-x-90) [61.119076] Starting subtest: primary-y-tiled-reflect-x-90 [61.123219] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s) [61.190424] [014/155] (956s left) kms_flip (basic-plain-flip) [61.283111] Starting subtest: basic-plain-flip [61.285519] Starting dynamic subtest: A-eDP1 [62.945399] Dynamic subtest A-eDP1: SUCCESS (1.656s) [62.956062] Starting dynamic subtest: B-eDP1 [64.598934] Dynamic subtest B-eDP1: SUCCESS (1.646s) [64.610716] Starting dynamic subtest: C-eDP1 [66.240478] Dynamic subtest C-eDP1: SUCCESS (1.635s) [66.250687] Starting dynamic subtest: D-eDP1 [67.888658] Dynamic subtest D-eDP1: SUCCESS (1.642s) [67.891107] Subtest basic-plain-flip: SUCCESS (6.587s) [69.074294] [015/155] (948s left) gem_exec_balancer (parallel-balancer) [69.339972] Starting subtest: parallel-balancer [70.269210] Subtest parallel-balancer: SUCCESS (0.930s) [70.379469] [016/155] (947s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen) [70.479774] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen [70.484201] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [70.571943] [017/155] (946s left) kms_properties (colorop-properties-legacy) [70.677028] Starting subtest: colorop-properties-legacy [70.679562] Starting dynamic subtest: pipe-A-eDP-1 [71.040534] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.364s) [71.050662] Starting dynamic subtest: pipe-B-eDP-1 [72.135785] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.092s) [72.148139] Starting dynamic subtest: pipe-C-eDP-1 [73.178097] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.041s) [73.187755] Starting dynamic subtest: pipe-D-eDP-1 [74.310205] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.129s) [74.312782] Subtest colorop-properties-legacy: SUCCESS (3.629s) [75.212215] [018/155] (942s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt) [75.323370] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt [83.031820] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.711s) [83.166214] [019/155] (934s left) kms_chamelium_frames (dp-frame-dump) [83.555367] Subtest dp-frame-dump: SKIP (0.000s) [84.370619] [020/155] (933s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-move) [84.466183] Starting subtest: hdr-2p-primscrn-spr-indfb-move [84.470345] Subtest hdr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [84.555329] [021/155] (933s left) kms_chamelium_color (ctm-0-75) [84.646427] Subtest ctm-0-75: SKIP (0.000s) [84.688043] [022/155] (933s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-blt) [84.778173] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-blt [84.782618] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [84.883146] [023/155] (932s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-render) [84.981454] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-render [84.985653] Subtest hdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [85.070477] [024/155] (932s left) kms_color_pipeline (plane-lut1d-lut1d) [85.170982] Starting subtest: plane-lut1d-lut1d [85.338519] Starting dynamic subtest: pipe-A-plane-0 [85.506916] Dynamic subtest pipe-A-plane-0: SUCCESS (0.167s) [85.515228] Starting dynamic subtest: pipe-A-plane-1 [85.694576] Dynamic subtest pipe-A-plane-1: SUCCESS (0.189s) [85.702478] Starting dynamic subtest: pipe-A-plane-2 [85.883263] Dynamic subtest pipe-A-plane-2: SUCCESS (0.189s) [87.116846] Starting dynamic subtest: pipe-B-plane-0 [87.310906] Dynamic subtest pipe-B-plane-0: SUCCESS (0.200s) [87.320592] Starting dynamic subtest: pipe-B-plane-1 [87.499893] Dynamic subtest pipe-B-plane-1: SUCCESS (0.189s) [87.508606] Starting dynamic subtest: pipe-B-plane-2 [87.655822] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s) [88.848844] Starting dynamic subtest: pipe-C-plane-0 [88.997464] Dynamic subtest pipe-C-plane-0: SUCCESS (0.156s) [89.006702] Starting dynamic subtest: pipe-C-plane-1 [89.164080] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s) [89.173808] Starting dynamic subtest: pipe-C-plane-2 [89.330963] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s) [90.586736] Starting dynamic subtest: pipe-D-plane-0 [90.747914] Dynamic subtest pipe-D-plane-0: SUCCESS (0.166s) [90.757120] Starting dynamic subtest: pipe-D-plane-1 [90.912950] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s) [90.921797] Starting dynamic subtest: pipe-D-plane-2 [91.080255] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s) [91.367693] Subtest plane-lut1d-lut1d: SUCCESS (6.195s) [92.223807] [025/155] (925s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt) [92.338229] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt [92.342736] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [92.429903] [026/155] (925s left) perf_pmu (rc6) [92.470042] Starting subtest: rc6 [92.472372] Starting dynamic subtest: gt0 [98.825894] Dynamic subtest gt0: SUCCESS (6.354s) [98.837048] Starting dynamic subtest: runtime-pm-gt0 [106.626944] Dynamic subtest runtime-pm-gt0: SUCCESS (7.798s) [106.638629] Starting dynamic subtest: runtime-pm-long-gt0 [119.130753] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.501s) [119.141643] Starting dynamic subtest: other-idle-gt0 [125.472799] Dynamic subtest other-idle-gt0: SUCCESS (6.340s) [125.484722] Starting dynamic subtest: gt1 [131.814237] Dynamic subtest gt1: SUCCESS (6.339s) [131.823958] Starting dynamic subtest: runtime-pm-gt1 [139.251500] Dynamic subtest runtime-pm-gt1: SUCCESS (7.435s) [139.263734] Starting dynamic subtest: runtime-pm-long-gt1 [151.741204] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.488s) [151.752617] Starting dynamic subtest: other-idle-gt1 [158.084879] Dynamic subtest other-idle-gt1: SUCCESS (6.342s) [158.087918] Subtest rc6: SUCCESS (65.609s) [159.223059] [027/155] (858s left) sriov_basic (bind-unbind-vf) [159.281289] Starting subtest: bind-unbind-vf [159.283833] Starting dynamic subtest: vf-1 [159.357890] Dynamic subtest vf-1: FAIL (0.016s) [159.366277] Starting dynamic subtest: vf-2 [159.430528] Dynamic subtest vf-2: FAIL (0.004s) [159.439643] Starting dynamic subtest: vf-3 [159.499641] Dynamic subtest vf-3: FAIL (0.004s) [159.508754] Starting dynamic subtest: vf-4 [159.567609] Dynamic subtest vf-4: FAIL (0.004s) [159.576712] Starting dynamic subtest: vf-5 [159.640936] Dynamic subtest vf-5: FAIL (0.004s) [159.650179] Starting dynamic subtest: vf-6 [159.711126] Dynamic subtest vf-6: FAIL (0.004s) [159.720222] Starting dynamic subtest: vf-7 [159.780268] Dynamic subtest vf-7: FAIL (0.004s) [159.787761] Starting dynamic subtest: vf-random [159.847193] Dynamic subtest vf-random: FAIL (0.004s) [159.855670] Starting dynamic subtest: vf-last [159.917279] Dynamic subtest vf-last: FAIL (0.439s) [159.919126] Subtest bind-unbind-vf: FAIL (0.486s) [159.954430] [028/155] (858s left) kms_content_protection (suspend-resume) [160.098737] Starting subtest: suspend-resume [160.102166] Subtest suspend-resume: SKIP (0.000s) [160.203748] [029/155] (857s left) i915_pm_rpm (reg-read-ioctl) [162.443199] Starting subtest: reg-read-ioctl [164.838344] Subtest reg-read-ioctl: SUCCESS (2.396s) [165.218590] [030/155] (852s left) syncobj_wait (wait-any-complex) [165.284869] Starting subtest: wait-any-complex [165.347617] Subtest wait-any-complex: SUCCESS (0.062s) [165.399980] [031/155] (852s left) gem_pwrite_snooped [165.529726] [032/155] (852s left) kms_psr (psr-sprite-plane-onoff) [165.635626] Starting subtest: psr-sprite-plane-onoff [165.637785] Starting dynamic subtest: eDP-1 [167.458645] Dynamic subtest eDP-1: SUCCESS (1.822s) [167.461104] Subtest psr-sprite-plane-onoff: SUCCESS (1.823s) [168.276562] [033/155] (849s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc) [168.374048] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc [168.378633] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [168.442789] [034/155] (849s left) gem_exec_schedule (timeslicing) [168.507678] Starting subtest: timeslicing [168.510580] Starting dynamic subtest: rcs0 [168.518780] Dynamic subtest rcs0: SUCCESS (0.021s) [168.530594] Starting dynamic subtest: bcs0 [168.538457] Dynamic subtest bcs0: SUCCESS (0.020s) [168.547707] Starting dynamic subtest: vcs0 [168.558482] Dynamic subtest vcs0: SUCCESS (0.020s) [168.576484] Starting dynamic subtest: vcs1 [168.582764] Dynamic subtest vcs1: SUCCESS (0.021s) [168.600087] Starting dynamic subtest: vecs0 [168.603110] Dynamic subtest vecs0: SUCCESS (0.020s) [168.614065] Starting dynamic subtest: ccs0 [168.619314] Dynamic subtest ccs0: SUCCESS (0.018s) [168.621712] Subtest timeslicing: SUCCESS (0.122s) [170.319132] [035/155] (847s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions) [170.436571] Starting subtest: flip-vs-cursor-atomic-transitions [178.408437] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.969s) [179.204611] [036/155] (839s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted) [179.257461] Starting subtest: multi-wait-available-unsubmitted-submitted [179.259513] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s) [179.353923] [037/155] (838s left) gem_create (create-clear) [179.407928] Starting subtest: create-clear [179.409856] Starting dynamic subtest: smem0 [212.312216] Dynamic subtest smem0: SUCCESS (32.897s) [212.314599] Subtest create-clear: SUCCESS (32.899s) [212.471423] [038/155] (805s left) api_intel_bb (purge-bb) [212.520034] Starting subtest: purge-bb [212.522344] Subtest purge-bb: SUCCESS (0.003s) [212.624723] [039/155] (805s left) syncobj_wait (wait-all-complex) [212.673266] Starting subtest: wait-all-complex [212.888449] Subtest wait-all-complex: SUCCESS (0.215s) [212.940525] [040/155] (805s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite) [213.040190] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite [217.953239] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.918s) [219.104932] [041/155] (799s left) gem_close (many-handles-one-vma) [219.164216] Starting subtest: many-handles-one-vma [219.186893] Subtest many-handles-one-vma: SUCCESS (0.024s) [219.287398] [042/155] (799s left) gem_mmap_gtt (basic-wc) [219.348877] Subtest basic-wc: SKIP (0.000s) [219.415060] [043/155] (799s left) gem_softpin (evict-active-interruptible) [219.485992] Starting subtest: evict-active-interruptible [219.492230] Subtest evict-active-interruptible: SUCCESS (0.006s) [219.595965] [044/155] (799s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt) [219.697840] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt [219.702278] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [219.759471] [045/155] (798s left) kms_atomic_interruptible (universal-setplane-cursor) [219.846506] Starting subtest: universal-setplane-cursor [219.848802] Starting dynamic subtest: pipe-A-eDP-1 [227.233815] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.386s) [227.235775] Subtest universal-setplane-cursor: SUCCESS (7.387s) [228.063868] [046/155] (790s left) kms_rotation_crc (bad-tiling) [228.154257] Starting subtest: bad-tiling [228.158602] Subtest bad-tiling: SKIP (0.001s) [228.203300] [047/155] (790s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier) [228.294571] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier [228.298649] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier: SKIP (0.000s) [228.340799] [048/155] (790s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt) [228.443046] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt [235.883834] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.444s) [235.996253] [049/155] (782s left) kms_psr (fbc-psr2-suspend) [236.091161] Starting subtest: fbc-psr2-suspend [236.093399] Starting dynamic subtest: eDP-1 [236.097468] Dynamic subtest eDP-1: SKIP (0.000s) [236.101607] Subtest fbc-psr2-suspend: SKIP (0.001s) [236.140819] [050/155] (782s left) perf_pmu (busy-check-all) [236.182039] Starting subtest: busy-check-all [236.184300] Starting dynamic subtest: rcs0 [236.731746] Dynamic subtest rcs0: SUCCESS (0.551s) [236.742702] Starting dynamic subtest: bcs0 [237.283231] Dynamic subtest bcs0: SUCCESS (0.549s) [237.295303] Starting dynamic subtest: vcs0 [239.293350] Dynamic subtest vcs0: SUCCESS (2.007s) [239.304926] Starting dynamic subtest: vcs1 [241.278080] Dynamic subtest vcs1: SUCCESS (1.982s) [241.291288] Starting dynamic subtest: vecs0 [243.261450] Dynamic subtest vecs0: SUCCESS (1.980s) [243.273046] Starting dynamic subtest: ccs0 [243.815377] Dynamic subtest ccs0: SUCCESS (0.554s) [243.817872] Subtest busy-check-all: SUCCESS (7.636s) [243.905703] [051/155] (774s left) gem_exec_params (invalid-fence-in) [243.975956] Starting subtest: invalid-fence-in [243.978318] Subtest invalid-fence-in: SUCCESS (0.000s) [244.059862] [052/155] (774s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling) [244.153151] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling [244.155443] Starting dynamic subtest: pipe-A-default-mode [245.356616] Dynamic subtest pipe-A-default-mode: SKIP (1.201s) [245.361067] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.203s) [245.477150] [053/155] (773s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-pwrite) [245.581608] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-pwrite [245.585666] Subtest hdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [245.650095] [054/155] (773s left) core_setmaster (master-drop-set-root) [245.689363] Starting subtest: master-drop-set-root [245.699946] Subtest master-drop-set-root: SUCCESS (0.011s) [245.747293] [055/155] (773s left) kms_psr (fbc-psr-primary-mmap-cpu) [245.840961] Starting subtest: fbc-psr-primary-mmap-cpu [245.843324] Starting dynamic subtest: eDP-1 [245.847707] Dynamic subtest eDP-1: SKIP (0.000s) [245.852225] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s) [245.891452] [056/155] (773s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [245.998839] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [246.002692] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [246.073697] [057/155] (773s left) syncobj_timeline (etime-single-wait-available-unsubmitted) [246.122652] Starting subtest: etime-single-wait-available-unsubmitted [246.224051] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.101s) [246.274071] [058/155] (772s left) api_intel_bb (bb-with-allocator) [246.326810] Starting subtest: bb-with-allocator [246.330193] Subtest bb-with-allocator: SUCCESS (0.006s) [246.421166] [059/155] (772s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa [246.485334] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled [246.592454] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.105s) [246.644342] [060/155] (772s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-indfb-pgflip-blt) [246.752472] Starting subtest: psrhdr-2p-primscrn-indfb-pgflip-blt [246.756510] Subtest psrhdr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [246.827906] [061/155] (772s left) kms_getfb (getfb-reject-nv12) [246.926114] Starting subtest: getfb-reject-nv12 [246.928515] Subtest getfb-reject-nv12: SUCCESS (0.001s) [247.000084] [062/155] (772s left) kms_addfb_basic (bad-pitch-256) [247.045908] Starting subtest: bad-pitch-256 [247.048142] Subtest bad-pitch-256: SUCCESS (0.000s) [247.159013] [063/155] (772s left) kms_multipipe_modeset (basic-max-pipe-crc-check) [247.262228] Starting subtest: basic-max-pipe-crc-check [247.266385] Subtest basic-max-pipe-crc-check: SKIP (0.000s) [247.308900] [064/155] (772s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt) [247.408039] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt [254.888699] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.484s) [254.999215] [065/155] (764s left) gem_ringfill (basic-all) [260.291036] Starting subtest: basic-all [261.437689] Subtest basic-all: SUCCESS (1.147s) [261.542655] [FACT gem_ringfill (basic-all)] new: kernel.kmod_is_loaded.vgem: true [261.546563] [066/155] (757s left) kms_dirtyfb (default-dirtyfb-ioctl) [261.653077] Starting subtest: default-dirtyfb-ioctl [261.655602] Starting dynamic subtest: A-eDP-1 [263.294422] Dynamic subtest A-eDP-1: SUCCESS (1.640s) [263.296620] Subtest default-dirtyfb-ioctl: SUCCESS (1.641s) [264.161556] [067/155] (755s left) kms_cursor_edge_walk (128x128-top-bottom) [264.251022] Starting subtest: 128x128-top-bottom [264.253245] Starting dynamic subtest: pipe-A-eDP-1 [267.747109] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.496s) [267.758609] Starting dynamic subtest: pipe-D-eDP-1 [270.876214] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.127s) [270.878087] Subtest 128x128-top-bottom: SUCCESS (6.625s) [271.674471] [068/155] (747s left) syncobj_timeline (invalid-signal-illegal-point) [271.733568] Starting subtest: invalid-signal-illegal-point [271.736061] Subtest invalid-signal-illegal-point: SUCCESS (0.000s) [271.826991] [069/155] (747s left) kms_cursor_crc (cursor-offscreen-64x64) [272.009587] Starting subtest: cursor-offscreen-64x64 [272.011747] Starting dynamic subtest: pipe-A-eDP-1 [273.955705] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.942s) [273.985603] Starting dynamic subtest: pipe-D-eDP-1 [276.621310] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.641s) [276.623652] Subtest cursor-offscreen-64x64: SUCCESS (4.611s) [277.452435] [070/155] (742s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt) [277.575165] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt [284.511480] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.940s) [284.639704] [071/155] (735s left) kms_frontbuffer_tracking (fbchdr-1p-pri-indfb-multidraw) [284.746693] Starting subtest: fbchdr-1p-pri-indfb-multidraw [284.751145] Subtest fbchdr-1p-pri-indfb-multidraw: SKIP (0.000s) [284.819352] [072/155] (734s left) kms_busy (extended-pageflip-hang-newfb) [284.907539] Starting subtest: extended-pageflip-hang-newfb [284.909833] Starting dynamic subtest: pipe-A [311.061275] Dynamic subtest pipe-A: SUCCESS (26.152s) [311.073452] Starting dynamic subtest: pipe-D [326.111135] Dynamic subtest pipe-D: SUCCESS (15.046s) [326.113999] Subtest extended-pageflip-hang-newfb: SUCCESS (41.203s) [326.950991] [073/155] (692s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [327.062908] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [327.731783] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.670s) [327.884358] [074/155] (691s left) kms_flip (2x-nonexisting-fb-interruptible) [327.987739] Starting subtest: 2x-nonexisting-fb-interruptible [327.999623] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.011s) [328.056582] [075/155] (691s left) kms_flip (absolute-wf_vblank-interruptible) [328.153505] Starting subtest: absolute-wf_vblank-interruptible [328.155855] Starting dynamic subtest: A-eDP1 [336.921668] Dynamic subtest A-eDP1: SUCCESS (8.766s) [336.933676] Starting dynamic subtest: B-eDP1 [345.652991] Dynamic subtest B-eDP1: SUCCESS (8.728s) [345.663453] Starting dynamic subtest: C-eDP1 [354.367656] Dynamic subtest C-eDP1: SUCCESS (8.713s) [354.377270] Starting dynamic subtest: D-eDP1 [363.100268] Dynamic subtest D-eDP1: SUCCESS (8.731s) [363.106781] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.951s) [364.288760] [076/155] (655s left) kms_cursor_legacy (flip-vs-cursor-toggle) [364.409556] Starting subtest: flip-vs-cursor-toggle [373.466762] Subtest flip-vs-cursor-toggle: SUCCESS (9.055s) [374.322567] [077/155] (645s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping) [374.422227] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping [374.426624] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s) [374.472667] [078/155] (645s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [374.572658] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc [374.576746] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [374.651475] [079/155] (645s left) gem_wait (busy) [374.711507] Starting subtest: busy [374.713864] Starting dynamic subtest: all-engines [376.317213] Dynamic subtest all-engines: SUCCESS (1.603s) [376.330256] Starting dynamic subtest: rcs0 [376.857703] Dynamic subtest rcs0: SUCCESS (0.540s) [376.869186] Starting dynamic subtest: bcs0 [377.397340] Dynamic subtest bcs0: SUCCESS (0.539s) [377.412899] Starting dynamic subtest: vcs0 [379.324445] Dynamic subtest vcs0: SUCCESS (1.924s) [379.335678] Starting dynamic subtest: vcs1 [381.307847] Dynamic subtest vcs1: SUCCESS (1.981s) [381.319099] Starting dynamic subtest: vecs0 [383.291990] Dynamic subtest vecs0: SUCCESS (1.982s) [383.303818] Starting dynamic subtest: ccs0 [383.834390] Dynamic subtest ccs0: SUCCESS (0.541s) [383.837093] Subtest busy: SUCCESS (9.123s) [384.012436] [080/155] (636s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt) [384.117892] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt [384.122369] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [384.183500] [081/155] (635s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt) [384.296234] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt [384.300468] Subtest psrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [384.372238] [082/155] (635s left) gem_ctx_param (non-root-set) [384.431026] Starting subtest: non-root-set [384.453181] Subtest non-root-set: SUCCESS (0.025s) [384.529919] [083/155] (635s left) gem_mmap (pf-nonblock) [384.588536] Subtest pf-nonblock: SKIP (0.000s) [384.650946] [084/155] (635s left) kms_big_fb (linear-64bpp-rotate-270) [384.754970] Starting subtest: linear-64bpp-rotate-270 [384.774623] Subtest linear-64bpp-rotate-270: SKIP (0.019s) [384.855981] [085/155] (635s left) kms_vblank (ts-continuation-dpms-rpm) [384.957988] Starting subtest: ts-continuation-dpms-rpm [384.960245] Starting dynamic subtest: pipe-A-eDP-1 [387.448859] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.489s) [387.463816] Starting dynamic subtest: pipe-D-eDP-1 [389.682964] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.231s) [389.685264] Subtest ts-continuation-dpms-rpm: SUCCESS (4.725s) [390.548198] [086/155] (629s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen) [390.641955] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen [390.646279] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [390.730734] [087/155] (629s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-pwrite) [390.833879] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-pwrite [390.838181] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [390.908700] [088/155] (629s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc) [391.016888] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc [391.021074] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [391.091755] [089/155] (629s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu) [391.193084] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu [397.830481] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.642s) [397.947657] [090/155] (622s left) gem_exec_fence (syncobj-timeline-invalid-flags) [398.496949] Starting subtest: syncobj-timeline-invalid-flags [398.499972] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s) [400.374604] [091/155] (620s left) i915_drm_fdinfo (virtual-busy-all) [400.411867] Starting subtest: virtual-busy-all [400.416236] Subtest virtual-busy-all: SKIP (0.000s) [400.465325] [092/155] (620s left) kms_pipe_stress (stress-xrgb8888-4tiled) [400.562508] Starting subtest: stress-xrgb8888-4tiled [406.466340] Subtest stress-xrgb8888-4tiled: SUCCESS (5.908s) [406.513980] [093/155] (614s left) kms_atomic (test-only) [406.600397] Starting subtest: test-only [406.654995] Starting dynamic subtest: pipe-A-eDP-1 [409.217050] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.561s) [409.219577] Subtest test-only: SUCCESS (2.617s) [410.066459] [094/155] (610s left) gem_exec_async (forked-writes) [410.124074] Starting subtest: forked-writes [410.126382] Starting dynamic subtest: rcs0 [410.151155] Dynamic subtest rcs0: SUCCESS (0.027s) [410.161593] Starting dynamic subtest: bcs0 [410.174038] Dynamic subtest bcs0: SUCCESS (0.022s) [410.184792] Starting dynamic subtest: vcs0 [410.196514] Dynamic subtest vcs0: SUCCESS (0.022s) [410.206565] Starting dynamic subtest: vcs1 [410.221237] Dynamic subtest vcs1: SUCCESS (0.024s) [410.231467] Starting dynamic subtest: vecs0 [410.245962] Dynamic subtest vecs0: SUCCESS (0.024s) [410.256696] Starting dynamic subtest: ccs0 [410.268042] Dynamic subtest ccs0: SUCCESS (0.021s) [410.270306] Subtest forked-writes: SUCCESS (0.145s) [410.473548] [095/155] (610s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-wc) [410.576106] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-wc [410.580220] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [410.653440] [096/155] (610s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip) [410.756083] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip [410.760531] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [410.839980] [097/155] (609s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled) [410.900819] Starting subtest: invalid-multi-wait-unsubmitted-signaled [410.903401] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s) [410.975952] [098/155] (609s left) kms_prop_blob (invalid-get-prop) [411.030530] Starting subtest: invalid-get-prop [411.032618] Subtest invalid-get-prop: SUCCESS (0.000s) [411.109468] [099/155] (609s left) kms_explicit_fence (multiplane-atomic-fence-wait) [411.247836] Starting subtest: multiplane-atomic-fence-wait [411.566725] Subtest multiplane-atomic-fence-wait: SUCCESS (0.317s) [412.696546] [100/155] (608s left) perf_pmu (init-busy) [412.735639] Starting subtest: init-busy [412.738057] Starting dynamic subtest: rcs0 [412.740416] Dynamic subtest rcs0: SUCCESS (0.001s) [412.750596] Starting dynamic subtest: bcs0 [412.752568] Dynamic subtest bcs0: SUCCESS (0.000s) [412.761998] Starting dynamic subtest: vcs0 [412.763980] Dynamic subtest vcs0: SUCCESS (0.001s) [412.772697] Starting dynamic subtest: vcs1 [412.774696] Dynamic subtest vcs1: SUCCESS (0.000s) [412.783435] Starting dynamic subtest: vecs0 [412.785237] Dynamic subtest vecs0: SUCCESS (0.001s) [412.794464] Starting dynamic subtest: ccs0 [412.796589] Dynamic subtest ccs0: SUCCESS (0.000s) [412.798724] Subtest init-busy: SUCCESS (0.007s) [412.839892] [101/155] (608s left) gem_readwrite (new-obj) [412.893877] Subtest new-obj: SKIP (0.000s) [412.961530] [102/155] (607s left) kms_tiled_display (basic-test-pattern) [413.068358] Subtest basic-test-pattern: SKIP (0.000s) [413.118651] [103/155] (607s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs) [413.205299] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs [413.209904] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s) [414.320582] [104/155] (606s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu) [414.420211] Starting subtest: fbc-rgb101010-draw-mmap-cpu [416.926997] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (2.513s) [418.022652] [105/155] (603s left) kms_chamelium_hpd (vga-hpd-after-suspend) [418.429421] Subtest vga-hpd-after-suspend: SKIP (0.000s) [419.248484] [106/155] (601s left) kms_flip (wf_vblank-ts-check) [419.349442] Starting subtest: wf_vblank-ts-check [419.351456] Starting dynamic subtest: A-eDP1 [428.318267] Dynamic subtest A-eDP1: SUCCESS (8.971s) [428.329373] Starting dynamic subtest: B-eDP1 [437.237950] Dynamic subtest B-eDP1: SUCCESS (8.918s) [437.249560] Starting dynamic subtest: C-eDP1 [446.160674] Dynamic subtest C-eDP1: SUCCESS (8.920s) [446.170687] Starting dynamic subtest: D-eDP1 [455.098725] Dynamic subtest D-eDP1: SUCCESS (8.936s) [455.101115] Subtest wf_vblank-ts-check: SUCCESS (35.752s) [456.313307] [107/155] (564s left) testdisplay [456.593893] [108/155] (564s left) i915_pm_freq_api (freq-reset) [456.663874] Starting subtest: freq-reset [456.666396] Starting dynamic subtest: gt0 [456.862469] Dynamic subtest gt0: SUCCESS (0.198s) [456.872752] Starting dynamic subtest: gt1 [457.025713] Dynamic subtest gt1: SUCCESS (0.161s) [457.028615] Subtest freq-reset: SUCCESS (0.361s) [457.082313] [109/155] (564s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-onoff) [457.180096] Starting subtest: fbchdr-2p-primscrn-spr-indfb-onoff [457.184224] Subtest fbchdr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [457.253022] [110/155] (564s left) gem_spin_batch (resubmit-new-all) [457.307521] Starting subtest: resubmit-new-all [457.309845] Starting dynamic subtest: rcs0 [457.323288] Dynamic subtest rcs0: SUCCESS (0.015s) [457.333154] Starting dynamic subtest: bcs0 [457.338044] Dynamic subtest bcs0: SUCCESS (0.013s) [457.347655] Starting dynamic subtest: vcs0 [457.352485] Dynamic subtest vcs0: SUCCESS (0.011s) [457.362666] Starting dynamic subtest: vcs1 [457.364898] Dynamic subtest vcs1: SUCCESS (0.009s) [457.374246] Starting dynamic subtest: vecs0 [457.376167] Dynamic subtest vecs0: SUCCESS (0.009s) [457.385440] Starting dynamic subtest: ccs0 [457.387704] Dynamic subtest ccs0: SUCCESS (0.011s) [457.389976] Subtest resubmit-new-all: SUCCESS (0.074s) [459.279667] [111/155] (562s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt) [459.382725] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt [459.387240] Subtest psrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [459.442680] [112/155] (561s left) gem_exec_schedule (implicit-boths) [459.514641] Starting subtest: implicit-boths [459.516550] Starting dynamic subtest: rcs0 [459.624926] Dynamic subtest rcs0: SUCCESS (0.119s) [459.637846] Starting dynamic subtest: vcs0 [459.714448] Dynamic subtest vcs0: SUCCESS (0.089s) [459.725750] Starting dynamic subtest: vcs1 [459.795209] Dynamic subtest vcs1: SUCCESS (0.080s) [459.808710] Starting dynamic subtest: vecs0 [459.875366] Dynamic subtest vecs0: SUCCESS (0.080s) [459.887845] Starting dynamic subtest: ccs0 [459.961721] Dynamic subtest ccs0: SUCCESS (0.086s) [459.964456] Subtest implicit-boths: SUCCESS (0.456s) [461.319790] [113/155] (560s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-render) [461.427071] Starting subtest: fbchdr-rgb565-draw-render [461.431344] Subtest fbchdr-rgb565-draw-render: SKIP (0.000s) [461.501869] [114/155] (559s left) gem_softpin (noreloc-interruptible) [461.556698] Starting subtest: noreloc-interruptible [466.991557] Subtest noreloc-interruptible: SUCCESS (5.433s) [467.096477] [115/155] (554s left) gem_pxp (reject-modify-context-protection-off-3) [467.218104] Starting subtest: reject-modify-context-protection-off-3 [467.220919] Subtest reject-modify-context-protection-off-3: SUCCESS (0.001s) [467.323429] [116/155] (554s left) gem_exec_fence (invalid-fence-array) [467.787079] Starting subtest: invalid-fence-array [467.794837] Subtest invalid-fence-array: SUCCESS (0.005s) [469.368765] [117/155] (552s left) dumb_buffer (map-valid) [469.426909] Starting subtest: map-valid [469.429277] Subtest map-valid: SUCCESS (0.000s) [469.507757] [118/155] (552s left) kms_plane (plane-panning-top-left) [469.597030] Starting subtest: plane-panning-top-left [469.599456] Starting dynamic subtest: pipe-A [471.319275] Dynamic subtest pipe-A: SUCCESS (1.721s) [471.329719] Starting dynamic subtest: pipe-B [473.796438] Dynamic subtest pipe-B: SUCCESS (2.478s) [473.798857] Subtest plane-panning-top-left: SUCCESS (4.202s) [474.653062] [119/155] (547s left) gem_exec_whisper (basic-normal-all) [474.712532] Starting subtest: basic-normal-all [477.085469] Subtest basic-normal-all: SUCCESS (2.370s) [477.242822] [120/155] (544s left) kms_vblank (crtc-id) [477.347320] Starting subtest: crtc-id [477.349668] Starting dynamic subtest: pipe-A-eDP-1 [477.792235] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.445s) [477.806829] Starting dynamic subtest: pipe-D-eDP-1 [478.893232] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.097s) [478.895397] Subtest crtc-id: SUCCESS (1.545s) [479.701847] [121/155] (542s left) kms_psr (psr2-sprite-plane-move) [479.797053] Starting subtest: psr2-sprite-plane-move [479.799421] Starting dynamic subtest: eDP-1 [481.539111] Dynamic subtest eDP-1: SUCCESS (1.742s) [481.541393] Subtest psr2-sprite-plane-move: SUCCESS (1.743s) [482.363538] [122/155] (539s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs) [482.465084] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs [482.467360] Starting dynamic subtest: pipe-A-eDP-1 [482.488244] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [482.499875] Starting dynamic subtest: pipe-B-eDP-1 [482.519612] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [482.529240] Starting dynamic subtest: pipe-C-eDP-1 [482.548964] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [482.558523] Starting dynamic subtest: pipe-D-eDP-1 [482.578190] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [482.580432] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.005s) [484.732869] [123/155] (537s left) i915_query (engine-info) [484.783642] Starting subtest: engine-info [484.789897] Subtest engine-info: SUCCESS (0.008s) [484.885879] [124/155] (537s left) gem_userptr_blits (dmabuf-sync) [484.948627] Starting subtest: dmabuf-sync [484.953309] Subtest dmabuf-sync: SKIP (0.002s) [485.068292] [125/155] (536s left) kms_pm_dc (dc9-dpms) [486.164979] Starting subtest: dc9-dpms [487.622550] Subtest dc9-dpms: SUCCESS (1.457s) [487.675778] [126/155] (534s left) gem_exec_whisper (basic-queues-priority-all) [487.740161] Starting subtest: basic-queues-priority-all [511.518569] Subtest basic-queues-priority-all: SUCCESS (23.773s) [511.678439] [127/155] (510s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs) [511.774283] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs [511.776555] Starting dynamic subtest: pipe-A-eDP-1 [511.798447] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [511.809687] Starting dynamic subtest: pipe-B-eDP-1 [511.830719] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [511.840514] Starting dynamic subtest: pipe-C-eDP-1 [511.862550] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [511.871842] Starting dynamic subtest: pipe-D-eDP-1 [511.894183] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [511.898824] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.005s) [514.022378] [128/155] (508s left) gem_exec_schedule (independent) [514.095997] Starting subtest: independent [514.098229] Starting dynamic subtest: rcs0 [515.325056] Dynamic subtest rcs0: SUCCESS (1.238s) [515.340926] Starting dynamic subtest: vcs0 [517.317775] Dynamic subtest vcs0: SUCCESS (1.990s) [517.330892] Starting dynamic subtest: vcs1 [519.304844] Dynamic subtest vcs1: SUCCESS (1.985s) [519.318378] Starting dynamic subtest: vecs0 [521.286503] Dynamic subtest vecs0: SUCCESS (1.979s) [521.297540] Starting dynamic subtest: ccs0 [523.324861] Dynamic subtest ccs0: SUCCESS (2.036s) [523.327948] Subtest independent: SUCCESS (9.240s) [523.606162] [129/155] (498s left) kms_joiner (basic-force-ultra-joiner) [523.723865] Starting subtest: basic-force-ultra-joiner [523.728127] Subtest basic-force-ultra-joiner: SKIP (0.000s) [523.779822] [130/155] (498s left) kms_flip (2x-plain-flip-interruptible) [523.879396] Starting subtest: 2x-plain-flip-interruptible [523.891296] Subtest 2x-plain-flip-interruptible: SKIP (0.011s) [523.965611] [131/155] (498s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-blt) [524.065218] Starting subtest: hdr-rgb101010-draw-blt [524.069401] Subtest hdr-rgb101010-draw-blt: SKIP (0.000s) [524.148292] [132/155] (498s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-render) [524.251757] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-render [524.255961] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [524.340699] [133/155] (497s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-mmap-cpu) [524.439778] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-mmap-cpu [524.444300] Subtest hdr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [524.537592] [134/155] (497s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels) [524.644252] Starting subtest: plane-all-modeset-transition-internal-panels [524.645905] Starting dynamic subtest: pipe-A-eDP-1 [525.966751] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.322s) [526.250926] Starting dynamic subtest: pipe-B-eDP-1 [527.281583] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.043s) [527.550854] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.906s) [528.369245] [135/155] (494s left) gem_exec_reloc (basic-gtt) [528.432197] Subtest basic-gtt: SKIP (0.000s) [528.517588] [136/155] (493s left) gem_exec_reloc (basic-wc-read-active) [528.572188] Subtest basic-wc-read-active: SKIP (0.000s) [528.651913] [137/155] (493s left) syncobj_wait (invalid-wait-bad-flags) [528.710153] Starting subtest: invalid-wait-bad-flags [528.712154] Subtest invalid-wait-bad-flags: SUCCESS (0.000s) [528.808430] [138/155] (493s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-pwrite) [528.907601] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-pwrite [528.911812] Subtest hdr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [528.977731] [139/155] (493s left) gem_readwrite (write-bad-handle) [529.038520] Subtest write-bad-handle: SKIP (0.000s) [529.115857] [140/155] (493s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move) [529.232197] Starting subtest: psr-1p-primscrn-cur-indfb-move [536.599572] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.372s) [536.727672] [141/155] (485s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu) [536.833780] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu [536.838210] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [536.907914] [142/155] (485s left) template (a) [536.956091] Starting subtest: A [536.958349] Subtest A: SUCCESS (0.000s) [537.033874] [143/155] (485s left) gem_mmap_gtt (cpuset-basic-small-copy-odd) [537.091624] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s) [537.153825] [144/155] (485s left) gem_ctx_persistence (engines-persistence) [537.205646] Starting subtest: engines-persistence [537.207939] Starting dynamic subtest: rcs0 [538.048938] Dynamic subtest rcs0: SUCCESS (0.842s) [538.064399] Starting dynamic subtest: bcs0 [538.806968] Dynamic subtest bcs0: SUCCESS (0.755s) [538.819695] Starting dynamic subtest: vcs0 [539.581817] Dynamic subtest vcs0: SUCCESS (0.773s) [539.594652] Starting dynamic subtest: vcs1 [540.344054] Dynamic subtest vcs1: SUCCESS (0.760s) [540.357087] Starting dynamic subtest: vecs0 [541.113304] Dynamic subtest vecs0: SUCCESS (0.767s) [541.126086] Starting dynamic subtest: ccs0 [541.880137] Dynamic subtest ccs0: SUCCESS (0.765s) [541.882925] Subtest engines-persistence: SUCCESS (4.675s) [541.939914] [145/155] (480s left) gem_ctx_persistence (hostile) [541.998475] Starting subtest: hostile [544.654165] Subtest hostile: SUCCESS (2.650s) [544.741890] [146/155] (478s left) kms_psr (psr2-cursor-plane-onoff) [544.843091] Starting subtest: psr2-cursor-plane-onoff [544.845472] Starting dynamic subtest: eDP-1 [546.587323] Dynamic subtest eDP-1: SUCCESS (1.744s) [546.589726] Subtest psr2-cursor-plane-onoff: SUCCESS (1.745s) [547.461966] [147/155] (475s left) syncobj_wait (invalid-reset-bad-pad) [547.523542] Starting subtest: invalid-reset-bad-pad [547.525699] Subtest invalid-reset-bad-pad: SUCCESS (0.000s) [547.608251] [148/155] (475s left) gem_exec_flush (basic-wb-rw-default) [547.671808] Starting subtest: basic-wb-rw-default [553.128070] Subtest basic-wb-rw-default: SUCCESS (5.457s) [553.296215] [149/155] (469s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-mmap-cpu) [553.397791] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-mmap-cpu [553.402076] Subtest fbchdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [553.470985] [150/155] (469s left) kms_addfb_basic (basic-y-tiled-legacy) [553.522477] Starting subtest: basic-y-tiled-legacy [553.526721] Subtest basic-y-tiled-legacy: SKIP (0.000s) [553.655331] [151/155] (469s left) kms_rotation_crc (primary-rotation-270) [553.750971] Starting subtest: primary-rotation-270 [553.755473] Subtest primary-rotation-270: SKIP (0.001s) [553.803464] [152/155] (469s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf) [553.916867] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf [553.921083] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s) [553.963379] [153/155] (469s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-indfb-plflip-blt) [554.065742] Starting subtest: fbchdr-2p-primscrn-indfb-plflip-blt [554.070148] Subtest fbchdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [554.145896] [154/155] (469s left) kms_cursor_crc (cursor-random-32x10) [554.314934] Starting subtest: cursor-random-32x10 [554.370968] Subtest cursor-random-32x10: SKIP (0.050s) [554.628643] [155/155] (468s left) kms_plane_scaling (planes-upscale-factor-0-25) [554.718717] Starting subtest: planes-upscale-factor-0-25 [554.720876] Starting dynamic subtest: pipe-A [554.779231] Dynamic subtest pipe-A: SUCCESS (0.062s) [554.790704] Starting dynamic subtest: pipe-B [555.908975] Dynamic subtest pipe-B: SUCCESS (1.127s) [555.921791] Starting dynamic subtest: pipe-C [557.020323] Dynamic subtest pipe-C: SUCCESS (1.111s) [557.030827] Starting dynamic subtest: pipe-D [558.158051] Dynamic subtest pipe-D: SUCCESS (1.137s) [558.160394] Subtest planes-upscale-factor-0-25: SUCCESS (3.442s) [559.305672] Closing watchdogs results: parsing output: 0/ for test: kms_frontbuffer_tracking results: parsing output: 1/ for test: gem_mmap_gtt results: parsing output: 2/ for test: kms_ccs results: parsing output: 3/ for test: kms_big_fb results: parsing output: 4/ for test: kms_big_fb results: parsing output: 5/ for test: kms_frontbuffer_tracking results: parsing output: 6/ for test: kms_big_fb results: parsing output: 7/ for test: gem_mmap_offset results: parsing output: 8/ for test: kms_psr results: parsing output: 9/ for test: gen9_exec_parse results: parsing output: 10/ for test: kms_flip_scaled_crc results: parsing output: 11/ for test: syncobj_timeline results: parsing output: 12/ for test: kms_rotation_crc results: parsing output: 13/ for test: kms_flip results: parsing output: 14/ for test: gem_exec_balancer results: parsing output: 15/ for test: kms_frontbuffer_tracking results: parsing output: 16/ for test: kms_properties results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: kms_chamelium_frames results: parsing output: 19/ for test: kms_frontbuffer_tracking results: parsing output: 20/ for test: kms_chamelium_color results: parsing output: 21/ for test: kms_frontbuffer_tracking results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: kms_color_pipeline results: parsing output: 24/ for test: kms_frontbuffer_tracking results: parsing output: 25/ for test: perf_pmu results: parsing output: 26/ for test: sriov_basic results: parsing output: 27/ for test: kms_content_protection results: parsing output: 28/ for test: i915_pm_rpm results: parsing output: 29/ for test: syncobj_wait results: parsing output: 30/ for test: gem_pwrite_snooped results: parsing output: 31/ for test: kms_psr results: parsing output: 32/ for test: kms_frontbuffer_tracking results: parsing output: 33/ for test: gem_exec_schedule results: parsing output: 34/ for test: kms_cursor_legacy results: parsing output: 35/ for test: syncobj_timeline results: parsing output: 36/ for test: gem_create results: parsing output: 37/ for test: api_intel_bb results: parsing output: 38/ for test: syncobj_wait results: parsing output: 39/ for test: kms_frontbuffer_tracking results: parsing output: 40/ for test: gem_close results: parsing output: 41/ for test: gem_mmap_gtt results: parsing output: 42/ for test: gem_softpin results: parsing output: 43/ for test: kms_frontbuffer_tracking results: parsing output: 44/ for test: kms_atomic_interruptible results: parsing output: 45/ for test: kms_rotation_crc results: parsing output: 46/ for test: kms_plane results: parsing output: 47/ for test: kms_frontbuffer_tracking results: parsing output: 48/ for test: kms_psr results: parsing output: 49/ for test: perf_pmu results: parsing output: 50/ for test: gem_exec_params results: parsing output: 51/ for test: kms_flip_scaled_crc results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: core_setmaster results: parsing output: 54/ for test: kms_psr results: parsing output: 55/ for test: kms_frontbuffer_tracking results: parsing output: 56/ for test: syncobj_timeline results: parsing output: 57/ for test: api_intel_bb results: parsing output: 58/ for test: syncobj_timeline results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: kms_getfb results: parsing output: 61/ for test: kms_addfb_basic results: parsing output: 62/ for test: kms_multipipe_modeset results: parsing output: 63/ for test: kms_frontbuffer_tracking results: parsing output: 64/ for test: gem_ringfill results: parsing output: 65/ for test: kms_dirtyfb results: parsing output: 66/ for test: kms_cursor_edge_walk results: parsing output: 67/ for test: syncobj_timeline results: parsing output: 68/ for test: kms_cursor_crc results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: kms_busy results: parsing output: 72/ for test: kms_big_fb results: parsing output: 73/ for test: kms_flip results: parsing output: 74/ for test: kms_flip results: parsing output: 75/ for test: kms_cursor_legacy results: parsing output: 76/ for test: kms_plane results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: gem_wait results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: gem_ctx_param results: parsing output: 82/ for test: gem_mmap results: parsing output: 83/ for test: kms_big_fb results: parsing output: 84/ for test: kms_vblank results: parsing output: 85/ for test: kms_frontbuffer_tracking results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: kms_frontbuffer_tracking results: parsing output: 88/ for test: kms_frontbuffer_tracking results: parsing output: 89/ for test: gem_exec_fence results: parsing output: 90/ for test: i915_drm_fdinfo results: parsing output: 91/ for test: kms_pipe_stress results: parsing output: 92/ for test: kms_atomic results: parsing output: 93/ for test: gem_exec_async results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: kms_big_fb results: parsing output: 96/ for test: syncobj_wait results: parsing output: 97/ for test: kms_prop_blob results: parsing output: 98/ for test: kms_explicit_fence results: parsing output: 99/ for test: perf_pmu results: parsing output: 100/ for test: gem_readwrite results: parsing output: 101/ for test: kms_tiled_display results: parsing output: 102/ for test: kms_ccs results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: kms_chamelium_hpd results: parsing output: 105/ for test: kms_flip results: parsing output: 106/ for test: testdisplay results: parsing output: 107/ for test: i915_pm_freq_api results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: gem_spin_batch results: parsing output: 110/ for test: kms_frontbuffer_tracking results: parsing output: 111/ for test: gem_exec_schedule results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: gem_softpin results: parsing output: 114/ for test: gem_pxp results: parsing output: 115/ for test: gem_exec_fence results: parsing output: 116/ for test: dumb_buffer results: parsing output: 117/ for test: kms_plane results: parsing output: 118/ for test: gem_exec_whisper results: parsing output: 119/ for test: kms_vblank results: parsing output: 120/ for test: kms_psr results: parsing output: 121/ for test: kms_ccs results: parsing output: 122/ for test: i915_query results: parsing output: 123/ for test: gem_userptr_blits results: parsing output: 124/ for test: kms_pm_dc results: parsing output: 125/ for test: gem_exec_whisper results: parsing output: 126/ for test: kms_ccs results: parsing output: 127/ for test: gem_exec_schedule results: parsing output: 128/ for test: kms_joiner results: parsing output: 129/ for test: kms_flip results: parsing output: 130/ for test: kms_frontbuffer_tracking 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_atomic_transition results: parsing output: 134/ for test: gem_exec_reloc results: parsing output: 135/ for test: gem_exec_reloc results: parsing output: 136/ for test: syncobj_wait results: parsing output: 137/ for test: kms_frontbuffer_tracking results: parsing output: 138/ for test: gem_readwrite results: parsing output: 139/ for test: kms_frontbuffer_tracking results: parsing output: 140/ for test: kms_frontbuffer_tracking results: parsing output: 141/ for test: template results: parsing output: 142/ for test: gem_mmap_gtt results: parsing output: 143/ for test: gem_ctx_persistence results: parsing output: 144/ for test: gem_ctx_persistence results: parsing output: 145/ for test: kms_psr results: parsing output: 146/ for test: syncobj_wait results: parsing output: 147/ for test: gem_exec_flush results: parsing output: 148/ for test: kms_frontbuffer_tracking results: parsing output: 149/ for test: kms_addfb_basic results: parsing output: 150/ for test: kms_rotation_crc results: parsing output: 151/ for test: kms_psr2_sf results: parsing output: 152/ for test: kms_frontbuffer_tracking results: parsing output: 153/ for test: kms_cursor_crc results: parsing output: 154/ for test: kms_plane_scaling Done.