[60.743393] Initializing watchdogs
[60.743439]   /dev/watchdog0
[60.758134] [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]
[60.762407] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.764550] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.767872] [001/133] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[60.889680] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[60.893896] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[60.974712] [002/133] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[61.087621] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[61.092084] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[61.179331] [003/133] (960s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[61.277528] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[62.301725] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.022s)
[62.422639] [004/133] (958s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[62.526621] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[69.059959] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.530s)
[69.171131] [005/133] (952s left) gem_exec_balancer (noheartbeat)
[69.439601] Starting subtest: noheartbeat
[69.444634] Subtest noheartbeat: SKIP (0.000s)
[69.533080] [006/133] (951s left) syncobj_wait (multi-wait-submitted-signaled)
[69.601077] Starting subtest: multi-wait-submitted-signaled
[69.603438] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[69.702874] [007/133] (951s left) gen7_exec_parse (batch-without-end)
[69.762370] Subtest batch-without-end: SKIP (0.000s)
[69.828322] [008/133] (951s left) gem_pread (exhaustion)
[69.887622] Subtest exhaustion: SKIP (0.000s)
[69.948206] [009/133] (951s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[70.031828] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[70.036174] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[70.137644] [010/133] (951s left) kms_cursor_crc (cursor-sliding-max-size)
[70.447505] Starting subtest: cursor-sliding-max-size
[70.453094] Subtest cursor-sliding-max-size: SKIP (0.000s)
[70.564238] [011/133] (951s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[70.659113] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[70.663223] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[70.747751] [012/133] (950s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[70.841383] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[70.843466] Starting dynamic subtest: pipe-A-eDP-1
[76.741770] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.901s)
[76.752060] Starting dynamic subtest: pipe-B-eDP-1
[83.404586] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.661s)
[83.406926] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.564s)
[84.274161] [013/133] (937s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[84.376326] Starting subtest: fbc-rgb565-draw-blt
[88.537498] Subtest fbc-rgb565-draw-blt: SUCCESS (4.166s)
[89.673484] [014/133] (932s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[89.770511] Starting subtest: plane-upscale-20x20-with-rotation
[89.772880] Starting dynamic subtest: pipe-A
[89.997416] Dynamic subtest pipe-A: SUCCESS (0.227s)
[90.006908] Starting dynamic subtest: pipe-B
[91.255107] Dynamic subtest pipe-B: SUCCESS (1.257s)
[91.264109] Starting dynamic subtest: pipe-C
[92.582160] Dynamic subtest pipe-C: SUCCESS (1.326s)
[92.589625] Starting dynamic subtest: pipe-D
[93.918755] Dynamic subtest pipe-D: SUCCESS (1.336s)
[93.921153] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.148s)
[95.100914] [015/133] (926s left) gem_exec_flush (basic-wb-ro-before-default)
[95.157981] Starting subtest: basic-wb-ro-before-default
[100.611136] Subtest basic-wb-ro-before-default: SUCCESS (5.454s)
[100.811852] [016/133] (921s left) gem_eio (in-flight-internal-immediate)
[101.035832] Starting subtest: in-flight-internal-immediate
[103.005407] Subtest in-flight-internal-immediate: SUCCESS (1.970s)
[103.117903] [017/133] (918s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping)
[103.217381] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping
[103.243514] Starting dynamic subtest: pipe-A-plane-0
[103.521080] Dynamic subtest pipe-A-plane-0: SUCCESS (0.278s)
[103.529058] Starting dynamic subtest: pipe-A-plane-3
[103.754382] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[104.884149] Starting dynamic subtest: pipe-B-plane-0
[105.200962] Dynamic subtest pipe-B-plane-0: SUCCESS (0.322s)
[105.209224] Starting dynamic subtest: pipe-B-plane-3
[105.434236] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[105.746720] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.529s)
[106.560675] [018/133] (915s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[106.825767] Starting subtest: cursor-rapid-movement-256x256
[106.828087] Starting dynamic subtest: pipe-A-eDP-1
[107.367361] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.540s)
[107.394553] Starting dynamic subtest: pipe-D-eDP-1
[108.567436] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.179s)
[108.569699] Subtest cursor-rapid-movement-256x256: SUCCESS (1.744s)
[109.415688] [019/133] (912s left) kms_psr (psr2-sprite-plane-move)
[109.511209] Starting subtest: psr2-sprite-plane-move
[109.513465] Starting dynamic subtest: eDP-1
[111.251493] Dynamic subtest eDP-1: SUCCESS (1.740s)
[111.253823] Subtest psr2-sprite-plane-move: SUCCESS (1.741s)
[112.094348] [020/133] (909s left) kms_invalid_mode (bad-vsync-start)
[112.195758] Starting subtest: bad-vsync-start
[112.198103] Starting dynamic subtest: pipe-A-eDP-1
[112.480545] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[112.489194] Starting dynamic subtest: pipe-B-eDP-1
[112.491347] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[112.498749] Starting dynamic subtest: pipe-C-eDP-1
[112.500960] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[112.508522] Starting dynamic subtest: pipe-D-eDP-1
[112.510926] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[112.513306] Subtest bad-vsync-start: SUCCESS (0.294s)
[113.301782] [021/133] (908s left) kms_cursor_crc (cursor-size-change)
[113.413472] Starting subtest: cursor-size-change
[113.415825] Starting dynamic subtest: pipe-A-eDP-1
[114.212850] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.798s)
[114.221873] Starting dynamic subtest: pipe-D-eDP-1
[115.636099] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.423s)
[115.638442] Subtest cursor-size-change: SUCCESS (2.224s)
[116.462455] [022/133] (905s left) kms_addfb_basic (legacy-format)
[116.518760] Starting subtest: legacy-format
[116.552194] Subtest legacy-format: SUCCESS (0.031s)
[116.679855] [023/133] (905s left) gem_exec_schedule (promotion)
[116.749079] Starting subtest: promotion
[116.751395] Starting dynamic subtest: rcs0
[116.858321] Dynamic subtest rcs0: SUCCESS (0.117s)
[116.870753] Starting dynamic subtest: vcs0
[116.963240] Dynamic subtest vcs0: SUCCESS (0.104s)
[116.975514] Starting dynamic subtest: vcs1
[117.056352] Dynamic subtest vcs1: SUCCESS (0.091s)
[117.071053] Starting dynamic subtest: vecs0
[117.144822] Dynamic subtest vecs0: SUCCESS (0.087s)
[117.158357] Starting dynamic subtest: ccs0
[117.249414] Dynamic subtest ccs0: SUCCESS (0.105s)
[117.252592] Subtest promotion: SUCCESS (0.509s)
[118.003812] [024/133] (904s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[118.121892] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[118.126526] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[118.220189] [025/133] (903s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[118.597263] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[119.360301] [026/133] (902s left) gem_exec_schedule (fairslice-all)
[119.427840] Starting subtest: fairslice-all
[121.482776] Subtest fairslice-all: SUCCESS (2.063s)
[121.784734] [027/133] (900s left) kms_lease (implicit-plane-lease)
[121.881971] Starting subtest: implicit-plane-lease
[121.884278] Subtest implicit-plane-lease: SUCCESS (0.002s)
[121.984181] [028/133] (900s left) kms_cursor_crc (cursor-alpha-opaque)
[122.080241] Starting subtest: cursor-alpha-opaque
[122.082150] Starting dynamic subtest: pipe-A-eDP-1
[122.707413] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.626s)
[122.716136] Starting dynamic subtest: pipe-D-eDP-1
[123.948652] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.241s)
[123.951078] Subtest cursor-alpha-opaque: SUCCESS (1.871s)
[124.749565] [029/133] (897s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[124.842952] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[124.845087] Starting dynamic subtest: pipe-A-eDP-1
[124.866740] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[124.875616] Starting dynamic subtest: pipe-B-eDP-1
[124.896023] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[124.903606] Starting dynamic subtest: pipe-C-eDP-1
[124.924071] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[124.931507] Starting dynamic subtest: pipe-D-eDP-1
[124.952323] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[124.956131] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.005s)
[127.031580] [030/133] (895s left) syncobj_timeline (reset-signaled)
[127.101428] Starting subtest: reset-signaled
[127.103372] Subtest reset-signaled: SUCCESS (0.000s)
[127.205964] [031/133] (895s left) gem_exec_reloc (basic-cpu-active)
[127.268047] Subtest basic-cpu-active: SKIP (0.000s)
[127.345479] [032/133] (895s left) gem_exec_parallel (fds)
[127.403838] Starting subtest: fds
[127.406073] Starting dynamic subtest: rcs0
[130.699860] Dynamic subtest rcs0: SUCCESS (3.296s)
[130.708426] Starting dynamic subtest: bcs0
[134.514622] Dynamic subtest bcs0: SUCCESS (3.814s)
[134.525839] Starting dynamic subtest: vcs0
[138.260455] Dynamic subtest vcs0: SUCCESS (3.741s)
[138.271082] Starting dynamic subtest: vcs1
[142.205826] Dynamic subtest vcs1: SUCCESS (3.943s)
[142.217063] Starting dynamic subtest: vecs0
[146.194963] Dynamic subtest vecs0: SUCCESS (3.987s)
[146.203612] Starting dynamic subtest: ccs0
[150.169229] Dynamic subtest ccs0: SUCCESS (3.970s)
[150.171898] Subtest fds: SUCCESS (22.766s)
[150.361254] [033/133] (872s left) kms_vblank (wait-busy)
[150.463080] Starting subtest: wait-busy
[150.465276] Starting dynamic subtest: pipe-A-eDP-1
[152.351560] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.889s)
[152.365224] Starting dynamic subtest: pipe-D-eDP-1
[154.912469] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.557s)
[154.914664] Subtest wait-busy: SUCCESS (4.449s)
[155.704149] [034/133] (866s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[155.792140] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[155.796193] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[155.864369] [035/133] (866s left) kms_sequence (queue-busy)
[155.961883] Starting subtest: queue-busy
[155.964069] Starting dynamic subtest: pipe-A-eDP-1
[157.902622] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.939s)
[157.911651] Starting dynamic subtest: pipe-B-eDP-1
[160.499936] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.598s)
[160.509772] Starting dynamic subtest: pipe-C-eDP-1
[163.142357] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.639s)
[163.152408] Starting dynamic subtest: pipe-D-eDP-1
[165.761636] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.617s)
[165.763634] Subtest queue-busy: SUCCESS (9.798s)
[166.559431] [036/133] (856s left) gem_exec_whisper (basic-fds-forked-all)
[166.622702] Starting subtest: basic-fds-forked-all
[189.937062] Subtest basic-fds-forked-all: SUCCESS (23.309s)
[190.127524] [037/133] (832s left) kms_cursor_legacy (torture-bo)
[190.248883] Starting subtest: torture-bo
[190.251178] Starting dynamic subtest: pipe-A
[196.310508] Dynamic subtest pipe-A: SUCCESS (6.060s)
[196.323092] Starting dynamic subtest: pipe-B
[203.649979] Dynamic subtest pipe-B: SUCCESS (7.337s)
[203.667619] Starting dynamic subtest: pipe-C
[211.175524] Dynamic subtest pipe-C: SUCCESS (7.525s)
[211.195254] Starting dynamic subtest: pipe-D
[217.314163] Dynamic subtest pipe-D: SUCCESS (6.138s)
[217.324249] Starting dynamic subtest: all-pipes
[224.485763] Dynamic subtest all-pipes: SUCCESS (7.168s)
[224.488859] Subtest torture-bo: SUCCESS (34.236s)
[224.641026] [038/133] (798s left) perf_pmu (most-busy-idle-check-all)
[224.686530] Starting subtest: most-busy-idle-check-all
[224.688939] Starting dynamic subtest: rcs0
[225.878809] Dynamic subtest rcs0: SUCCESS (1.192s)
[225.893049] Starting dynamic subtest: bcs0
[227.926404] Dynamic subtest bcs0: SUCCESS (2.045s)
[227.938181] Starting dynamic subtest: vcs0
[229.911869] Dynamic subtest vcs0: SUCCESS (1.982s)
[229.923319] Starting dynamic subtest: vcs1
[231.893728] Dynamic subtest vcs1: SUCCESS (1.979s)
[231.906346] Starting dynamic subtest: vecs0
[233.878393] Dynamic subtest vecs0: SUCCESS (1.982s)
[233.890821] Starting dynamic subtest: ccs0
[235.927039] Dynamic subtest ccs0: SUCCESS (2.046s)
[235.930237] Subtest most-busy-idle-check-all: SUCCESS (11.242s)
[236.041411] [039/133] (786s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[236.146400] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[242.833986] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.690s)
[242.980343] [040/133] (779s left) gem_exec_fence (basic-wait)
[243.161947] Starting subtest: basic-wait
[243.164383] Starting dynamic subtest: rcs0
[243.243209] Dynamic subtest rcs0: SUCCESS (0.085s)
[243.253918] Starting dynamic subtest: bcs0
[243.315021] Dynamic subtest bcs0: SUCCESS (0.069s)
[243.326560] Starting dynamic subtest: vcs0
[243.371862] Dynamic subtest vcs0: SUCCESS (0.056s)
[243.383142] Starting dynamic subtest: vcs1
[243.435200] Dynamic subtest vcs1: SUCCESS (0.061s)
[243.445238] Starting dynamic subtest: vecs0
[243.491798] Dynamic subtest vecs0: SUCCESS (0.055s)
[243.502305] Starting dynamic subtest: ccs0
[243.562297] Dynamic subtest ccs0: SUCCESS (0.068s)
[243.564676] Subtest basic-wait: SUCCESS (0.405s)
[244.969147] [FACT gem_exec_fence (basic-wait)] new: kernel.kmod_is_loaded.vgem: true
[244.972751] [041/133] (777s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[245.066671] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[245.069042] Starting dynamic subtest: pipe-A-eDP-1
[245.125630] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[245.140576] Starting dynamic subtest: pipe-B-eDP-1
[245.198694] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[245.209338] Starting dynamic subtest: pipe-C-eDP-1
[245.268268] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[245.278471] Starting dynamic subtest: pipe-D-eDP-1
[245.336271] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[245.340532] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.008s)
[247.269352] [042/133] (775s left) gem_lmem_swapping (verify-ccs)
[247.319366] Subtest verify-ccs: SKIP (0.000s)
[247.364439] [043/133] (775s left) sw_sync (timeline_closed_signaled)
[247.402824] Starting subtest: timeline_closed_signaled
[247.405283] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[247.479657] [044/133] (775s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[247.593043] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[247.597369] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[247.694395] [045/133] (775s left) kms_prop_blob (invalid-set-prop-any)
[247.748337] Starting subtest: invalid-set-prop-any
[247.750529] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[247.861047] [046/133] (775s left) kms_flip (2x-flip-vs-expired-vblank)
[247.968330] Starting subtest: 2x-flip-vs-expired-vblank
[247.976939] Subtest 2x-flip-vs-expired-vblank: SKIP (0.010s)
[248.075749] [047/133] (775s left) gem_lmem_swapping (parallel-random-engines)
[248.119038] Subtest parallel-random-engines: SKIP (0.000s)
[248.163361] [048/133] (775s left) kms_flip (plain-flip-fb-recreate-interruptible)
[248.248507] Starting subtest: plain-flip-fb-recreate-interruptible
[248.250439] Starting dynamic subtest: A-eDP1
[257.059421] Dynamic subtest A-eDP1: SUCCESS (8.809s)
[257.072514] Starting dynamic subtest: B-eDP1
[265.881385] Dynamic subtest B-eDP1: SUCCESS (8.819s)
[265.891950] Starting dynamic subtest: C-eDP1
[274.705929] Dynamic subtest C-eDP1: SUCCESS (8.822s)
[274.714413] Starting dynamic subtest: D-eDP1
[283.541448] Dynamic subtest D-eDP1: SUCCESS (8.834s)
[283.546176] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.295s)
[284.733575] [049/133] (738s left) api_intel_bb (object-reloc-keep-cache)
[284.784020] Starting subtest: object-reloc-keep-cache
[284.788455] Subtest object-reloc-keep-cache: SKIP (0.003s)
[284.917054] [050/133] (738s left) kms_pm_dc (dc5-dpms)
[286.008890] Starting subtest: dc5-dpms
[288.099831] Subtest dc5-dpms: SUCCESS (2.088s)
[288.175848] [051/133] (735s left) kms_plane_cursor (overlay)
[288.264462] Starting subtest: overlay
[288.269123] Starting dynamic subtest: pipe-A-eDP-1-size-64
[290.747497] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.484s)
[290.808527] Starting dynamic subtest: pipe-A-eDP-1-size-128
[293.237491] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.438s)
[293.303790] Starting dynamic subtest: pipe-A-eDP-1-size-256
[295.740066] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.449s)
[296.086899] Starting dynamic subtest: pipe-B-eDP-1-size-64
[299.156535] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.080s)
[299.217508] Starting dynamic subtest: pipe-B-eDP-1-size-128
[301.603182] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.393s)
[301.663056] Starting dynamic subtest: pipe-B-eDP-1-size-256
[304.025933] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.371s)
[304.373802] Starting dynamic subtest: pipe-C-eDP-1-size-64
[307.263504] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.900s)
[307.300110] Starting dynamic subtest: pipe-C-eDP-1-size-128
[309.328510] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.036s)
[309.367237] Starting dynamic subtest: pipe-C-eDP-1-size-256
[311.418115] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.058s)
[311.749186] Starting dynamic subtest: pipe-D-eDP-1-size-64
[314.494582] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.758s)
[314.532583] Starting dynamic subtest: pipe-D-eDP-1-size-128
[316.605599] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.080s)
[316.644554] Starting dynamic subtest: pipe-D-eDP-1-size-256
[318.950240] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.313s)
[319.270180] Subtest overlay: SUCCESS (31.003s)
[320.068122] [052/133] (703s left) gem_exec_reloc (basic-wc-active)
[320.136623] Subtest basic-wc-active: SKIP (0.000s)
[320.212779] [053/133] (703s left) kms_psr (pr-primary-mmap-gtt)
[320.293120] Starting subtest: pr-primary-mmap-gtt
[320.297576] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[320.366074] [054/133] (703s left) gem_exec_schedule (lateslice)
[320.431718] Starting subtest: lateslice
[320.433623] Starting dynamic subtest: rcs0
[320.441827] Dynamic subtest rcs0: SUCCESS (0.020s)
[320.450678] Starting dynamic subtest: bcs0
[320.459038] Dynamic subtest bcs0: SUCCESS (0.017s)
[320.467829] Starting dynamic subtest: vcs0
[320.477369] Dynamic subtest vcs0: SUCCESS (0.018s)
[320.489420] Starting dynamic subtest: vcs1
[320.495861] Dynamic subtest vcs1: SUCCESS (0.018s)
[320.504713] Starting dynamic subtest: vecs0
[320.514678] Dynamic subtest vecs0: SUCCESS (0.018s)
[320.523495] Starting dynamic subtest: ccs0
[320.533544] Dynamic subtest ccs0: SUCCESS (0.018s)
[320.535798] Subtest lateslice: SUCCESS (0.113s)
[321.953532] [055/133] (701s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[322.043121] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[329.652528] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.612s)
[329.800728] [056/133] (693s left) kms_color (ctm-max)
[329.893162] Starting subtest: ctm-max
[329.895076] Starting dynamic subtest: pipe-A-eDP-1
[330.594058] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.702s)
[330.603673] Starting dynamic subtest: pipe-B-eDP-1
[331.981991] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.387s)
[331.990962] Starting dynamic subtest: pipe-C-eDP-1
[333.375020] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.390s)
[333.384271] Starting dynamic subtest: pipe-D-eDP-1
[334.699869] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.326s)
[334.702277] Subtest ctm-max: SUCCESS (4.809s)
[335.509806] [057/133] (688s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[335.575767] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[335.578267] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[335.677356] [058/133] (687s left) gem_eio (reset-stress)
[335.910618] Starting subtest: reset-stress
[335.912897] Starting dynamic subtest: render
[340.974820] Dynamic subtest render: SUCCESS (5.062s)
[340.991409] Starting dynamic subtest: bsd1
[359.458295] Dynamic subtest bsd1: SUCCESS (18.482s)
[359.476682] Starting dynamic subtest: bsd2
[377.431688] Dynamic subtest bsd2: SUCCESS (17.971s)
[377.448042] Starting dynamic subtest: blt
[377.452790] Dynamic subtest blt: SKIP (0.000s)
[377.461562] Starting dynamic subtest: vebox
[395.454866] Dynamic subtest vebox: SUCCESS (18.020s)
[395.457630] Subtest reset-stress: SUCCESS (59.540s)
[396.926306] [059/133] (626s left) kms_addfb_basic (bad-pitch-256)
[396.993799] Starting subtest: bad-pitch-256
[396.996573] Subtest bad-pitch-256: SUCCESS (0.000s)
[397.117807] [060/133] (626s left) kms_addfb_basic (bo-too-small)
[397.204482] Starting subtest: bo-too-small
[397.206767] Subtest bo-too-small: SUCCESS (0.000s)
[397.306100] [061/133] (626s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[397.392869] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[397.396979] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[397.488423] [062/133] (626s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[397.590043] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[397.594020] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[397.663984] [063/133] (626s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[397.755266] Starting subtest: disable-crc-after-crtc
[397.757572] Starting dynamic subtest: pipe-A-eDP-1
[399.438414] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.684s)
[399.447500] Starting dynamic subtest: pipe-B-eDP-1
[401.706428] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.268s)
[401.716307] Starting dynamic subtest: pipe-C-eDP-1
[403.969484] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.260s)
[403.980044] Starting dynamic subtest: pipe-D-eDP-1
[406.223135] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.250s)
[406.225109] Subtest disable-crc-after-crtc: SUCCESS (8.468s)
[407.059372] [064/133] (616s left) kms_chamelium_frames (hdmi-crc-multiple)
[407.451454] Subtest hdmi-crc-multiple: SKIP (0.000s)
[408.284916] [065/133] (615s left) perf (oa-formats)
[408.439273] Starting subtest: oa-formats
[408.441120] Starting dynamic subtest: 0-rcs0
[408.454285] Dynamic subtest 0-rcs0: SUCCESS (0.015s)
[408.463474] Starting dynamic subtest: 1-vcs1
[408.475505] Dynamic subtest 1-vcs1: SUCCESS (0.021s)
[408.477835] Subtest oa-formats: SUCCESS (0.038s)
[408.526998] [066/133] (615s left) kms_dsc (dsc-fractional-bpp-with-bpc)
[408.621331] Starting subtest: dsc-fractional-bpp-with-bpc
[408.652280] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.001s)
[408.692807] [067/133] (615s left) syncobj_eventfd (timeline-wait)
[408.743677] Starting subtest: timeline-wait
[408.752308] Subtest timeline-wait: SUCCESS (0.011s)
[408.864414] [068/133] (615s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[408.954299] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[408.956205] Starting dynamic subtest: pipe-A-eDP-1
[425.557488] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.561s)
[425.567583] Starting dynamic subtest: pipe-B-eDP-1
[443.533352] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.480s)
[443.544535] Starting dynamic subtest: pipe-C-eDP-1
[460.486930] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.404s)
[460.498649] Starting dynamic subtest: pipe-D-eDP-1
[477.519718] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.407s)
[477.522386] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.857s)
[478.670126] [069/133] (545s left) gem_mmap_offset (isolation)
[478.724079] Starting subtest: isolation
[478.744472] Subtest isolation: SUCCESS (0.006s)
[478.855855] [070/133] (545s left) kms_chamelium_color (ctm-negative)
[478.964476] Subtest ctm-negative: SKIP (0.000s)
[479.008636] [071/133] (545s left) kms_hdmi_inject (inject-audio)
[479.351801] Starting subtest: inject-audio
[479.624897] Subtest inject-audio: SUCCESS (0.274s)
[480.253690] [072/133] (543s left) i915_drm_fdinfo (virtual-idle)
[480.301160] Starting subtest: virtual-idle
[483.386293] Subtest virtual-idle: SUCCESS (3.058s)
[483.468249] [073/133] (540s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[483.576873] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[483.582434] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[483.694873] [074/133] (540s left) gem_set_tiling_vs_gtt
[483.817667] [075/133] (540s left) api_intel_allocator (reopen-fork)
[483.883027] Starting subtest: reopen-fork
[487.156206] Subtest reopen-fork: SUCCESS (3.255s)
[487.249857] [076/133] (537s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[487.361262] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[487.364015] Starting dynamic subtest: pipe-A-default-mode
[490.073293] Dynamic subtest pipe-A-default-mode: SUCCESS (2.700s)
[490.075670] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.701s)
[490.884060] [077/133] (533s left) gem_eio (wait-1us)
[491.105103] Starting subtest: wait-1us
[491.452383] Subtest wait-1us: SUCCESS (0.345s)
[491.598429] [078/133] (532s left) gem_exec_create (forked)
[491.656893] Starting subtest: forked
[491.659321] Starting dynamic subtest: smem
[513.454439] Dynamic subtest smem: SUCCESS (21.772s)
[513.457603] Subtest forked: SUCCESS (21.775s)
[513.647267] [079/133] (510s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[513.705870] Starting subtest: etime-single-wait-all-for-submit-submitted
[513.809637] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.105s)
[513.893992] [080/133] (510s left) gem_exec_params (rel-constants-invalid-ring)
[513.959288] Starting subtest: rel-constants-invalid-ring
[513.962328] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[514.066739] [081/133] (510s left) kms_flip (plain-flip-interruptible)
[514.180071] Starting subtest: plain-flip-interruptible
[514.182538] Starting dynamic subtest: A-eDP1
[515.877602] Dynamic subtest A-eDP1: SUCCESS (1.698s)
[515.889205] Starting dynamic subtest: B-eDP1
[517.503289] Dynamic subtest B-eDP1: SUCCESS (1.623s)
[517.515460] Starting dynamic subtest: C-eDP1
[519.174418] Dynamic subtest C-eDP1: SUCCESS (1.669s)
[519.185685] Starting dynamic subtest: D-eDP1
[520.780067] Dynamic subtest D-eDP1: SUCCESS (1.604s)
[520.786118] Subtest plain-flip-interruptible: SUCCESS (6.606s)
[522.009297] [082/133] (502s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[522.125667] Starting subtest: short-flip-before-cursor-atomic-transitions
[523.078756] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.951s)
[523.912671] [083/133] (500s left) gem_userptr_blits (forbidden-operations)
[523.992308] Starting subtest: forbidden-operations
[523.997149] Subtest forbidden-operations: SKIP (0.000s)
[524.120231] [084/133] (500s left) gem_ctx_engines (invalid-engines)
[524.184025] Starting subtest: invalid-engines
[524.192085] Subtest invalid-engines: SUCCESS (0.008s)
[524.418280] [085/133] (500s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[524.516043] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[524.521460] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[524.614798] [086/133] (500s left) kms_pm_rpm (i2c)
[526.645215] Starting subtest: i2c
[531.715004] Subtest i2c: SUCCESS (5.070s)
[531.805417] [087/133] (493s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[531.912881] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[538.616353] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.704s)
[538.745938] [088/133] (486s left) kms_atomic (plane-overlay-legacy)
[538.836144] Starting subtest: plane-overlay-legacy
[538.838991] Starting dynamic subtest: pipe-A-eDP-1
[539.275856] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.441s)
[539.278593] Subtest plane-overlay-legacy: SUCCESS (0.442s)
[540.169805] [089/133] (484s left) syncobj_timeline (wait-all-for-submit-complex)
[540.226222] Starting subtest: wait-all-for-submit-complex
[540.442632] Subtest wait-all-for-submit-complex: SUCCESS (0.217s)
[540.536140] [090/133] (484s left) gem_request_retire (retire-vma-not-inactive)
[540.604265] Starting subtest: retire-vma-not-inactive
[540.664460] Subtest retire-vma-not-inactive: SUCCESS (0.058s)
[540.777077] [091/133] (484s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[540.832487] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[540.838014] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[541.018237] [092/133] (484s left) gem_pxp (reject-modify-context-protection-on)
[541.135256] Starting subtest: reject-modify-context-protection-on
[541.138446] Subtest reject-modify-context-protection-on: SUCCESS (0.002s)
[541.246291] [093/133] (483s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[541.351619] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[541.354090] Starting dynamic subtest: pipe-A-eDP-1
[541.377078] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[541.387431] Starting dynamic subtest: pipe-B-eDP-1
[541.412911] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[541.422427] Starting dynamic subtest: pipe-C-eDP-1
[541.447572] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[541.457344] Starting dynamic subtest: pipe-D-eDP-1
[541.484237] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[541.489260] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.008s)
[543.630935] [094/133] (481s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[543.735214] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[543.740342] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[543.808867] [095/133] (481s left) gem_exec_fence (syncobj-export)
[544.299328] Starting subtest: syncobj-export
[544.306151] Subtest syncobj-export: SUCCESS (0.005s)
[545.527158] [096/133] (479s left) dumb_buffer (map-invalid-size)
[545.587476] Starting subtest: map-invalid-size
[545.590262] Subtest map-invalid-size: SUCCESS (0.000s)
[545.705178] [097/133] (479s left) kms_psr (fbc-psr-primary-render)
[545.796707] Starting subtest: fbc-psr-primary-render
[545.799248] Starting dynamic subtest: eDP-1
[545.804174] Dynamic subtest eDP-1: SKIP (0.000s)
[545.809153] Subtest fbc-psr-primary-render: SKIP (0.001s)
[545.869918] [098/133] (479s left) fbdev (eof)
[545.912329] Starting subtest: eof
[545.915288] Subtest eof: SUCCESS (0.000s)
[545.981059] [099/133] (479s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[546.076642] Starting subtest: fbc-rgb101010-draw-pwrite
[551.408940] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.333s)
[552.538144] [100/133] (472s left) kms_vrr (negative-basic)
[552.626959] Starting subtest: negative-basic
[552.633983] Starting dynamic subtest: pipe-A-eDP-1
[558.656424] Dynamic subtest pipe-A-eDP-1: FAIL (5.449s)
[558.659058] Subtest negative-basic: FAIL (5.745s)
[559.250526] [101/133] (466s left) gem_exec_schedule (smoketest-all)
[559.321389] Starting subtest: smoketest-all
[591.722721] Subtest smoketest-all: SUCCESS (32.356s)
[592.596103] [102/133] (432s left) kms_big_fb (y-tiled-addfb-size-overflow)
[592.714957] Starting subtest: y-tiled-addfb-size-overflow
[592.719642] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[592.817463] [103/133] (432s left) vgem_basic (bad-fence)
[592.861799] Starting subtest: bad-fence
[592.864323] Subtest bad-fence: SUCCESS (0.000s)
[592.920058] [104/133] (432s left) gem_ctx_persistence (engines-hostile)
[592.976445] Starting subtest: engines-hostile
[592.979268] Starting dynamic subtest: rcs0
[593.053562] Dynamic subtest rcs0: SUCCESS (0.077s)
[593.068433] Starting dynamic subtest: bcs0
[593.160720] Dynamic subtest bcs0: SUCCESS (0.105s)
[593.172491] Starting dynamic subtest: vcs0
[593.257819] Dynamic subtest vcs0: SUCCESS (0.095s)
[593.272240] Starting dynamic subtest: vcs1
[593.356840] Dynamic subtest vcs1: SUCCESS (0.097s)
[593.370747] Starting dynamic subtest: vecs0
[593.447687] Dynamic subtest vecs0: SUCCESS (0.089s)
[593.461479] Starting dynamic subtest: ccs0
[593.528420] Dynamic subtest ccs0: SUCCESS (0.079s)
[593.530978] Subtest engines-hostile: SUCCESS (0.554s)
[593.650435] [105/133] (431s left) prime_mmap (test_forked)
[593.705243] Starting subtest: test_forked
[593.707439] Starting dynamic subtest: test_forked-smem
[593.740986] Dynamic subtest test_forked-smem: SUCCESS (0.037s)
[593.743505] Subtest test_forked: SUCCESS (0.039s)
[593.856552] [106/133] (431s left) gem_spin_batch (resubmit-all)
[593.929017] Starting subtest: resubmit-all
[593.931273] Starting dynamic subtest: rcs0
[593.942808] Dynamic subtest rcs0: SUCCESS (0.013s)
[593.955328] Starting dynamic subtest: bcs0
[593.957958] Dynamic subtest bcs0: SUCCESS (0.002s)
[593.967613] Starting dynamic subtest: vcs0
[593.969712] Dynamic subtest vcs0: SUCCESS (0.002s)
[593.978651] Starting dynamic subtest: vcs1
[593.980808] Dynamic subtest vcs1: SUCCESS (0.002s)
[593.989865] Starting dynamic subtest: vecs0
[593.991894] Dynamic subtest vecs0: SUCCESS (0.001s)
[594.001240] Starting dynamic subtest: ccs0
[594.003471] Dynamic subtest ccs0: SUCCESS (0.002s)
[594.005546] Subtest resubmit-all: SUCCESS (0.028s)
[595.559512] [107/133] (430s left) i915_drm_fdinfo (busy-idle)
[595.607804] Starting subtest: busy-idle
[595.610719] Starting dynamic subtest: rcs0
[595.629357] Dynamic subtest rcs0: SKIP (0.020s)
[595.639985] Starting dynamic subtest: bcs0
[595.644438] Dynamic subtest bcs0: SKIP (0.011s)
[595.654660] Starting dynamic subtest: vcs0
[595.659675] Dynamic subtest vcs0: SKIP (0.000s)
[595.670164] Starting dynamic subtest: vcs1
[595.674963] Dynamic subtest vcs1: SKIP (0.000s)
[595.684845] Starting dynamic subtest: vecs0
[595.689293] Dynamic subtest vecs0: SKIP (0.000s)
[595.698818] Starting dynamic subtest: ccs0
[595.703311] Dynamic subtest ccs0: SKIP (0.000s)
[595.707690] Subtest busy-idle: SKIP (0.035s)
[595.746734] [108/133] (430s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[595.863397] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[596.722112] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.859s)
[596.872806] [109/133] (428s left) perf (non-sampling-read-error)
[596.977467] Starting subtest: non-sampling-read-error
[596.986105] Subtest non-sampling-read-error: SUCCESS (0.008s)
[597.038469] [110/133] (428s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[597.123434] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[605.876434] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.756s)
[606.012523] [111/133] (419s left) kms_force_connector_basic (force-load-detect)
[606.090034] Starting subtest: force-load-detect
[606.095093] Subtest force-load-detect: SKIP (0.000s)
[606.202942] [112/133] (419s left) kms_content_protection (lic-type-0-hdcp14)
[606.337875] Starting subtest: lic-type-0-hdcp14
[606.343295] Subtest lic-type-0-hdcp14: SKIP (0.000s)
[606.452369] [113/133] (419s left) gem_ctx_shared (q-in-order)
[606.514268] Starting subtest: Q-in-order
[606.517370] Starting dynamic subtest: rcs0
[606.631090] Dynamic subtest rcs0: SUCCESS (0.115s)
[606.646541] Starting dynamic subtest: vcs0
[606.724024] Dynamic subtest vcs0: SUCCESS (0.093s)
[606.740015] Starting dynamic subtest: vcs1
[606.819462] Dynamic subtest vcs1: SUCCESS (0.095s)
[606.838783] Starting dynamic subtest: vecs0
[606.907022] Dynamic subtest vecs0: SUCCESS (0.085s)
[606.925863] Starting dynamic subtest: ccs0
[607.013920] Dynamic subtest ccs0: SUCCESS (0.104s)
[607.016774] Subtest Q-in-order: SUCCESS (0.501s)
[608.589253] [114/133] (417s left) i915_suspend (basic-s3-without-i915)
[608.635110] Starting subtest: basic-s3-without-i915
[611.895101] Subtest basic-s3-without-i915: SKIP (3.256s)
[614.376917] [115/133] (411s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[614.502179] Starting subtest: yf-tiled-32bpp-rotate-270
[614.507256] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[614.596651] [116/133] (411s left) gem_ctx_persistence (legacy-engines-persistence)
[614.660097] Starting subtest: legacy-engines-persistence
[614.663337] Starting dynamic subtest: render
[615.487978] Dynamic subtest render: SUCCESS (0.827s)
[615.503491] Starting dynamic subtest: bsd1
[616.236574] Dynamic subtest bsd1: SUCCESS (0.746s)
[616.248484] Starting dynamic subtest: bsd2
[617.000838] Dynamic subtest bsd2: SUCCESS (0.761s)
[617.012781] Starting dynamic subtest: blt
[617.761666] Dynamic subtest blt: SUCCESS (0.758s)
[617.774457] Starting dynamic subtest: vebox
[618.544005] Dynamic subtest vebox: SUCCESS (0.779s)
[618.546969] Subtest legacy-engines-persistence: SUCCESS (3.885s)
[618.627127] [117/133] (407s left) kms_rotation_crc (primary-rotation-90)
[618.726768] Starting subtest: primary-rotation-90
[618.731995] Subtest primary-rotation-90: SKIP (0.001s)
[618.813665] [118/133] (407s left) syncobj_wait (multi-wait-all-signaled)
[618.884494] Starting subtest: multi-wait-all-signaled
[618.887454] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[618.995345] [119/133] (407s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[619.094246] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[619.099514] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[619.210539] [120/133] (407s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[619.302201] Starting subtest: fbc-pr-sprite-mmap-gtt
[619.307087] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[619.387769] [121/133] (406s left) kms_force_connector_basic (prune-stale-modes)
[619.458754] Starting subtest: prune-stale-modes
[619.897308] Subtest prune-stale-modes: SUCCESS (0.440s)
[620.034519] [122/133] (406s left) perf (stress-open-close)
[620.155605] Starting subtest: stress-open-close
[620.157887] Starting dynamic subtest: 0-rcs0
[622.320647] Dynamic subtest 0-rcs0: SUCCESS (2.169s)
[622.328995] Starting dynamic subtest: 1-vcs0
[624.487699] Dynamic subtest 1-vcs0: SUCCESS (2.165s)
[624.490033] Subtest stress-open-close: SUCCESS (4.336s)
[624.539863] [123/133] (401s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[624.600742] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[624.603232] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[624.695562] [124/133] (401s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[624.798515] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[624.803267] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[624.888201] [125/133] (401s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[624.978849] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[624.980992] Starting dynamic subtest: pipe-A-eDP-1
[625.102867] Dynamic subtest pipe-A-eDP-1: SKIP (0.125s)
[625.112011] Starting dynamic subtest: pipe-B-eDP-1
[626.275739] Dynamic subtest pipe-B-eDP-1: SKIP (1.170s)
[626.280731] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.297s)
[627.540970] [126/133] (398s left) sw_sync (sync_merge_same)
[627.581049] Starting subtest: sync_merge_same
[627.583800] Subtest sync_merge_same: SUCCESS (0.000s)
[627.638140] [127/133] (398s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[627.734830] Starting subtest: 4-tiled-32bpp-rotate-0
[629.081251] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.345s)
[629.229637] [128/133] (397s left) i915_pm_rc6_residency (media-rc6-accuracy)
[629.278357] Starting subtest: media-rc6-accuracy
[629.282882] Subtest media-rc6-accuracy: SKIP (0.000s)
[629.366154] [129/133] (397s left) kms_psr (psr-primary-render)
[629.455999] Starting subtest: psr-primary-render
[629.457887] Starting dynamic subtest: eDP-1
[631.204628] Dynamic subtest eDP-1: SUCCESS (1.747s)
[631.207345] Subtest psr-primary-render: SUCCESS (1.748s)
[632.028260] [130/133] (394s left) kms_getfb (getfb2-handle-closed)
[632.133452] Starting subtest: getfb2-handle-closed
[632.136430] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[632.230339] [131/133] (394s left) gem_wait (write-busy)
[632.291350] Starting subtest: write-busy
[632.294272] Starting dynamic subtest: all-engines
[632.891677] Dynamic subtest all-engines: SUCCESS (0.599s)
[632.907486] Starting dynamic subtest: rcs0
[633.441768] Dynamic subtest rcs0: SUCCESS (0.548s)
[633.457930] Starting dynamic subtest: bcs0
[633.991833] Dynamic subtest bcs0: SUCCESS (0.549s)
[634.006808] Starting dynamic subtest: vcs0
[635.503318] Dynamic subtest vcs0: SUCCESS (1.509s)
[635.519474] Starting dynamic subtest: vcs1
[637.549222] Dynamic subtest vcs1: SUCCESS (2.043s)
[637.565923] Starting dynamic subtest: vecs0
[639.532989] Dynamic subtest vecs0: SUCCESS (1.980s)
[639.550218] Starting dynamic subtest: ccs0
[640.084797] Dynamic subtest ccs0: SUCCESS (0.550s)
[640.088128] Subtest write-busy: SUCCESS (7.792s)
[640.294352] [132/133] (386s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[640.428206] Starting subtest: cursorB-vs-flipB-legacy
[640.433370] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[640.580282] [133/133] (386s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[640.676240] Starting subtest: primary-x-tiled-reflect-x-0
[647.552915] Subtest primary-x-tiled-reflect-x-0: SUCCESS (6.876s)
[648.741764] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gem_exec_balancer
results: parsing output: 5/ for test: syncobj_wait
results: parsing output: 6/ for test: gen7_exec_parse
results: parsing output: 7/ for test: gem_pread
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_cursor_crc
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_psr2_sf
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_plane_scaling
results: parsing output: 14/ for test: gem_exec_flush
results: parsing output: 15/ for test: gem_eio
results: parsing output: 16/ for test: kms_plane
results: parsing output: 17/ for test: kms_cursor_crc
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: kms_invalid_mode
results: parsing output: 20/ for test: kms_cursor_crc
results: parsing output: 21/ for test: kms_addfb_basic
results: parsing output: 22/ for test: gem_exec_schedule
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: kms_chamelium_hpd
results: parsing output: 25/ for test: gem_exec_schedule
results: parsing output: 26/ for test: kms_lease
results: parsing output: 27/ for test: kms_cursor_crc
results: parsing output: 28/ for test: kms_ccs
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: gem_exec_reloc
results: parsing output: 31/ for test: gem_exec_parallel
results: parsing output: 32/ for test: kms_vblank
results: parsing output: 33/ for test: kms_flip_scaled_crc
results: parsing output: 34/ for test: kms_sequence
results: parsing output: 35/ for test: gem_exec_whisper
results: parsing output: 36/ for test: kms_cursor_legacy
results: parsing output: 37/ for test: perf_pmu
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_exec_fence
results: parsing output: 40/ for test: kms_ccs
results: parsing output: 41/ for test: gem_lmem_swapping
results: parsing output: 42/ for test: sw_sync
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_prop_blob
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: gem_lmem_swapping
results: parsing output: 47/ for test: kms_flip
results: parsing output: 48/ for test: api_intel_bb
results: parsing output: 49/ for test: kms_pm_dc
results: parsing output: 50/ for test: kms_plane_cursor
results: parsing output: 51/ for test: gem_exec_reloc
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: gem_exec_schedule
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_color
results: parsing output: 56/ for test: syncobj_timeline
results: parsing output: 57/ for test: gem_eio
results: parsing output: 58/ for test: kms_addfb_basic
results: parsing output: 59/ for test: kms_addfb_basic
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_plane
results: parsing output: 62/ for test: kms_pipe_crc_basic
results: parsing output: 63/ for test: kms_chamelium_frames
results: parsing output: 64/ for test: perf
results: parsing output: 65/ for test: kms_dsc
results: parsing output: 66/ for test: syncobj_eventfd
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: gem_mmap_offset
results: parsing output: 69/ for test: kms_chamelium_color
results: parsing output: 70/ for test: kms_hdmi_inject
results: parsing output: 71/ for test: i915_drm_fdinfo
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: gem_set_tiling_vs_gtt
results: parsing output: 74/ for test: api_intel_allocator
results: parsing output: 75/ for test: kms_flip_scaled_crc
results: parsing output: 76/ for test: gem_eio
results: parsing output: 77/ for test: gem_exec_create
results: parsing output: 78/ for test: syncobj_timeline
results: parsing output: 79/ for test: gem_exec_params
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: kms_cursor_legacy
results: parsing output: 82/ for test: gem_userptr_blits
results: parsing output: 83/ for test: gem_ctx_engines
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_pm_rpm
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_atomic
results: parsing output: 88/ for test: syncobj_timeline
results: parsing output: 89/ for test: gem_request_retire
results: parsing output: 90/ for test: gem_render_copy
results: parsing output: 91/ for test: gem_pxp
results: parsing output: 92/ for test: kms_ccs
results: parsing output: 93/ for test: kms_flip_scaled_crc
results: parsing output: 94/ for test: gem_exec_fence
results: parsing output: 95/ for test: dumb_buffer
results: parsing output: 96/ for test: kms_psr
results: parsing output: 97/ for test: fbdev
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_vrr
results: parsing output: 100/ for test: gem_exec_schedule
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: vgem_basic
results: parsing output: 103/ for test: gem_ctx_persistence
results: parsing output: 104/ for test: prime_mmap
results: parsing output: 105/ for test: gem_spin_batch
results: parsing output: 106/ for test: i915_drm_fdinfo
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: perf
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_force_connector_basic
results: parsing output: 111/ for test: kms_content_protection
results: parsing output: 112/ for test: gem_ctx_shared
results: parsing output: 113/ for test: i915_suspend
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: gem_ctx_persistence
results: parsing output: 116/ for test: kms_rotation_crc
results: parsing output: 117/ for test: syncobj_wait
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: kms_force_connector_basic
results: parsing output: 121/ for test: perf
results: parsing output: 122/ for test: syncobj_wait
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_psr2_sf
results: parsing output: 125/ for test: sw_sync
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: i915_pm_rc6_residency
results: parsing output: 128/ for test: kms_psr
results: parsing output: 129/ for test: kms_getfb
results: parsing output: 130/ for test: gem_wait
results: parsing output: 131/ for test: kms_cursor_legacy
results: parsing output: 132/ for test: kms_rotation_crc
Done.