[58.351947] Initializing watchdogs
[58.351991]   /dev/watchdog0
[58.364740] [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]
[58.368780] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.370868] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.373672] [001/130] (960s left) gem_exec_params (invalid-ring)
[58.446645] Starting subtest: invalid-ring
[58.448973] Subtest invalid-ring: SUCCESS (0.000s)
[58.554861] [002/130] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu)
[58.657377] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu
[65.158195] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (6.503s)
[65.303148] [003/130] (953s left) gem_spin_batch (legacy)
[65.371099] Starting subtest: legacy
[65.373397] Starting dynamic subtest: default
[68.609715] Dynamic subtest default: SUCCESS (3.233s)
[68.619092] Starting dynamic subtest: render
[71.836827] Dynamic subtest render: SUCCESS (3.226s)
[71.846214] Starting dynamic subtest: bsd
[75.069452] Dynamic subtest bsd: SUCCESS (3.232s)
[75.078911] Starting dynamic subtest: bsd1
[78.301369] Dynamic subtest bsd1: SUCCESS (3.231s)
[78.310735] Starting dynamic subtest: bsd2
[81.538031] Dynamic subtest bsd2: SUCCESS (3.234s)
[81.549256] Starting dynamic subtest: blt
[84.770778] Dynamic subtest blt: SUCCESS (3.232s)
[84.780334] Starting dynamic subtest: vebox
[88.008589] Dynamic subtest vebox: SUCCESS (3.233s)
[88.011028] Subtest legacy: SUCCESS (22.628s)
[89.949254] [004/130] (929s left) perf (gen12-group-exclusive-stream-ctx-handle)
[90.052539] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[90.077456] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.025s)
[90.121401] [005/130] (928s left) i915_pm_rps (thresholds-idle)
[91.896501] Starting subtest: thresholds-idle
[91.901540] Subtest thresholds-idle: SKIP (0.000s)
[91.979702] [006/130] (927s left) tools_test (tools_test)
[92.041179] Starting subtest: tools_test
[92.083462] Subtest tools_test: SUCCESS (0.062s)
[92.144370] [007/130] (926s left) gem_mmap_gtt (medium-copy-xy)
[92.192965] Subtest medium-copy-XY: SKIP (0.000s)
[92.253622] [008/130] (926s left) kms_invalid_mode (int-max-clock)
[92.346845] Starting subtest: int-max-clock
[92.349132] Starting dynamic subtest: pipe-A-eDP-1
[92.636527] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.291s)
[92.645936] Starting dynamic subtest: pipe-B-eDP-1
[92.647759] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[92.654120] Starting dynamic subtest: pipe-C-eDP-1
[92.655988] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[92.662933] Starting dynamic subtest: pipe-D-eDP-1
[92.665110] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[92.667241] Subtest int-max-clock: SUCCESS (0.294s)
[93.430352] [009/130] (925s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[93.538386] Starting subtest: yf-tiled-64bpp-rotate-0
[93.542716] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[93.645203] [010/130] (925s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[93.707832] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[93.814745] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.105s)
[93.901813] [011/130] (925s left) gem_exec_reloc (basic-range)
[93.958555] Subtest basic-range: SKIP (0.000s)
[94.037984] [012/130] (925s left) gem_userptr_blits (forbidden-operations)
[94.102156] Starting subtest: forbidden-operations
[94.106466] Subtest forbidden-operations: SKIP (0.000s)
[94.211061] [013/130] (925s left) kms_pm_rpm (pm-caching)
[96.052650] Starting subtest: pm-caching
[96.058103] Subtest pm-caching: SKIP (0.000s)
[96.475024] [014/130] (922s left) gem_exec_schedule (u-submit-golden-slice)
[96.545856] Starting subtest: u-submit-golden-slice
[96.547823] Starting dynamic subtest: rcs0
[96.571697] Dynamic subtest rcs0: SUCCESS (0.033s)
[96.581829] Starting dynamic subtest: bcs0
[96.598336] Dynamic subtest bcs0: SUCCESS (0.027s)
[96.605870] Starting dynamic subtest: vcs0
[96.637819] Dynamic subtest vcs0: SUCCESS (0.039s)
[96.648342] Starting dynamic subtest: vcs1
[96.670515] Dynamic subtest vcs1: SUCCESS (0.033s)
[96.679967] Starting dynamic subtest: vecs0
[96.697638] Dynamic subtest vecs0: SUCCESS (0.027s)
[96.704734] Starting dynamic subtest: ccs0
[96.724904] Dynamic subtest ccs0: SUCCESS (0.027s)
[96.727205] Subtest u-submit-golden-slice: SUCCESS (0.187s)
[97.968818] [015/130] (921s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[102.962251] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[102.970139] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.004s)
[103.798079] [016/130] (915s left) gem_exec_params (dr4-dirt)
[103.850601] Starting subtest: DR4-dirt
[103.852838] Subtest DR4-dirt: SUCCESS (0.000s)
[103.940298] [017/130] (915s left) kms_flip (flip-vs-rmfb)
[104.039484] Starting subtest: flip-vs-rmfb
[104.041986] Starting dynamic subtest: A-eDP1
[112.695082] Dynamic subtest A-eDP1: SUCCESS (8.654s)
[112.702811] Starting dynamic subtest: B-eDP1
[121.327965] Dynamic subtest B-eDP1: SUCCESS (8.631s)
[121.335478] Starting dynamic subtest: C-eDP1
[129.944503] Dynamic subtest C-eDP1: SUCCESS (8.614s)
[129.954270] Starting dynamic subtest: D-eDP1
[138.571808] Dynamic subtest D-eDP1: SUCCESS (8.627s)
[138.576257] Subtest flip-vs-rmfb: SUCCESS (34.533s)
[139.750133] [018/130] (879s left) prime_self_import (basic-with_one_bo_two_files)
[139.791166] Starting subtest: basic-with_one_bo_two_files
[139.818145] Subtest basic-with_one_bo_two_files: SUCCESS (0.027s)
[139.923324] [019/130] (879s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[140.032180] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[144.533247] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.504s)
[145.650160] [020/130] (873s left) gem_wait (busy)
[145.704516] Starting subtest: busy
[145.706884] Starting dynamic subtest: all-engines
[146.898706] Dynamic subtest all-engines: SUCCESS (1.192s)
[146.908917] Starting dynamic subtest: rcs0
[147.440041] Dynamic subtest rcs0: SUCCESS (0.540s)
[147.450070] Starting dynamic subtest: bcs0
[147.978907] Dynamic subtest bcs0: SUCCESS (0.538s)
[147.988961] Starting dynamic subtest: vcs0
[149.905743] Dynamic subtest vcs0: SUCCESS (1.925s)
[149.916344] Starting dynamic subtest: vcs1
[151.890469] Dynamic subtest vcs1: SUCCESS (1.983s)
[151.900687] Starting dynamic subtest: vecs0
[153.937842] Dynamic subtest vecs0: SUCCESS (2.046s)
[153.947900] Starting dynamic subtest: ccs0
[154.479226] Dynamic subtest ccs0: SUCCESS (0.541s)
[154.481673] Subtest busy: SUCCESS (8.778s)
[154.665625] [021/130] (864s left) kms_addfb_basic (bad-pitch-128)
[154.722083] Starting subtest: bad-pitch-128
[154.724052] Subtest bad-pitch-128: SUCCESS (0.000s)
[154.887863] [022/130] (864s left) kms_psr (fbc-psr-sprite-plane-onoff)
[154.983307] Starting subtest: fbc-psr-sprite-plane-onoff
[154.985614] Starting dynamic subtest: eDP-1
[154.990060] Dynamic subtest eDP-1: SKIP (0.000s)
[154.994498] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[155.052837] [023/130] (864s left) device_reset (unbind-reset-rebind)
[155.095874] Starting subtest: unbind-reset-rebind
[158.188370] Subtest unbind-reset-rebind: SUCCESS (3.089s)
[158.225236] [024/130] (861s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[158.320937] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[158.323161] Starting dynamic subtest: pipe-A-eDP-1
[158.382273] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[158.392033] Starting dynamic subtest: pipe-B-eDP-1
[158.450619] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[158.460052] Starting dynamic subtest: pipe-C-eDP-1
[158.518097] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[158.527166] Starting dynamic subtest: pipe-D-eDP-1
[158.583999] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[158.588326] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.008s)
[160.494826] [025/130] (859s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[160.553199] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[160.555563] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[160.643386] [026/130] (859s left) kms_lease (lease-again)
[160.733295] Starting subtest: lease-again
[160.735796] Starting dynamic subtest: pipe-A-eDP-1
[160.738142] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[160.748697] Starting dynamic subtest: pipe-B-eDP-1
[160.750858] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[160.758146] Starting dynamic subtest: pipe-C-eDP-1
[160.760061] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[160.767473] Starting dynamic subtest: pipe-D-eDP-1
[160.769365] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[160.771223] Subtest lease-again: SUCCESS (0.015s)
[160.860486] [027/130] (858s left) gem_ctx_isolation (preservation-s3)
[160.919204] Starting subtest: preservation-S3
[160.921462] Starting dynamic subtest: rcs0
[176.812535] Dynamic subtest rcs0: SUCCESS (1.475s)
[176.822629] Starting dynamic subtest: bcs0
[192.735594] Dynamic subtest bcs0: SUCCESS (1.382s)
[192.745100] Starting dynamic subtest: vcs0
[208.748693] Dynamic subtest vcs0: SUCCESS (3.119s)
[208.762534] Starting dynamic subtest: vcs1
[226.809068] Dynamic subtest vcs1: SUCCESS (5.033s)
[226.818195] Starting dynamic subtest: vecs0
[244.804441] Dynamic subtest vecs0: SUCCESS (4.986s)
[244.817461] Starting dynamic subtest: ccs0
[262.752413] Dynamic subtest ccs0: SUCCESS (3.185s)
[262.754668] Subtest preservation-S3: SUCCESS (19.186s)
[262.985876] [028/130] (756s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[263.089881] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[266.636001] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.546s)
[267.752124] [029/130] (752s left) syncobj_timeline (wait-for-submit-delayed-submit)
[267.818757] Starting subtest: wait-for-submit-delayed-submit
[267.923135] Subtest wait-for-submit-delayed-submit: SUCCESS (0.104s)
[267.996364] [030/130] (751s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[268.043160] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[268.149495] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.106s)
[268.222419] [031/130] (751s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[268.322007] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[268.935225] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.614s)
[269.115993] [032/130] (750s left) gem_ctx_persistence (legacy-engines-persistence)
[269.182672] Starting subtest: legacy-engines-persistence
[269.185060] Starting dynamic subtest: render
[269.994427] Dynamic subtest render: SUCCESS (0.810s)
[270.005852] Starting dynamic subtest: bsd1
[270.746354] Dynamic subtest bsd1: SUCCESS (0.749s)
[270.758378] Starting dynamic subtest: bsd2
[271.530515] Dynamic subtest bsd2: SUCCESS (0.781s)
[271.542497] Starting dynamic subtest: blt
[272.287464] Dynamic subtest blt: SUCCESS (0.754s)
[272.299337] Starting dynamic subtest: vebox
[273.048600] Dynamic subtest vebox: SUCCESS (0.758s)
[273.051102] Subtest legacy-engines-persistence: SUCCESS (3.863s)
[273.153353] [033/130] (746s left) gem_exec_schedule (preempt-other-chain)
[273.218078] Starting subtest: preempt-other-chain
[273.220414] Starting dynamic subtest: rcs0
[273.356218] Dynamic subtest rcs0: SUCCESS (0.140s)
[273.373599] Starting dynamic subtest: bcs0
[273.488283] Dynamic subtest bcs0: SUCCESS (0.131s)
[273.502327] Starting dynamic subtest: vcs0
[273.613177] Dynamic subtest vcs0: SUCCESS (0.124s)
[273.626297] Starting dynamic subtest: vcs1
[273.740317] Dynamic subtest vcs1: SUCCESS (0.125s)
[273.751348] Starting dynamic subtest: vecs0
[273.869783] Dynamic subtest vecs0: SUCCESS (0.129s)
[273.884468] Starting dynamic subtest: ccs0
[274.004131] Dynamic subtest ccs0: SUCCESS (0.134s)
[274.007048] Subtest preempt-other-chain: SUCCESS (0.787s)
[274.638795] [034/130] (745s left) kms_cursor_edge_walk (256x256-top-edge)
[274.735004] Starting subtest: 256x256-top-edge
[274.737268] Starting dynamic subtest: pipe-A-eDP-1
[278.218797] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.477s)
[278.234363] Starting dynamic subtest: pipe-D-eDP-1
[281.335416] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.115s)
[281.337768] Subtest 256x256-top-edge: SUCCESS (6.595s)
[282.142620] [035/130] (737s left) gem_mmap_gtt (medium-copy)
[282.197731] Subtest medium-copy: SKIP (0.000s)
[282.256969] [036/130] (737s left) api_intel_bb (blit-noreloc-purge-cache)
[282.316144] Starting subtest: blit-noreloc-purge-cache
[282.325624] Subtest blit-noreloc-purge-cache: SUCCESS (0.011s)
[282.437972] [037/130] (737s left) kms_chamelium_color (gamma)
[282.537768] Subtest gamma: SKIP (0.000s)
[282.580612] [038/130] (737s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[282.677074] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[282.681431] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[282.780658] [039/130] (737s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[282.882650] Starting subtest: blocking-absolute-wf_vblank-interruptible
[282.885046] Starting dynamic subtest: A-eDP1
[291.614604] Dynamic subtest A-eDP1: SUCCESS (8.727s)
[291.624537] Starting dynamic subtest: B-eDP1
[300.346775] Dynamic subtest B-eDP1: SUCCESS (8.727s)
[300.359806] Starting dynamic subtest: C-eDP1
[309.056751] Dynamic subtest C-eDP1: SUCCESS (8.710s)
[309.067287] Starting dynamic subtest: D-eDP1
[317.785935] Dynamic subtest D-eDP1: SUCCESS (8.728s)
[317.790981] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.902s)
[318.993922] [040/130] (701s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[319.098045] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[319.100434] Starting dynamic subtest: pipe-A-default-mode
[321.802886] Dynamic subtest pipe-A-default-mode: SUCCESS (2.703s)
[321.805266] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.704s)
[322.674922] [041/130] (697s left) kms_cursor_crc (cursor-onscreen-128x128)
[322.887817] Starting subtest: cursor-onscreen-128x128
[322.890193] Starting dynamic subtest: pipe-A-eDP-1
[324.976485] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.086s)
[325.003291] Starting dynamic subtest: pipe-D-eDP-1
[327.745670] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.749s)
[327.747798] Subtest cursor-onscreen-128x128: SUCCESS (4.857s)
[328.543874] [042/130] (691s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[328.659210] Starting subtest: cursorB-vs-flipB-varying-size
[328.663728] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[328.805313] [043/130] (691s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[328.916500] Starting subtest: cursorB-vs-flipB-toggle
[328.921029] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[329.058148] [044/130] (691s left) kms_dp_link_training (non-uhbr-mst)
[329.154976] Starting subtest: non-uhbr-mst
[329.163410] Subtest non-uhbr-mst: SKIP (0.000s)
[329.225975] [045/130] (691s left) gem_exec_params (secure-non-master)
[329.275441] Starting subtest: secure-non-master
[329.279841] Subtest secure-non-master: SKIP (0.000s)
[329.386950] [046/130] (691s left) gem_exec_params (rel-constants-invalid-ring)
[329.438610] Starting subtest: rel-constants-invalid-ring
[329.440770] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[329.532299] [047/130] (691s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[329.623591] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[329.625572] Starting dynamic subtest: pipe-A-eDP-1
[329.647811] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[329.659245] Starting dynamic subtest: pipe-B-eDP-1
[329.679201] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[329.687580] Starting dynamic subtest: pipe-C-eDP-1
[329.707488] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[329.715393] Starting dynamic subtest: pipe-D-eDP-1
[329.735531] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[329.739160] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[331.800062] [048/130] (688s left) fbdev (unaligned-read)
[331.844366] Starting subtest: unaligned-read
[331.857997] Subtest unaligned-read: SUCCESS (0.015s)
[331.912361] [049/130] (688s left) core_auth (many-magics)
[331.972101] Starting subtest: many-magics
[332.838861] Subtest many-magics: SUCCESS (0.868s)
[333.025599] [050/130] (687s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[333.125552] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[333.129761] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[333.247786] [051/130] (687s left) i915_hangman (gt-engine-hang)
[333.301739] Starting subtest: gt-engine-hang
[333.304007] Starting dynamic subtest: rcs0
[334.522189] Dynamic subtest rcs0: SUCCESS (1.220s)
[334.534878] Starting dynamic subtest: bcs0
[336.504424] Dynamic subtest bcs0: SUCCESS (1.980s)
[336.516882] Starting dynamic subtest: vcs0
[338.487907] Dynamic subtest vcs0: SUCCESS (1.981s)
[338.503735] Starting dynamic subtest: vcs1
[340.536086] Dynamic subtest vcs1: SUCCESS (2.045s)
[340.548298] Starting dynamic subtest: vecs0
[342.520065] Dynamic subtest vecs0: SUCCESS (1.981s)
[342.532792] Starting dynamic subtest: ccs0
[344.503374] Dynamic subtest ccs0: SUCCESS (1.980s)
[344.506320] Subtest gt-engine-hang: SUCCESS (11.199s)
[344.586980] [052/130] (676s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[344.697317] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[344.701439] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[344.803262] [053/130] (676s left) kms_plane_scaling (intel-max-src-size)
[344.894795] Starting subtest: intel-max-src-size
[344.901470] Subtest intel-max-src-size: SKIP (0.000s)
[345.009857] [054/130] (675s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-wc)
[345.121006] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-wc
[349.062437] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-wc: SUCCESS (3.944s)
[350.224017] [055/130] (670s left) perf_pmu (multi-client)
[350.259010] Starting subtest: multi-client
[350.261466] Starting dynamic subtest: rcs0
[351.327493] Dynamic subtest rcs0: SUCCESS (1.066s)
[351.339655] Starting dynamic subtest: bcs0
[352.376219] Dynamic subtest bcs0: SUCCESS (1.047s)
[352.386905] Starting dynamic subtest: vcs0
[353.427486] Dynamic subtest vcs0: SUCCESS (1.049s)
[353.439928] Starting dynamic subtest: vcs1
[354.574561] Dynamic subtest vcs1: SUCCESS (1.144s)
[354.585287] Starting dynamic subtest: vecs0
[356.563772] Dynamic subtest vecs0: SUCCESS (1.986s)
[356.575998] Starting dynamic subtest: ccs0
[358.546079] Dynamic subtest ccs0: SUCCESS (1.979s)
[358.548855] Subtest multi-client: SUCCESS (8.284s)
[358.677943] [056/130] (662s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[358.780343] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[358.784837] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[358.876774] [057/130] (662s left) kms_async_flips (crc-atomic)
[358.970425] Starting subtest: crc-atomic
[359.345138] Starting dynamic subtest: pipe-A-eDP-1
[362.215258] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.870s)
[362.598898] Starting dynamic subtest: pipe-B-eDP-1
[365.452094] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.867s)
[365.838247] Starting dynamic subtest: pipe-C-eDP-1
[368.684625] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.856s)
[369.047131] Starting dynamic subtest: pipe-D-eDP-1
[371.930760] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.893s)
[371.933143] Subtest crc-atomic: SUCCESS (12.960s)
[373.079241] [058/130] (647s left) gem_close_race (multigpu-basic-process)
[373.143675] Starting subtest: multigpu-basic-process
[373.148127] Subtest multigpu-basic-process: SKIP (0.000s)
[373.377202] [059/130] (647s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[373.476434] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[373.480724] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[373.562719] [060/130] (647s left) kms_cursor_crc (cursor-random-max-size)
[373.848643] Starting subtest: cursor-random-max-size
[373.855619] Subtest cursor-random-max-size: SKIP (0.000s)
[373.979502] [061/130] (647s left) kms_lease (simple-lease)
[374.068053] Starting subtest: simple-lease
[374.070433] Starting dynamic subtest: pipe-A-eDP-1
[374.566549] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.497s)
[374.578027] Starting dynamic subtest: pipe-B-eDP-1
[376.015644] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.446s)
[376.025949] Starting dynamic subtest: pipe-C-eDP-1
[377.399827] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.385s)
[377.410040] Starting dynamic subtest: pipe-D-eDP-1
[378.795437] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.391s)
[378.797353] Subtest simple-lease: SUCCESS (4.726s)
[379.613170] [062/130] (641s left) gem_softpin (overlap)
[379.671408] Starting subtest: overlap
[380.495069] Subtest overlap: SUCCESS (0.822s)
[380.616888] [063/130] (640s left) kms_vrr (flip-basic)
[380.712825] Starting subtest: flip-basic
[380.719474] Subtest flip-basic: SKIP (0.000s)
[380.786145] [064/130] (640s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[380.892506] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[380.894966] Starting dynamic subtest: pipe-A
[381.230757] Dynamic subtest pipe-A: SUCCESS (0.338s)
[381.240390] Starting dynamic subtest: pipe-B
[382.601940] Dynamic subtest pipe-B: SUCCESS (1.371s)
[382.616068] Starting dynamic subtest: pipe-C
[384.038331] Dynamic subtest pipe-C: SUCCESS (1.435s)
[384.054553] Starting dynamic subtest: pipe-D
[385.462770] Dynamic subtest pipe-D: SUCCESS (1.423s)
[385.465057] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.571s)
[386.627896] [065/130] (634s left) kms_atomic_transition (plane-all-transition-fencing)
[386.720992] Starting subtest: plane-all-transition-fencing
[386.723307] Starting dynamic subtest: pipe-A-eDP-1
[389.224064] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.503s)
[389.543798] Starting dynamic subtest: pipe-B-eDP-1
[392.779531] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.245s)
[393.088015] Subtest plane-all-transition-fencing: SUCCESS (6.367s)
[393.911835] [066/130] (627s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[394.019749] Starting subtest: y-tiled-64bpp-rotate-90
[394.024287] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[394.139506] [067/130] (627s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[394.244062] Starting subtest: fbcpsr-rgb565-draw-blt
[401.195901] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (6.954s)
[401.330993] [068/130] (620s left) gem_ctx_persistence (engines-mixed-process)
[401.397762] Starting subtest: engines-mixed-process
[401.400082] Starting dynamic subtest: rcs0
[402.536589] Dynamic subtest rcs0: SUCCESS (1.138s)
[402.546549] Starting dynamic subtest: bcs0
[404.552528] Dynamic subtest bcs0: SUCCESS (2.014s)
[404.561828] Starting dynamic subtest: vcs0
[406.585605] Dynamic subtest vcs0: SUCCESS (2.033s)
[406.597406] Starting dynamic subtest: vcs1
[408.540081] Dynamic subtest vcs1: SUCCESS (1.952s)
[408.549776] Starting dynamic subtest: vecs0
[410.555983] Dynamic subtest vecs0: SUCCESS (2.014s)
[410.568279] Starting dynamic subtest: ccs0
[412.606643] Dynamic subtest ccs0: SUCCESS (2.049s)
[412.609123] Subtest engines-mixed-process: SUCCESS (11.208s)
[412.688857] [069/130] (608s left) kms_dsc (dsc-with-output-formats-with-bpc)
[412.788002] Starting subtest: dsc-with-output-formats-with-bpc
[412.846182] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[412.884050] [070/130] (608s left) gem_softpin (invalid)
[412.933940] Starting subtest: invalid
[412.941112] Subtest invalid: SUCCESS (0.006s)
[413.079322] [071/130] (608s left) gem_lmem_swapping (random-engines)
[413.115479] Subtest random-engines: SKIP (0.000s)
[413.163057] [072/130] (608s left) gem_exec_reloc (basic-cpu-wc-active)
[413.217342] Subtest basic-cpu-wc-active: SKIP (0.000s)
[413.301303] [073/130] (608s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[413.403595] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[417.590940] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.191s)
[418.763283] [074/130] (602s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[418.864520] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[418.866897] Starting dynamic subtest: pipe-A-eDP-1
[418.890494] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[418.901482] Starting dynamic subtest: pipe-B-eDP-1
[418.922751] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[418.932030] Starting dynamic subtest: pipe-C-eDP-1
[418.954177] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[418.965159] Starting dynamic subtest: pipe-D-eDP-1
[418.987025] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[418.991449] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[421.029489] [075/130] (600s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[426.005373] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[426.007683] Starting dynamic subtest: pipe-A-eDP-1
[438.022978] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.012s)
[438.032627] Starting dynamic subtest: pipe-B-eDP-1
[450.048989] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.022s)
[450.051377] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (24.037s)
[450.903203] [076/130] (570s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[451.014124] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[451.018117] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[451.135732] [077/130] (570s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[451.239395] Starting subtest: psr-rgb101010-draw-render
[458.366640] Subtest psr-rgb101010-draw-render: SUCCESS (7.129s)
[458.502407] [078/130] (563s left) kms_pm_rpm (cursor-dpms)
[460.739328] Starting subtest: cursor-dpms
[460.744505] Subtest cursor-dpms: SKIP (0.000s)
[461.120016] [079/130] (560s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[461.226656] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[467.886769] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.662s)
[468.009387] [080/130] (553s left) perf (sysctl-defaults)
[468.083616] Starting subtest: sysctl-defaults
[468.086057] Subtest sysctl-defaults: SUCCESS (0.000s)
[468.165635] [081/130] (553s left) kms_psr (fbc-psr2-cursor-plane-move)
[468.267546] Starting subtest: fbc-psr2-cursor-plane-move
[468.269400] Starting dynamic subtest: eDP-1
[468.273291] Dynamic subtest eDP-1: SKIP (0.000s)
[468.277231] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[468.337312] [082/130] (553s left) gen9_exec_parse (secure-batches)
[468.402005] Subtest secure-batches: SKIP (0.000s)
[468.498101] [083/130] (553s left) gem_mmap_offset (clear-via-pagefault)
[468.546058] Starting subtest: clear-via-pagefault
[468.548418] Starting dynamic subtest: smem0
[499.714034] Dynamic subtest smem0: SUCCESS (31.159s)
[499.716175] Subtest clear-via-pagefault: SUCCESS (31.160s)
[499.821474] [084/130] (522s left) kms_atomic_transition (modeset-transition-fencing)
[499.921871] Starting subtest: modeset-transition-fencing
[499.924319] Starting dynamic subtest: 1x-outputs
[510.414039] Dynamic subtest 1x-outputs: SUCCESS (10.496s)
[510.681531] Subtest modeset-transition-fencing: SUCCESS (10.765s)
[511.534478] [085/130] (510s left) gem_exec_schedule (in-order)
[511.601470] Starting subtest: in-order
[511.603323] Starting dynamic subtest: rcs0
[511.703361] Dynamic subtest rcs0: SUCCESS (0.109s)
[511.715543] Starting dynamic subtest: vcs0
[511.783094] Dynamic subtest vcs0: SUCCESS (0.079s)
[511.795570] Starting dynamic subtest: vcs1
[511.860393] Dynamic subtest vcs1: SUCCESS (0.077s)
[511.872940] Starting dynamic subtest: vecs0
[511.939636] Dynamic subtest vecs0: SUCCESS (0.078s)
[511.951568] Starting dynamic subtest: ccs0
[512.032709] Dynamic subtest ccs0: SUCCESS (0.093s)
[512.035156] Subtest in-order: SUCCESS (0.440s)
[513.656009] [086/130] (508s left) kms_psr (fbc-pr-dpms)
[513.764345] Starting subtest: fbc-pr-dpms
[513.768357] Subtest fbc-pr-dpms: SKIP (0.000s)
[513.831519] [087/130] (508s left) i915_selftest (perf)
[515.895788] Starting subtest: perf
[515.897816] Starting dynamic subtest: engine_cs
[520.286407] Dynamic subtest engine_cs: SUCCESS (4.391s)
[520.295993] Starting dynamic subtest: request
[525.688040] Dynamic subtest request: SUCCESS (5.400s)
[525.697436] Starting dynamic subtest: migrate
[530.060296] Dynamic subtest migrate: SUCCESS (4.371s)
[530.069410] Starting dynamic subtest: region
[536.061386] Dynamic subtest region: SUCCESS (6.000s)
[536.063851] Subtest perf: SUCCESS (20.168s)
[536.093809] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[536.096858] [088/130] (486s left) kms_psr (psr-primary-blt)
[537.576407] Starting subtest: psr-primary-blt
[537.578650] Starting dynamic subtest: eDP-1
[539.300635] Dynamic subtest eDP-1: SUCCESS (1.731s)
[539.302966] Subtest psr-primary-blt: SUCCESS (1.732s)
[540.174816] [FACT kms_psr (psr-primary-blt)] new: kernel.kmod_is_loaded.i915: true
[540.178432] [089/130] (481s left) kms_sequence (get-idle)
[540.281774] Starting subtest: get-idle
[540.284079] Starting dynamic subtest: pipe-A-eDP-1
[542.097020] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.811s)
[542.106879] Starting dynamic subtest: pipe-B-eDP-1
[544.536350] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.441s)
[544.547546] Starting dynamic subtest: pipe-C-eDP-1
[546.953286] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.414s)
[546.965807] Starting dynamic subtest: pipe-D-eDP-1
[549.389453] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.437s)
[549.391784] Subtest get-idle: SUCCESS (9.108s)
[550.182748] [090/130] (472s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[550.288731] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[550.290870] Starting dynamic subtest: A-eDP1
[553.821022] Dynamic subtest A-eDP1: SUCCESS (3.530s)
[553.830418] Starting dynamic subtest: B-eDP1
[557.008374] Dynamic subtest B-eDP1: SUCCESS (3.187s)
[557.017883] Starting dynamic subtest: C-eDP1
[560.135614] Dynamic subtest C-eDP1: SUCCESS (3.125s)
[560.154873] Starting dynamic subtest: D-eDP1
[563.234425] Dynamic subtest D-eDP1: SUCCESS (3.100s)
[563.236822] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.948s)
[564.042343] [091/130] (458s left) gem_workarounds (basic-read-fd)
[564.117931] Starting subtest: basic-read-fd
[564.130853] Subtest basic-read-fd: SUCCESS (0.013s)
[564.268856] [092/130] (458s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[564.376456] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[571.517189] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.144s)
[571.651659] [093/130] (450s left) prime_busy (after-wait)
[571.702484] Starting subtest: after-wait
[571.708086] Starting dynamic subtest: rcs0
[571.737191] Dynamic subtest rcs0: SUCCESS (0.032s)
[571.747843] Starting dynamic subtest: bcs0
[571.794539] Dynamic subtest bcs0: SUCCESS (0.057s)
[571.805349] Starting dynamic subtest: vcs0
[571.836600] Dynamic subtest vcs0: SUCCESS (0.041s)
[571.847234] Starting dynamic subtest: vcs1
[571.877563] Dynamic subtest vcs1: SUCCESS (0.040s)
[571.886484] Starting dynamic subtest: vecs0
[571.917373] Dynamic subtest vecs0: SUCCESS (0.039s)
[571.926734] Starting dynamic subtest: ccs0
[571.957999] Dynamic subtest ccs0: SUCCESS (0.040s)
[572.066799] Subtest after-wait: SUCCESS (0.363s)
[572.140830] [094/130] (450s left) gem_sync (basic-store-all)
[572.224331] Starting subtest: basic-store-all
[575.339679] Subtest basic-store-all: SUCCESS (3.126s)
[575.520085] [095/130] (446s left) gem_exec_balancer (bonded-true-hang)
[575.762102] Starting subtest: bonded-true-hang
[575.767294] Subtest bonded-true-hang: SKIP (0.000s)
[575.874594] [096/130] (446s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[575.982295] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[580.181074] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.202s)
[581.363357] [097/130] (441s left) gem_mmap_gtt (bad-object)
[581.423319] Subtest bad-object: SKIP (0.000s)
[581.484062] [098/130] (441s left) kms_flip (flip-vs-wf_vblank-interruptible)
[581.570774] Starting subtest: flip-vs-wf_vblank-interruptible
[581.575299] Starting dynamic subtest: A-eDP1
[583.510866] Dynamic subtest A-eDP1: SUCCESS (1.936s)
[583.522761] Starting dynamic subtest: B-eDP1
[585.455007] Dynamic subtest B-eDP1: SUCCESS (1.943s)
[585.466387] Starting dynamic subtest: C-eDP1
[587.379090] Dynamic subtest C-eDP1: SUCCESS (1.923s)
[587.390447] Starting dynamic subtest: D-eDP1
[589.309980] Dynamic subtest D-eDP1: SUCCESS (1.930s)
[589.312278] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.741s)
[590.531732] [099/130] (432s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[590.621464] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[590.625589] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[590.730192] [100/130] (431s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[590.834163] Starting subtest: x-tiled-16bpp-rotate-270
[590.856076] Subtest x-tiled-16bpp-rotate-270: SKIP (0.021s)
[590.975934] [101/130] (431s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[591.107940] Starting subtest: basic-flip-after-cursor-varying-size
[592.022895] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.914s)
[592.859552] [102/130] (429s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[592.923076] Starting subtest: mixed-tiled-to-y-tiled-ccs
[592.927653] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[593.103134] [103/130] (429s left) gem_softpin (allocator-nopin-reserve)
[593.159320] Starting subtest: allocator-nopin-reserve
[593.250396] Subtest allocator-nopin-reserve: SUCCESS (0.091s)
[593.393215] [104/130] (429s left) gem_ctx_param (invalid-size-get)
[593.445573] Starting subtest: invalid-size-get
[593.447817] Subtest invalid-size-get: SUCCESS (0.002s)
[593.554050] [105/130] (429s left) kms_psr (psr-sprite-mmap-gtt)
[593.651984] Starting subtest: psr-sprite-mmap-gtt
[593.654555] Starting dynamic subtest: eDP-1
[595.096957] Dynamic subtest eDP-1: SKIP (1.440s)
[595.101767] Subtest psr-sprite-mmap-gtt: SKIP (1.441s)
[595.263599] [106/130] (427s left) kms_color (legacy-gamma)
[595.356874] Starting subtest: legacy-gamma
[595.359142] Starting dynamic subtest: pipe-A-eDP-1
[596.064937] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.707s)
[596.075220] Starting dynamic subtest: pipe-B-eDP-1
[597.486144] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.418s)
[597.497434] Starting dynamic subtest: pipe-C-eDP-1
[598.774237] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.289s)
[598.783140] Starting dynamic subtest: pipe-D-eDP-1
[600.108216] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.332s)
[600.110523] Subtest legacy-gamma: SUCCESS (4.750s)
[600.918309] [107/130] (421s left) i915_drm_fdinfo (isolation)
[600.958839] Starting subtest: isolation
[600.961169] Starting dynamic subtest: rcs0
[600.981714] Dynamic subtest rcs0: SKIP (0.021s)
[600.993388] Starting dynamic subtest: bcs0
[600.997983] Dynamic subtest bcs0: SKIP (0.000s)
[601.006183] Starting dynamic subtest: vcs0
[601.010731] Dynamic subtest vcs0: SKIP (0.000s)
[601.019262] Starting dynamic subtest: vcs1
[601.023686] Dynamic subtest vcs1: SKIP (0.000s)
[601.031862] Starting dynamic subtest: vecs0
[601.036274] Dynamic subtest vecs0: SKIP (0.000s)
[601.044525] Starting dynamic subtest: ccs0
[601.048964] Dynamic subtest ccs0: SKIP (0.000s)
[601.053380] Subtest isolation: SKIP (0.025s)
[601.088405] [108/130] (421s left) gem_tiled_fence_blits (basic)
[601.146467] Subtest basic: SKIP (0.000s)
[601.218312] [109/130] (421s left) syncobj_timeline (invalid-transfer-illegal-handle)
[601.265203] Starting subtest: invalid-transfer-illegal-handle
[601.267192] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[601.373037] [110/130] (421s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[601.467821] Starting subtest: bad-rotation-90-y-tiled-ccs
[601.470103] Starting dynamic subtest: pipe-A-eDP-1
[601.493222] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[601.505316] Starting dynamic subtest: pipe-B-eDP-1
[601.527767] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[601.538277] Starting dynamic subtest: pipe-C-eDP-1
[601.559441] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[601.568384] Starting dynamic subtest: pipe-D-eDP-1
[601.589847] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[601.593833] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.005s)
[603.683775] [111/130] (419s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[603.743404] Starting subtest: multi-wait-for-submit-available-submitted
[603.745849] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s)
[603.851890] [112/130] (419s left) api_intel_allocator (default-alignment)
[603.914304] Starting subtest: default-alignment
[603.916776] Subtest default-alignment: SUCCESS (0.003s)
[604.048977] [113/130] (419s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[604.443714] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[605.284573] [114/130] (417s left) kms_content_protection (type1)
[605.430100] Starting subtest: type1
[608.854356] Subtest type1: SKIP (3.421s)
[610.028107] [115/130] (413s left) kms_plane_lowres (tiling-x)
[610.129445] Starting subtest: tiling-x
[610.131731] Starting dynamic subtest: pipe-A-eDP-1
[610.136144] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[610.424962] Starting dynamic subtest: pipe-B-eDP-1
[610.429489] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[610.438738] Starting dynamic subtest: pipe-C-eDP-1
[610.443352] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[610.454184] Starting dynamic subtest: pipe-D-eDP-1
[610.458216] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[610.462259] Subtest tiling-x: SKIP (0.291s)
[611.267631] [116/130] (411s left) gem_exec_params (invalid-batch-start-offset)
[611.328826] Starting subtest: invalid-batch-start-offset
[611.334037] Subtest invalid-batch-start-offset: SUCCESS (0.002s)
[611.476882] [117/130] (411s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[611.583082] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[611.587386] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[611.700063] [118/130] (411s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[611.806168] Starting subtest: fbcpsr-tiling-y
[611.810257] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[611.913534] [119/130] (411s left) gem_exec_balancer (hog)
[611.978814] Starting subtest: hog
[611.983010] Subtest hog: SKIP (0.000s)
[612.285637] [120/130] (411s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[612.392641] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[613.291557] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.900s)
[613.437952] [121/130] (409s left) gem_exec_capture (pi)
[613.508293] Starting subtest: pi
[613.510647] Starting dynamic subtest: rcs0
[617.702585] Dynamic subtest rcs0: SUCCESS (4.196s)
[617.715102] Starting dynamic subtest: bcs0
[621.588901] Dynamic subtest bcs0: SUCCESS (3.883s)
[621.600941] Starting dynamic subtest: vcs0
[625.465382] Dynamic subtest vcs0: SUCCESS (3.873s)
[625.481536] Starting dynamic subtest: vcs1
[629.357718] Dynamic subtest vcs1: SUCCESS (3.891s)
[629.368376] Starting dynamic subtest: vecs0
[633.251585] Dynamic subtest vecs0: SUCCESS (3.892s)
[633.264251] Starting dynamic subtest: ccs0
[637.191250] Dynamic subtest ccs0: SUCCESS (3.937s)
[637.193626] Subtest pi: SUCCESS (23.682s)
[637.269420] [122/130] (386s left) gem_pwrite (basic-self)
[637.383013] Subtest basic-self: SKIP (0.000s)
[637.452799] [123/130] (385s left) kms_rotation_crc (primary-rotation-180)
[637.544942] Starting subtest: primary-rotation-180
[644.423656] Subtest primary-rotation-180: SUCCESS (6.877s)
[645.634961] [124/130] (377s left) gem_exec_whisper (basic-queues)
[645.704313] Starting subtest: basic-queues
[651.511308] Subtest basic-queues: SUCCESS (5.804s)
[651.692231] [125/130] (371s left) kms_flip (flip-vs-expired-vblank)
[651.797727] Starting subtest: flip-vs-expired-vblank
[651.799973] Starting dynamic subtest: A-eDP1
[660.549743] Dynamic subtest A-eDP1: SUCCESS (8.749s)
[660.559628] Starting dynamic subtest: B-eDP1
[669.183532] Dynamic subtest B-eDP1: SUCCESS (8.631s)
[669.194266] Starting dynamic subtest: C-eDP1
[677.804727] Dynamic subtest C-eDP1: SUCCESS (8.618s)
[677.814657] Starting dynamic subtest: D-eDP1
[686.428464] Dynamic subtest D-eDP1: SUCCESS (8.620s)
[686.433679] Subtest flip-vs-expired-vblank: SUCCESS (34.629s)
[687.602241] [126/130] (335s left) gem_eio (wait-wedge-immediate)
[687.831495] Starting subtest: wait-wedge-immediate
[689.634127] Subtest wait-wedge-immediate: SUCCESS (1.801s)
[689.779848] [127/130] (333s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[689.866531] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[689.869123] Starting dynamic subtest: pipe-A-eDP-1
[689.893535] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[689.906643] Starting dynamic subtest: pipe-B-eDP-1
[689.928949] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[689.938823] Starting dynamic subtest: pipe-C-eDP-1
[689.960408] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[689.970714] Starting dynamic subtest: pipe-D-eDP-1
[689.992767] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[689.996875] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[692.086345] [128/130] (331s left) kms_psr (pr-no-drrs)
[692.193077] Starting subtest: pr-no-drrs
[692.197456] Subtest pr-no-drrs: SKIP (0.000s)
[692.261677] [129/130] (331s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[692.374511] Starting subtest: y-tiled-8bpp-rotate-90
[692.378789] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[692.481394] [130/130] (331s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[692.588220] Starting subtest: fbcpsr-rgb565-draw-pwrite
[699.498099] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (6.912s)
[699.603464] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_params
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: gem_spin_batch
results: parsing output: 3/ for test: perf
results: parsing output: 4/ for test: i915_pm_rps
results: parsing output: 5/ for test: tools_test
results: parsing output: 6/ for test: gem_mmap_gtt
results: parsing output: 7/ for test: kms_invalid_mode
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: gem_exec_reloc
results: parsing output: 11/ for test: gem_userptr_blits
results: parsing output: 12/ for test: kms_pm_rpm
results: parsing output: 13/ for test: gem_exec_schedule
results: parsing output: 14/ for test: kms_psr2_sf
results: parsing output: 15/ for test: gem_exec_params
results: parsing output: 16/ for test: kms_flip
results: parsing output: 17/ for test: prime_self_import
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_wait
results: parsing output: 20/ for test: kms_addfb_basic
results: parsing output: 21/ for test: kms_psr
results: parsing output: 22/ for test: device_reset
results: parsing output: 23/ for test: kms_ccs
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: kms_lease
results: parsing output: 26/ for test: gem_ctx_isolation
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: syncobj_wait
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: gem_ctx_persistence
results: parsing output: 32/ for test: gem_exec_schedule
results: parsing output: 33/ for test: kms_cursor_edge_walk
results: parsing output: 34/ for test: gem_mmap_gtt
results: parsing output: 35/ for test: api_intel_bb
results: parsing output: 36/ for test: kms_chamelium_color
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_flip
results: parsing output: 39/ for test: kms_flip_scaled_crc
results: parsing output: 40/ for test: kms_cursor_crc
results: parsing output: 41/ for test: kms_cursor_legacy
results: parsing output: 42/ for test: kms_cursor_legacy
results: parsing output: 43/ for test: kms_dp_link_training
results: parsing output: 44/ for test: gem_exec_params
results: parsing output: 45/ for test: gem_exec_params
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: fbdev
results: parsing output: 48/ for test: core_auth
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: i915_hangman
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_plane_scaling
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: perf_pmu
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_async_flips
results: parsing output: 57/ for test: gem_close_race
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_cursor_crc
results: parsing output: 60/ for test: kms_lease
results: parsing output: 61/ for test: gem_softpin
results: parsing output: 62/ for test: kms_vrr
results: parsing output: 63/ for test: kms_plane_scaling
results: parsing output: 64/ for test: kms_atomic_transition
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_ctx_persistence
results: parsing output: 68/ for test: kms_dsc
results: parsing output: 69/ for test: gem_softpin
results: parsing output: 70/ for test: gem_lmem_swapping
results: parsing output: 71/ for test: gem_exec_reloc
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: kms_psr2_sf
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_pm_rpm
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: perf
results: parsing output: 80/ for test: kms_psr
results: parsing output: 81/ for test: gen9_exec_parse
results: parsing output: 82/ for test: gem_mmap_offset
results: parsing output: 83/ for test: kms_atomic_transition
results: parsing output: 84/ for test: gem_exec_schedule
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: i915_selftest
results: parsing output: 87/ for test: kms_psr
results: parsing output: 88/ for test: kms_sequence
results: parsing output: 89/ for test: kms_flip
results: parsing output: 90/ for test: gem_workarounds
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: prime_busy
results: parsing output: 93/ for test: gem_sync
results: parsing output: 94/ for test: gem_exec_balancer
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_mmap_gtt
results: parsing output: 97/ for test: kms_flip
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_cursor_legacy
results: parsing output: 101/ for test: gem_render_copy
results: parsing output: 102/ for test: gem_softpin
results: parsing output: 103/ for test: gem_ctx_param
results: parsing output: 104/ for test: kms_psr
results: parsing output: 105/ for test: kms_color
results: parsing output: 106/ for test: i915_drm_fdinfo
results: parsing output: 107/ for test: gem_tiled_fence_blits
results: parsing output: 108/ for test: syncobj_timeline
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: api_intel_allocator
results: parsing output: 112/ for test: kms_chamelium_hpd
results: parsing output: 113/ for test: kms_content_protection
results: parsing output: 114/ for test: kms_plane_lowres
results: parsing output: 115/ for test: gem_exec_params
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: gem_exec_balancer
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: gem_exec_capture
results: parsing output: 121/ for test: gem_pwrite
results: parsing output: 122/ for test: kms_rotation_crc
results: parsing output: 123/ for test: gem_exec_whisper
results: parsing output: 124/ for test: kms_flip
results: parsing output: 125/ for test: gem_eio
results: parsing output: 126/ for test: kms_ccs
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: kms_frontbuffer_tracking
Done.