[56.542953] Initializing watchdogs
[56.543017]   /dev/watchdog0
[56.556812] [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]
[56.561010] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.563131] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.566237] [001/130] (960s left) gem_exec_params (invalid-ring)
[56.643667] Starting subtest: invalid-ring
[56.646308] Subtest invalid-ring: SUCCESS (0.000s)
[56.736635] [002/130] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu)
[56.838881] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu
[63.643495] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (6.842s)
[63.788844] [003/130] (953s left) gem_spin_batch (legacy)
[63.854477] Starting subtest: legacy
[63.856822] Starting dynamic subtest: default
[67.090600] Dynamic subtest default: SUCCESS (3.239s)
[67.100529] Starting dynamic subtest: render
[70.319914] Dynamic subtest render: SUCCESS (3.235s)
[70.329020] Starting dynamic subtest: bsd
[73.543369] Dynamic subtest bsd: SUCCESS (3.225s)
[73.552218] Starting dynamic subtest: bsd1
[76.774735] Dynamic subtest bsd1: SUCCESS (3.232s)
[76.784156] Starting dynamic subtest: bsd2
[80.005466] Dynamic subtest bsd2: SUCCESS (3.232s)
[80.014764] Starting dynamic subtest: blt
[83.237207] Dynamic subtest blt: SUCCESS (3.232s)
[83.246644] Starting dynamic subtest: vebox
[86.469794] Dynamic subtest vebox: SUCCESS (3.232s)
[86.471976] Subtest legacy: SUCCESS (22.633s)
[86.962005] [004/130] (930s left) perf (gen12-group-exclusive-stream-ctx-handle)
[87.067796] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[87.088209] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.024s)
[87.124373] [005/130] (930s left) i915_pm_rps (thresholds-idle)
[88.895299] Starting subtest: thresholds-idle
[88.899675] Subtest thresholds-idle: SKIP (0.000s)
[88.965894] [006/130] (928s left) tools_test (tools_test)
[89.012759] Starting subtest: tools_test
[89.065027] Subtest tools_test: SUCCESS (0.071s)
[89.125350] [007/130] (928s left) gem_mmap_gtt (medium-copy-xy)
[89.179093] Subtest medium-copy-XY: SKIP (0.000s)
[89.234023] [008/130] (928s left) kms_invalid_mode (int-max-clock)
[89.337673] Starting subtest: int-max-clock
[89.340103] Starting dynamic subtest: pipe-A-eDP-1
[89.621068] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[89.629633] Starting dynamic subtest: pipe-B-eDP-1
[89.631833] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[89.638678] Starting dynamic subtest: pipe-C-eDP-1
[89.640890] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[89.647771] Starting dynamic subtest: pipe-D-eDP-1
[89.649694] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[89.651599] Subtest int-max-clock: SUCCESS (0.288s)
[90.477361] [009/130] (926s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[90.584526] Starting subtest: yf-tiled-64bpp-rotate-0
[90.589047] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[90.683122] [010/130] (926s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[90.743167] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[90.848240] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.103s)
[90.920989] [011/130] (926s left) gem_exec_reloc (basic-range)
[90.987759] Subtest basic-range: SKIP (0.000s)
[91.068362] [012/130] (926s left) gem_userptr_blits (forbidden-operations)
[91.133689] Starting subtest: forbidden-operations
[91.138157] Subtest forbidden-operations: SKIP (0.000s)
[91.246056] [013/130] (926s left) kms_pm_rpm (pm-caching)
[93.003749] Starting subtest: pm-caching
[93.013599] Subtest pm-caching: SKIP (0.000s)
[93.513788] [014/130] (924s left) gem_exec_schedule (u-submit-golden-slice)
[93.592067] Starting subtest: u-submit-golden-slice
[93.594395] Starting dynamic subtest: rcs0
[93.619374] Dynamic subtest rcs0: SUCCESS (0.034s)
[93.629524] Starting dynamic subtest: bcs0
[93.645307] Dynamic subtest bcs0: SUCCESS (0.026s)
[93.654905] Starting dynamic subtest: vcs0
[93.673261] Dynamic subtest vcs0: SUCCESS (0.028s)
[93.680594] Starting dynamic subtest: vcs1
[93.703438] Dynamic subtest vcs1: SUCCESS (0.030s)
[93.711310] Starting dynamic subtest: vecs0
[93.729220] Dynamic subtest vecs0: SUCCESS (0.026s)
[93.736361] Starting dynamic subtest: ccs0
[93.757110] Dynamic subtest ccs0: SUCCESS (0.027s)
[93.759345] Subtest u-submit-golden-slice: SUCCESS (0.172s)
[95.049184] [015/130] (922s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[100.075861] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[100.080470] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.002s)
[100.911909] [016/130] (916s left) gem_exec_params (dr4-dirt)
[100.973692] Starting subtest: DR4-dirt
[100.975866] Subtest DR4-dirt: SUCCESS (0.000s)
[101.088562] [017/130] (916s left) kms_flip (flip-vs-rmfb)
[101.183383] Starting subtest: flip-vs-rmfb
[101.185817] Starting dynamic subtest: A-eDP1
[109.825689] Dynamic subtest A-eDP1: SUCCESS (8.643s)
[109.834160] Starting dynamic subtest: B-eDP1
[118.451997] Dynamic subtest B-eDP1: SUCCESS (8.626s)
[118.459413] Starting dynamic subtest: C-eDP1
[127.069264] Dynamic subtest C-eDP1: SUCCESS (8.616s)
[127.078102] Starting dynamic subtest: D-eDP1
[135.709061] Dynamic subtest D-eDP1: SUCCESS (8.639s)
[135.713179] Subtest flip-vs-rmfb: SUCCESS (34.530s)
[136.881675] [018/130] (880s left) prime_self_import (basic-with_one_bo_two_files)
[136.928085] Starting subtest: basic-with_one_bo_two_files
[136.948415] Subtest basic-with_one_bo_two_files: SUCCESS (0.021s)
[137.055933] [019/130] (880s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[137.154555] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[141.650998] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.501s)
[142.794499] [020/130] (874s left) gem_wait (busy)
[142.862553] Starting subtest: busy
[142.864763] Starting dynamic subtest: all-engines
[144.915473] Dynamic subtest all-engines: SUCCESS (2.051s)
[144.925352] Starting dynamic subtest: rcs0
[145.458507] Dynamic subtest rcs0: SUCCESS (0.542s)
[145.468612] Starting dynamic subtest: bcs0
[145.998180] Dynamic subtest bcs0: SUCCESS (0.539s)
[146.008189] Starting dynamic subtest: vcs0
[147.924098] Dynamic subtest vcs0: SUCCESS (1.924s)
[147.935291] Starting dynamic subtest: vcs1
[149.906875] Dynamic subtest vcs1: SUCCESS (1.980s)
[149.916905] Starting dynamic subtest: vecs0
[151.891296] Dynamic subtest vecs0: SUCCESS (1.982s)
[151.901475] Starting dynamic subtest: ccs0
[152.432712] Dynamic subtest ccs0: SUCCESS (0.540s)
[152.435491] Subtest busy: SUCCESS (9.570s)
[152.630665] [021/130] (865s left) kms_addfb_basic (bad-pitch-128)
[152.686906] Starting subtest: bad-pitch-128
[152.689291] Subtest bad-pitch-128: SUCCESS (0.000s)
[152.844058] [022/130] (864s left) kms_psr (fbc-psr-sprite-plane-onoff)
[152.947241] Starting subtest: fbc-psr-sprite-plane-onoff
[152.949404] Starting dynamic subtest: eDP-1
[152.953354] Dynamic subtest eDP-1: SKIP (0.000s)
[152.957294] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[153.015727] [023/130] (864s left) device_reset (unbind-reset-rebind)
[153.058606] Starting subtest: unbind-reset-rebind
[156.117625] Subtest unbind-reset-rebind: SUCCESS (3.053s)
[156.155690] [024/130] (861s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[156.248106] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[156.250368] Starting dynamic subtest: pipe-A-eDP-1
[156.309445] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[156.319128] Starting dynamic subtest: pipe-B-eDP-1
[156.376901] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[156.386873] Starting dynamic subtest: pipe-C-eDP-1
[156.445728] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[156.453229] Starting dynamic subtest: pipe-D-eDP-1
[156.519867] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[156.524023] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.008s)
[158.431974] [025/130] (859s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[158.494756] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[158.496730] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[158.602213] [026/130] (859s left) kms_lease (lease-again)
[158.683080] Starting subtest: lease-again
[158.685368] Starting dynamic subtest: pipe-A-eDP-1
[158.687659] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.003s)
[158.696222] Starting dynamic subtest: pipe-B-eDP-1
[158.698033] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[158.705222] Starting dynamic subtest: pipe-C-eDP-1
[158.707099] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[158.714094] Starting dynamic subtest: pipe-D-eDP-1
[158.715966] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[158.717805] Subtest lease-again: SUCCESS (0.012s)
[158.812958] [027/130] (859s left) gem_ctx_isolation (preservation-s3)
[158.866074] Starting subtest: preservation-S3
[158.868455] Starting dynamic subtest: rcs0
[174.728783] Dynamic subtest rcs0: SUCCESS (1.391s)
[174.738411] Starting dynamic subtest: bcs0
[190.656559] Dynamic subtest bcs0: SUCCESS (1.247s)
[190.665939] Starting dynamic subtest: vcs0
[206.663502] Dynamic subtest vcs0: SUCCESS (2.368s)
[206.673753] Starting dynamic subtest: vcs1
[223.682843] Dynamic subtest vcs1: SUCCESS (4.089s)
[223.691616] Starting dynamic subtest: vecs0
[241.735085] Dynamic subtest vecs0: SUCCESS (5.094s)
[241.744952] Starting dynamic subtest: ccs0
[259.657529] Dynamic subtest ccs0: SUCCESS (3.069s)
[259.659861] Subtest preservation-S3: SUCCESS (17.264s)
[259.912414] [028/130] (758s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[260.021690] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[263.609089] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.614s)
[264.717722] [029/130] (753s left) syncobj_timeline (wait-for-submit-delayed-submit)
[264.776931] Starting subtest: wait-for-submit-delayed-submit
[264.879127] Subtest wait-for-submit-delayed-submit: SUCCESS (0.104s)
[264.949449] [030/130] (753s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[264.998828] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[265.105367] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.108s)
[265.177524] [031/130] (752s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[265.288615] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[265.887779] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.603s)
[266.096744] [032/130] (752s left) gem_ctx_persistence (legacy-engines-persistence)
[266.156197] Starting subtest: legacy-engines-persistence
[266.158847] Starting dynamic subtest: render
[266.975705] Dynamic subtest render: SUCCESS (0.821s)
[266.991335] Starting dynamic subtest: bsd1
[267.749407] Dynamic subtest bsd1: SUCCESS (0.773s)
[267.763501] Starting dynamic subtest: bsd2
[268.520677] Dynamic subtest bsd2: SUCCESS (0.770s)
[268.532647] Starting dynamic subtest: blt
[269.290402] Dynamic subtest blt: SUCCESS (0.770s)
[269.301491] Starting dynamic subtest: vebox
[270.120977] Dynamic subtest vebox: SUCCESS (0.831s)
[270.123402] Subtest legacy-engines-persistence: SUCCESS (3.978s)
[270.203955] [033/130] (748s left) gem_exec_schedule (preempt-other-chain)
[270.266302] Starting subtest: preempt-other-chain
[270.268501] Starting dynamic subtest: rcs0
[270.399488] Dynamic subtest rcs0: SUCCESS (0.136s)
[270.407487] Starting dynamic subtest: bcs0
[270.533659] Dynamic subtest bcs0: SUCCESS (0.134s)
[270.546934] Starting dynamic subtest: vcs0
[270.662367] Dynamic subtest vcs0: SUCCESS (0.128s)
[270.674932] Starting dynamic subtest: vcs1
[270.786805] Dynamic subtest vcs1: SUCCESS (0.123s)
[270.798592] Starting dynamic subtest: vecs0
[270.915791] Dynamic subtest vecs0: SUCCESS (0.129s)
[270.928100] Starting dynamic subtest: ccs0
[271.041687] Dynamic subtest ccs0: SUCCESS (0.125s)
[271.043783] Subtest preempt-other-chain: SUCCESS (0.779s)
[271.617700] [034/130] (746s left) kms_cursor_edge_walk (256x256-top-edge)
[271.716558] Starting subtest: 256x256-top-edge
[271.718889] Starting dynamic subtest: pipe-A-eDP-1
[275.153091] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.439s)
[275.163151] Starting dynamic subtest: pipe-D-eDP-1
[278.261443] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.112s)
[278.263655] Subtest 256x256-top-edge: SUCCESS (6.554s)
[279.078509] [035/130] (739s left) gem_mmap_gtt (medium-copy)
[279.135701] Subtest medium-copy: SKIP (0.000s)
[279.202386] [036/130] (739s left) api_intel_bb (blit-noreloc-purge-cache)
[279.263924] Starting subtest: blit-noreloc-purge-cache
[279.272734] Subtest blit-noreloc-purge-cache: SUCCESS (0.010s)
[279.402118] [037/130] (738s left) kms_chamelium_color (gamma)
[279.494289] Subtest gamma: SKIP (0.000s)
[279.537641] [038/130] (738s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[279.649929] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[279.654467] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[279.768644] [039/130] (738s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[279.865943] Starting subtest: blocking-absolute-wf_vblank-interruptible
[279.868169] Starting dynamic subtest: A-eDP1
[288.527717] Dynamic subtest A-eDP1: SUCCESS (8.668s)
[288.536488] Starting dynamic subtest: B-eDP1
[297.261551] Dynamic subtest B-eDP1: SUCCESS (8.728s)
[297.271444] Starting dynamic subtest: C-eDP1
[305.991067] Dynamic subtest C-eDP1: SUCCESS (8.720s)
[306.003047] Starting dynamic subtest: D-eDP1
[314.719454] Dynamic subtest D-eDP1: SUCCESS (8.726s)
[314.721809] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.851s)
[315.927369] [040/130] (702s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[316.026998] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[316.029404] Starting dynamic subtest: pipe-A-default-mode
[318.762622] Dynamic subtest pipe-A-default-mode: SUCCESS (2.736s)
[318.765007] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.738s)
[319.616159] [041/130] (698s left) kms_cursor_crc (cursor-onscreen-128x128)
[319.817065] Starting subtest: cursor-onscreen-128x128
[319.822057] Starting dynamic subtest: pipe-A-eDP-1
[321.911542] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.090s)
[321.938010] Starting dynamic subtest: pipe-D-eDP-1
[324.688375] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.760s)
[324.690982] Subtest cursor-onscreen-128x128: SUCCESS (4.871s)
[325.486098] [042/130] (693s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[325.606883] Starting subtest: cursorB-vs-flipB-varying-size
[325.611214] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[325.758368] [043/130] (692s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[325.872089] Starting subtest: cursorB-vs-flipB-toggle
[325.876679] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[326.014696] [044/130] (692s left) kms_dp_link_training (non-uhbr-mst)
[326.111140] Starting subtest: non-uhbr-mst
[326.119905] Subtest non-uhbr-mst: SKIP (0.000s)
[326.182989] [045/130] (692s left) gem_exec_params (secure-non-master)
[326.240305] Starting subtest: secure-non-master
[326.244909] Subtest secure-non-master: SKIP (0.000s)
[326.333225] [046/130] (692s left) gem_exec_params (rel-constants-invalid-ring)
[326.388254] Starting subtest: rel-constants-invalid-ring
[326.390495] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[326.486732] [047/130] (692s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[326.572022] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[326.573992] Starting dynamic subtest: pipe-A-eDP-1
[326.594831] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[326.604598] Starting dynamic subtest: pipe-B-eDP-1
[326.624203] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[326.632097] Starting dynamic subtest: pipe-C-eDP-1
[326.651158] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[326.659194] Starting dynamic subtest: pipe-D-eDP-1
[326.678009] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[326.681176] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[328.759951] [048/130] (690s left) fbdev (unaligned-read)
[328.800152] Starting subtest: unaligned-read
[328.820001] Subtest unaligned-read: SUCCESS (0.020s)
[328.877079] [049/130] (689s left) core_auth (many-magics)
[328.935839] Starting subtest: many-magics
[329.819300] Subtest many-magics: SUCCESS (0.887s)
[330.003478] [050/130] (688s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[330.101273] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[330.105704] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[330.194777] [051/130] (688s left) i915_hangman (gt-engine-hang)
[330.261074] Starting subtest: gt-engine-hang
[330.263658] Starting dynamic subtest: rcs0
[331.444726] Dynamic subtest rcs0: SUCCESS (1.186s)
[331.457109] Starting dynamic subtest: bcs0
[333.494539] Dynamic subtest bcs0: SUCCESS (2.048s)
[333.510372] Starting dynamic subtest: vcs0
[335.476977] Dynamic subtest vcs0: SUCCESS (1.981s)
[335.488959] Starting dynamic subtest: vcs1
[337.460364] Dynamic subtest vcs1: SUCCESS (1.982s)
[337.472262] Starting dynamic subtest: vecs0
[339.445076] Dynamic subtest vecs0: SUCCESS (1.983s)
[339.456804] Starting dynamic subtest: ccs0
[341.492700] Dynamic subtest ccs0: SUCCESS (2.046s)
[341.495662] Subtest gt-engine-hang: SUCCESS (11.236s)
[341.572692] [052/130] (677s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[341.677073] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[341.680984] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[341.760606] [053/130] (677s left) kms_plane_scaling (intel-max-src-size)
[341.853592] Starting subtest: intel-max-src-size
[341.860166] Subtest intel-max-src-size: SKIP (0.000s)
[341.958700] [054/130] (677s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-wc)
[342.061244] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-wc
[346.048373] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-wc: SUCCESS (3.992s)
[347.168907] [055/130] (671s left) perf_pmu (multi-client)
[347.209589] Starting subtest: multi-client
[347.211835] Starting dynamic subtest: rcs0
[348.296762] Dynamic subtest rcs0: SUCCESS (1.087s)
[348.308164] Starting dynamic subtest: bcs0
[349.346853] Dynamic subtest bcs0: SUCCESS (1.048s)
[349.358214] Starting dynamic subtest: vcs0
[350.397823] Dynamic subtest vcs0: SUCCESS (1.049s)
[350.409227] Starting dynamic subtest: vcs1
[351.515378] Dynamic subtest vcs1: SUCCESS (1.099s)
[351.524108] Starting dynamic subtest: vecs0
[353.487714] Dynamic subtest vecs0: SUCCESS (1.986s)
[353.498577] Starting dynamic subtest: ccs0
[355.534117] Dynamic subtest ccs0: SUCCESS (2.046s)
[355.536960] Subtest multi-client: SUCCESS (8.327s)
[355.663784] [056/130] (663s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[355.774453] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[355.778577] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[355.894907] [057/130] (663s left) kms_async_flips (crc-atomic)
[355.992472] Starting subtest: crc-atomic
[356.361750] Starting dynamic subtest: pipe-A-eDP-1
[359.272152] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.909s)
[359.658247] Starting dynamic subtest: pipe-B-eDP-1
[362.604641] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.954s)
[362.977994] Starting dynamic subtest: pipe-C-eDP-1
[365.901969] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.933s)
[366.263033] Starting dynamic subtest: pipe-D-eDP-1
[369.118211] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.864s)
[369.120542] Subtest crc-atomic: SUCCESS (13.124s)
[370.286571] [058/130] (648s left) gem_close_race (multigpu-basic-process)
[370.362238] Starting subtest: multigpu-basic-process
[370.366769] Subtest multigpu-basic-process: SKIP (0.000s)
[370.592346] [059/130] (648s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[370.690933] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[370.694948] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[370.803390] [060/130] (648s left) kms_cursor_crc (cursor-random-max-size)
[371.085895] Starting subtest: cursor-random-max-size
[371.092695] Subtest cursor-random-max-size: SKIP (0.000s)
[371.221991] [061/130] (648s left) kms_lease (simple-lease)
[371.308461] Starting subtest: simple-lease
[371.310654] Starting dynamic subtest: pipe-A-eDP-1
[371.809695] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.500s)
[371.819278] Starting dynamic subtest: pipe-B-eDP-1
[373.209213] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.397s)
[373.219304] Starting dynamic subtest: pipe-C-eDP-1
[374.616172] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.403s)
[374.625743] Starting dynamic subtest: pipe-D-eDP-1
[376.026184] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.408s)
[376.028508] Subtest simple-lease: SUCCESS (4.714s)
[376.821497] [062/130] (642s left) gem_softpin (overlap)
[376.884933] Starting subtest: overlap
[377.728524] Subtest overlap: SUCCESS (0.842s)
[377.862786] [063/130] (641s left) kms_vrr (flip-basic)
[377.957570] Starting subtest: flip-basic
[377.964216] Subtest flip-basic: SKIP (0.000s)
[378.028037] [064/130] (641s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[378.122431] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[378.124757] Starting dynamic subtest: pipe-A
[378.460104] Dynamic subtest pipe-A: SUCCESS (0.337s)
[378.470156] Starting dynamic subtest: pipe-B
[379.817293] Dynamic subtest pipe-B: SUCCESS (1.357s)
[379.827415] Starting dynamic subtest: pipe-C
[381.243500] Dynamic subtest pipe-C: SUCCESS (1.424s)
[381.253369] Starting dynamic subtest: pipe-D
[382.678430] Dynamic subtest pipe-D: SUCCESS (1.433s)
[382.680781] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.556s)
[383.852124] [065/130] (635s left) kms_atomic_transition (plane-all-transition-fencing)
[383.955113] Starting subtest: plane-all-transition-fencing
[383.957393] Starting dynamic subtest: pipe-A-eDP-1
[386.457519] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.502s)
[386.768109] Starting dynamic subtest: pipe-B-eDP-1
[389.986530] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.228s)
[390.285641] Subtest plane-all-transition-fencing: SUCCESS (6.329s)
[391.106415] [066/130] (628s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[391.218508] Starting subtest: y-tiled-64bpp-rotate-90
[391.222980] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[391.338593] [067/130] (628s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[391.449241] Starting subtest: fbcpsr-rgb565-draw-blt
[398.394744] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (6.949s)
[398.538285] [068/130] (621s left) gem_ctx_persistence (engines-mixed-process)
[398.609808] Starting subtest: engines-mixed-process
[398.612248] Starting dynamic subtest: rcs0
[400.491242] Dynamic subtest rcs0: SUCCESS (1.881s)
[400.502176] Starting dynamic subtest: bcs0
[402.528494] Dynamic subtest bcs0: SUCCESS (2.036s)
[402.538157] Starting dynamic subtest: vcs0
[404.520155] Dynamic subtest vcs0: SUCCESS (1.990s)
[404.531927] Starting dynamic subtest: vcs1
[406.515774] Dynamic subtest vcs1: SUCCESS (1.994s)
[406.527402] Starting dynamic subtest: vecs0
[408.489079] Dynamic subtest vecs0: SUCCESS (1.971s)
[408.499642] Starting dynamic subtest: ccs0
[410.536641] Dynamic subtest ccs0: SUCCESS (2.046s)
[410.538873] Subtest engines-mixed-process: SUCCESS (11.928s)
[410.618118] [069/130] (609s left) kms_dsc (dsc-with-output-formats-with-bpc)
[410.720183] Starting subtest: dsc-with-output-formats-with-bpc
[410.778706] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[410.820789] [070/130] (608s left) gem_softpin (invalid)
[410.875806] Starting subtest: invalid
[410.883143] Subtest invalid: SUCCESS (0.007s)
[411.021905] [071/130] (608s left) gem_lmem_swapping (random-engines)
[411.060508] Subtest random-engines: SKIP (0.000s)
[411.096461] [072/130] (608s left) gem_exec_reloc (basic-cpu-wc-active)
[411.152038] Subtest basic-cpu-wc-active: SKIP (0.000s)
[411.237312] [073/130] (608s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[411.340396] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[415.578305] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.243s)
[416.717561] [074/130] (603s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[416.819627] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[416.821934] Starting dynamic subtest: pipe-A-eDP-1
[416.845070] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[416.857004] Starting dynamic subtest: pipe-B-eDP-1
[416.879182] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[416.888184] Starting dynamic subtest: pipe-C-eDP-1
[416.909637] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[416.918503] Starting dynamic subtest: pipe-D-eDP-1
[416.940265] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[416.944657] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[419.060930] [075/130] (600s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[424.047886] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[424.050070] Starting dynamic subtest: pipe-A-eDP-1
[436.086091] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.036s)
[436.098053] Starting dynamic subtest: pipe-B-eDP-1
[448.123784] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.038s)
[448.126083] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (24.078s)
[448.958603] [076/130] (570s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[449.061027] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[449.065496] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[449.154889] [077/130] (570s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[449.250139] Starting subtest: psr-rgb101010-draw-render
[456.402156] Subtest psr-rgb101010-draw-render: SUCCESS (7.157s)
[456.545315] [078/130] (563s left) kms_pm_rpm (cursor-dpms)
[458.666532] Starting subtest: cursor-dpms
[458.671758] Subtest cursor-dpms: SKIP (0.000s)
[459.026643] [079/130] (560s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[459.131644] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[465.755793] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.629s)
[465.886839] [080/130] (554s left) perf (sysctl-defaults)
[465.947287] Starting subtest: sysctl-defaults
[465.949560] Subtest sysctl-defaults: SUCCESS (0.000s)
[466.032057] [081/130] (554s left) kms_psr (fbc-psr2-cursor-plane-move)
[466.131678] Starting subtest: fbc-psr2-cursor-plane-move
[466.133902] Starting dynamic subtest: eDP-1
[466.138363] Dynamic subtest eDP-1: SKIP (0.000s)
[466.142849] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[466.203865] [082/130] (553s left) gen9_exec_parse (secure-batches)
[466.262862] Subtest secure-batches: SKIP (0.000s)
[466.329901] [083/130] (553s left) gem_mmap_offset (clear-via-pagefault)
[466.383776] Starting subtest: clear-via-pagefault
[466.385953] Starting dynamic subtest: smem0
[499.315716] Dynamic subtest smem0: SUCCESS (32.928s)
[499.318068] Subtest clear-via-pagefault: SUCCESS (32.929s)
[499.425145] [084/130] (520s left) kms_atomic_transition (modeset-transition-fencing)
[499.524841] Starting subtest: modeset-transition-fencing
[499.527349] Starting dynamic subtest: 1x-outputs
[510.133428] Dynamic subtest 1x-outputs: SUCCESS (10.607s)
[510.405017] Subtest modeset-transition-fencing: SUCCESS (10.880s)
[511.258772] [085/130] (508s left) gem_exec_schedule (in-order)
[511.330113] Starting subtest: in-order
[511.332042] Starting dynamic subtest: rcs0
[511.429081] Dynamic subtest rcs0: SUCCESS (0.107s)
[511.441375] Starting dynamic subtest: vcs0
[511.504690] Dynamic subtest vcs0: SUCCESS (0.076s)
[511.516214] Starting dynamic subtest: vcs1
[511.586596] Dynamic subtest vcs1: SUCCESS (0.081s)
[511.595669] Starting dynamic subtest: vecs0
[511.665837] Dynamic subtest vecs0: SUCCESS (0.078s)
[511.678192] Starting dynamic subtest: ccs0
[511.757675] Dynamic subtest ccs0: SUCCESS (0.091s)
[511.760039] Subtest in-order: SUCCESS (0.437s)
[513.601580] [086/130] (506s left) kms_psr (fbc-pr-dpms)
[513.690561] Starting subtest: fbc-pr-dpms
[513.694569] Subtest fbc-pr-dpms: SKIP (0.000s)
[513.759492] [087/130] (506s left) i915_selftest (perf)
[515.777559] Starting subtest: perf
[515.780099] Starting dynamic subtest: engine_cs
[520.200190] Dynamic subtest engine_cs: SUCCESS (4.422s)
[520.209260] Starting dynamic subtest: request
[527.538033] Dynamic subtest request: SUCCESS (7.335s)
[527.547380] Starting dynamic subtest: migrate
[531.961951] Dynamic subtest migrate: SUCCESS (4.422s)
[531.971581] Starting dynamic subtest: region
[537.901388] Dynamic subtest region: SUCCESS (5.937s)
[537.903745] Subtest perf: SUCCESS (22.123s)
[537.933865] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[537.937085] [088/130] (482s left) kms_psr (psr-primary-blt)
[539.398340] Starting subtest: psr-primary-blt
[539.400741] Starting dynamic subtest: eDP-1
[541.129501] Dynamic subtest eDP-1: SUCCESS (1.732s)
[541.131687] Subtest psr-primary-blt: SUCCESS (1.733s)
[542.006578] [FACT kms_psr (psr-primary-blt)] new: kernel.kmod_is_loaded.i915: true
[542.010200] [089/130] (478s left) kms_sequence (get-idle)
[542.110463] Starting subtest: get-idle
[542.112817] Starting dynamic subtest: pipe-A-eDP-1
[543.924033] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.811s)
[543.935617] Starting dynamic subtest: pipe-B-eDP-1
[546.365368] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.441s)
[546.376038] Starting dynamic subtest: pipe-C-eDP-1
[548.774671] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.406s)
[548.782708] Starting dynamic subtest: pipe-D-eDP-1
[551.203117] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.430s)
[551.205367] Subtest get-idle: SUCCESS (9.092s)
[552.016483] [090/130] (468s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[552.111355] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[552.113624] Starting dynamic subtest: A-eDP1
[555.635490] Dynamic subtest A-eDP1: SUCCESS (3.523s)
[555.643820] Starting dynamic subtest: B-eDP1
[558.841358] Dynamic subtest B-eDP1: SUCCESS (3.205s)
[558.850670] Starting dynamic subtest: C-eDP1
[561.955570] Dynamic subtest C-eDP1: SUCCESS (3.114s)
[561.965051] Starting dynamic subtest: D-eDP1
[565.046236] Dynamic subtest D-eDP1: SUCCESS (3.089s)
[565.048723] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.937s)
[565.866831] [091/130] (454s left) gem_workarounds (basic-read-fd)
[565.939743] Starting subtest: basic-read-fd
[565.952466] Subtest basic-read-fd: SUCCESS (0.012s)
[566.078424] [092/130] (454s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[566.175689] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[573.441236] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.267s)
[573.572576] [093/130] (446s left) prime_busy (after-wait)
[573.631362] Starting subtest: after-wait
[573.636504] Starting dynamic subtest: rcs0
[573.677785] Dynamic subtest rcs0: SUCCESS (0.044s)
[573.687737] Starting dynamic subtest: bcs0
[573.755611] Dynamic subtest bcs0: SUCCESS (0.077s)
[573.763767] Starting dynamic subtest: vcs0
[573.793996] Dynamic subtest vcs0: SUCCESS (0.037s)
[573.801887] Starting dynamic subtest: vcs1
[573.832009] Dynamic subtest vcs1: SUCCESS (0.038s)
[573.839907] Starting dynamic subtest: vecs0
[573.870850] Dynamic subtest vecs0: SUCCESS (0.038s)
[573.878956] Starting dynamic subtest: ccs0
[573.909892] Dynamic subtest ccs0: SUCCESS (0.039s)
[574.018367] Subtest after-wait: SUCCESS (0.385s)
[574.088875] [094/130] (446s left) gem_sync (basic-store-all)
[574.170037] Starting subtest: basic-store-all
[577.349886] Subtest basic-store-all: SUCCESS (3.193s)
[577.532701] [095/130] (443s left) gem_exec_balancer (bonded-true-hang)
[577.796157] Starting subtest: bonded-true-hang
[577.801529] Subtest bonded-true-hang: SKIP (0.000s)
[577.892475] [096/130] (442s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[577.996040] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[582.257425] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.267s)
[583.398166] [097/130] (437s left) gem_mmap_gtt (bad-object)
[583.459105] Subtest bad-object: SKIP (0.000s)
[583.517793] [098/130] (437s left) kms_flip (flip-vs-wf_vblank-interruptible)
[583.612443] Starting subtest: flip-vs-wf_vblank-interruptible
[583.614768] Starting dynamic subtest: A-eDP1
[585.537446] Dynamic subtest A-eDP1: SUCCESS (1.925s)
[585.548452] Starting dynamic subtest: B-eDP1
[587.471672] Dynamic subtest B-eDP1: SUCCESS (1.932s)
[587.483016] Starting dynamic subtest: C-eDP1
[589.391341] Dynamic subtest C-eDP1: SUCCESS (1.918s)
[589.400556] Starting dynamic subtest: D-eDP1
[591.322576] Dynamic subtest D-eDP1: SUCCESS (1.931s)
[591.324916] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.714s)
[592.545106] [099/130] (428s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[592.654870] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[592.658867] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[592.763252] [100/130] (428s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[592.870399] Starting subtest: x-tiled-16bpp-rotate-270
[592.890871] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s)
[593.036815] [101/130] (427s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[593.149233] Starting subtest: basic-flip-after-cursor-varying-size
[594.073820] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.925s)
[594.877933] [102/130] (425s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[594.936845] Starting subtest: mixed-tiled-to-y-tiled-ccs
[594.941600] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[595.135442] [103/130] (425s left) gem_softpin (allocator-nopin-reserve)
[595.203042] Starting subtest: allocator-nopin-reserve
[595.288112] Subtest allocator-nopin-reserve: SUCCESS (0.086s)
[595.435553] [104/130] (425s left) gem_ctx_param (invalid-size-get)
[595.477091] Starting subtest: invalid-size-get
[595.479363] Subtest invalid-size-get: SUCCESS (0.001s)
[595.575824] [105/130] (425s left) kms_psr (psr-sprite-mmap-gtt)
[595.671681] Starting subtest: psr-sprite-mmap-gtt
[595.673983] Starting dynamic subtest: eDP-1
[597.104451] Dynamic subtest eDP-1: SKIP (1.431s)
[597.109041] Subtest psr-sprite-mmap-gtt: SKIP (1.432s)
[597.304472] [106/130] (423s left) kms_color (legacy-gamma)
[597.400597] Starting subtest: legacy-gamma
[597.402928] Starting dynamic subtest: pipe-A-eDP-1
[598.087412] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.685s)
[598.097664] Starting dynamic subtest: pipe-B-eDP-1
[599.528900] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.439s)
[599.538141] Starting dynamic subtest: pipe-C-eDP-1
[600.872874] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.343s)
[600.881395] Starting dynamic subtest: pipe-D-eDP-1
[602.214897] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.343s)
[602.216823] Subtest legacy-gamma: SUCCESS (4.813s)
[603.035620] [107/130] (418s left) i915_drm_fdinfo (isolation)
[603.075034] Starting subtest: isolation
[603.077193] Starting dynamic subtest: rcs0
[603.096401] Dynamic subtest rcs0: SKIP (0.020s)
[603.106078] Starting dynamic subtest: bcs0
[603.110658] Dynamic subtest bcs0: SKIP (0.010s)
[603.119298] Starting dynamic subtest: vcs0
[603.123870] Dynamic subtest vcs0: SKIP (0.000s)
[603.133073] Starting dynamic subtest: vcs1
[603.137896] Dynamic subtest vcs1: SKIP (0.000s)
[603.145888] Starting dynamic subtest: vecs0
[603.150305] Dynamic subtest vecs0: SKIP (0.000s)
[603.158445] Starting dynamic subtest: ccs0
[603.162846] Dynamic subtest ccs0: SKIP (0.000s)
[603.167214] Subtest isolation: SKIP (0.034s)
[603.202332] [108/130] (417s left) gem_tiled_fence_blits (basic)
[603.255350] Subtest basic: SKIP (0.000s)
[603.326750] [109/130] (417s left) syncobj_timeline (invalid-transfer-illegal-handle)
[603.377926] Starting subtest: invalid-transfer-illegal-handle
[603.379930] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[603.496452] [110/130] (417s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[603.589154] Starting subtest: bad-rotation-90-y-tiled-ccs
[603.594278] Starting dynamic subtest: pipe-A-eDP-1
[603.616679] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[603.625954] Starting dynamic subtest: pipe-B-eDP-1
[603.647103] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[603.655123] Starting dynamic subtest: pipe-C-eDP-1
[603.676591] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[603.685458] Starting dynamic subtest: pipe-D-eDP-1
[603.707465] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[603.712449] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.007s)
[605.821789] [111/130] (415s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[605.874288] Starting subtest: multi-wait-for-submit-available-submitted
[605.876594] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s)
[605.978844] [112/130] (415s left) api_intel_allocator (default-alignment)
[606.025248] Starting subtest: default-alignment
[606.029840] Subtest default-alignment: SUCCESS (0.005s)
[606.141192] [113/130] (415s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[606.520277] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[607.334823] [114/130] (413s left) kms_content_protection (type1)
[607.481629] Starting subtest: type1
[610.896489] Subtest type1: SKIP (3.413s)
[612.064743] [115/130] (409s left) kms_plane_lowres (tiling-x)
[612.146408] Starting subtest: tiling-x
[612.148700] Starting dynamic subtest: pipe-A-eDP-1
[612.153377] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[612.450935] Starting dynamic subtest: pipe-B-eDP-1
[612.455720] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[612.465592] Starting dynamic subtest: pipe-C-eDP-1
[612.470172] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[612.478507] Starting dynamic subtest: pipe-D-eDP-1
[612.482621] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[612.486636] Subtest tiling-x: SKIP (0.301s)
[613.287928] [116/130] (408s left) gem_exec_params (invalid-batch-start-offset)
[613.350508] Starting subtest: invalid-batch-start-offset
[613.352982] Subtest invalid-batch-start-offset: SUCCESS (0.002s)
[613.462389] [117/130] (407s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[613.560468] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[613.564398] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[613.656444] [118/130] (407s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[613.769040] Starting subtest: fbcpsr-tiling-y
[613.773458] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[613.883919] [119/130] (407s left) gem_exec_balancer (hog)
[613.934103] Starting subtest: hog
[613.938745] Subtest hog: SKIP (0.000s)
[614.230491] [120/130] (407s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[614.331694] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[615.418700] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.089s)
[615.554238] [121/130] (406s left) gem_exec_capture (pi)
[615.603407] Starting subtest: pi
[615.605443] Starting dynamic subtest: rcs0
[619.912117] Dynamic subtest rcs0: SUCCESS (4.308s)
[619.922941] Starting dynamic subtest: bcs0
[623.829463] Dynamic subtest bcs0: SUCCESS (3.915s)
[623.840305] Starting dynamic subtest: vcs0
[627.702507] Dynamic subtest vcs0: SUCCESS (3.871s)
[627.714847] Starting dynamic subtest: vcs1
[631.652147] Dynamic subtest vcs1: SUCCESS (3.949s)
[631.664379] Starting dynamic subtest: vecs0
[635.574134] Dynamic subtest vecs0: SUCCESS (3.921s)
[635.585816] Starting dynamic subtest: ccs0
[639.446879] Dynamic subtest ccs0: SUCCESS (3.872s)
[639.449385] Subtest pi: SUCCESS (23.846s)
[639.523671] [122/130] (382s left) gem_pwrite (basic-self)
[639.629003] Subtest basic-self: SKIP (0.000s)
[639.694314] [123/130] (381s left) kms_rotation_crc (primary-rotation-180)
[639.794610] Starting subtest: primary-rotation-180
[646.774175] Subtest primary-rotation-180: SUCCESS (6.981s)
[647.959497] [124/130] (373s left) gem_exec_whisper (basic-queues)
[648.035899] Starting subtest: basic-queues
[653.548976] Subtest basic-queues: SUCCESS (5.510s)
[653.731777] [125/130] (368s left) kms_flip (flip-vs-expired-vblank)
[653.832315] Starting subtest: flip-vs-expired-vblank
[653.834718] Starting dynamic subtest: A-eDP1
[662.562746] Dynamic subtest A-eDP1: SUCCESS (8.731s)
[662.574876] Starting dynamic subtest: B-eDP1
[671.194247] Dynamic subtest B-eDP1: SUCCESS (8.631s)
[671.203865] Starting dynamic subtest: C-eDP1
[679.814827] Dynamic subtest C-eDP1: SUCCESS (8.621s)
[679.826185] Starting dynamic subtest: D-eDP1
[688.435814] Dynamic subtest D-eDP1: SUCCESS (8.620s)
[688.438208] Subtest flip-vs-expired-vblank: SUCCESS (34.610s)
[689.584411] [126/130] (332s left) gem_eio (wait-wedge-immediate)
[689.813272] Starting subtest: wait-wedge-immediate
[691.551275] Subtest wait-wedge-immediate: SUCCESS (1.739s)
[691.688854] [127/130] (330s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[691.784435] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[691.786750] Starting dynamic subtest: pipe-A-eDP-1
[691.813102] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[691.822563] Starting dynamic subtest: pipe-B-eDP-1
[691.844181] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[691.852882] Starting dynamic subtest: pipe-C-eDP-1
[691.874476] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[691.883229] Starting dynamic subtest: pipe-D-eDP-1
[691.904720] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[691.909072] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[693.978308] [128/130] (327s left) kms_psr (pr-no-drrs)
[694.084358] Starting subtest: pr-no-drrs
[694.088711] Subtest pr-no-drrs: SKIP (0.000s)
[694.154748] [129/130] (327s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[694.262716] Starting subtest: y-tiled-8bpp-rotate-90
[694.266965] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[694.356608] [130/130] (327s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[694.464151] Starting subtest: fbcpsr-rgb565-draw-pwrite
[701.438621] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (6.978s)
[701.557593] 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.