[57.572816] Initializing watchdogs [57.572938] /dev/watchdog0 [57.588372] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [57.594692] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.597559] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.600797] [001/131] (960s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [57.732348] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip [57.736780] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.002s) [57.871073] [002/131] (960s left) gem_exec_fence (submit3) [58.047885] Starting subtest: submit3 [58.052533] Subtest submit3: SKIP (0.000s) [60.043907] [FACT gem_exec_fence (submit3)] new: kernel.kmod_is_loaded.vgem: true [60.047491] [003/131] (958s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt) [60.152197] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt [60.156706] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [60.303521] [004/131] (957s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc) [60.406468] Starting subtest: fbc-rgb101010-draw-mmap-wc [65.044744] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.634s) [66.255858] [005/131] (952s left) gem_exec_balancer (noheartbeat) [66.522403] Starting subtest: noheartbeat [66.527050] Subtest noheartbeat: SKIP (0.000s) [66.650650] [006/131] (951s left) kms_chamelium_color (ctm-blue-to-red) [66.798601] Subtest ctm-blue-to-red: SKIP (0.000s) [66.844258] [007/131] (951s left) gem_workarounds (suspend-resume) [66.941917] Starting subtest: suspend-resume [83.025540] Subtest suspend-resume: SUCCESS (5.573s) [83.145825] [008/131] (935s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling) [83.267095] Starting subtest: planes-downscale-factor-0-75-unity-scaling [83.269464] Starting dynamic subtest: pipe-A [83.330608] Dynamic subtest pipe-A: SUCCESS (0.066s) [83.338877] Starting dynamic subtest: pipe-B [84.526215] Dynamic subtest pipe-B: SUCCESS (1.177s) [84.535456] Starting dynamic subtest: pipe-C [85.661735] Dynamic subtest pipe-C: SUCCESS (1.118s) [85.670996] Starting dynamic subtest: pipe-D [86.798089] Dynamic subtest pipe-D: SUCCESS (1.121s) [86.800505] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.485s) [87.997488] [009/131] (930s left) gem_pxp (create-regular-buffer) [88.123198] Starting subtest: create-regular-buffer [88.125495] Subtest create-regular-buffer: SUCCESS (0.000s) [88.277142] [010/131] (930s left) gem_exec_params (rel-constants-invalid-rel-gen5) [88.329449] Starting subtest: rel-constants-invalid-rel-gen5 [88.332241] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s) [88.484915] [011/131] (930s left) gem_exec_nop (basic-series) [88.568910] Starting subtest: basic-series [104.418361] Subtest basic-series: SUCCESS (15.789s) [104.680022] [012/131] (913s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc) [104.788216] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc [104.792222] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [104.908087] [013/131] (913s left) kms_psr (fbc-psr-primary-page-flip) [105.004356] Starting subtest: fbc-psr-primary-page-flip [105.006339] Starting dynamic subtest: eDP-1 [105.010511] Dynamic subtest eDP-1: SKIP (0.000s) [105.014683] Subtest fbc-psr-primary-page-flip: SKIP (0.000s) [105.103823] [014/131] (913s left) i915_pm_rps (engine-order) [105.162298] Starting subtest: engine-order [109.965259] Subtest engine-order: SUCCESS (4.795s) [110.148337] [015/131] (908s left) gem_softpin (evict-active) [110.208237] Starting subtest: evict-active [110.219046] Subtest evict-active: SUCCESS (0.011s) [110.378155] [016/131] (908s left) syncobj_timeline (wait-delayed-signal) [110.425198] Starting subtest: wait-delayed-signal [110.526985] Subtest wait-delayed-signal: SUCCESS (0.103s) [110.637943] [017/131] (908s left) kms_panel_fitting (atomic-fastset) [110.743048] Starting subtest: atomic-fastset [110.745393] Starting dynamic subtest: pipe-A-eDP-1 [110.886416] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.145s) [110.897976] Starting dynamic subtest: pipe-B-eDP-1 [112.117421] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.229s) [112.127229] Starting dynamic subtest: pipe-C-eDP-1 [113.308118] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.189s) [113.318189] Starting dynamic subtest: pipe-D-eDP-1 [114.442197] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.133s) [114.444585] Subtest atomic-fastset: SUCCESS (3.699s) [115.705602] [018/131] (903s left) kms_big_fb (x-tiled-16bpp-rotate-270) [115.835659] Starting subtest: x-tiled-16bpp-rotate-270 [115.855000] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s) [115.994190] [019/131] (902s left) api_intel_bb (render-ccs) [116.061028] Starting subtest: render-ccs [116.416562] Subtest render-ccs: SUCCESS (0.354s) [116.528330] [020/131] (902s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc) [116.616043] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc [116.618403] Starting dynamic subtest: pipe-A-eDP-1 [116.642397] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [116.654627] Starting dynamic subtest: pipe-B-eDP-1 [116.676597] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [116.685003] Starting dynamic subtest: pipe-C-eDP-1 [116.707377] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [116.715534] Starting dynamic subtest: pipe-D-eDP-1 [116.737389] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [116.741731] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [118.881835] [021/131] (900s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled) [118.958409] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled [119.066031] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.108s) [119.163015] [022/131] (899s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move) [119.262734] Starting subtest: psr-2p-primscrn-cur-indfb-move [119.267493] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [119.399841] [023/131] (899s left) gem_lmem_swapping (heavy-multi) [119.438944] Subtest heavy-multi: SKIP (0.000s) [119.479594] [024/131] (899s left) kms_async_flips (test-cursor) [119.576506] Starting subtest: test-cursor [119.580944] Subtest test-cursor: SKIP (0.000s) [120.801400] [025/131] (898s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf) [125.953406] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf [125.955769] Starting dynamic subtest: pipe-A-eDP-1 [126.725736] Dynamic subtest pipe-A-eDP-1: SKIP (0.769s) [126.736309] Starting dynamic subtest: pipe-B-eDP-1 [127.853425] Dynamic subtest pipe-B-eDP-1: SKIP (1.126s) [127.858050] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.899s) [129.067116] [026/131] (890s left) kms_plane_multiple (2x-tiling-4) [129.168486] Starting subtest: 2x-tiling-4 [129.172929] Subtest 2x-tiling-4: SKIP (0.000s) [129.306537] [027/131] (889s left) gem_ctx_param (invalid-param-set) [129.366575] Starting subtest: invalid-param-set [129.368947] Subtest invalid-param-set: SUCCESS (0.000s) [129.468561] [028/131] (889s left) kms_ccs (bad-pixel-format-y-tiled-ccs) [129.574065] Starting subtest: bad-pixel-format-y-tiled-ccs [129.576439] Starting dynamic subtest: pipe-A-eDP-1 [129.598873] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [129.611793] Starting dynamic subtest: pipe-B-eDP-1 [129.633524] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [129.646389] Starting dynamic subtest: pipe-C-eDP-1 [129.668438] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [129.678458] Starting dynamic subtest: pipe-D-eDP-1 [129.700008] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [129.704118] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.003s) [131.736253] [029/131] (887s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers) [131.842322] Starting subtest: plane-downscale-factor-0-5-with-modifiers [131.844512] Starting dynamic subtest: pipe-A [131.861925] Dynamic subtest pipe-A: SKIP (0.017s) [131.871978] Starting dynamic subtest: pipe-B [131.894261] Dynamic subtest pipe-B: SKIP (0.031s) [131.903330] Starting dynamic subtest: pipe-C [131.925258] Dynamic subtest pipe-C: SKIP (0.031s) [131.933945] Starting dynamic subtest: pipe-D [131.955606] Dynamic subtest pipe-D: SKIP (0.031s) [131.959968] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.111s) [132.074590] [030/131] (887s left) syncobj_timeline (multi-wait-all-available-submitted-signaled) [132.128304] Starting subtest: multi-wait-all-available-submitted-signaled [132.130531] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s) [132.255662] [031/131] (887s left) perf (missing-sample-flags) [132.401918] Starting subtest: missing-sample-flags [132.404188] Subtest missing-sample-flags: SUCCESS (0.000s) [132.449251] [032/131] (887s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite) [132.551576] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite [138.708407] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.158s) [139.926983] [033/131] (879s left) kms_pm_rpm (system-suspend-idle) [141.594637] Starting subtest: system-suspend-idle [161.572078] Subtest system-suspend-idle: SUCCESS (4.575s) [161.975283] [034/131] (857s left) kms_vblank (wait-forked) [162.085204] Starting subtest: wait-forked [162.087538] Starting dynamic subtest: pipe-A-eDP-1 [163.929683] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.822s) [163.945419] Starting dynamic subtest: pipe-D-eDP-1 [166.486829] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.534s) [166.489083] Subtest wait-forked: SUCCESS (4.360s) [167.380637] [035/131] (852s left) kms_big_fb (y-tiled-32bpp-rotate-0) [167.490256] Starting subtest: y-tiled-32bpp-rotate-0 [167.495190] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s) [167.602932] [036/131] (852s left) kms_pipe_crc_basic (read-crc) [167.692558] Starting subtest: read-crc [167.694577] Starting dynamic subtest: pipe-A-eDP-1 [168.409839] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.711s) [168.420117] Starting dynamic subtest: pipe-B-eDP-1 [169.830095] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.413s) [169.840103] Starting dynamic subtest: pipe-C-eDP-1 [171.135069] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.298s) [171.145263] Starting dynamic subtest: pipe-D-eDP-1 [172.454771] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.312s) [172.457244] Subtest read-crc: SUCCESS (4.739s) [173.308229] [037/131] (846s left) kms_cursor_legacy (single-move) [173.437073] Starting subtest: single-move [173.438981] Starting dynamic subtest: pipe-A [178.832283] Dynamic subtest pipe-A: SUCCESS (5.380s) [178.841578] Starting dynamic subtest: pipe-B [184.225709] Dynamic subtest pipe-B: SUCCESS (5.383s) [184.239816] Starting dynamic subtest: pipe-C [189.610446] Dynamic subtest pipe-C: SUCCESS (5.379s) [189.621609] Starting dynamic subtest: pipe-D [194.992684] Dynamic subtest pipe-D: SUCCESS (5.379s) [195.004247] Starting dynamic subtest: all-pipes [200.380179] Dynamic subtest all-pipes: SUCCESS (5.387s) [200.382655] Subtest single-move: SUCCESS (26.916s) [200.547537] [038/131] (819s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf) [205.616416] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf [205.621101] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.003s) [206.467988] [039/131] (813s left) gem_unref_active_buffers [206.730285] [040/131] (813s left) kms_psr (fbc-psr2-primary-mmap-gtt) [206.824258] Starting subtest: fbc-psr2-primary-mmap-gtt [206.826385] Starting dynamic subtest: eDP-1 [206.830342] Dynamic subtest eDP-1: SKIP (0.000s) [206.834329] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s) [206.921161] [041/131] (812s left) syncobj_wait (invalid-signal-zero-handles) [206.982070] Starting subtest: invalid-signal-zero-handles [206.984045] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [207.126442] [042/131] (812s left) gen9_exec_parse (bb-oversize) [207.187698] Subtest bb-oversize: SKIP (0.000s) [207.265961] [043/131] (812s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted) [207.325788] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted [207.427957] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.102s) [207.529123] [044/131] (812s left) gem_exec_reloc (basic-write-cpu-noreloc) [207.605295] Subtest basic-write-cpu-noreloc: SKIP (0.000s) [207.703631] [045/131] (812s left) gem_mmap_offset (bad-flags) [207.760411] Starting subtest: bad-flags [207.762548] Subtest bad-flags: SUCCESS (0.000s) [207.899541] [046/131] (812s left) kms_cursor_legacy (cursor-vs-flip-legacy) [208.019875] Starting subtest: cursor-vs-flip-legacy [237.395087] Subtest cursor-vs-flip-legacy: SUCCESS (29.369s) [238.301957] [047/131] (781s left) kms_rotation_crc (sprite-rotation-90-pos-100-0) [238.405695] Starting subtest: sprite-rotation-90-pos-100-0 [238.409865] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s) [238.500353] [048/131] (781s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip) [238.604071] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip [239.605758] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.000s) [239.788842] [049/131] (780s left) gem_create (busy-create) [239.846973] Starting subtest: busy-create [239.849493] Starting dynamic subtest: smem0 [272.838418] Dynamic subtest smem0: SUCCESS (32.988s) [272.841456] Subtest busy-create: SUCCESS (32.989s) [273.056589] [050/131] (747s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render) [273.166849] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render [277.322429] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.159s) [278.490042] [051/131] (741s left) perf (invalid-open-flags) [278.597838] Starting subtest: invalid-open-flags [278.600309] Subtest invalid-open-flags: SUCCESS (0.000s) [278.641928] [052/131] (741s left) perf (oa-formats) [278.756370] Starting subtest: oa-formats [278.758506] Starting dynamic subtest: 0-rcs0 [278.772315] Dynamic subtest 0-rcs0: SUCCESS (0.016s) [278.782920] Starting dynamic subtest: 1-vecs0 [278.794915] Dynamic subtest 1-vecs0: SUCCESS (0.022s) [278.797303] Subtest oa-formats: SUCCESS (0.040s) [278.838078] [053/131] (741s left) kms_big_fb (4-tiled-8bpp-rotate-270) [278.942017] Starting subtest: 4-tiled-8bpp-rotate-270 [278.963011] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.020s) [279.125968] [054/131] (741s left) kms_cursor_crc (cursor-onscreen-64x21) [279.314959] Starting subtest: cursor-onscreen-64x21 [279.365958] Subtest cursor-onscreen-64x21: SKIP (0.045s) [279.628192] [055/131] (740s left) kms_rotation_crc (primary-4-tiled-reflect-x-180) [279.735043] Starting subtest: primary-4-tiled-reflect-x-180 [286.843730] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.108s) [288.039987] [056/131] (732s left) kms_cursor_crc (cursor-onscreen-256x256) [288.294035] Starting subtest: cursor-onscreen-256x256 [288.299065] Starting dynamic subtest: pipe-A-eDP-1 [290.398111] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.100s) [290.428475] Starting dynamic subtest: pipe-D-eDP-1 [293.198113] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.775s) [293.200317] Subtest cursor-onscreen-256x256: SUCCESS (4.902s) [294.109583] [057/131] (726s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt) [294.216313] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt [301.593090] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.378s) [301.761669] [058/131] (718s left) kms_async_flips (async-flip-with-page-flip-events-tiled) [301.857690] Starting subtest: async-flip-with-page-flip-events-tiled [302.230672] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs [304.974961] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.743s) [304.984708] Starting dynamic subtest: pipe-A-eDP-1-4 [307.161978] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.185s) [307.171512] Starting dynamic subtest: pipe-A-eDP-1-4 [309.172458] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s) [309.186997] Starting dynamic subtest: pipe-A-eDP-1-x [311.362594] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.188s) [311.729966] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs [314.507447] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.785s) [314.520356] Starting dynamic subtest: pipe-B-eDP-1-4 [316.695311] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s) [316.706848] Starting dynamic subtest: pipe-B-eDP-1-4 [318.704722] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.008s) [318.714547] Starting dynamic subtest: pipe-B-eDP-1-x [320.895932] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.190s) [321.261585] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs [324.032319] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.777s) [324.042544] Starting dynamic subtest: pipe-C-eDP-1-4 [326.207543] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s) [326.219222] Starting dynamic subtest: pipe-C-eDP-1-4 [328.218332] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s) [328.233410] Starting dynamic subtest: pipe-C-eDP-1-x [330.397695] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s) [330.760047] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs [333.556859] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.803s) [333.567473] Starting dynamic subtest: pipe-D-eDP-1-4 [335.733089] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s) [335.744918] Starting dynamic subtest: pipe-D-eDP-1-4 [337.743906] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s) [337.753866] Starting dynamic subtest: pipe-D-eDP-1-x [339.923148] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s) [339.925774] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.057s) [341.176423] [059/131] (679s left) perf (polling) [341.281437] Starting subtest: polling [341.283794] Starting dynamic subtest: 0-rcs0 [351.297781] Dynamic subtest 0-rcs0: SUCCESS (10.012s) [351.307049] Starting dynamic subtest: 1-vcs0 [361.319308] Dynamic subtest 1-vcs0: SUCCESS (10.017s) [361.321681] Subtest polling: SUCCESS (20.032s) [361.368002] [060/131] (659s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc) [361.475934] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc [361.480414] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [361.613066] [061/131] (659s left) syncobj_timeline (reset-signaled) [361.673275] Starting subtest: reset-signaled [361.675829] Subtest reset-signaled: SUCCESS (0.000s) [361.792245] [062/131] (658s left) kms_rmfb (rmfb-ioctl) [361.898671] Starting subtest: rmfb-ioctl [361.900652] Starting dynamic subtest: pipe-A-eDP-1 [362.001359] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.105s) [362.012871] Starting dynamic subtest: pipe-B-eDP-1 [363.211852] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.208s) [363.223019] Starting dynamic subtest: pipe-C-eDP-1 [364.438083] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.225s) [364.447768] Starting dynamic subtest: pipe-D-eDP-1 [365.573834] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.134s) [365.576142] Subtest rmfb-ioctl: SUCCESS (3.678s) [366.811070] [063/131] (653s left) gem_userptr_blits (create-destroy-sync) [366.876263] Starting subtest: create-destroy-sync [371.893472] Subtest create-destroy-sync: SUCCESS (5.017s) [372.034151] [064/131] (648s left) gem_exec_reloc (basic-gtt-cpu-active) [372.104530] Subtest basic-gtt-cpu-active: SKIP (0.000s) [372.197531] [065/131] (648s left) api_intel_allocator (execbuf-with-allocator) [372.248915] Starting subtest: execbuf-with-allocator [372.257890] Subtest execbuf-with-allocator: SUCCESS (0.010s) [372.374306] [066/131] (648s left) kms_lease (cursor-implicit-plane) [372.472015] Starting subtest: cursor-implicit-plane [372.474277] Starting dynamic subtest: pipe-A-eDP-1 [372.937004] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.463s) [372.949526] Starting dynamic subtest: pipe-B-eDP-1 [374.022883] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.085s) [374.033071] Starting dynamic subtest: pipe-C-eDP-1 [375.138476] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.111s) [375.148816] Starting dynamic subtest: pipe-D-eDP-1 [376.266371] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.126s) [376.268900] Subtest cursor-implicit-plane: SUCCESS (3.791s) [377.138770] [067/131] (643s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size) [377.272228] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size [377.276746] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s) [377.461714] [068/131] (643s left) syncobj_wait (invalid-signal-illegal-handle) [377.514295] Starting subtest: invalid-signal-illegal-handle [377.516610] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [377.652619] [069/131] (643s left) kms_psr (psr-primary-blt) [377.752557] Starting subtest: psr-primary-blt [377.754786] Starting dynamic subtest: eDP-1 [379.505369] Dynamic subtest eDP-1: SUCCESS (1.752s) [379.507719] Subtest psr-primary-blt: SUCCESS (1.753s) [380.392534] [070/131] (640s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs) [380.493724] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs [380.496054] Starting dynamic subtest: pipe-A-eDP-1 [380.560779] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [380.570198] Starting dynamic subtest: pipe-B-eDP-1 [380.627472] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [380.637422] Starting dynamic subtest: pipe-C-eDP-1 [380.694812] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [380.705958] Starting dynamic subtest: pipe-D-eDP-1 [380.762857] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [380.767263] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.010s) [382.848650] [071/131] (638s left) kms_psr (pr-primary-blt) [382.947080] Starting subtest: pr-primary-blt [382.951572] Subtest pr-primary-blt: SKIP (0.000s) [383.046688] [072/131] (638s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move) [383.143233] Starting subtest: psr-2p-primscrn-spr-indfb-move [383.147618] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [383.278575] [073/131] (637s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [383.381837] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [383.384087] Starting dynamic subtest: pipe-A-default-mode [384.493900] Dynamic subtest pipe-A-default-mode: SKIP (1.108s) [384.497925] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.109s) [384.688708] [074/131] (636s left) gem_exec_schedule (u-semaphore-noskip) [384.774024] Starting subtest: u-semaphore-noskip [385.166326] Subtest u-semaphore-noskip: SUCCESS (0.397s) [385.551916] [075/131] (635s left) i915_drm_fdinfo (memory-info-idle) [385.600663] Starting subtest: memory-info-idle [385.603011] Starting dynamic subtest: smem0 [385.682324] Dynamic subtest smem0: SUCCESS (0.084s) [385.684703] Subtest memory-info-idle: SUCCESS (0.085s) [385.778446] [076/131] (635s left) i915_selftest (live) [387.832521] Starting subtest: live [387.834919] Starting dynamic subtest: sanitycheck [392.280191] Dynamic subtest sanitycheck: SUCCESS (4.448s) [392.290482] Starting dynamic subtest: uncore [396.778702] Dynamic subtest uncore: SUCCESS (4.497s) [396.793856] Starting dynamic subtest: workarounds [401.667098] Dynamic subtest workarounds: SUCCESS (4.887s) [401.677196] Starting dynamic subtest: gt_engines [406.400991] Dynamic subtest gt_engines: SUCCESS (4.732s) [406.411179] Starting dynamic subtest: gt_timelines [424.216527] Dynamic subtest gt_timelines: SUCCESS (17.815s) [424.226654] Starting dynamic subtest: gt_contexts [428.724216] Dynamic subtest gt_contexts: SUCCESS (4.506s) [428.734215] Starting dynamic subtest: gt_lrc [435.047665] Dynamic subtest gt_lrc: SUCCESS (6.321s) [435.057673] Starting dynamic subtest: gt_mocs [438.184337] Dynamic subtest gt_mocs: SUCCESS (3.135s) [438.193902] Starting dynamic subtest: gt_pm [443.089957] Dynamic subtest gt_pm: SUCCESS (4.903s) [443.100002] Starting dynamic subtest: gt_heartbeat [447.537272] Dynamic subtest gt_heartbeat: SUCCESS (4.446s) [447.547278] Starting dynamic subtest: gt_tlb [456.980514] Dynamic subtest gt_tlb: SUCCESS (9.440s) [456.990285] Starting dynamic subtest: requests [470.752336] Dynamic subtest requests: SUCCESS (13.768s) [470.762097] Starting dynamic subtest: migrate [476.915922] Dynamic subtest migrate: SUCCESS (6.160s) [476.925696] Starting dynamic subtest: active [481.357085] Dynamic subtest active: SUCCESS (4.438s) [481.367190] Starting dynamic subtest: objects [486.196926] Dynamic subtest objects: SUCCESS (4.837s) [486.212614] Starting dynamic subtest: mman [491.141117] Dynamic subtest mman: SUCCESS (4.941s) [491.151531] Starting dynamic subtest: dmabuf [495.678928] Dynamic subtest dmabuf: SUCCESS (4.528s) [495.689448] Starting dynamic subtest: vma [500.119985] Dynamic subtest vma: SUCCESS (4.445s) [500.130006] Starting dynamic subtest: coherency [505.228008] Dynamic subtest coherency: SUCCESS (5.105s) [505.237853] Starting dynamic subtest: gtt [515.456665] Dynamic subtest gtt: SUCCESS (10.225s) [515.466702] Starting dynamic subtest: gem [523.679885] Dynamic subtest gem: SUCCESS (8.220s) [523.689847] Starting dynamic subtest: evict [529.280821] Dynamic subtest evict: SUCCESS (5.598s) [529.291322] Starting dynamic subtest: hugepages [540.384924] Dynamic subtest hugepages: SUCCESS (11.100s) [540.394732] Starting dynamic subtest: gem_contexts [567.601960] Dynamic subtest gem_contexts: SUCCESS (27.210s) [567.616492] Starting dynamic subtest: client [572.060146] Dynamic subtest client: SUCCESS (4.456s) [572.069960] Starting dynamic subtest: gem_migrate [576.553922] Dynamic subtest gem_migrate: SUCCESS (4.491s) [576.563719] Starting dynamic subtest: reset [580.969321] Dynamic subtest reset: SUCCESS (4.412s) [580.979692] Starting dynamic subtest: memory_region [585.426874] Dynamic subtest memory_region: SUCCESS (4.454s) [585.436902] Starting dynamic subtest: hangcheck [598.639306] Dynamic subtest hangcheck: SUCCESS (13.207s) [598.649729] Starting dynamic subtest: execlists [603.104223] Dynamic subtest execlists: SUCCESS (4.462s) [603.115044] Starting dynamic subtest: ring_submission [605.948667] Dynamic subtest ring_submission: SUCCESS (2.842s) [605.958819] Starting dynamic subtest: perf [610.432333] Dynamic subtest perf: SUCCESS (4.480s) [610.447964] Starting dynamic subtest: slpc [624.657091] Dynamic subtest slpc: SUCCESS (14.219s) [624.667115] Starting dynamic subtest: guc [628.738230] Dynamic subtest guc: SUCCESS (4.078s) [628.747266] Starting dynamic subtest: guc_multi_lrc [633.139591] Dynamic subtest guc_multi_lrc: SUCCESS (4.399s) [633.149659] Starting dynamic subtest: guc_hang [638.183664] Dynamic subtest guc_hang: SUCCESS (5.041s) [638.195468] Starting dynamic subtest: late_gt_pm [641.077509] Dynamic subtest late_gt_pm: SUCCESS (2.892s) [641.080030] Subtest live: SUCCESS (253.217s) [641.107208] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [641.107927] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true [641.111065] [077/131] (380s left) gem_userptr_blits (nohangcheck) [642.720607] Starting subtest: nohangcheck [642.996552] Subtest nohangcheck: SUCCESS (0.273s) [643.094944] [FACT gem_userptr_blits (nohangcheck)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [643.096144] [FACT gem_userptr_blits (nohangcheck)] new: kernel.kmod_is_loaded.i915: true [643.099830] [078/131] (378s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs) [643.198694] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs [643.200926] Starting dynamic subtest: pipe-A-eDP-1 [644.098920] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.895s) [644.107736] Starting dynamic subtest: pipe-B-eDP-1 [645.783404] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.675s) [645.793472] Starting dynamic subtest: pipe-C-eDP-1 [647.269467] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.491s) [647.279503] Starting dynamic subtest: pipe-D-eDP-1 [648.811106] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.541s) [648.813062] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.607s) [650.084063] [079/131] (371s left) gem_softpin (allocator-nopin) [650.154967] Starting subtest: allocator-nopin [650.250136] Subtest allocator-nopin: SUCCESS (0.094s) [650.418597] [080/131] (371s left) kms_draw_crc (draw-method-pwrite) [650.518711] Starting subtest: draw-method-pwrite [650.520878] Starting dynamic subtest: xrgb8888-untiled [651.141671] Dynamic subtest xrgb8888-untiled: SUCCESS (0.624s) [651.152326] Starting dynamic subtest: rgb565-untiled [651.641780] Dynamic subtest rgb565-untiled: SUCCESS (0.499s) [651.652428] Starting dynamic subtest: xrgb2101010-untiled [652.197562] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.555s) [652.206799] Starting dynamic subtest: xbgr16161616f-untiled [652.963700] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.765s) [652.972931] Starting dynamic subtest: xrgb8888-xtiled [654.818343] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.853s) [654.827322] Starting dynamic subtest: rgb565-xtiled [655.940446] Dynamic subtest rgb565-xtiled: SUCCESS (1.121s) [655.949855] Starting dynamic subtest: xrgb2101010-xtiled [657.707005] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.766s) [657.716474] Starting dynamic subtest: xbgr16161616f-xtiled [661.006495] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.299s) [661.016225] Starting dynamic subtest: xrgb8888-4tiled [662.117340] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.110s) [662.129341] Starting dynamic subtest: rgb565-4tiled [662.694736] Dynamic subtest rgb565-4tiled: SUCCESS (0.577s) [662.704241] Starting dynamic subtest: xrgb2101010-4tiled [663.795158] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.099s) [663.804597] Starting dynamic subtest: xbgr16161616f-4tiled [666.761875] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (2.966s) [666.764158] Subtest draw-method-pwrite: SUCCESS (16.247s) [666.896558] [081/131] (354s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip) [666.998604] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip [667.002972] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [667.124053] [082/131] (354s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt) [667.223672] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt [667.227939] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [667.351502] [083/131] (354s left) syncobj_timeline (host-signal-points) [667.421182] Starting subtest: host-signal-points [667.426062] Subtest host-signal-points: SUCCESS (0.004s) [667.551449] [084/131] (354s left) gem_mmap_gtt (basic-small-bo) [667.606936] Subtest basic-small-bo: SKIP (0.000s) [667.669378] [085/131] (353s left) perf_pmu (semaphore-wait-idle) [667.705298] Starting subtest: semaphore-wait-idle [667.707282] Starting dynamic subtest: rcs0 [668.221043] Dynamic subtest rcs0: SUCCESS (0.514s) [668.234272] Starting dynamic subtest: bcs0 [668.736969] Dynamic subtest bcs0: SUCCESS (0.512s) [668.749410] Starting dynamic subtest: vcs0 [669.252832] Dynamic subtest vcs0: SUCCESS (0.511s) [669.265301] Starting dynamic subtest: vcs1 [669.766179] Dynamic subtest vcs1: SUCCESS (0.510s) [669.778370] Starting dynamic subtest: vecs0 [670.281069] Dynamic subtest vecs0: SUCCESS (0.512s) [670.293743] Starting dynamic subtest: ccs0 [670.797039] Dynamic subtest ccs0: SUCCESS (0.513s) [670.799945] Subtest semaphore-wait-idle: SUCCESS (3.092s) [670.952685] [086/131] (350s left) kms_addfb_basic (no-handle) [671.002529] Starting subtest: no-handle [671.004422] Subtest no-handle: SUCCESS (0.000s) [671.187669] [087/131] (350s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite) [671.289425] Starting subtest: fbcpsr-rgb101010-draw-pwrite [678.565693] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (7.279s) [678.724295] [088/131] (343s left) gem_render_copy (yf-tiled-ccs-to-linear) [678.779891] Starting subtest: yf-tiled-ccs-to-linear [678.784368] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s) [678.981932] [089/131] (342s left) kms_flip (wf_vblank-ts-check) [679.068931] Starting subtest: wf_vblank-ts-check [679.071283] Starting dynamic subtest: A-eDP1 [688.005428] Dynamic subtest A-eDP1: SUCCESS (8.937s) [688.015829] Starting dynamic subtest: B-eDP1 [696.925632] Dynamic subtest B-eDP1: SUCCESS (8.919s) [696.938329] Starting dynamic subtest: C-eDP1 [705.833470] Dynamic subtest C-eDP1: SUCCESS (8.907s) [705.844464] Starting dynamic subtest: D-eDP1 [714.764498] Dynamic subtest D-eDP1: SUCCESS (8.927s) [714.766760] Subtest wf_vblank-ts-check: SUCCESS (35.700s) [716.026973] [090/131] (305s left) gem_exec_schedule (deep) [716.212462] Starting subtest: deep [716.214992] Starting dynamic subtest: rcs0 [721.549390] Dynamic subtest rcs0: SKIP (5.336s) [721.560873] Starting dynamic subtest: vcs0 [731.729203] Dynamic subtest vcs0: SUCCESS (10.180s) [731.741627] Starting dynamic subtest: vcs1 [743.022891] Dynamic subtest vcs1: SUCCESS (11.293s) [743.033943] Starting dynamic subtest: vecs0 [754.106560] Dynamic subtest vecs0: SUCCESS (11.082s) [754.120301] Starting dynamic subtest: ccs0 [766.627757] Dynamic subtest ccs0: SUCCESS (12.519s) [766.630684] Subtest deep: SUCCESS (50.415s) [768.381627] [091/131] (253s left) kms_sequence (queue-idle) [768.501715] Starting subtest: queue-idle [768.503846] Starting dynamic subtest: pipe-A-eDP-1 [770.319141] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.817s) [770.328874] Starting dynamic subtest: pipe-B-eDP-1 [772.761465] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.438s) [772.775524] Starting dynamic subtest: pipe-C-eDP-1 [775.271812] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.512s) [775.282084] Starting dynamic subtest: pipe-D-eDP-1 [777.712210] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.439s) [777.714597] Subtest queue-idle: SUCCESS (9.212s) [778.549300] [092/131] (243s left) gem_gtt_cpu_tlb [778.683406] [093/131] (243s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc) [778.793142] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc [785.382688] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.591s) [785.545482] [094/131] (236s left) gem_eio (create-ext) [785.773035] Starting subtest: create-ext [786.097048] Subtest create-ext: SUCCESS (0.323s) [786.271052] [095/131] (235s left) gem_partial_pwrite_pread (writes-after-reads-uncached) [786.340222] Subtest writes-after-reads-uncached: SKIP (0.000s) [786.430655] [096/131] (235s left) sysfs_preempt_timeout (idempotent) [786.510134] Starting subtest: idempotent [786.512113] Starting dynamic subtest: vecs0 [786.514165] Dynamic subtest vecs0: SUCCESS (0.001s) [786.524706] Starting dynamic subtest: ccs0 [786.526233] Dynamic subtest ccs0: SUCCESS (0.001s) [786.535904] Starting dynamic subtest: vcs0 [786.537607] Dynamic subtest vcs0: SUCCESS (0.001s) [786.546679] Starting dynamic subtest: bcs0 [786.548256] Dynamic subtest bcs0: SUCCESS (0.001s) [786.557151] Starting dynamic subtest: rcs0 [786.558758] Dynamic subtest rcs0: SUCCESS (0.001s) [786.567476] Starting dynamic subtest: vcs1 [786.569095] Dynamic subtest vcs1: SUCCESS (0.000s) [786.570714] Subtest idempotent: SUCCESS (0.011s) [786.617919] [097/131] (235s left) gem_busy (semaphore) [786.820121] Subtest semaphore: SKIP (0.000s) [787.087664] [098/131] (235s left) sriov_basic (enable-vfs-bind-unbind-each) [787.149610] Starting subtest: enable-vfs-bind-unbind-each [787.152098] Starting dynamic subtest: numvfs-1 [787.230056] Dynamic subtest numvfs-1: FAIL (0.029s) [787.241611] Starting dynamic subtest: numvfs-2 [787.313149] Dynamic subtest numvfs-2: FAIL (0.004s) [787.324345] Starting dynamic subtest: numvfs-3 [787.398180] Dynamic subtest numvfs-3: FAIL (0.004s) [787.410103] Starting dynamic subtest: numvfs-4 [787.481872] Dynamic subtest numvfs-4: FAIL (0.004s) [787.492262] Starting dynamic subtest: numvfs-5 [787.564268] Dynamic subtest numvfs-5: FAIL (0.004s) [787.575352] Starting dynamic subtest: numvfs-6 [787.647738] Dynamic subtest numvfs-6: FAIL (0.004s) [787.659420] Starting dynamic subtest: numvfs-7 [787.731417] Dynamic subtest numvfs-7: FAIL (0.004s) [787.742309] Starting dynamic subtest: numvfs-random [787.813677] Dynamic subtest numvfs-random: FAIL (0.004s) [787.816038] Subtest enable-vfs-bind-unbind-each: FAIL (0.061s) [787.860107] [099/131] (234s left) kms_pm_lpsp (screens-disabled) [788.957775] Starting subtest: screens-disabled [788.962027] Subtest screens-disabled: SKIP (0.000s) [789.057071] [100/131] (233s left) gem_exec_capture (capture-invisible) [789.128967] Starting subtest: capture-invisible [789.131153] Starting dynamic subtest: smem0 [789.135426] Dynamic subtest smem0: SKIP (0.000s) [789.139803] Subtest capture-invisible: SKIP (0.001s) [789.270455] [101/131] (233s left) gem_lmem_swapping (verify-ccs) [789.309923] Subtest verify-ccs: SKIP (0.000s) [789.354762] [102/131] (233s left) kms_joiner (basic-force-ultra-joiner) [789.458983] Starting subtest: basic-force-ultra-joiner [789.463185] Subtest basic-force-ultra-joiner: SKIP (0.000s) [789.546968] [103/131] (232s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc) [789.641580] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc [796.207723] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.570s) [796.360614] [104/131] (226s left) kms_color (legacy-gamma) [796.463546] Starting subtest: legacy-gamma [796.465708] Starting dynamic subtest: pipe-A-eDP-1 [797.172659] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.710s) [797.183807] Starting dynamic subtest: pipe-B-eDP-1 [798.594653] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.420s) [798.604632] Starting dynamic subtest: pipe-C-eDP-1 [799.971942] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.375s) [799.984477] Starting dynamic subtest: pipe-D-eDP-1 [801.278514] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.305s) [801.280787] Subtest legacy-gamma: SUCCESS (4.813s) [802.122275] [105/131] (220s left) gem_exec_schedule (wide) [802.314674] Starting subtest: wide [802.317458] Starting dynamic subtest: rcs0 [812.656072] Dynamic subtest rcs0: SUCCESS (10.339s) [812.671354] Starting dynamic subtest: vcs0 [823.630960] Dynamic subtest vcs0: SUCCESS (10.973s) [823.646097] Starting dynamic subtest: vcs1 [832.821238] Dynamic subtest vcs1: SUCCESS (9.188s) [832.834173] Starting dynamic subtest: vecs0 [844.302343] Dynamic subtest vecs0: SUCCESS (11.479s) [844.316066] Starting dynamic subtest: ccs0 [858.984611] Dynamic subtest ccs0: SUCCESS (14.679s) [858.987988] Subtest wide: SUCCESS (56.663s) [860.766557] [106/131] (161s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling) [860.876581] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling [860.878860] Starting dynamic subtest: pipe-A-default-mode [861.164702] Dynamic subtest pipe-A-default-mode: SKIP (0.284s) [861.169423] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.286s) [862.040356] [107/131] (160s left) kms_big_fb (linear-64bpp-rotate-180) [862.151788] Starting subtest: linear-64bpp-rotate-180 [863.664375] Subtest linear-64bpp-rotate-180: SUCCESS (1.511s) [863.858598] [108/131] (158s left) gem_ppgtt (blt-vs-render-ctxn) [863.911764] Starting subtest: blt-vs-render-ctxN [897.047687] Subtest blt-vs-render-ctxN: SUCCESS (33.129s) [897.222145] [109/131] (125s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt) [897.375539] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt [897.379725] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [897.515915] [110/131] (125s left) kms_chamelium_frames (dp-frame-dump) [897.898269] Subtest dp-frame-dump: SKIP (0.000s) [898.734037] [111/131] (124s left) kms_psr2_su (page_flip-nv12) [898.794670] Subtest page_flip-NV12: SKIP (0.000s) [898.867894] [112/131] (123s left) gem_tiling_max_stride [899.001042] [113/131] (123s left) perf_pmu (busy-idle) [899.043660] Starting subtest: busy-idle [899.045934] Starting dynamic subtest: rcs0 [899.755229] Dynamic subtest rcs0: SUCCESS (0.711s) [899.768509] Starting dynamic subtest: bcs0 [900.426363] Dynamic subtest bcs0: SUCCESS (0.669s) [900.439603] Starting dynamic subtest: vcs0 [901.800669] Dynamic subtest vcs0: SUCCESS (1.370s) [901.814724] Starting dynamic subtest: vcs1 [903.785994] Dynamic subtest vcs1: SUCCESS (1.982s) [903.799438] Starting dynamic subtest: vecs0 [905.768576] Dynamic subtest vecs0: SUCCESS (1.979s) [905.781928] Starting dynamic subtest: ccs0 [906.439758] Dynamic subtest ccs0: SUCCESS (0.670s) [906.442176] Subtest busy-idle: SUCCESS (7.396s) [906.581698] [114/131] (116s left) dmabuf_sync_file (export-before-signal) [906.621867] Starting subtest: export-before-signal [906.623921] Subtest export-before-signal: SUCCESS (0.001s) [906.699209] [115/131] (116s left) gem_exec_reloc (basic-cpu-read) [906.769650] Subtest basic-cpu-read: SKIP (0.000s) [906.854789] [116/131] (116s left) kms_hdr (bpc-switch) [906.956309] Starting subtest: bpc-switch [908.021716] Starting dynamic subtest: pipe-A-eDP-1 [911.420363] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.398s) [911.422689] Subtest bpc-switch: SUCCESS (4.466s) [911.583307] [117/131] (111s left) perf (i915-ref-count) [911.692067] Starting subtest: i915-ref-count [911.762790] Subtest i915-ref-count: SUCCESS (0.068s) [911.818995] [118/131] (111s left) gem_ctx_isolation (nonpriv) [911.878018] Starting subtest: nonpriv [911.880390] Starting dynamic subtest: rcs0 [912.117812] Dynamic subtest rcs0: SUCCESS (0.240s) [912.131287] Starting dynamic subtest: bcs0 [912.394441] Dynamic subtest bcs0: SUCCESS (0.276s) [912.407472] Starting dynamic subtest: vcs0 [912.657113] Dynamic subtest vcs0: SUCCESS (0.262s) [912.669882] Starting dynamic subtest: vcs1 [914.007452] Dynamic subtest vcs1: SUCCESS (1.349s) [914.018166] Starting dynamic subtest: vecs0 [916.019431] Dynamic subtest vecs0: SUCCESS (2.010s) [916.032582] Starting dynamic subtest: ccs0 [918.104660] Dynamic subtest ccs0: SUCCESS (2.084s) [918.107106] Subtest nonpriv: SUCCESS (6.226s) [918.369055] [119/131] (104s left) gem_render_copy (y-tiled-to-vebox-x-tiled) [918.449047] Starting subtest: y-tiled-to-vebox-x-tiled [918.453633] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s) [918.658994] [120/131] (104s left) kms_atomic_transition (plane-use-after-nonblocking-unbind) [918.766512] Starting subtest: plane-use-after-nonblocking-unbind [918.768782] Starting dynamic subtest: pipe-A-eDP-1 [918.827781] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s) [919.136872] Starting dynamic subtest: pipe-B-eDP-1 [919.968081] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.843s) [920.253725] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.488s) [921.155257] [121/131] (102s left) i915_hangman (engine-error-state-capture) [921.221123] Starting subtest: engine-error-state-capture [921.223373] Starting dynamic subtest: rcs0 [924.742759] Dynamic subtest rcs0: SUCCESS (3.519s) [924.756490] Starting dynamic subtest: bcs0 [930.760319] Dynamic subtest bcs0: SUCCESS (6.014s) [930.771750] Starting dynamic subtest: vcs0 [936.712605] Dynamic subtest vcs0: SUCCESS (5.947s) [936.727160] Starting dynamic subtest: vcs1 [942.727437] Dynamic subtest vcs1: SUCCESS (6.011s) [942.741478] Starting dynamic subtest: vecs0 [948.744603] Dynamic subtest vecs0: SUCCESS (6.013s) [948.757424] Starting dynamic subtest: ccs0 [954.757704] Dynamic subtest ccs0: SUCCESS (6.009s) [954.760521] Subtest engine-error-state-capture: SUCCESS (33.531s) [954.864486] [122/131] ( 68s left) gem_exec_schedule (pi-shared-iova) [955.095771] Starting subtest: pi-shared-iova [955.097881] Starting dynamic subtest: rcs0 [955.256229] Dynamic subtest rcs0: SUCCESS (0.160s) [955.270445] Starting dynamic subtest: vcs0 [955.343251] Dynamic subtest vcs0: SUCCESS (0.087s) [955.357375] Starting dynamic subtest: vcs1 [955.431148] Dynamic subtest vcs1: SUCCESS (0.086s) [955.443245] Starting dynamic subtest: vecs0 [955.516053] Dynamic subtest vecs0: SUCCESS (0.084s) [955.527401] Starting dynamic subtest: ccs0 [955.641364] Dynamic subtest ccs0: SUCCESS (0.124s) [955.643696] Subtest pi-shared-iova: SUCCESS (0.546s) [956.893897] [123/131] ( 66s left) syncobj_wait (invalid-reset-illegal-handle) [956.943999] Starting subtest: invalid-reset-illegal-handle [956.945893] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [957.067050] [124/131] ( 66s left) syncobj_wait (single-wait-all-for-submit-signaled) [957.125244] Starting subtest: single-wait-all-for-submit-signaled [957.127673] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [957.270327] [125/131] ( 66s left) kms_cursor_crc (cursor-sliding-512x170) [957.568483] Starting subtest: cursor-sliding-512x170 [957.572393] Subtest cursor-sliding-512x170: SKIP (0.001s) [957.755528] [126/131] ( 65s left) kms_chamelium_hpd (hdmi-hpd-fast) [958.151470] Subtest hdmi-hpd-fast: SKIP (0.000s) [958.957406] [127/131] ( 64s left) gem_ctx_persistence (hostile) [959.011545] Starting subtest: hostile [969.165221] Subtest hostile: SUCCESS (10.146s) [969.320102] [128/131] ( 54s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt) [969.413383] Starting subtest: fbc-rgb565-draw-blt [973.568402] Subtest fbc-rgb565-draw-blt: SUCCESS (4.158s) [974.794805] [129/131] ( 48s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite) [974.885487] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite [984.162938] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.278s) [984.350112] [130/131] ( 39s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [984.460109] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt [984.464476] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [984.604819] [131/131] ( 39s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move) [984.707970] Starting subtest: fbc-2p-scndscrn-spr-indfb-move [984.712069] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [984.840262] Closing watchdogs results: parsing output: 0/ for test: kms_big_fb results: parsing output: 1/ for test: gem_exec_fence results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: gem_exec_balancer results: parsing output: 5/ for test: kms_chamelium_color results: parsing output: 6/ for test: gem_workarounds results: parsing output: 7/ for test: kms_plane_scaling results: parsing output: 8/ for test: gem_pxp results: parsing output: 9/ for test: gem_exec_params results: parsing output: 10/ for test: gem_exec_nop results: parsing output: 11/ for test: kms_frontbuffer_tracking results: parsing output: 12/ for test: kms_psr results: parsing output: 13/ for test: i915_pm_rps results: parsing output: 14/ for test: gem_softpin results: parsing output: 15/ for test: syncobj_timeline results: parsing output: 16/ for test: kms_panel_fitting results: parsing output: 17/ for test: kms_big_fb results: parsing output: 18/ for test: api_intel_bb results: parsing output: 19/ for test: kms_ccs results: parsing output: 20/ for test: syncobj_wait results: parsing output: 21/ for test: kms_frontbuffer_tracking results: parsing output: 22/ for test: gem_lmem_swapping results: parsing output: 23/ for test: kms_async_flips results: parsing output: 24/ for test: kms_psr2_sf results: parsing output: 25/ for test: kms_plane_multiple results: parsing output: 26/ for test: gem_ctx_param results: parsing output: 27/ for test: kms_ccs results: parsing output: 28/ for test: kms_plane_scaling results: parsing output: 29/ for test: syncobj_timeline results: parsing output: 30/ for test: perf results: parsing output: 31/ for test: kms_frontbuffer_tracking results: parsing output: 32/ for test: kms_pm_rpm results: parsing output: 33/ for test: kms_vblank results: parsing output: 34/ for test: kms_big_fb results: parsing output: 35/ for test: kms_pipe_crc_basic results: parsing output: 36/ for test: kms_cursor_legacy results: parsing output: 37/ for test: kms_psr2_sf results: parsing output: 38/ for test: gem_unref_active_buffers results: parsing output: 39/ for test: kms_psr results: parsing output: 40/ for test: syncobj_wait results: parsing output: 41/ for test: gen9_exec_parse results: parsing output: 42/ for test: syncobj_timeline results: parsing output: 43/ for test: gem_exec_reloc results: parsing output: 44/ for test: gem_mmap_offset results: parsing output: 45/ for test: kms_cursor_legacy results: parsing output: 46/ for test: kms_rotation_crc results: parsing output: 47/ for test: kms_big_fb results: parsing output: 48/ for test: gem_create results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: perf results: parsing output: 51/ for test: perf results: parsing output: 52/ for test: kms_big_fb results: parsing output: 53/ for test: kms_cursor_crc results: parsing output: 54/ for test: kms_rotation_crc results: parsing output: 55/ for test: kms_cursor_crc results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: kms_async_flips results: parsing output: 58/ for test: perf results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: syncobj_timeline results: parsing output: 61/ for test: kms_rmfb results: parsing output: 62/ for test: gem_userptr_blits results: parsing output: 63/ for test: gem_exec_reloc results: parsing output: 64/ for test: api_intel_allocator results: parsing output: 65/ for test: kms_lease results: parsing output: 66/ for test: kms_cursor_legacy results: parsing output: 67/ for test: syncobj_wait results: parsing output: 68/ for test: kms_psr results: parsing output: 69/ for test: kms_ccs results: parsing output: 70/ for test: kms_psr results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: kms_flip_scaled_crc results: parsing output: 73/ for test: gem_exec_schedule results: parsing output: 74/ for test: i915_drm_fdinfo results: parsing output: 75/ for test: i915_selftest results: parsing output: 76/ for test: gem_userptr_blits results: parsing output: 77/ for test: kms_ccs results: parsing output: 78/ for test: gem_softpin results: parsing output: 79/ for test: kms_draw_crc results: parsing output: 80/ for test: kms_big_fb results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: syncobj_timeline results: parsing output: 83/ for test: gem_mmap_gtt results: parsing output: 84/ for test: perf_pmu results: parsing output: 85/ for test: kms_addfb_basic results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: gem_render_copy results: parsing output: 88/ for test: kms_flip results: parsing output: 89/ for test: gem_exec_schedule results: parsing output: 90/ for test: kms_sequence results: parsing output: 91/ for test: gem_gtt_cpu_tlb results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: gem_eio results: parsing output: 94/ for test: gem_partial_pwrite_pread results: parsing output: 95/ for test: sysfs_preempt_timeout results: parsing output: 96/ for test: gem_busy results: parsing output: 97/ for test: sriov_basic results: parsing output: 98/ for test: kms_pm_lpsp results: parsing output: 99/ for test: gem_exec_capture results: parsing output: 100/ for test: gem_lmem_swapping results: parsing output: 101/ for test: kms_joiner results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: kms_color results: parsing output: 104/ for test: gem_exec_schedule results: parsing output: 105/ for test: kms_flip_scaled_crc results: parsing output: 106/ for test: kms_big_fb results: parsing output: 107/ for test: gem_ppgtt results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: kms_chamelium_frames results: parsing output: 110/ for test: kms_psr2_su results: parsing output: 111/ for test: gem_tiling_max_stride results: parsing output: 112/ for test: perf_pmu results: parsing output: 113/ for test: dmabuf_sync_file results: parsing output: 114/ for test: gem_exec_reloc results: parsing output: 115/ for test: kms_hdr results: parsing output: 116/ for test: perf results: parsing output: 117/ for test: gem_ctx_isolation results: parsing output: 118/ for test: gem_render_copy results: parsing output: 119/ for test: kms_atomic_transition results: parsing output: 120/ for test: i915_hangman results: parsing output: 121/ for test: gem_exec_schedule results: parsing output: 122/ for test: syncobj_wait results: parsing output: 123/ for test: syncobj_wait results: parsing output: 124/ for test: kms_cursor_crc results: parsing output: 125/ for test: kms_chamelium_hpd results: parsing output: 126/ for test: gem_ctx_persistence results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: kms_frontbuffer_tracking results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: kms_frontbuffer_tracking Done.