[59.268994] Initializing watchdogs [59.269061] /dev/watchdog0 [59.283305] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [59.288288] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.290356] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.292093] [001/131] (960s left) kms_addfb_basic (bad-pitch-0) [59.351467] Starting subtest: bad-pitch-0 [59.352571] Subtest bad-pitch-0: SUCCESS (0.000s) [59.516966] [002/131] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt) [59.604626] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt [59.606576] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [59.719656] [003/131] (960s left) kms_big_fb (x-tiled-64bpp-rotate-90) [59.823675] Starting subtest: x-tiled-64bpp-rotate-90 [59.854493] Subtest x-tiled-64bpp-rotate-90: SKIP (0.030s) [60.016924] [004/131] (959s left) kms_vrr (negative-basic) [60.111419] Starting subtest: negative-basic [60.114286] Starting dynamic subtest: pipe-A-eDP-1 [65.538049] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.422s) [65.840601] Subtest negative-basic: SUCCESS (5.730s) [66.712714] [005/131] (953s left) syncobj_timeline (etime-multi-wait-available-unsubmitted) [66.775970] Starting subtest: etime-multi-wait-available-unsubmitted [66.882518] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.104s) [66.979266] [006/131] (952s left) gem_exec_fence (syncobj-channel) [67.704593] Starting subtest: syncobj-channel [68.733924] Subtest syncobj-channel: SUCCESS (1.027s) [69.040171] [FACT gem_exec_fence (syncobj-channel)] new: kernel.kmod_is_loaded.vgem: true [69.042275] [007/131] (950s left) perf_pmu (interrupts-sync) [69.077096] Starting subtest: interrupts-sync [70.176113] Subtest interrupts-sync: SUCCESS (1.096s) [70.323395] [008/131] (949s left) kms_plane_multiple (2x-tiling-x) [70.425095] Starting subtest: 2x-tiling-x [70.426939] Subtest 2x-tiling-x: SKIP (0.000s) [70.514514] [009/131] (949s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [70.627036] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip [71.263272] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.637s) [71.461306] [010/131] (948s left) kms_big_fb (linear-64bpp-rotate-270) [71.564362] Starting subtest: linear-64bpp-rotate-270 [71.583882] Subtest linear-64bpp-rotate-270: SKIP (0.019s) [71.725683] [011/131] (948s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt) [71.816285] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt [76.473411] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.658s) [77.626940] [012/131] (942s left) gem_exec_whisper (basic-contexts-forked) [77.685257] Starting subtest: basic-contexts-forked [102.402469] Subtest basic-contexts-forked: SUCCESS (24.714s) [102.598652] [013/131] (917s left) sw_sync (alloc_fence) [102.629449] Starting subtest: alloc_fence [102.630520] Subtest alloc_fence: SUCCESS (0.000s) [102.695016] [014/131] (917s left) i915_query (query-garbage) [102.750046] Starting subtest: query-garbage [102.751061] Subtest query-garbage: SUCCESS (0.000s) [102.880774] [015/131] (917s left) gem_exec_reloc (basic-cpu-gtt-active) [102.932516] Subtest basic-cpu-gtt-active: SKIP (0.000s) [102.994320] [016/131] (917s left) gem_exec_endless (dispatch) [103.048512] Starting subtest: dispatch [103.049713] Starting dynamic subtest: rcs0 [103.054228] Dynamic subtest rcs0: SUCCESS (0.005s) [103.067729] Starting dynamic subtest: bcs0 [103.069695] Dynamic subtest bcs0: SUCCESS (0.006s) [103.078942] Starting dynamic subtest: vcs0 [103.080564] Dynamic subtest vcs0: SUCCESS (0.005s) [103.087830] Starting dynamic subtest: vcs1 [103.089456] Dynamic subtest vcs1: SUCCESS (0.005s) [103.095319] Starting dynamic subtest: vecs0 [103.096914] Dynamic subtest vecs0: SUCCESS (0.005s) [103.102893] Starting dynamic subtest: ccs0 [103.104466] Dynamic subtest ccs0: SUCCESS (0.006s) [103.105254] Subtest dispatch: SUCCESS (0.033s) [104.974215] [017/131] (915s left) kms_selftest (drm_dp_mst_helper) [105.008263] Starting subtest: drm_dp_mst_helper [105.063570] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode [105.204562] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.142s) [105.211864] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div [105.341905] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.136s) [105.349200] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode [105.467885] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.127s) [105.468769] Subtest drm_dp_mst_helper: SUCCESS (0.460s) [105.668383] [018/131] (914s left) kms_big_fb (y-tiled-64bpp-rotate-0) [105.767124] Starting subtest: y-tiled-64bpp-rotate-0 [105.768855] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s) [105.890626] [019/131] (914s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu) [105.982393] Starting subtest: fbc-rgb565-draw-mmap-cpu [110.044353] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (4.062s) [111.215982] [020/131] (909s left) gem_mmap_wc (bad-size) [111.275102] Subtest bad-size: SKIP (0.000s) [111.334134] [021/131] (909s left) gem_mmap_gtt (basic-read-write) [111.380685] Subtest basic-read-write: SKIP (0.000s) [111.439077] [022/131] (909s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff) [111.542988] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff [118.482882] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (6.941s) [118.673183] [023/131] (901s left) kms_psr (psr-cursor-plane-onoff) [118.763264] Starting subtest: psr-cursor-plane-onoff [118.764171] Starting dynamic subtest: eDP-1 [120.508947] Dynamic subtest eDP-1: SUCCESS (1.745s) [120.509858] Subtest psr-cursor-plane-onoff: SUCCESS (1.746s) [121.393587] [024/131] (899s left) dmabuf_sync_file (export-wait-after-attach) [121.436775] Starting subtest: export-wait-after-attach [121.437743] Subtest export-wait-after-attach: SUCCESS (0.001s) [121.514395] [025/131] (899s left) kms_pm_rpm (modeset-lpsp-stress) [123.045733] Starting subtest: modeset-lpsp-stress [139.335625] Subtest modeset-lpsp-stress: SUCCESS (16.292s) [139.441756] [026/131] (881s left) kms_plane_scaling (plane-upscale-20x20-with-rotation) [139.530926] Starting subtest: plane-upscale-20x20-with-rotation [139.531815] Starting dynamic subtest: pipe-A [139.757573] Dynamic subtest pipe-A: SUCCESS (0.227s) [139.772313] Starting dynamic subtest: pipe-B [141.073168] Dynamic subtest pipe-B: SUCCESS (1.314s) [141.080595] Starting dynamic subtest: pipe-C [142.403624] Dynamic subtest pipe-C: SUCCESS (1.330s) [142.410102] Starting dynamic subtest: pipe-D [143.736874] Dynamic subtest pipe-D: SUCCESS (1.333s) [143.737953] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.206s) [144.932562] [027/131] (875s left) prime_vgem (basic-fence-flip) [145.019422] Starting subtest: basic-fence-flip [145.310442] Subtest basic-fence-flip: SUCCESS (0.292s) [145.443483] [028/131] (875s left) gem_mmap_gtt (big-copy-xy) [145.502435] Subtest big-copy-XY: SKIP (0.000s) [145.566825] [029/131] (875s left) kms_cursor_crc (cursor-onscreen-512x512) [145.817739] Starting subtest: cursor-onscreen-512x512 [145.819461] Subtest cursor-onscreen-512x512: SKIP (0.001s) [146.008519] [030/131] (874s left) i915_pm_sseu (full-enable) [146.070546] Subtest full-enable: SKIP (0.000s) [146.200692] [031/131] (874s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc) [146.300076] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc [146.300873] Starting dynamic subtest: pipe-A-eDP-1 [146.309864] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [146.316565] Starting dynamic subtest: pipe-B-eDP-1 [146.325615] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [146.332546] Starting dynamic subtest: pipe-C-eDP-1 [146.341142] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [146.347277] Starting dynamic subtest: pipe-D-eDP-1 [146.356195] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [146.357794] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s) [148.517688] [032/131] (872s left) kms_dp_link_training (non-uhbr-sst) [148.606479] Starting subtest: non-uhbr-sst [148.610145] Subtest non-uhbr-sst: SKIP (0.000s) [148.706808] [033/131] (872s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs) [148.794193] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs [148.795069] Starting dynamic subtest: pipe-A-eDP-1 [148.804223] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [148.816045] Starting dynamic subtest: pipe-B-eDP-1 [148.826375] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [148.834150] Starting dynamic subtest: pipe-C-eDP-1 [148.843028] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [148.849732] Starting dynamic subtest: pipe-D-eDP-1 [148.859392] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [148.861033] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.003s) [150.980829] [034/131] (869s left) gem_pxp (regular-baseline-src-copy-readible) [151.095261] Starting subtest: regular-baseline-src-copy-readible [151.154771] Subtest regular-baseline-src-copy-readible: SUCCESS (0.061s) [151.316682] [035/131] (869s left) gem_exec_flush (basic-wb-rw-default) [151.372278] Starting subtest: basic-wb-rw-default [156.826123] Subtest basic-wb-rw-default: SUCCESS (5.453s) [157.032534] [036/131] (863s left) syncobj_timeline (signal-array) [157.105566] Starting subtest: signal-array [157.106527] Subtest signal-array: SUCCESS (0.001s) [157.239327] [037/131] (863s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip) [157.348936] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip [158.294600] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (0.946s) [158.434397] [038/131] (862s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff) [158.532921] Starting subtest: psr-2p-primscrn-cur-indfb-onoff [158.534637] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [158.675949] [039/131] (862s left) gem_partial_pwrite_pread (writes-after-reads-uncached) [158.746370] Subtest writes-after-reads-uncached: SKIP (0.000s) [158.802805] [040/131] (862s left) gem_flink_basic (bad-open) [158.862727] Starting subtest: bad-open [158.863836] Subtest bad-open: SUCCESS (0.000s) [158.988450] [041/131] (862s left) gem_ctx_shared (q-promotion) [159.038295] Starting subtest: Q-promotion [159.039270] Starting dynamic subtest: rcs0 [159.138326] Dynamic subtest rcs0: SUCCESS (0.099s) [159.151849] Starting dynamic subtest: vcs0 [159.220673] Dynamic subtest vcs0: SUCCESS (0.082s) [159.233605] Starting dynamic subtest: vcs1 [159.300974] Dynamic subtest vcs1: SUCCESS (0.079s) [159.314624] Starting dynamic subtest: vecs0 [159.372774] Dynamic subtest vecs0: SUCCESS (0.072s) [159.386774] Starting dynamic subtest: ccs0 [159.454101] Dynamic subtest ccs0: SUCCESS (0.081s) [159.455223] Subtest Q-promotion: SUCCESS (0.416s) [161.040242] [042/131] (860s left) kms_cursor_legacy (forked-bo) [161.154450] Starting subtest: forked-bo [161.155363] Starting dynamic subtest: pipe-A [166.608993] Dynamic subtest pipe-A: SUCCESS (5.451s) [166.618715] Starting dynamic subtest: pipe-B [172.086647] Dynamic subtest pipe-B: SUCCESS (5.475s) [172.095369] Starting dynamic subtest: pipe-C [177.548177] Dynamic subtest pipe-C: SUCCESS (5.462s) [177.557309] Starting dynamic subtest: pipe-D [183.037399] Dynamic subtest pipe-D: SUCCESS (5.485s) [183.050471] Starting dynamic subtest: all-pipes [188.537334] Dynamic subtest all-pipes: SUCCESS (5.499s) [188.538477] Subtest forked-bo: SUCCESS (27.379s) [188.697342] [043/131] (832s left) gem_readwrite (new-obj) [188.758616] Subtest new-obj: SKIP (0.000s) [188.814849] [044/131] (832s left) kms_busy (extended-modeset-hang-newfb) [188.911204] Starting subtest: extended-modeset-hang-newfb [188.912146] Starting dynamic subtest: pipe-A [223.940592] Dynamic subtest pipe-A: SUCCESS (35.028s) [223.948365] Starting dynamic subtest: pipe-D [246.964404] Dynamic subtest pipe-D: SUCCESS (23.021s) [246.965208] Subtest extended-modeset-hang-newfb: SUCCESS (58.053s) [247.782322] [045/131] (773s left) kms_color (ctm-0-50) [247.875339] Starting subtest: ctm-0-50 [247.876210] Starting dynamic subtest: pipe-A-eDP-1 [251.253260] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.378s) [251.259730] Starting dynamic subtest: pipe-B-eDP-1 [255.342650] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.088s) [255.349462] Starting dynamic subtest: pipe-C-eDP-1 [259.298775] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.956s) [259.305824] Starting dynamic subtest: pipe-D-eDP-1 [263.281741] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.983s) [263.282709] Subtest ctm-0-50: SUCCESS (15.407s) [264.131358] [046/131] (757s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs) [264.235488] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs [264.236398] Starting dynamic subtest: pipe-A-eDP-1 [266.281034] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.046s) [266.288868] Starting dynamic subtest: pipe-B-eDP-1 [268.348612] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.066s) [268.356473] Starting dynamic subtest: pipe-C-eDP-1 [270.398985] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.049s) [270.406585] Starting dynamic subtest: pipe-D-eDP-1 [272.388244] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.988s) [272.389153] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.155s) [273.664474] [047/131] (747s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt) [273.781438] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt [273.783367] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [273.900715] [048/131] (747s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render) [273.992548] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render [273.994295] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [274.124617] [049/131] (747s left) i915_drm_fdinfo (busy) [274.159569] Starting subtest: busy [274.160601] Starting dynamic subtest: rcs0 [274.199479] Dynamic subtest rcs0: SKIP (0.039s) [274.208482] Starting dynamic subtest: bcs0 [274.210283] Dynamic subtest bcs0: SKIP (0.000s) [274.216894] Starting dynamic subtest: vcs0 [274.218856] Dynamic subtest vcs0: SKIP (0.000s) [274.225527] Starting dynamic subtest: vcs1 [274.227345] Dynamic subtest vcs1: SKIP (0.000s) [274.234199] Starting dynamic subtest: vecs0 [274.235952] Dynamic subtest vecs0: SKIP (0.000s) [274.242376] Starting dynamic subtest: ccs0 [274.244128] Dynamic subtest ccs0: SKIP (0.000s) [274.245933] Subtest busy: SKIP (0.045s) [274.294617] [050/131] (747s left) kms_addfb_basic (bad-pitch-32) [274.336593] Starting subtest: bad-pitch-32 [274.337580] Subtest bad-pitch-32: SUCCESS (0.000s) [274.506146] [051/131] (746s left) sysfs_heartbeat_interval (invalid) [274.553280] Starting subtest: invalid [274.554231] Starting dynamic subtest: vecs0 [274.555122] Dynamic subtest vecs0: SUCCESS (0.000s) [274.563549] Starting dynamic subtest: ccs0 [274.564468] Dynamic subtest ccs0: SUCCESS (0.000s) [274.571504] Starting dynamic subtest: vcs0 [274.572706] Dynamic subtest vcs0: SUCCESS (0.000s) [274.579357] Starting dynamic subtest: bcs0 [274.580254] Dynamic subtest bcs0: SUCCESS (0.000s) [274.586815] Starting dynamic subtest: rcs0 [274.587746] Dynamic subtest rcs0: SUCCESS (0.000s) [274.594365] Starting dynamic subtest: vcs1 [274.595286] Dynamic subtest vcs1: SUCCESS (0.000s) [274.596359] Subtest invalid: SUCCESS (0.005s) [274.691420] [052/131] (746s left) kms_atomic (test-only) [274.781390] Starting subtest: test-only [274.830261] Starting dynamic subtest: pipe-A-eDP-1 [277.387928] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.559s) [277.388785] Subtest test-only: SUCCESS (2.608s) [278.280600] [053/131] (743s left) kms_sequence (get-busy) [278.382228] Starting subtest: get-busy [278.383022] Starting dynamic subtest: pipe-A-eDP-1 [280.325410] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.942s) [280.332913] Starting dynamic subtest: pipe-B-eDP-1 [282.958970] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.632s) [282.966832] Starting dynamic subtest: pipe-C-eDP-1 [285.575107] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.615s) [285.583111] Starting dynamic subtest: pipe-D-eDP-1 [288.119806] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.542s) [288.120715] Subtest get-busy: SUCCESS (9.738s) [288.937456] [054/131] (732s left) kms_invalid_mode (zero-hdisplay) [289.029663] Starting subtest: zero-hdisplay [289.030728] Starting dynamic subtest: pipe-A-eDP-1 [289.312664] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.282s) [289.319661] Starting dynamic subtest: pipe-B-eDP-1 [289.320505] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [289.326936] Starting dynamic subtest: pipe-C-eDP-1 [289.327856] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [289.333911] Starting dynamic subtest: pipe-D-eDP-1 [289.335079] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [289.336092] Subtest zero-hdisplay: SUCCESS (0.288s) [290.161434] [055/131] (731s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt) [290.260171] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt [293.970353] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.715s) [295.170411] [056/131] (726s left) gem_softpin (allocator-evict) [295.229827] Starting subtest: allocator-evict [295.230887] Starting dynamic subtest: rcs0 [318.923989] Dynamic subtest rcs0: SUCCESS (23.692s) [318.935880] Starting dynamic subtest: bcs0 [342.437578] Dynamic subtest bcs0: SUCCESS (23.510s) [342.449373] Starting dynamic subtest: vcs0 [365.945718] Dynamic subtest vcs0: SUCCESS (23.506s) [365.954991] Starting dynamic subtest: vcs1 [389.578342] Dynamic subtest vcs1: SUCCESS (23.631s) [389.594564] Starting dynamic subtest: vecs0 [413.321068] Dynamic subtest vecs0: SUCCESS (23.741s) [413.329571] Starting dynamic subtest: ccs0 [437.408248] Dynamic subtest ccs0: SUCCESS (24.085s) [437.409397] Subtest allocator-evict: SUCCESS (142.174s) [437.508996] [057/131] (584s left) kms_cursor_crc (cursor-offscreen-256x85) [437.810255] Starting subtest: cursor-offscreen-256x85 [437.850979] Subtest cursor-offscreen-256x85: SKIP (0.038s) [438.049334] [058/131] (583s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt) [438.145026] Starting subtest: fbcpsr-rgb101010-draw-blt [444.885882] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.741s) [445.049254] [059/131] (576s left) kms_color (deep-color) [445.154797] Starting subtest: deep-color [446.205850] Starting dynamic subtest: pipe-A-eDP-1-gamma [446.916045] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.710s) [446.923183] Starting dynamic subtest: pipe-A-eDP-1-degamma [448.386264] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.470s) [448.393765] Starting dynamic subtest: pipe-A-eDP-1-ctm [449.819752] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.432s) [450.607308] Starting dynamic subtest: pipe-B-eDP-1-gamma [451.299656] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.697s) [451.316341] Starting dynamic subtest: pipe-B-eDP-1-degamma [452.685340] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.386s) [452.692485] Starting dynamic subtest: pipe-B-eDP-1-ctm [454.123361] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.438s) [454.916943] Starting dynamic subtest: pipe-C-eDP-1-gamma [455.570813] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.659s) [455.578191] Starting dynamic subtest: pipe-C-eDP-1-degamma [456.967395] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.396s) [456.974593] Starting dynamic subtest: pipe-C-eDP-1-ctm [458.360871] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.393s) [459.110614] Starting dynamic subtest: pipe-D-eDP-1-gamma [459.773761] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.669s) [459.781229] Starting dynamic subtest: pipe-D-eDP-1-degamma [461.164061] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.389s) [461.171150] Starting dynamic subtest: pipe-D-eDP-1-ctm [462.574953] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.411s) [462.575865] Subtest deep-color: SUCCESS (17.421s) [463.471290] [060/131] (558s left) gem_exec_create (forked) [463.532847] Starting subtest: forked [463.533970] Starting dynamic subtest: smem [484.888762] Dynamic subtest smem: SUCCESS (21.352s) [484.890420] Subtest forked: SUCCESS (21.355s) [485.103553] [061/131] (536s left) gem_exec_schedule (pi-common) [485.283969] Starting subtest: pi-common [485.285328] Starting dynamic subtest: rcs0 [485.321736] Dynamic subtest rcs0: SUCCESS (0.040s) [485.329095] Starting dynamic subtest: bcs0 [485.369074] Dynamic subtest bcs0: SUCCESS (0.046s) [485.376521] Starting dynamic subtest: vcs0 [485.412941] Dynamic subtest vcs0: SUCCESS (0.043s) [485.421067] Starting dynamic subtest: vcs1 [485.448313] Dynamic subtest vcs1: SUCCESS (0.034s) [485.455148] Starting dynamic subtest: vecs0 [485.482673] Dynamic subtest vecs0: SUCCESS (0.033s) [485.489582] Starting dynamic subtest: ccs0 [485.515037] Dynamic subtest ccs0: SUCCESS (0.032s) [485.515886] Subtest pi-common: SUCCESS (0.234s) [485.771611] [062/131] (535s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted) [485.829330] Starting subtest: invalid-multi-wait-unsubmitted-submitted [485.830301] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [485.956901] [063/131] (535s left) syncobj_timeline (single-wait-signaled) [486.010051] Starting subtest: single-wait-signaled [486.011029] Subtest single-wait-signaled: SUCCESS (0.000s) [486.133548] [064/131] (535s left) gem_ctx_persistence (saturated-hostile) [486.194800] Starting subtest: saturated-hostile [486.195836] Starting dynamic subtest: rcs0 [487.058539] Dynamic subtest rcs0: SUCCESS (0.862s) [487.068232] Starting dynamic subtest: bcs0 [487.875493] Dynamic subtest bcs0: SUCCESS (0.816s) [487.886196] Starting dynamic subtest: vcs0 [488.692389] Dynamic subtest vcs0: SUCCESS (0.815s) [488.701324] Starting dynamic subtest: vcs1 [489.516805] Dynamic subtest vcs1: SUCCESS (0.822s) [489.526842] Starting dynamic subtest: vecs0 [490.328415] Dynamic subtest vecs0: SUCCESS (0.811s) [490.339212] Starting dynamic subtest: ccs0 [491.186536] Dynamic subtest ccs0: SUCCESS (0.856s) [491.189588] Subtest saturated-hostile: SUCCESS (4.993s) [491.283772] [065/131] (530s left) gem_close_race (multigpu-basic-threads) [491.359608] Starting subtest: multigpu-basic-threads [491.361445] Subtest multigpu-basic-threads: SKIP (0.000s) [491.634628] [066/131] (530s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt) [491.731762] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt [491.733404] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [491.861835] [067/131] (530s left) kms_pm_rpm (i2c) [494.089947] Starting subtest: i2c [499.421590] Subtest i2c: SUCCESS (5.335s) [499.534652] [068/131] (522s left) kms_psr (fbc-pr-sprite-plane-move) [499.635467] Starting subtest: fbc-pr-sprite-plane-move [499.637372] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s) [499.729387] [069/131] (522s left) gem_mmap_offset (bad-extensions) [499.794813] Starting subtest: bad-extensions [499.795808] Subtest bad-extensions: SUCCESS (0.000s) [499.910275] [070/131] (522s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render) [500.004898] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render [500.006613] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [500.123475] [071/131] (521s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt) [500.209344] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt [500.211473] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [500.350490] [072/131] (521s left) perf_pmu (most-busy-idle-check-all) [500.388341] Starting subtest: most-busy-idle-check-all [500.389611] Starting dynamic subtest: rcs0 [501.911473] Dynamic subtest rcs0: SUCCESS (1.520s) [501.922403] Starting dynamic subtest: bcs0 [503.895787] Dynamic subtest bcs0: SUCCESS (1.982s) [503.904877] Starting dynamic subtest: vcs0 [505.879348] Dynamic subtest vcs0: SUCCESS (1.981s) [505.888060] Starting dynamic subtest: vcs1 [507.926415] Dynamic subtest vcs1: SUCCESS (2.046s) [507.937882] Starting dynamic subtest: vecs0 [509.912087] Dynamic subtest vecs0: SUCCESS (1.981s) [509.922614] Starting dynamic subtest: ccs0 [511.896213] Dynamic subtest ccs0: SUCCESS (1.981s) [511.897693] Subtest most-busy-idle-check-all: SUCCESS (11.507s) [512.032731] [073/131] (510s left) kms_chamelium_edid (dp-edid-stress-resolution-4k) [512.437291] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s) [513.201402] [074/131] (508s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [513.307819] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [513.309561] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [513.426185] [075/131] (508s left) gem_ctx_persistence (engines-cleanup) [513.489359] Starting subtest: engines-cleanup [513.490204] Starting dynamic subtest: rcs0 [513.602783] Dynamic subtest rcs0: SUCCESS (0.114s) [513.614254] Starting dynamic subtest: bcs0 [513.667917] Dynamic subtest bcs0: SUCCESS (0.063s) [513.679532] Starting dynamic subtest: vcs0 [513.728655] Dynamic subtest vcs0: SUCCESS (0.059s) [513.739684] Starting dynamic subtest: vcs1 [513.747938] Dynamic subtest vcs1: SUCCESS (0.018s) [513.754451] Starting dynamic subtest: vecs0 [513.831831] Dynamic subtest vecs0: SUCCESS (0.082s) [513.843407] Starting dynamic subtest: ccs0 [513.881581] Dynamic subtest ccs0: SUCCESS (0.048s) [513.882765] Subtest engines-cleanup: SUCCESS (0.394s) [513.980665] [076/131] (508s left) prime_mmap (test_map_unmap) [514.033139] Starting subtest: test_map_unmap [514.033982] Starting dynamic subtest: test_map_unmap-smem [514.063887] Dynamic subtest test_map_unmap-smem: SUCCESS (0.031s) [514.064905] Subtest test_map_unmap: SUCCESS (0.032s) [514.181980] [077/131] (508s left) gem_userptr_blits (set-cache-level) [514.240016] Starting subtest: set-cache-level [514.241988] Subtest set-cache-level: SKIP (0.000s) [514.385604] [078/131] (507s left) gem_busy (busy) [514.449919] Starting subtest: busy [514.450953] Starting dynamic subtest: all-engines [514.522908] Dynamic subtest all-engines: SUCCESS (0.073s) [514.530700] Starting dynamic subtest: rcs0 [515.870190] Dynamic subtest rcs0: SUCCESS (1.346s) [515.879020] Starting dynamic subtest: bcs0 [515.911051] Dynamic subtest bcs0: SUCCESS (0.041s) [515.918057] Starting dynamic subtest: vcs0 [515.951431] Dynamic subtest vcs0: SUCCESS (0.040s) [515.959525] Starting dynamic subtest: vcs1 [517.915696] Dynamic subtest vcs1: SUCCESS (1.959s) [517.924968] Starting dynamic subtest: vecs0 [519.898215] Dynamic subtest vecs0: SUCCESS (1.982s) [519.907646] Starting dynamic subtest: ccs0 [521.883645] Dynamic subtest ccs0: SUCCESS (1.983s) [521.884898] Subtest busy: SUCCESS (7.431s) [522.274642] [079/131] (500s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render) [522.391650] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render [529.730084] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.339s) [529.894511] [080/131] (492s left) core_auth (basic-auth) [529.950849] Starting subtest: basic-auth [529.951822] Subtest basic-auth: SUCCESS (0.001s) [530.084230] [081/131] (492s left) prime_mmap_coherency (write) [530.135100] Starting subtest: write [535.511450] Subtest write: SUCCESS (5.373s) [535.696190] [082/131] (486s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs) [535.762719] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs [535.764677] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s) [535.965740] [083/131] (486s left) perf (gen12-invalid-class-instance) [536.093619] Starting subtest: gen12-invalid-class-instance [536.104059] Subtest gen12-invalid-class-instance: SUCCESS (0.011s) [536.136939] [084/131] (486s left) kms_lease (lease-get) [536.240917] Starting subtest: lease-get [536.241862] Starting dynamic subtest: pipe-A-eDP-1 [536.242716] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [536.253966] Starting dynamic subtest: pipe-B-eDP-1 [536.254801] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [536.261826] Starting dynamic subtest: pipe-C-eDP-1 [536.262653] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [536.269453] Starting dynamic subtest: pipe-D-eDP-1 [536.270302] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [536.271110] Subtest lease-get: SUCCESS (0.009s) [536.389254] [085/131] (486s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt) [536.479737] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt [536.481433] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [536.613928] [086/131] (485s left) i915_pm_rpm (system-suspend-devices) [538.140718] Starting subtest: system-suspend-devices [549.630931] Subtest system-suspend-devices: SUCCESS (11.489s) [556.032072] [087/131] (472s left) kms_cursor_edge_walk (128x128-right-edge) [556.118920] Starting subtest: 128x128-right-edge [556.119790] Starting dynamic subtest: pipe-A-eDP-1 [559.543608] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.424s) [559.551816] Starting dynamic subtest: pipe-D-eDP-1 [562.669317] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.124s) [562.670175] Subtest 128x128-right-edge: SUCCESS (6.551s) [563.490878] [088/131] (465s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf) [568.565146] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf [568.566056] Starting dynamic subtest: pipe-A-eDP-1 [569.348496] Dynamic subtest pipe-A-eDP-1: SKIP (0.782s) [569.357846] Starting dynamic subtest: pipe-B-eDP-1 [570.475141] Dynamic subtest pipe-B-eDP-1: SKIP (1.124s) [570.476944] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.911s) [571.687613] [089/131] (456s left) perf (i915-ref-count) [571.778793] Starting subtest: i915-ref-count [571.800949] Subtest i915-ref-count: SUCCESS (0.021s) [571.867809] [090/131] (456s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move) [571.962791] Starting subtest: fbc-2p-primscrn-spr-indfb-move [571.964372] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s) [572.088260] [091/131] (456s left) core_auth (getclient-simple) [572.122462] Starting subtest: getclient-simple [572.147816] Subtest getclient-simple: SUCCESS (0.025s) [572.280861] [092/131] (456s left) i915_pciid [572.460373] [093/131] (456s left) gem_exec_fence (syncobj-timeline-signal) [573.050354] Starting subtest: syncobj-timeline-signal [573.058249] Subtest syncobj-timeline-signal: SUCCESS (0.008s) [574.036546] [094/131] (454s left) kms_flip (bo-too-big) [574.131657] Starting subtest: bo-too-big [574.133850] Starting dynamic subtest: A-eDP1 [575.420801] Dynamic subtest A-eDP1: SUCCESS (1.286s) [575.430308] Starting dynamic subtest: B-eDP1 [576.757501] Dynamic subtest B-eDP1: SUCCESS (1.336s) [576.769873] Starting dynamic subtest: C-eDP1 [578.095666] Dynamic subtest C-eDP1: SUCCESS (1.337s) [578.105448] Starting dynamic subtest: D-eDP1 [579.425718] Dynamic subtest D-eDP1: SUCCESS (1.329s) [579.428854] Subtest bo-too-big: SUCCESS (5.296s) [580.658933] [095/131] (448s left) kms_psr (pr-basic) [580.750683] Starting subtest: pr-basic [580.752775] Subtest pr-basic: SKIP (0.000s) [580.843835] [096/131] (448s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt) [580.931479] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt [580.933250] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [581.050468] [097/131] (447s left) kms_addfb_basic (tile-pitch-mismatch) [581.111696] Starting subtest: tile-pitch-mismatch [581.113837] Subtest tile-pitch-mismatch: SKIP (0.000s) [581.272952] [098/131] (447s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs) [581.359350] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs [581.360221] Starting dynamic subtest: pipe-A-eDP-1 [581.363435] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [581.373838] Starting dynamic subtest: pipe-B-eDP-1 [581.377256] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [581.385440] Starting dynamic subtest: pipe-C-eDP-1 [581.388902] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [581.396561] Starting dynamic subtest: pipe-D-eDP-1 [581.399858] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [581.401503] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.005s) [583.518596] [099/131] (445s left) gem_exec_reloc (basic-write-cpu-active) [583.588450] Subtest basic-write-cpu-active: SKIP (0.000s) [583.665474] [100/131] (445s left) gem_exec_whisper (basic-queues-forked-all) [583.734831] Starting subtest: basic-queues-forked-all [602.149882] Subtest basic-queues-forked-all: SUCCESS (18.410s) [602.348077] [101/131] (426s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling) [602.433185] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling [602.434066] Starting dynamic subtest: pipe-A-default-mode [603.560796] Dynamic subtest pipe-A-default-mode: SKIP (1.125s) [603.562920] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.126s) [603.747048] [102/131] (425s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling) [603.832152] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling [603.832919] Starting dynamic subtest: pipe-A-default-mode [604.118579] Dynamic subtest pipe-A-default-mode: SKIP (0.284s) [604.120420] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.285s) [604.999939] [103/131] (424s left) prime_mmap (test_dup) [605.054573] Starting subtest: test_dup [605.055451] Starting dynamic subtest: test_dup-smem [605.085835] Dynamic subtest test_dup-smem: SUCCESS (0.032s) [605.086758] Subtest test_dup: SUCCESS (0.033s) [605.180562] [104/131] (424s left) kms_addfb_basic (legacy-format) [605.234431] Starting subtest: legacy-format [605.261233] Subtest legacy-format: SUCCESS (0.027s) [605.419150] [105/131] (423s left) gem_workarounds (suspend-resume-context) [605.495549] Starting subtest: suspend-resume-context [622.265506] Subtest suspend-resume-context: SUCCESS (1.603s) [631.441818] [106/131] (406s left) gem_fence_thrash (bo-write-verify-none) [631.475442] Starting subtest: bo-write-verify-none [631.489689] Subtest bo-write-verify-none: SKIP (0.014s) [631.552479] [107/131] (406s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf) [636.563614] Starting subtest: psr2-cursor-plane-move-continuous-sf [636.564716] Starting dynamic subtest: pipe-A-eDP-1 [647.653572] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.083s) [647.664148] Starting dynamic subtest: pipe-B-eDP-1 [658.670733] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.012s) [658.671733] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (22.099s) [659.486054] [108/131] (378s left) kms_rotation_crc (primary-rotation-270) [659.588851] Starting subtest: primary-rotation-270 [659.590549] Subtest primary-rotation-270: SKIP (0.001s) [659.680249] [109/131] (378s left) syncobj_wait (invalid-reset-illegal-handle) [659.737642] Starting subtest: invalid-reset-illegal-handle [659.738695] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [659.862250] [110/131] (378s left) gem_render_copy (y-tiled-ccs-to-y-tiled) [659.923501] Starting subtest: y-tiled-ccs-to-y-tiled [659.925491] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s) [660.133547] [111/131] (378s left) kms_rotation_crc (primary-y-tiled-reflect-x-270) [660.214715] Starting subtest: primary-y-tiled-reflect-x-270 [660.216315] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s) [660.303846] [112/131] (378s left) gen9_exec_parse (bb-large) [660.359577] Subtest bb-large: SKIP (0.000s) [660.435867] [113/131] (378s left) syncobj_timeline (multi-wait-all-for-submit-signaled) [660.487984] Starting subtest: multi-wait-all-for-submit-signaled [660.488905] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s) [660.614039] [114/131] (377s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats) [660.701758] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats [660.702582] Starting dynamic subtest: pipe-A [660.823908] Dynamic subtest pipe-A: SKIP (0.121s) [660.832167] Starting dynamic subtest: pipe-B [662.018365] Dynamic subtest pipe-B: SKIP (1.192s) [662.026582] Starting dynamic subtest: pipe-C [663.167147] Dynamic subtest pipe-C: SUCCESS (1.150s) [663.175398] Starting dynamic subtest: pipe-D [664.318896] Dynamic subtest pipe-D: SUCCESS (1.151s) [664.321011] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.619s) [665.525687] [115/131] (373s left) kms_psr (psr2-cursor-render) [665.609274] Starting subtest: psr2-cursor-render [665.610243] Starting dynamic subtest: eDP-1 [667.288356] Dynamic subtest eDP-1: SUCCESS (1.680s) [667.289218] Subtest psr2-cursor-render: SUCCESS (1.681s) [668.191119] [116/131] (370s left) gem_userptr_blits (invalid-null-pointer) [668.250127] Starting subtest: invalid-null-pointer [668.250930] Subtest invalid-null-pointer: SUCCESS (0.001s) [668.402264] [117/131] (370s left) api_intel_allocator (simple-allocator) [668.458308] Starting subtest: simple-allocator [668.459308] Starting dynamic subtest: basic [668.464349] Dynamic subtest basic: SUCCESS (0.006s) [668.476897] Starting dynamic subtest: parallel-one [668.654216] Dynamic subtest parallel-one: SUCCESS (0.187s) [668.662750] Starting dynamic subtest: print [668.664014] Dynamic subtest print: SUCCESS (0.000s) [668.672449] Starting dynamic subtest: reuse [668.673412] Dynamic subtest reuse: SUCCESS (0.000s) [668.681378] Starting dynamic subtest: reserve [668.682261] Dynamic subtest reserve: SUCCESS (0.000s) [668.690079] Starting dynamic subtest: fork-reopen-allocator [668.690974] Dynamic subtest fork-reopen-allocator: SUCCESS (0.010s) [668.691734] Subtest simple-allocator: SUCCESS (0.211s) [668.806488] [118/131] (369s left) kms_pipe_stress (stress-xrgb8888-yftiled) [668.906607] Starting subtest: stress-xrgb8888-yftiled [668.908325] Subtest stress-xrgb8888-yftiled: SKIP (0.000s) [668.967592] [119/131] (369s left) kms_flip (wf_vblank-ts-check) [669.057482] Starting subtest: wf_vblank-ts-check [669.059798] Starting dynamic subtest: A-eDP1 [678.027616] Dynamic subtest A-eDP1: SUCCESS (8.966s) [678.037474] Starting dynamic subtest: B-eDP1 [686.962353] Dynamic subtest B-eDP1: SUCCESS (8.931s) [686.985415] Starting dynamic subtest: C-eDP1 [695.889638] Dynamic subtest C-eDP1: SUCCESS (8.923s) [695.906623] Starting dynamic subtest: D-eDP1 [704.819456] Dynamic subtest D-eDP1: SUCCESS (8.926s) [704.821865] Subtest wf_vblank-ts-check: SUCCESS (35.757s) [706.067207] [120/131] (332s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs) [706.166115] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs [706.167042] Starting dynamic subtest: pipe-A-eDP-1 [706.175767] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [706.184723] Starting dynamic subtest: pipe-B-eDP-1 [706.193119] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [706.201532] Starting dynamic subtest: pipe-C-eDP-1 [706.209712] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [706.217434] Starting dynamic subtest: pipe-D-eDP-1 [706.225895] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [706.227474] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.004s) [708.438082] [121/131] (330s left) syncobj_timeline (invalid-multi-wait-unsubmitted) [708.497725] Starting subtest: invalid-multi-wait-unsubmitted [708.498809] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s) [708.699279] [122/131] (330s left) prime_mmap (test_errors) [708.883397] Starting subtest: test_errors [708.884504] Starting dynamic subtest: test_errors-smem [709.087894] Dynamic subtest test_errors-smem: SUCCESS (0.203s) [709.089491] Subtest test_errors: SUCCESS (0.204s) [709.301196] [123/131] (329s left) gem_exec_async (forked-writes) [709.423338] Starting subtest: forked-writes [709.424530] Starting dynamic subtest: rcs0 [709.457859] Dynamic subtest rcs0: SUCCESS (0.034s) [709.467143] Starting dynamic subtest: bcs0 [709.483833] Dynamic subtest bcs0: SUCCESS (0.025s) [709.492142] Starting dynamic subtest: vcs0 [709.513495] Dynamic subtest vcs0: SUCCESS (0.029s) [709.523182] Starting dynamic subtest: vcs1 [709.558870] Dynamic subtest vcs1: SUCCESS (0.044s) [709.567888] Starting dynamic subtest: vecs0 [709.596402] Dynamic subtest vecs0: SUCCESS (0.036s) [709.608408] Starting dynamic subtest: ccs0 [709.646914] Dynamic subtest ccs0: SUCCESS (0.049s) [709.648076] Subtest forked-writes: SUCCESS (0.224s) [709.936696] [124/131] (328s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt) [710.036071] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt [714.511259] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.475s) [715.729571] [125/131] (323s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling) [715.816966] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling [715.817845] Starting dynamic subtest: pipe-A-default-mode [716.127907] Dynamic subtest pipe-A-default-mode: SKIP (0.310s) [716.129606] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.311s) [716.936542] [126/131] (322s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite) [717.029204] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite [726.321314] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.290s) [726.476557] [127/131] (312s left) gem_mmap_gtt (cpuset-basic-small-copy) [726.530597] Subtest cpuset-basic-small-copy: SKIP (0.000s) [726.595697] [128/131] (312s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area) [731.577797] Starting subtest: psr2-primary-plane-update-sf-dmg-area [731.578669] Starting dynamic subtest: pipe-A-eDP-1 [738.224523] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.646s) [738.233973] Starting dynamic subtest: pipe-B-eDP-1 [744.897602] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.671s) [744.898556] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (13.323s) [745.782000] [129/131] (293s left) sriov_basic (enable-vfs-bind-unbind-each) [745.842534] Starting subtest: enable-vfs-bind-unbind-each [745.843862] Starting dynamic subtest: numvfs-1 [745.876413] Dynamic subtest numvfs-1: FAIL (0.016s) [745.887346] Starting dynamic subtest: numvfs-2 [745.915995] Dynamic subtest numvfs-2: FAIL (0.004s) [745.924045] Starting dynamic subtest: numvfs-3 [745.951101] Dynamic subtest numvfs-3: FAIL (0.004s) [745.961402] Starting dynamic subtest: numvfs-4 [745.988533] Dynamic subtest numvfs-4: FAIL (0.004s) [745.996700] Starting dynamic subtest: numvfs-5 [746.023620] Dynamic subtest numvfs-5: FAIL (0.004s) [746.031227] Starting dynamic subtest: numvfs-6 [746.058168] Dynamic subtest numvfs-6: FAIL (0.005s) [746.065648] Starting dynamic subtest: numvfs-7 [746.092726] Dynamic subtest numvfs-7: FAIL (0.005s) [746.100157] Starting dynamic subtest: numvfs-random [746.126956] Dynamic subtest numvfs-random: FAIL (0.004s) [746.127797] Subtest enable-vfs-bind-unbind-each: FAIL (0.052s) [746.156589] [130/131] (292s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite) [746.254851] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite [753.092259] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.840s) [753.250124] [131/131] (285s left) gem_exec_schedule (u-fairslice) [753.324616] Starting subtest: u-fairslice [753.325614] Starting dynamic subtest: rcs0 [755.350687] Dynamic subtest rcs0: SUCCESS (2.025s) [755.359553] Starting dynamic subtest: bcs0 [757.370339] Dynamic subtest bcs0: SUCCESS (2.020s) [757.379097] Starting dynamic subtest: vcs0 [759.392345] Dynamic subtest vcs0: SUCCESS (2.019s) [759.400730] Starting dynamic subtest: vcs1 [761.411696] Dynamic subtest vcs1: SUCCESS (2.019s) [761.420382] Starting dynamic subtest: vecs0 [763.433049] Dynamic subtest vecs0: SUCCESS (2.021s) [763.441312] Starting dynamic subtest: ccs0 [765.454529] Dynamic subtest ccs0: SUCCESS (2.021s) [765.455573] Subtest u-fairslice: SUCCESS (12.132s) [765.767691] Closing watchdogs results: parsing output: 0/ for test: kms_addfb_basic results: parsing output: 1/ for test: kms_frontbuffer_tracking results: parsing output: 2/ for test: kms_big_fb results: parsing output: 3/ for test: kms_vrr results: parsing output: 4/ for test: syncobj_timeline results: parsing output: 5/ for test: gem_exec_fence results: parsing output: 6/ for test: perf_pmu results: parsing output: 7/ for test: kms_plane_multiple results: parsing output: 8/ for test: kms_big_fb results: parsing output: 9/ for test: kms_big_fb results: parsing output: 10/ for test: kms_frontbuffer_tracking results: parsing output: 11/ for test: gem_exec_whisper results: parsing output: 12/ for test: sw_sync results: parsing output: 13/ for test: i915_query results: parsing output: 14/ for test: gem_exec_reloc results: parsing output: 15/ for test: gem_exec_endless results: parsing output: 16/ for test: kms_selftest results: parsing output: 17/ for test: kms_big_fb results: parsing output: 18/ for test: kms_frontbuffer_tracking results: parsing output: 19/ for test: gem_mmap_wc results: parsing output: 20/ for test: gem_mmap_gtt results: parsing output: 21/ for test: kms_frontbuffer_tracking results: parsing output: 22/ for test: kms_psr results: parsing output: 23/ for test: dmabuf_sync_file results: parsing output: 24/ for test: kms_pm_rpm results: parsing output: 25/ for test: kms_plane_scaling results: parsing output: 26/ for test: prime_vgem results: parsing output: 27/ for test: gem_mmap_gtt results: parsing output: 28/ for test: kms_cursor_crc results: parsing output: 29/ for test: i915_pm_sseu results: parsing output: 30/ for test: kms_ccs results: parsing output: 31/ for test: kms_dp_link_training results: parsing output: 32/ for test: kms_ccs results: parsing output: 33/ for test: gem_pxp results: parsing output: 34/ for test: gem_exec_flush results: parsing output: 35/ for test: syncobj_timeline results: parsing output: 36/ for test: kms_big_fb results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: gem_partial_pwrite_pread results: parsing output: 39/ for test: gem_flink_basic results: parsing output: 40/ for test: gem_ctx_shared results: parsing output: 41/ for test: kms_cursor_legacy results: parsing output: 42/ for test: gem_readwrite results: parsing output: 43/ for test: kms_busy results: parsing output: 44/ for test: kms_color results: parsing output: 45/ for test: kms_ccs results: parsing output: 46/ for test: kms_frontbuffer_tracking results: parsing output: 47/ for test: kms_frontbuffer_tracking results: parsing output: 48/ for test: i915_drm_fdinfo results: parsing output: 49/ for test: kms_addfb_basic results: parsing output: 50/ for test: sysfs_heartbeat_interval results: parsing output: 51/ for test: kms_atomic results: parsing output: 52/ for test: kms_sequence results: parsing output: 53/ for test: kms_invalid_mode results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: gem_softpin results: parsing output: 56/ for test: kms_cursor_crc results: parsing output: 57/ for test: kms_frontbuffer_tracking results: parsing output: 58/ for test: kms_color results: parsing output: 59/ for test: gem_exec_create results: parsing output: 60/ for test: gem_exec_schedule results: parsing output: 61/ for test: syncobj_wait results: parsing output: 62/ for test: syncobj_timeline results: parsing output: 63/ for test: gem_ctx_persistence results: parsing output: 64/ for test: gem_close_race results: parsing output: 65/ for test: kms_frontbuffer_tracking results: parsing output: 66/ for test: kms_pm_rpm results: parsing output: 67/ for test: kms_psr results: parsing output: 68/ for test: gem_mmap_offset results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: perf_pmu results: parsing output: 72/ for test: kms_chamelium_edid results: parsing output: 73/ for test: kms_big_fb results: parsing output: 74/ for test: gem_ctx_persistence results: parsing output: 75/ for test: prime_mmap results: parsing output: 76/ for test: gem_userptr_blits results: parsing output: 77/ for test: gem_busy results: parsing output: 78/ for test: kms_frontbuffer_tracking results: parsing output: 79/ for test: core_auth results: parsing output: 80/ for test: prime_mmap_coherency results: parsing output: 81/ for test: gem_render_copy results: parsing output: 82/ for test: perf results: parsing output: 83/ for test: kms_lease results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: i915_pm_rpm results: parsing output: 86/ for test: kms_cursor_edge_walk results: parsing output: 87/ for test: kms_psr2_sf results: parsing output: 88/ for test: perf results: parsing output: 89/ for test: kms_frontbuffer_tracking results: parsing output: 90/ for test: core_auth results: parsing output: 91/ for test: i915_pciid results: parsing output: 92/ for test: gem_exec_fence results: parsing output: 93/ for test: kms_flip results: parsing output: 94/ for test: kms_psr results: parsing output: 95/ for test: kms_frontbuffer_tracking results: parsing output: 96/ for test: kms_addfb_basic results: parsing output: 97/ for test: kms_ccs results: parsing output: 98/ for test: gem_exec_reloc results: parsing output: 99/ for test: gem_exec_whisper results: parsing output: 100/ for test: kms_flip_scaled_crc results: parsing output: 101/ for test: kms_flip_scaled_crc results: parsing output: 102/ for test: prime_mmap results: parsing output: 103/ for test: kms_addfb_basic results: parsing output: 104/ for test: gem_workarounds results: parsing output: 105/ for test: gem_fence_thrash results: parsing output: 106/ for test: kms_psr2_sf results: parsing output: 107/ for test: kms_rotation_crc results: parsing output: 108/ for test: syncobj_wait results: parsing output: 109/ for test: gem_render_copy results: parsing output: 110/ for test: kms_rotation_crc results: parsing output: 111/ for test: gen9_exec_parse results: parsing output: 112/ for test: syncobj_timeline results: parsing output: 113/ for test: kms_plane_scaling results: parsing output: 114/ for test: kms_psr results: parsing output: 115/ for test: gem_userptr_blits results: parsing output: 116/ for test: api_intel_allocator results: parsing output: 117/ for test: kms_pipe_stress results: parsing output: 118/ for test: kms_flip results: parsing output: 119/ for test: kms_ccs results: parsing output: 120/ for test: syncobj_timeline results: parsing output: 121/ for test: prime_mmap results: parsing output: 122/ for test: gem_exec_async results: parsing output: 123/ for test: kms_frontbuffer_tracking results: parsing output: 124/ for test: kms_flip_scaled_crc results: parsing output: 125/ for test: kms_frontbuffer_tracking results: parsing output: 126/ for test: gem_mmap_gtt results: parsing output: 127/ for test: kms_psr2_sf results: parsing output: 128/ for test: sriov_basic results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: gem_exec_schedule Done.