[59.373033] Initializing watchdogs [59.373094] /dev/watchdog0 [59.389376] [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.393773] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.396094] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.398172] [001/131] (960s left) gem_userptr_blits (unsync-unmap) [59.467090] Subtest unsync-unmap: SKIP (0.000s) [59.627364] [002/131] (960s left) kms_flip (flip-vs-panning-interruptible) [59.725845] Starting subtest: flip-vs-panning-interruptible [59.727092] Starting dynamic subtest: A-eDP1 [68.417284] Dynamic subtest A-eDP1: SUCCESS (8.689s) [68.425692] Starting dynamic subtest: B-eDP1 [77.154719] Dynamic subtest B-eDP1: SUCCESS (8.737s) [77.163948] Starting dynamic subtest: C-eDP1 [85.869549] Dynamic subtest C-eDP1: SUCCESS (8.712s) [85.877909] Starting dynamic subtest: D-eDP1 [94.603698] Dynamic subtest D-eDP1: SUCCESS (8.733s) [94.606781] Subtest flip-vs-panning-interruptible: SUCCESS (34.880s) [95.776225] [003/131] (924s left) kms_pipe_crc_basic (hang-read-crc) [95.857820] Starting subtest: hang-read-crc [95.858651] Starting dynamic subtest: pipe-A-eDP-1 [97.947937] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.089s) [97.954213] Starting dynamic subtest: pipe-B-eDP-1 [100.695835] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.747s) [100.707122] Starting dynamic subtest: pipe-C-eDP-1 [103.313420] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.616s) [103.319718] Starting dynamic subtest: pipe-D-eDP-1 [105.969938] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.655s) [105.970878] Subtest hang-read-crc: SUCCESS (10.111s) [106.831352] [004/131] (913s left) kms_vblank (query-forked-hang) [106.928419] Starting subtest: query-forked-hang [106.930483] Starting dynamic subtest: pipe-A-eDP-1 [133.734825] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.803s) [133.743551] Starting dynamic subtest: pipe-D-eDP-1 [148.696637] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.959s) [148.697498] Subtest query-forked-hang: SUCCESS (41.768s) [149.595380] [005/131] (870s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size) [149.714133] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size [181.296161] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.581s) [182.115111] [006/131] (837s left) gem_readwrite (new-obj) [182.177930] Subtest new-obj: SKIP (0.000s) [182.243235] [007/131] (837s left) gem_create (create-size-update) [182.307797] Starting subtest: create-size-update [182.308840] Subtest create-size-update: SUCCESS (0.000s) [182.563223] [008/131] (837s left) syncobj_timeline (multi-wait-available-signaled) [182.614751] Starting subtest: multi-wait-available-signaled [182.615651] Subtest multi-wait-available-signaled: SUCCESS (0.000s) [182.755182] [009/131] (837s left) gem_mmap_offset (partial-unmap) [182.810986] Starting subtest: partial-unmap [182.811988] Starting dynamic subtest: smem0 [183.250347] Dynamic subtest smem0: SUCCESS (0.439s) [183.251747] Subtest partial-unmap: SUCCESS (0.440s) [183.397195] [010/131] (836s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render) [183.486893] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render [190.590960] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (7.102s) [190.754386] [011/131] (829s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels) [190.848389] Starting subtest: plane-all-modeset-transition-internal-panels [190.849337] Starting dynamic subtest: pipe-A-eDP-1 [192.187448] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.336s) [192.468727] Starting dynamic subtest: pipe-B-eDP-1 [193.511048] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.048s) [193.795382] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.947s) [194.636465] [012/131] (825s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75) [194.725449] Starting subtest: planes-unity-scaling-downscale-factor-0-75 [194.726444] Starting dynamic subtest: pipe-A [194.788907] Dynamic subtest pipe-A: SUCCESS (0.064s) [194.796618] Starting dynamic subtest: pipe-B [195.949604] Dynamic subtest pipe-B: SUCCESS (1.159s) [195.958914] Starting dynamic subtest: pipe-C [197.051318] Dynamic subtest pipe-C: SUCCESS (1.100s) [197.058964] Starting dynamic subtest: pipe-D [198.184846] Dynamic subtest pipe-D: SUCCESS (1.131s) [198.185810] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.461s) [199.357870] [013/131] (820s left) gem_render_copy (y-tiled-to-vebox-linear) [199.417286] Starting subtest: y-tiled-to-vebox-linear [199.419059] Subtest y-tiled-to-vebox-linear: SKIP (0.000s) [199.617445] [014/131] (820s left) syncobj_basic (bad-flags-fd-to-handle) [199.678869] Starting subtest: bad-flags-fd-to-handle [199.679791] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s) [199.807105] [015/131] (820s left) kms_content_protection (srm) [199.954631] Starting subtest: srm [199.956434] Subtest srm: SKIP (0.001s) [200.115540] [016/131] (820s left) kms_vblank (query-idle-hang) [200.200130] Starting subtest: query-idle-hang [200.200971] Starting dynamic subtest: pipe-A-eDP-1 [226.708284] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.506s) [226.716458] Starting dynamic subtest: pipe-D-eDP-1 [241.751096] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.041s) [241.752052] Subtest query-idle-hang: SUCCESS (41.552s) [242.607464] [017/131] (777s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt) [242.714997] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt [242.716971] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [242.825266] [018/131] (777s left) kms_frontbuffer_tracking (psr-suspend) [242.910284] Starting subtest: psr-suspend [281.669088] Subtest psr-suspend: SUCCESS (12.358s) [287.848278] [019/131] (738s left) kms_addfb_basic (invalid-get-prop-any) [287.906502] Starting subtest: invalid-get-prop-any [287.907314] Subtest invalid-get-prop-any: SUCCESS (0.000s) [288.071842] [020/131] (738s left) kms_busy (extended-pageflip-hang-oldfb) [288.159828] Starting subtest: extended-pageflip-hang-oldfb [288.160676] Starting dynamic subtest: pipe-A [288.561094] Dynamic subtest pipe-A: SUCCESS (0.400s) [288.570244] Starting dynamic subtest: pipe-D [289.698750] Dynamic subtest pipe-D: SUCCESS (1.133s) [289.699603] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.538s) [290.568746] [021/131] (735s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt) [290.661564] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt [290.663469] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [290.763451] [022/131] (735s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite) [290.859901] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite [298.436488] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.572s) [298.568038] [023/131] (728s left) kms_pm_rpm (dpms-non-lpsp) [300.485324] Starting subtest: dpms-non-lpsp [300.488099] Subtest dpms-non-lpsp: SKIP (0.001s) [300.866710] [024/131] (725s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt) [300.958289] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt [300.960133] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [301.081086] [025/131] (725s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset) [301.169762] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset [301.181291] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.011s) [301.276301] [026/131] (725s left) prime_self_import (basic-with_one_bo_two_files) [301.304460] Starting subtest: basic-with_one_bo_two_files [301.326638] Subtest basic-with_one_bo_two_files: SUCCESS (0.023s) [301.452904] [027/131] (725s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw) [301.536607] Starting subtest: fbcpsr-1p-pri-indfb-multidraw [323.823410] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.283s) [323.974124] [028/131] (702s left) kms_psr (pr-sprite-render) [324.075085] Starting subtest: pr-sprite-render [324.076983] Subtest pr-sprite-render: SKIP (0.000s) [324.166551] [029/131] (702s left) gem_ctx_persistence (many-contexts) [324.214536] Starting subtest: many-contexts [369.469175] Subtest many-contexts: SUCCESS (45.247s) [369.566668] [030/131] (657s left) gem_exec_schedule (noreorder-priority) [369.765499] Starting subtest: noreorder-priority [369.766695] Starting dynamic subtest: rcs0 [370.941203] Dynamic subtest rcs0: SUCCESS (1.176s) [370.952003] Starting dynamic subtest: vcs0 [372.323279] Dynamic subtest vcs0: SUCCESS (1.379s) [372.334119] Starting dynamic subtest: vcs1 [374.354697] Dynamic subtest vcs1: SUCCESS (2.028s) [374.372034] Starting dynamic subtest: vecs0 [376.344169] Dynamic subtest vecs0: SUCCESS (1.985s) [376.352842] Starting dynamic subtest: ccs0 [377.516447] Dynamic subtest ccs0: SUCCESS (1.172s) [377.518167] Subtest noreorder-priority: SUCCESS (7.751s) [377.714785] [031/131] (649s left) kms_cursor_crc (cursor-sliding-128x42) [377.908854] Starting subtest: cursor-sliding-128x42 [377.949524] Subtest cursor-sliding-128x42: SKIP (0.039s) [378.185093] [032/131] (648s left) kms_psr (fbc-pr-sprite-blt) [378.274757] Starting subtest: fbc-pr-sprite-blt [378.276516] Subtest fbc-pr-sprite-blt: SKIP (0.000s) [378.362858] [033/131] (648s left) prime_self_import (basic-with_one_bo) [378.392555] Starting subtest: basic-with_one_bo [378.415233] Subtest basic-with_one_bo: SUCCESS (0.023s) [378.557247] [034/131] (648s left) gem_softpin (allocator-fork) [378.616372] Starting subtest: allocator-fork [380.834945] Subtest allocator-fork: SUCCESS (2.218s) [380.992364] [035/131] (645s left) vgem_basic (bad-handle) [381.083678] Starting subtest: bad-handle [381.084674] Subtest bad-handle: SUCCESS (0.000s) [381.155943] [FACT vgem_basic (bad-handle)] new: kernel.kmod_is_loaded.vgem: true [381.157747] [036/131] (645s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt) [381.256346] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt [381.258094] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [381.399021] [037/131] (645s left) kms_cursor_legacy (cursora-vs-flipb-atomic) [381.524387] Starting subtest: cursorA-vs-flipB-atomic [381.526304] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s) [381.686747] [038/131] (645s left) gem_ctx_create (basic-files) [381.752105] Starting subtest: basic-files [383.760526] Subtest basic-files: SUCCESS (2.008s) [385.394717] [039/131] (641s left) kms_big_fb (x-tiled-32bpp-rotate-90) [385.515136] Starting subtest: x-tiled-32bpp-rotate-90 [385.534882] Subtest x-tiled-32bpp-rotate-90: SKIP (0.019s) [385.693909] [040/131] (641s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf) [390.747785] Starting subtest: pr-cursor-plane-move-continuous-sf [390.750512] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.002s) [391.615531] [041/131] (635s left) kms_big_fb (y-tiled-8bpp-rotate-270) [391.715079] Starting subtest: y-tiled-8bpp-rotate-270 [391.716876] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s) [391.845520] [042/131] (635s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move) [391.958891] Starting subtest: psr-2p-scndscrn-cur-indfb-move [391.960650] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [392.096268] [043/131] (635s left) kms_flip (flip-vs-panning-vs-hang) [392.195209] Starting subtest: flip-vs-panning-vs-hang [392.197557] Starting dynamic subtest: A-eDP1 [431.775784] Dynamic subtest A-eDP1: SUCCESS (39.582s) [431.787138] Starting dynamic subtest: D-eDP1 [481.850643] Dynamic subtest D-eDP1: SUCCESS (50.070s) [481.853472] Subtest flip-vs-panning-vs-hang: SUCCESS (89.657s) [483.018474] [044/131] (544s left) gem_mmap_wc (pf-nonblock) [483.094989] Subtest pf-nonblock: SKIP (0.000s) [483.131128] [045/131] (544s left) i915_hangman (engine-engine-hang) [483.188829] Starting subtest: engine-engine-hang [483.189760] Starting dynamic subtest: rcs0 [484.244033] Dynamic subtest rcs0: SUCCESS (1.055s) [484.256353] Starting dynamic subtest: bcs0 [486.293473] Dynamic subtest bcs0: SUCCESS (2.045s) [486.304145] Starting dynamic subtest: vcs0 [488.275933] Dynamic subtest vcs0: SUCCESS (1.981s) [488.287643] Starting dynamic subtest: vcs1 [490.258904] Dynamic subtest vcs1: SUCCESS (1.980s) [490.269967] Starting dynamic subtest: vecs0 [492.247471] Dynamic subtest vecs0: SUCCESS (1.984s) [492.258096] Starting dynamic subtest: ccs0 [494.293506] Dynamic subtest ccs0: SUCCESS (2.043s) [494.295216] Subtest engine-engine-hang: SUCCESS (11.104s) [494.393827] [046/131] (532s left) kms_cursor_crc (cursor-random-64x21) [494.563980] Starting subtest: cursor-random-64x21 [494.604134] Subtest cursor-random-64x21: SKIP (0.038s) [494.874649] [047/131] (532s left) syncobj_timeline (single-wait-available-submitted) [494.916145] Starting subtest: single-wait-available-submitted [494.917074] Subtest single-wait-available-submitted: SUCCESS (0.000s) [495.046552] [048/131] (532s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc) [495.130634] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc [495.131461] Starting dynamic subtest: pipe-A-eDP-1 [495.139670] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [495.147355] Starting dynamic subtest: pipe-B-eDP-1 [495.155739] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [495.163693] Starting dynamic subtest: pipe-C-eDP-1 [495.171858] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [495.179052] Starting dynamic subtest: pipe-D-eDP-1 [495.187184] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [495.188813] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s) [497.375756] [049/131] (530s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs) [497.446461] Starting subtest: mixed-tiled-to-yf-tiled-ccs [497.448356] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s) [497.646299] [050/131] (529s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite) [497.746143] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite [504.482475] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.737s) [504.625380] [051/131] (522s left) kms_dirtyfb (psr-dirtyfb-ioctl) [504.721784] Starting subtest: psr-dirtyfb-ioctl [504.722798] Starting dynamic subtest: A-eDP-1 [508.634026] Dynamic subtest A-eDP-1: SUCCESS (3.912s) [508.634917] Subtest psr-dirtyfb-ioctl: SUCCESS (3.913s) [509.456553] [052/131] (518s left) prime_vgem (fence-wait) [509.548833] Starting subtest: fence-wait [509.549731] Starting dynamic subtest: rcs0 [510.615811] Dynamic subtest rcs0: SUCCESS (1.064s) [510.624719] Starting dynamic subtest: bcs0 [511.683756] Dynamic subtest bcs0: SUCCESS (1.067s) [511.693875] Starting dynamic subtest: vcs0 [512.721852] Dynamic subtest vcs0: SUCCESS (1.037s) [512.733253] Starting dynamic subtest: vcs1 [513.769725] Dynamic subtest vcs1: SUCCESS (1.046s) [513.778662] Starting dynamic subtest: vecs0 [514.816228] Dynamic subtest vecs0: SUCCESS (1.043s) [514.825101] Starting dynamic subtest: ccs0 [515.853713] Dynamic subtest ccs0: SUCCESS (1.035s) [515.855183] Subtest fence-wait: SUCCESS (6.303s) [515.994063] [053/131] (511s left) gem_exec_alignment (many) [516.054883] Starting subtest: many [538.799786] Subtest many: SUCCESS (22.742s) [540.044569] [054/131] (487s left) gem_exec_gttfill (basic) [540.133969] Starting subtest: basic [543.246125] Subtest basic: SUCCESS (3.112s) [543.451780] [055/131] (484s left) gem_exec_schedule (fifo) [543.535933] Starting subtest: fifo [543.536842] Starting dynamic subtest: rcs0 [543.713185] Dynamic subtest rcs0: SUCCESS (0.175s) [543.723553] Starting dynamic subtest: vcs0 [543.810049] Dynamic subtest vcs0: SUCCESS (0.097s) [543.821104] Starting dynamic subtest: vcs1 [543.914876] Dynamic subtest vcs1: SUCCESS (0.103s) [543.924817] Starting dynamic subtest: vecs0 [544.016496] Dynamic subtest vecs0: SUCCESS (0.101s) [544.026344] Starting dynamic subtest: ccs0 [544.163218] Dynamic subtest ccs0: SUCCESS (0.147s) [544.167363] Subtest fifo: SUCCESS (0.628s) [545.457212] [056/131] (482s left) kms_feature_discovery (display-3x) [545.555601] Starting subtest: display-3x [545.557462] Subtest display-3x: SKIP (0.000s) [545.646820] [057/131] (482s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render) [545.742361] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render [552.471799] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.730s) [552.626594] [058/131] (475s left) syncobj_basic (create-signaled) [552.685436] Starting subtest: create-signaled [552.686389] Subtest create-signaled: SUCCESS (0.000s) [552.798865] [059/131] (474s left) sw_sync (sync_random_merge) [552.838649] Starting subtest: sync_random_merge [552.891201] Subtest sync_random_merge: SUCCESS (0.052s) [552.973438] [060/131] (474s left) kms_frontbuffer_tracking (fbcpsr-2p-rte) [553.078253] Starting subtest: fbcpsr-2p-rte [553.080127] Subtest fbcpsr-2p-rte: SKIP (0.000s) [553.195708] [061/131] (474s left) kms_psr (fbc-psr-cursor-mmap-cpu) [553.287880] Starting subtest: fbc-psr-cursor-mmap-cpu [553.288785] Starting dynamic subtest: eDP-1 [553.290488] Dynamic subtest eDP-1: SKIP (0.000s) [553.292152] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.001s) [553.378504] [062/131] (474s left) kms_atomic (plane-invalid-params) [553.472926] Starting subtest: plane-invalid-params [553.473858] Starting dynamic subtest: pipe-A-eDP-1 [553.884359] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.411s) [553.885261] Subtest plane-invalid-params: SUCCESS (0.413s) [554.738457] [063/131] (473s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs) [554.835737] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs [554.836658] Starting dynamic subtest: pipe-A-eDP-1 [554.859251] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.024s) [554.868803] Starting dynamic subtest: pipe-B-eDP-1 [554.882221] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s) [554.892010] Starting dynamic subtest: pipe-C-eDP-1 [554.904946] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s) [554.914307] Starting dynamic subtest: pipe-D-eDP-1 [554.927414] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.021s) [554.928306] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.093s) [557.178865] [064/131] (470s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [557.273406] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [557.909897] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.637s) [558.156449] [065/131] (469s left) kms_psr (psr2-sprite-blt) [558.247535] Starting subtest: psr2-sprite-blt [558.248467] Starting dynamic subtest: eDP-1 [559.948467] Dynamic subtest eDP-1: SUCCESS (1.700s) [559.949492] Subtest psr2-sprite-blt: SUCCESS (1.700s) [560.840159] [066/131] (467s left) drm_mm (drm_mm) [560.870568] Starting subtest: drm_mm [560.918971] Starting dynamic subtest: drm_test_mm_init [561.052570] Dynamic subtest drm_test_mm_init: SUCCESS (0.131s) [561.060929] Starting dynamic subtest: drm_test_mm_debug [561.181556] Dynamic subtest drm_test_mm_debug: SUCCESS (0.127s) [561.189901] Starting dynamic subtest: drm_test_mm_align32 [561.306863] Dynamic subtest drm_test_mm_align32: SUCCESS (0.125s) [561.315479] Starting dynamic subtest: drm_test_mm_align64 [561.433934] Dynamic subtest drm_test_mm_align64: SUCCESS (0.126s) [561.442138] Starting dynamic subtest: drm_test_mm_lowest [561.559569] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.124s) [561.568646] Starting dynamic subtest: drm_test_mm_highest [561.681676] Dynamic subtest drm_test_mm_highest: SUCCESS (0.120s) [561.682672] Subtest drm_mm: SUCCESS (0.808s) [561.884199] [067/131] (466s left) kms_lease (lease-invalid-plane) [561.973523] Starting subtest: lease-invalid-plane [561.974347] Starting dynamic subtest: pipe-A-eDP-1 [561.975695] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [561.984185] Starting dynamic subtest: pipe-B-eDP-1 [561.985130] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [561.993469] Starting dynamic subtest: pipe-C-eDP-1 [561.994483] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [562.002730] Starting dynamic subtest: pipe-D-eDP-1 [562.003655] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [562.004540] Subtest lease-invalid-plane: SUCCESS (0.005s) [562.068197] [068/131] (466s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic) [562.191337] Starting subtest: flip-vs-cursor-busy-crc-atomic [562.995117] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.803s) [563.870592] [069/131] (464s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted) [563.936019] Starting subtest: etime-single-wait-all-available-unsubmitted [564.043294] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.104s) [564.134839] [070/131] (464s left) api_intel_bb (simple-bb-ctx) [564.187268] Starting subtest: simple-bb-ctx [564.194320] Subtest simple-bb-ctx: SUCCESS (0.008s) [564.358960] [071/131] (463s left) kms_psr (fbc-psr2-cursor-mmap-cpu) [564.459997] Starting subtest: fbc-psr2-cursor-mmap-cpu [564.460931] Starting dynamic subtest: eDP-1 [564.462852] Dynamic subtest eDP-1: SKIP (0.000s) [564.464699] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s) [564.551664] [072/131] (463s left) gem_busy (busy) [564.620829] Starting subtest: busy [564.621821] Starting dynamic subtest: all-engines [564.696809] Dynamic subtest all-engines: SUCCESS (0.076s) [564.707343] Starting dynamic subtest: rcs0 [566.334099] Dynamic subtest rcs0: SUCCESS (1.635s) [566.344489] Starting dynamic subtest: bcs0 [566.390784] Dynamic subtest bcs0: SUCCESS (0.056s) [566.400270] Starting dynamic subtest: vcs0 [566.430044] Dynamic subtest vcs0: SUCCESS (0.038s) [566.439481] Starting dynamic subtest: vcs1 [568.316763] Dynamic subtest vcs1: SUCCESS (1.882s) [568.327585] Starting dynamic subtest: vecs0 [570.298669] Dynamic subtest vecs0: SUCCESS (1.981s) [570.306711] Starting dynamic subtest: ccs0 [572.346316] Dynamic subtest ccs0: SUCCESS (2.047s) [572.347493] Subtest busy: SUCCESS (7.723s) [572.734980] [073/131] (455s left) gen9_exec_parse (bb-start-out) [572.799516] Subtest bb-start-out: SKIP (0.000s) [572.888996] [074/131] (455s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt) [573.007917] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt [579.878099] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.868s) [580.042444] [075/131] (448s left) kms_invalid_mode (zero-hdisplay) [580.129125] Starting subtest: zero-hdisplay [580.130048] Starting dynamic subtest: pipe-A-eDP-1 [580.412717] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s) [580.420844] Starting dynamic subtest: pipe-B-eDP-1 [580.421704] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [580.429388] Starting dynamic subtest: pipe-C-eDP-1 [580.430305] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [580.438204] Starting dynamic subtest: pipe-D-eDP-1 [580.439098] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [580.440011] Subtest zero-hdisplay: SUCCESS (0.289s) [581.231824] [076/131] (447s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt) [581.330178] Starting subtest: fbc-rgb101010-draw-mmap-gtt [581.331956] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s) [581.445398] [077/131] (446s left) kms_chamelium_frames (dp-crc-fast) [581.829971] Subtest dp-crc-fast: SKIP (0.000s) [582.609220] [078/131] (445s left) syncobj_timeline (reset-unsignaled) [582.659569] Starting subtest: reset-unsignaled [582.660597] Subtest reset-unsignaled: SUCCESS (0.000s) [582.785230] [079/131] (445s left) kms_selftest (drm_cmdline_parser) [582.819980] Starting subtest: drm_cmdline_parser [582.828663] Starting dynamic subtest: drm_test_cmdline_force_d_only [582.922533] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.094s) [582.932808] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi [583.071749] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.147s) [583.080729] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi [583.175057] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.104s) [583.184891] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital [583.296836] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.120s) [583.306225] Starting dynamic subtest: drm_test_cmdline_force_e_only [583.436804] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.139s) [583.446475] Starting dynamic subtest: drm_test_cmdline_res [583.539060] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.103s) [583.548566] Starting dynamic subtest: drm_test_cmdline_res_vesa [583.678556] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.138s) [583.686732] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank [583.810709] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.131s) [583.820218] Starting dynamic subtest: drm_test_cmdline_res_rblank [583.944459] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.132s) [583.953801] Starting dynamic subtest: drm_test_cmdline_res_bpp [584.045241] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.102s) [584.054872] Starting dynamic subtest: drm_test_cmdline_res_refresh [584.159675] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.112s) [584.169024] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh [584.292702] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.132s) [584.302092] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced [584.378791] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.087s) [584.388313] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins [584.455841] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.076s) [584.464992] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off [584.570541] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.112s) [584.580005] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on [584.695784] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.124s) [584.705220] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog [584.810546] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.114s) [584.820044] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital [584.934408] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.124s) [584.944151] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on [585.050533] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.114s) [585.060072] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on [585.147796] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.098s) [585.157435] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins [585.276624] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.126s) [585.284680] Starting dynamic subtest: drm_test_cmdline_name [585.403975] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.128s) [585.411878] Starting dynamic subtest: drm_test_cmdline_name_bpp [585.522493] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.117s) [585.530836] Starting dynamic subtest: drm_test_cmdline_name_option [585.668922] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.145s) [585.678014] Starting dynamic subtest: drm_test_cmdline_name_bpp_option [585.791647] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.123s) [585.799915] Starting dynamic subtest: drm_test_cmdline_rotate_0 [585.915605] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.122s) [585.924006] Starting dynamic subtest: drm_test_cmdline_rotate_90 [586.043805] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.128s) [586.053468] Starting dynamic subtest: drm_test_cmdline_rotate_180 [586.173652] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.129s) [586.183169] Starting dynamic subtest: drm_test_cmdline_rotate_270 [586.302711] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.128s) [586.312306] Starting dynamic subtest: drm_test_cmdline_hmirror [586.429229] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.125s) [586.438937] Starting dynamic subtest: drm_test_cmdline_vmirror [586.560119] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.131s) [586.569608] Starting dynamic subtest: drm_test_cmdline_margin_options [586.705568] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.145s) [586.715248] Starting dynamic subtest: drm_test_cmdline_multiple_options [586.833561] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.127s) [586.842859] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option [586.944174] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.111s) [586.953491] Starting dynamic subtest: drm_test_cmdline_extra_and_option [587.078626] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.132s) [587.088004] Starting dynamic subtest: drm_test_cmdline_freestanding_options [587.216551] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.138s) [587.225904] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options [587.350593] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.133s) [587.359862] Starting dynamic subtest: drm_test_cmdline_panel_orientation [587.497472] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.146s) [587.505527] Starting dynamic subtest: drm_test_cmdline_invalid [587.636844] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.140s) [587.644776] Starting dynamic subtest: drm_test_cmdline_tv_options [587.774295] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.138s) [587.775271] Subtest drm_cmdline_parser: SUCCESS (4.955s) [588.016902] [080/131] (440s left) vgem_basic (setversion) [588.058934] Starting subtest: setversion [588.060717] Subtest setversion: SUCCESS (0.000s) [588.136035] [081/131] (440s left) kms_big_fb (4-tiled-8bpp-rotate-0) [588.233490] Starting subtest: 4-tiled-8bpp-rotate-0 [589.391003] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.158s) [589.566098] [082/131] (439s left) gem_lmem_swapping (parallel-multi) [589.605497] Subtest parallel-multi: SKIP (0.000s) [589.637735] [083/131] (438s left) kms_pm_rpm (modeset-lpsp-stress-no-wait) [591.398481] Starting subtest: modeset-lpsp-stress-no-wait [601.240712] Subtest modeset-lpsp-stress-no-wait: SUCCESS (9.843s) [601.343632] [084/131] (427s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs) [601.440123] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs [601.440978] Starting dynamic subtest: pipe-A-eDP-1 [601.444248] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [601.452688] Starting dynamic subtest: pipe-B-eDP-1 [601.455954] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [601.464215] Starting dynamic subtest: pipe-C-eDP-1 [601.467702] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [601.475599] Starting dynamic subtest: pipe-D-eDP-1 [601.478922] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [601.480551] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.005s) [603.686192] [085/131] (424s left) syncobj_basic (bad-destroy-pad) [603.752630] Starting subtest: bad-destroy-pad [603.753684] Subtest bad-destroy-pad: SUCCESS (0.000s) [603.890221] [086/131] (424s left) perf (gen12-unprivileged-single-ctx-counters) [604.022486] Starting subtest: gen12-unprivileged-single-ctx-counters [604.023348] Starting dynamic subtest: rcs0 [604.062139] Dynamic subtest rcs0: SUCCESS (0.040s) [604.063084] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.040s) [604.106060] [087/131] (424s left) syncobj_wait (invalid-signal-zero-handles) [604.208564] Starting subtest: invalid-signal-zero-handles [604.209698] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [604.340038] [088/131] (424s left) syncobj_eventfd (invalid-illegal-handle) [604.400885] Starting subtest: invalid-illegal-handle [604.401846] Subtest invalid-illegal-handle: SUCCESS (0.000s) [604.527886] [089/131] (424s left) kms_plane_multiple (tiling-yf) [604.616659] Starting subtest: tiling-yf [604.618320] Subtest tiling-yf: SKIP (0.000s) [604.706799] [090/131] (424s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers) [604.799552] Starting subtest: plane-downscale-factor-0-5-with-modifiers [604.800471] Starting dynamic subtest: pipe-A [604.817143] Dynamic subtest pipe-A: SKIP (0.016s) [604.825572] Starting dynamic subtest: pipe-B [604.847799] Dynamic subtest pipe-B: SKIP (0.029s) [604.856286] Starting dynamic subtest: pipe-C [604.873966] Dynamic subtest pipe-C: SKIP (0.026s) [604.881970] Starting dynamic subtest: pipe-D [604.904903] Dynamic subtest pipe-D: SKIP (0.029s) [604.906465] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.103s) [605.054291] [091/131] (423s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180) [605.147629] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180 [605.149300] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s) [605.282393] [092/131] (423s left) kms_properties (connector-properties-atomic) [605.374812] Starting subtest: connector-properties-atomic [605.375664] Starting dynamic subtest: pipe-A-eDP-1 [613.149576] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.773s) [613.157815] Starting dynamic subtest: pipe-None-DP-1 [613.159591] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s) [613.167475] Starting dynamic subtest: pipe-None-HDMI-A-1 [613.169156] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s) [613.177414] Starting dynamic subtest: pipe-None-DP-2 [613.179198] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s) [613.187124] Starting dynamic subtest: pipe-None-HDMI-A-2 [613.188909] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s) [613.197141] Starting dynamic subtest: pipe-None-DP-3 [613.198870] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s) [613.207001] Starting dynamic subtest: pipe-None-DP-4 [613.208803] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s) [613.209724] Subtest connector-properties-atomic: SUCCESS (7.784s) [614.028304] [093/131] (414s left) gem_mmap_gtt (fault-concurrent) [614.090592] Subtest fault-concurrent: SKIP (0.000s) [614.156834] [094/131] (414s left) kms_addfb_basic (addfb25-modifier-no-flag) [614.243273] Starting subtest: addfb25-modifier-no-flag [614.244082] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [614.370884] [095/131] (414s left) kms_getfb (getfb-repeated-different-handles) [614.470818] Starting subtest: getfb-repeated-different-handles [614.471747] Subtest getfb-repeated-different-handles: SUCCESS (0.000s) [614.600635] [096/131] (414s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling) [614.688490] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling [614.689297] Starting dynamic subtest: pipe-A-default-mode [615.870494] Dynamic subtest pipe-A-default-mode: SKIP (1.180s) [615.872138] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.181s) [616.045895] [097/131] (413s left) gem_exec_schedule (timeslicing) [616.113990] Starting subtest: timeslicing [616.114877] Starting dynamic subtest: rcs0 [616.135964] Dynamic subtest rcs0: SUCCESS (0.021s) [616.147705] Starting dynamic subtest: bcs0 [616.160327] Dynamic subtest bcs0: SUCCESS (0.022s) [616.168830] Starting dynamic subtest: vcs0 [616.182388] Dynamic subtest vcs0: SUCCESS (0.021s) [616.191965] Starting dynamic subtest: vcs1 [616.204707] Dynamic subtest vcs1: SUCCESS (0.021s) [616.213000] Starting dynamic subtest: vecs0 [616.225452] Dynamic subtest vecs0: SUCCESS (0.020s) [616.233818] Starting dynamic subtest: ccs0 [616.245030] Dynamic subtest ccs0: SUCCESS (0.019s) [616.245965] Subtest timeslicing: SUCCESS (0.131s) [617.389414] [098/131] (411s left) gem_wait (wait) [617.451864] Starting subtest: wait [617.452984] Starting dynamic subtest: all-engines [619.319476] Dynamic subtest all-engines: SUCCESS (1.864s) [619.330847] Starting dynamic subtest: rcs0 [620.365963] Dynamic subtest rcs0: SUCCESS (1.046s) [620.379244] Starting dynamic subtest: bcs0 [621.416340] Dynamic subtest bcs0: SUCCESS (1.048s) [621.428475] Starting dynamic subtest: vcs0 [622.463094] Dynamic subtest vcs0: SUCCESS (1.045s) [622.475498] Starting dynamic subtest: vcs1 [623.507307] Dynamic subtest vcs1: SUCCESS (1.042s) [623.520010] Starting dynamic subtest: vecs0 [624.552742] Dynamic subtest vecs0: SUCCESS (1.043s) [624.564813] Starting dynamic subtest: ccs0 [625.599587] Dynamic subtest ccs0: SUCCESS (1.045s) [625.602606] Subtest wait: SUCCESS (8.148s) [625.818791] [099/131] (403s left) gem_mmap_gtt (bad-object) [625.880665] Subtest bad-object: SKIP (0.000s) [625.945574] [100/131] (403s left) gem_exec_params (invalid-bsd2-flag-on-blt) [626.002169] Starting subtest: invalid-bsd2-flag-on-blt [626.003267] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s) [626.145832] [101/131] (403s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt) [626.252895] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt [630.722335] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.469s) [631.870814] [102/131] (397s left) gem_exec_balancer (bonded-semaphore) [631.921595] Starting subtest: bonded-semaphore [631.923378] Subtest bonded-semaphore: SKIP (0.000s) [632.236587] [103/131] (397s left) gem_exec_fence (syncobj-backward-timeline-chain-engines) [632.774897] Starting subtest: syncobj-backward-timeline-chain-engines [632.865360] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.093s) [634.424914] [104/131] (394s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt) [634.524473] Starting subtest: psr-rgb101010-draw-blt [641.681625] Subtest psr-rgb101010-draw-blt: SUCCESS (7.156s) [641.836278] [105/131] (387s left) i915_pm_rps (min-max-config-idle) [641.897520] Starting subtest: min-max-config-idle [641.899674] Subtest min-max-config-idle: SKIP (0.001s) [642.032387] [106/131] (387s left) gem_ctx_exec (basic-norecovery) [642.091296] Starting subtest: basic-norecovery [642.404057] Subtest basic-norecovery: SUCCESS (0.312s) [642.562032] [107/131] (386s left) kms_cursor_legacy (cursor-vs-flip-legacy) [642.668816] Starting subtest: cursor-vs-flip-legacy [671.996468] Subtest cursor-vs-flip-legacy: SUCCESS (29.324s) [672.832239] [108/131] (356s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf) [677.880408] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf [677.881373] Starting dynamic subtest: pipe-A-eDP-1 [678.657211] Dynamic subtest pipe-A-eDP-1: SKIP (0.775s) [678.667319] Starting dynamic subtest: pipe-B-eDP-1 [679.789111] Dynamic subtest pipe-B-eDP-1: SKIP (1.130s) [679.790869] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.909s) [680.987407] [109/131] (348s left) gem_exec_whisper (basic-fds-forked) [681.050248] Starting subtest: basic-fds-forked [705.271755] Subtest basic-fds-forked: SUCCESS (24.216s) [705.473050] [110/131] (324s left) kms_color (ctm-0-50) [705.569401] Starting subtest: ctm-0-50 [705.570324] Starting dynamic subtest: pipe-A-eDP-1 [708.988725] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.419s) [708.997886] Starting dynamic subtest: pipe-B-eDP-1 [713.107563] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.117s) [713.116694] Starting dynamic subtest: pipe-C-eDP-1 [717.058858] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.951s) [717.067988] Starting dynamic subtest: pipe-D-eDP-1 [721.105535] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.045s) [721.106317] Subtest ctm-0-50: SUCCESS (15.535s) [721.930542] [111/131] (307s left) kms_atomic_interruptible (legacy-cursor) [722.030511] Starting subtest: legacy-cursor [722.031512] Starting dynamic subtest: pipe-A-eDP-1 [729.417168] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.384s) [729.418168] Subtest legacy-cursor: SUCCESS (7.386s) [730.278411] [112/131] (299s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted) [730.335516] Starting subtest: invalid-multi-wait-unsubmitted-submitted [730.336558] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [730.473853] [113/131] (299s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs) [730.567536] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs [730.568482] Starting dynamic subtest: pipe-A-eDP-1 [730.579584] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [730.589563] Starting dynamic subtest: pipe-B-eDP-1 [730.599226] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [730.608218] Starting dynamic subtest: pipe-C-eDP-1 [730.616391] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [730.625153] Starting dynamic subtest: pipe-D-eDP-1 [730.633882] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [730.635621] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.005s) [732.829603] [114/131] (296s left) kms_dsc (dsc-with-output-formats-with-bpc) [732.919597] Starting subtest: dsc-with-output-formats-with-bpc [732.945157] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s) [733.015977] [115/131] (296s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen) [733.104939] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen [733.106594] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [733.245593] [116/131] (296s left) kms_color (legacy-gamma-reset) [733.341855] Starting subtest: legacy-gamma-reset [733.342772] Starting dynamic subtest: pipe-A-eDP-1 [733.718635] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.377s) [733.728994] Starting dynamic subtest: pipe-B-eDP-1 [733.732056] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.012s) [733.742240] Starting dynamic subtest: pipe-C-eDP-1 [733.745696] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.013s) [733.756260] Starting dynamic subtest: pipe-D-eDP-1 [733.759918] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.012s) [733.760739] Subtest legacy-gamma-reset: SUCCESS (0.418s) [734.562641] [117/131] (295s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite) [734.659556] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite [734.661236] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [734.804969] [118/131] (294s left) kms_setmode (invalid-clone-single-crtc) [734.855630] Starting subtest: invalid-clone-single-crtc [734.858186] Subtest invalid-clone-single-crtc: SKIP (0.000s) [734.979355] [119/131] (294s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [735.074967] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip [735.889234] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.814s) [736.102451] [120/131] (293s left) i915_suspend (fence-restore-untiled) [736.156741] Starting subtest: fence-restore-untiled [736.158697] Subtest fence-restore-untiled: SKIP (0.000s) [736.269909] [121/131] (293s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled) [736.328197] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled [736.435299] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.104s) [736.526674] [122/131] (293s left) intel_hwmon (hwmon-read) [736.585177] Subtest hwmon-read: SKIP (0.000s) [736.640045] [123/131] (293s left) kms_ccs (random-ccs-data-y-tiled-ccs) [736.736806] Starting subtest: random-ccs-data-y-tiled-ccs [736.737730] Starting dynamic subtest: pipe-A-eDP-1 [736.746785] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [736.761128] Starting dynamic subtest: pipe-B-eDP-1 [736.771018] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [736.780359] Starting dynamic subtest: pipe-C-eDP-1 [736.789131] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [736.797951] Starting dynamic subtest: pipe-D-eDP-1 [736.807143] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [736.808808] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.005s) [739.019023] [124/131] (290s left) api_intel_allocator (fork-simple-once) [739.077863] Starting subtest: fork-simple-once [739.091567] Subtest fork-simple-once: SUCCESS (0.014s) [739.251643] [125/131] (290s left) gem_busy (close-race) [739.310812] Starting subtest: close-race [763.319468] Subtest close-race: SUCCESS (24.003s) [763.724966] [126/131] (266s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc) [763.855102] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc [763.856910] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [764.004274] [127/131] (266s left) gem_partial_pwrite_pread (reads) [764.063089] Subtest reads: SKIP (0.000s) [764.146684] [128/131] (265s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling) [764.229834] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling [764.230784] Starting dynamic subtest: pipe-A-default-mode [764.516973] Dynamic subtest pipe-A-default-mode: SKIP (0.286s) [764.518699] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.288s) [765.348960] [129/131] (264s left) gen9_exec_parse (unaligned-access) [765.404152] Subtest unaligned-access: SKIP (0.000s) [765.476348] [130/131] (264s left) perf_pmu (module-unload) [765.575123] Starting subtest: module-unload [773.732040] Subtest module-unload: FAIL (8.121s) [773.753193] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [773.753917] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true [773.755807] [131/131] (256s left) gem_exec_capture (pi) [775.194259] Starting subtest: pi [775.195142] Starting dynamic subtest: rcs0 [779.422250] Dynamic subtest rcs0: SUCCESS (4.229s) [779.435057] Starting dynamic subtest: bcs0 [783.540319] Dynamic subtest bcs0: SUCCESS (4.116s) [783.549569] Starting dynamic subtest: vcs0 [787.630245] Dynamic subtest vcs0: SUCCESS (4.088s) [787.642607] Starting dynamic subtest: vcs1 [791.752973] Dynamic subtest vcs1: SUCCESS (4.121s) [791.763882] Starting dynamic subtest: vecs0 [795.902910] Dynamic subtest vecs0: SUCCESS (4.149s) [795.914935] Starting dynamic subtest: ccs0 [800.163141] Dynamic subtest ccs0: SUCCESS (4.258s) [800.164460] Subtest pi: SUCCESS (24.972s) [800.230732] [FACT gem_exec_capture (pi)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [800.231967] [FACT gem_exec_capture (pi)] new: kernel.kmod_is_loaded.i915: true [800.233366] Closing watchdogs results: parsing output: 0/ for test: gem_userptr_blits results: parsing output: 1/ for test: kms_flip results: parsing output: 2/ for test: kms_pipe_crc_basic results: parsing output: 3/ for test: kms_vblank results: parsing output: 4/ for test: kms_cursor_legacy results: parsing output: 5/ for test: gem_readwrite results: parsing output: 6/ for test: gem_create results: parsing output: 7/ for test: syncobj_timeline results: parsing output: 8/ for test: gem_mmap_offset results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: kms_atomic_transition results: parsing output: 11/ for test: kms_plane_scaling results: parsing output: 12/ for test: gem_render_copy results: parsing output: 13/ for test: syncobj_basic results: parsing output: 14/ for test: kms_content_protection results: parsing output: 15/ for test: kms_vblank results: parsing output: 16/ for test: kms_frontbuffer_tracking results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: kms_addfb_basic results: parsing output: 19/ for test: kms_busy results: parsing output: 20/ for test: kms_frontbuffer_tracking results: parsing output: 21/ for test: kms_frontbuffer_tracking results: parsing output: 22/ for test: kms_pm_rpm results: parsing output: 23/ for test: kms_frontbuffer_tracking results: parsing output: 24/ for test: kms_flip results: parsing output: 25/ for test: prime_self_import results: parsing output: 26/ for test: kms_frontbuffer_tracking results: parsing output: 27/ for test: kms_psr results: parsing output: 28/ for test: gem_ctx_persistence results: parsing output: 29/ for test: gem_exec_schedule results: parsing output: 30/ for test: kms_cursor_crc results: parsing output: 31/ for test: kms_psr results: parsing output: 32/ for test: prime_self_import results: parsing output: 33/ for test: gem_softpin results: parsing output: 34/ for test: vgem_basic results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: kms_cursor_legacy results: parsing output: 37/ for test: gem_ctx_create results: parsing output: 38/ for test: kms_big_fb results: parsing output: 39/ for test: kms_psr2_sf results: parsing output: 40/ for test: kms_big_fb results: parsing output: 41/ for test: kms_frontbuffer_tracking results: parsing output: 42/ for test: kms_flip results: parsing output: 43/ for test: gem_mmap_wc results: parsing output: 44/ for test: i915_hangman results: parsing output: 45/ for test: kms_cursor_crc results: parsing output: 46/ for test: syncobj_timeline results: parsing output: 47/ for test: kms_ccs results: parsing output: 48/ for test: gem_render_copy results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: kms_dirtyfb results: parsing output: 51/ for test: prime_vgem results: parsing output: 52/ for test: gem_exec_alignment results: parsing output: 53/ for test: gem_exec_gttfill results: parsing output: 54/ for test: gem_exec_schedule results: parsing output: 55/ for test: kms_feature_discovery results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: syncobj_basic results: parsing output: 58/ for test: sw_sync results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: kms_psr results: parsing output: 61/ for test: kms_atomic results: parsing output: 62/ for test: kms_ccs results: parsing output: 63/ for test: kms_big_fb results: parsing output: 64/ for test: kms_psr results: parsing output: 65/ for test: drm_mm results: parsing output: 66/ for test: kms_lease results: parsing output: 67/ for test: kms_cursor_legacy results: parsing output: 68/ for test: syncobj_timeline results: parsing output: 69/ for test: api_intel_bb results: parsing output: 70/ for test: kms_psr results: parsing output: 71/ for test: gem_busy results: parsing output: 72/ for test: gen9_exec_parse results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: kms_invalid_mode results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: kms_chamelium_frames results: parsing output: 77/ for test: syncobj_timeline results: parsing output: 78/ for test: kms_selftest results: parsing output: 79/ for test: vgem_basic results: parsing output: 80/ for test: kms_big_fb results: parsing output: 81/ for test: gem_lmem_swapping results: parsing output: 82/ for test: kms_pm_rpm results: parsing output: 83/ for test: kms_ccs results: parsing output: 84/ for test: syncobj_basic results: parsing output: 85/ for test: perf results: parsing output: 86/ for test: syncobj_wait results: parsing output: 87/ for test: syncobj_eventfd results: parsing output: 88/ for test: kms_plane_multiple results: parsing output: 89/ for test: kms_plane_scaling results: parsing output: 90/ for test: kms_big_fb results: parsing output: 91/ for test: kms_properties results: parsing output: 92/ for test: gem_mmap_gtt results: parsing output: 93/ for test: kms_addfb_basic results: parsing output: 94/ for test: kms_getfb results: parsing output: 95/ for test: kms_flip_scaled_crc results: parsing output: 96/ for test: gem_exec_schedule results: parsing output: 97/ for test: gem_wait results: parsing output: 98/ for test: gem_mmap_gtt results: parsing output: 99/ for test: gem_exec_params results: parsing output: 100/ for test: kms_frontbuffer_tracking results: parsing output: 101/ for test: gem_exec_balancer results: parsing output: 102/ for test: gem_exec_fence results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: i915_pm_rps results: parsing output: 105/ for test: gem_ctx_exec results: parsing output: 106/ for test: kms_cursor_legacy results: parsing output: 107/ for test: kms_psr2_sf results: parsing output: 108/ for test: gem_exec_whisper results: parsing output: 109/ for test: kms_color results: parsing output: 110/ for test: kms_atomic_interruptible results: parsing output: 111/ for test: syncobj_wait results: parsing output: 112/ for test: kms_ccs results: parsing output: 113/ for test: kms_dsc results: parsing output: 114/ for test: kms_frontbuffer_tracking results: parsing output: 115/ for test: kms_color results: parsing output: 116/ for test: kms_frontbuffer_tracking results: parsing output: 117/ for test: kms_setmode results: parsing output: 118/ for test: kms_big_fb results: parsing output: 119/ for test: i915_suspend results: parsing output: 120/ for test: syncobj_wait results: parsing output: 121/ for test: intel_hwmon results: parsing output: 122/ for test: kms_ccs results: parsing output: 123/ for test: api_intel_allocator results: parsing output: 124/ for test: gem_busy results: parsing output: 125/ for test: kms_frontbuffer_tracking results: parsing output: 126/ for test: gem_partial_pwrite_pread results: parsing output: 127/ for test: kms_flip_scaled_crc results: parsing output: 128/ for test: gen9_exec_parse results: parsing output: 129/ for test: perf_pmu results: parsing output: 130/ for test: gem_exec_capture Done.