[64.968389] Initializing watchdogs
[64.968435]   /dev/watchdog0
[64.983549] [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]
[64.988367] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[64.990748] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[64.994215] [001/132] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[65.104103] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[65.108625] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[65.211988] [002/132] (960s left) prime_busy (before)
[65.273785] Starting subtest: before
[65.278321] Starting dynamic subtest: rcs0
[65.314148] Dynamic subtest rcs0: SUCCESS (0.038s)
[65.323822] Starting dynamic subtest: bcs0
[65.364422] Dynamic subtest bcs0: SUCCESS (0.049s)
[65.373229] Starting dynamic subtest: vcs0
[65.405463] Dynamic subtest vcs0: SUCCESS (0.041s)
[65.413958] Starting dynamic subtest: vcs1
[65.445649] Dynamic subtest vcs1: SUCCESS (0.040s)
[65.454361] Starting dynamic subtest: vecs0
[65.487570] Dynamic subtest vecs0: SUCCESS (0.041s)
[65.496339] Starting dynamic subtest: ccs0
[65.528445] Dynamic subtest ccs0: SUCCESS (0.040s)
[65.637236] Subtest before: SUCCESS (0.361s)
[65.704433] [003/132] (959s left) gem_spin_batch (spin-all-new)
[65.773372] Starting subtest: spin-all-new
[65.788732] Subtest spin-all-new: SUCCESS (0.015s)
[66.954944] [004/132] (958s left) perf_pmu (faulting-read)
[67.033733] Starting subtest: faulting-read
[67.036716] Starting dynamic subtest: wb
[67.039132] Dynamic subtest wb: SUCCESS (0.002s)
[67.050426] Starting dynamic subtest: wc
[67.053091] Dynamic subtest wc: SUCCESS (0.004s)
[67.062385] Starting dynamic subtest: uc
[67.065187] Dynamic subtest uc: SUCCESS (0.002s)
[67.067505] Subtest faulting-read: SUCCESS (0.015s)
[67.425543] [005/132] (958s left) gem_ctx_exec (basic-nohangcheck)
[67.600617] Starting subtest: basic-nohangcheck
[68.036291] Subtest basic-nohangcheck: SUCCESS (0.438s)
[68.296751] [006/132] (957s left) kms_feature_discovery (display-2x)
[68.392824] Starting subtest: display-2x
[68.397418] Subtest display-2x: SKIP (0.000s)
[68.464566] [007/132] (957s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[68.548618] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[68.553909] Starting dynamic subtest: pipe-A-eDP-1
[68.578630] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[68.589771] Starting dynamic subtest: pipe-B-eDP-1
[68.611997] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[68.619419] Starting dynamic subtest: pipe-C-eDP-1
[68.640986] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[68.648438] Starting dynamic subtest: pipe-D-eDP-1
[68.670240] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[68.674657] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[70.763329] [008/132] (955s left) gem_ctx_persistence (processes)
[70.820732] Starting subtest: processes
[72.855705] Subtest processes: SUCCESS (2.032s)
[72.931225] [009/132] (952s left) gem_exec_fence (syncobj-timeline-export)
[73.481586] Starting subtest: syncobj-timeline-export
[73.494927] Subtest syncobj-timeline-export: SUCCESS (0.014s)
[74.984186] [FACT gem_exec_fence (syncobj-timeline-export)] new: kernel.kmod_is_loaded.vgem: true
[74.987691] [010/132] (950s left) sw_sync (timeline_closed)
[75.027666] Starting subtest: timeline_closed
[75.029996] Subtest timeline_closed: SUCCESS (0.000s)
[75.080662] [011/132] (950s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[77.047567] Starting subtest: dpms-mode-unset-non-lpsp
[78.214561] Subtest dpms-mode-unset-non-lpsp: SKIP (1.166s)
[78.591453] [012/132] (947s left) gem_busy (busy)
[78.652048] Starting subtest: busy
[78.654092] Starting dynamic subtest: all-engines
[78.708016] Dynamic subtest all-engines: SUCCESS (0.058s)
[78.716895] Starting dynamic subtest: rcs0
[79.900850] Dynamic subtest rcs0: SUCCESS (1.191s)
[79.911497] Starting dynamic subtest: bcs0
[79.940841] Dynamic subtest bcs0: SUCCESS (0.039s)
[79.950163] Starting dynamic subtest: vcs0
[79.980856] Dynamic subtest vcs0: SUCCESS (0.040s)
[79.990178] Starting dynamic subtest: vcs1
[81.882342] Dynamic subtest vcs1: SUCCESS (1.897s)
[81.892599] Starting dynamic subtest: vecs0
[83.930255] Dynamic subtest vecs0: SUCCESS (2.046s)
[83.940486] Starting dynamic subtest: ccs0
[85.916581] Dynamic subtest ccs0: SUCCESS (1.985s)
[85.918733] Subtest busy: SUCCESS (7.260s)
[86.280602] [013/132] (939s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[86.384608] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[86.388761] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[86.469317] [014/132] (939s left) kms_color (invalid-degamma-lut-sizes)
[86.557782] Starting subtest: invalid-degamma-lut-sizes
[86.560165] Starting dynamic subtest: pipe-A
[86.856432] Dynamic subtest pipe-A: SUCCESS (0.299s)
[86.866078] Starting dynamic subtest: pipe-B
[86.868327] Dynamic subtest pipe-B: SUCCESS (0.000s)
[86.876955] Starting dynamic subtest: pipe-C
[86.879266] Dynamic subtest pipe-C: SUCCESS (0.000s)
[86.887208] Starting dynamic subtest: pipe-D
[86.889363] Dynamic subtest pipe-D: SUCCESS (0.000s)
[86.891563] Subtest invalid-degamma-lut-sizes: SUCCESS (0.300s)
[87.714184] [015/132] (938s left) gem_mmap_wc (close)
[87.770087] Subtest close: SKIP (0.000s)
[87.831567] [016/132] (938s left) gem_ctx_shared (q-smoketest)
[87.895506] Starting subtest: Q-smoketest
[87.897770] Starting dynamic subtest: rcs0
[93.507922] Dynamic subtest rcs0: SUCCESS (5.510s)
[93.516956] Starting dynamic subtest: bcs0
[99.002184] Dynamic subtest bcs0: SUCCESS (5.487s)
[99.018798] Starting dynamic subtest: vcs0
[104.462740] Dynamic subtest vcs0: SUCCESS (5.465s)
[104.473468] Starting dynamic subtest: vcs1
[109.946385] Dynamic subtest vcs1: SUCCESS (5.479s)
[109.959366] Starting dynamic subtest: vecs0
[115.426371] Dynamic subtest vecs0: SUCCESS (5.485s)
[115.436152] Starting dynamic subtest: ccs0
[120.875543] Dynamic subtest ccs0: SUCCESS (5.497s)
[120.877920] Subtest Q-smoketest: SUCCESS (32.924s)
[121.016598] [017/132] (905s left) api_intel_bb (simple-bb)
[121.080688] Starting subtest: simple-bb
[121.088370] Subtest simple-bb: SUCCESS (0.009s)
[121.218437] [018/132] (904s left) gem_create (busy-create)
[121.284796] Starting subtest: busy-create
[121.287097] Starting dynamic subtest: smem0
[154.906553] Dynamic subtest smem0: SUCCESS (33.621s)
[154.909291] Subtest busy-create: SUCCESS (33.622s)
[155.093557] [019/132] (871s left) kms_psr (fbc-psr-sprite-plane-onoff)
[155.185721] Starting subtest: fbc-psr-sprite-plane-onoff
[155.187871] Starting dynamic subtest: eDP-1
[155.192213] Dynamic subtest eDP-1: SKIP (0.000s)
[155.196518] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.000s)
[155.259066] [020/132] (871s left) i915_drm_fdinfo (memory-info-active)
[155.295578] Starting subtest: memory-info-active
[155.297790] Starting dynamic subtest: smem0
[158.227027] Dynamic subtest smem0: SUCCESS (2.932s)
[158.229689] Subtest memory-info-active: SUCCESS (2.932s)
[158.313258] [021/132] (868s left) api_intel_bb (add-remove-objects)
[158.364143] Starting subtest: add-remove-objects
[158.371783] Subtest add-remove-objects: SUCCESS (0.010s)
[158.518215] [022/132] (867s left) gem_exec_balancer (bonded-semaphore)
[158.583198] Starting subtest: bonded-semaphore
[158.586971] Subtest bonded-semaphore: SKIP (0.000s)
[158.898454] [023/132] (867s left) gen7_exec_parse (basic-allocation)
[158.960519] Subtest basic-allocation: SKIP (0.000s)
[159.027093] [024/132] (867s left) kms_lease (lease-uevent)
[159.125067] Starting subtest: lease-uevent
[160.137623] Subtest lease-uevent: SUCCESS (1.011s)
[160.237349] [025/132] (866s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier)
[160.333172] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier
[160.337574] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (0.000s)
[160.407948] [026/132] (866s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[160.497964] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[160.500240] Starting dynamic subtest: pipe-A-eDP-1
[160.999335] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.472s)
[161.009594] Starting dynamic subtest: pipe-B-eDP-1
[162.442401] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.444s)
[162.452898] Starting dynamic subtest: pipe-C-eDP-1
[163.814276] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.370s)
[163.824782] Starting dynamic subtest: pipe-D-eDP-1
[165.163900] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.350s)
[165.166608] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.639s)
[166.337406] [027/132] (860s left) gem_eio (wait-10ms)
[166.598740] Starting subtest: wait-10ms
[166.981106] Subtest wait-10ms: SUCCESS (0.385s)
[167.150498] [028/132] (859s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[167.252897] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[167.257276] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[167.325552] [029/132] (859s left) kms_cursor_crc (cursor-random-64x64)
[167.497880] Starting subtest: cursor-random-64x64
[167.503475] Starting dynamic subtest: pipe-A-eDP-1
[170.846488] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.345s)
[170.875529] Starting dynamic subtest: pipe-D-eDP-1
[174.819357] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.952s)
[174.821869] Subtest cursor-random-64x64: SUCCESS (7.321s)
[175.707555] [030/132] (851s left) gem_ctx_bad_destroy (invalid-default-ctx)
[175.769944] Starting subtest: invalid-default-ctx
[175.772486] Subtest invalid-default-ctx: SUCCESS (0.000s)
[175.847087] [031/132] (850s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[175.948138] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[175.952287] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[176.041199] [032/132] (850s left) kms_flip_event_leak (basic)
[176.129364] Starting subtest: basic
[176.131774] Starting dynamic subtest: pipe-A-eDP-1
[176.554709] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.423s)
[176.564942] Starting dynamic subtest: pipe-B-eDP-1
[177.722537] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.167s)
[177.732196] Starting dynamic subtest: pipe-C-eDP-1
[178.850267] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.126s)
[178.862224] Starting dynamic subtest: pipe-D-eDP-1
[179.977643] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.128s)
[179.980097] Subtest basic: SUCCESS (3.848s)
[180.858058] [033/132] (845s left) gem_madvise (dontneed-before-exec)
[180.896367] Starting subtest: dontneed-before-exec
[180.918188] Subtest dontneed-before-exec: SKIP (0.021s)
[180.992248] [034/132] (845s left) perf_pmu (frequency)
[181.033897] Starting subtest: frequency
[181.036259] Starting dynamic subtest: gt0
[183.197586] Dynamic subtest gt0: SUCCESS (2.157s)
[183.208495] Starting dynamic subtest: idle-gt0
[183.702855] Dynamic subtest idle-gt0: SUCCESS (0.505s)
[183.711920] Starting dynamic subtest: gt1
[187.931966] Dynamic subtest gt1: SUCCESS (4.226s)
[187.941787] Starting dynamic subtest: idle-gt1
[188.436467] Dynamic subtest idle-gt1: SUCCESS (0.505s)
[188.439307] Subtest frequency: SUCCESS (7.405s)
[188.533903] [035/132] (838s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[188.636134] Starting subtest: psr-2p-primscrn-spr-indfb-move
[188.640375] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[188.733073] [036/132] (838s left) kms_chamelium_audio (hdmi-audio)
[189.106470] Subtest hdmi-audio: SKIP (0.000s)
[189.953050] [037/132] (837s left) gem_exec_schedule (implicit-boths)
[190.025312] Starting subtest: implicit-boths
[190.027407] Starting dynamic subtest: rcs0
[190.133451] Dynamic subtest rcs0: SUCCESS (0.120s)
[190.145057] Starting dynamic subtest: vcs0
[190.216868] Dynamic subtest vcs0: SUCCESS (0.083s)
[190.228096] Starting dynamic subtest: vcs1
[190.294987] Dynamic subtest vcs1: SUCCESS (0.077s)
[190.306369] Starting dynamic subtest: vecs0
[190.371701] Dynamic subtest vecs0: SUCCESS (0.077s)
[190.382468] Starting dynamic subtest: ccs0
[190.462404] Dynamic subtest ccs0: SUCCESS (0.091s)
[190.464893] Subtest implicit-boths: SUCCESS (0.449s)
[192.008789] [038/132] (835s left) core_getversion (all-cards)
[192.045294] Starting subtest: all-cards
[192.053571] Subtest all-cards: SUCCESS (0.011s)
[192.103335] [039/132] (835s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[192.204317] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[192.206471] Starting dynamic subtest: pipe-A-eDP-1
[192.290316] Dynamic subtest pipe-A-eDP-1: SKIP (0.089s)
[192.300575] Starting dynamic subtest: pipe-B-eDP-1
[193.447427] Dynamic subtest pipe-B-eDP-1: SKIP (1.155s)
[193.451793] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.246s)
[194.666035] [040/132] (832s left) gem_mmap_offset (isolation)
[194.719174] Starting subtest: isolation
[194.735963] Subtest isolation: SUCCESS (0.006s)
[194.821314] [041/132] (832s left) kms_psr (fbc-pr-cursor-plane-move)
[194.915247] Starting subtest: fbc-pr-cursor-plane-move
[194.919640] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[195.010191] [042/132] (832s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[195.104124] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[195.106046] Starting dynamic subtest: pipe-A-eDP-1
[195.191179] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.088s)
[195.201613] Starting dynamic subtest: pipe-B-eDP-1
[195.264992] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.073s)
[195.273842] Starting dynamic subtest: pipe-C-eDP-1
[195.327780] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.062s)
[195.337250] Starting dynamic subtest: pipe-D-eDP-1
[195.390830] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.062s)
[195.393073] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.289s)
[197.704118] [043/132] (829s left) gem_exec_schedule (in-order)
[197.793067] Starting subtest: in-order
[197.795487] Starting dynamic subtest: rcs0
[197.918376] Dynamic subtest rcs0: SUCCESS (0.134s)
[197.931630] Starting dynamic subtest: vcs0
[198.011692] Dynamic subtest vcs0: SUCCESS (0.092s)
[198.023184] Starting dynamic subtest: vcs1
[198.095172] Dynamic subtest vcs1: SUCCESS (0.083s)
[198.106874] Starting dynamic subtest: vecs0
[198.175582] Dynamic subtest vecs0: SUCCESS (0.079s)
[198.187793] Starting dynamic subtest: ccs0
[198.288243] Dynamic subtest ccs0: SUCCESS (0.112s)
[198.290755] Subtest in-order: SUCCESS (0.505s)
[199.930416] [044/132] (827s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[200.043082] Starting subtest: basic-flip-before-cursor-atomic
[200.958369] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.916s)
[201.835912] [045/132] (825s left) kms_flip (bo-too-big)
[201.938457] Starting subtest: bo-too-big
[201.940423] Starting dynamic subtest: A-eDP1
[203.281349] Dynamic subtest A-eDP1: SUCCESS (1.340s)
[203.292415] Starting dynamic subtest: B-eDP1
[204.620915] Dynamic subtest B-eDP1: SUCCESS (1.339s)
[204.632394] Starting dynamic subtest: C-eDP1
[205.954292] Dynamic subtest C-eDP1: SUCCESS (1.333s)
[205.963078] Starting dynamic subtest: D-eDP1
[207.283902] Dynamic subtest D-eDP1: SUCCESS (1.328s)
[207.286617] Subtest bo-too-big: SUCCESS (5.350s)
[208.494393] [046/132] (818s left) kms_flip (plain-flip-ts-check)
[208.590124] Starting subtest: plain-flip-ts-check
[208.592257] Starting dynamic subtest: A-eDP1
[217.511866] Dynamic subtest A-eDP1: SUCCESS (8.890s)
[217.526731] Starting dynamic subtest: B-eDP1
[226.341928] Dynamic subtest B-eDP1: SUCCESS (8.829s)
[226.353981] Starting dynamic subtest: C-eDP1
[235.175262] Dynamic subtest C-eDP1: SUCCESS (8.820s)
[235.186974] Starting dynamic subtest: D-eDP1
[244.013338] Dynamic subtest D-eDP1: SUCCESS (8.833s)
[244.016181] Subtest plain-flip-ts-check: SUCCESS (35.384s)
[245.148998] [047/132] (782s left) kms_flip (flip-vs-modeset-vs-hang)
[245.237468] Starting subtest: flip-vs-modeset-vs-hang
[245.239781] Starting dynamic subtest: A-eDP1
[296.375583] Dynamic subtest A-eDP1: SUCCESS (51.125s)
[296.387684] Starting dynamic subtest: D-eDP1
[346.425261] Dynamic subtest D-eDP1: SUCCESS (50.040s)
[346.427659] Subtest flip-vs-modeset-vs-hang: SUCCESS (101.169s)
[346.788523] [048/132] (680s left) kms_properties (crtc-properties-legacy)
[346.892357] Starting subtest: crtc-properties-legacy
[346.894666] Starting dynamic subtest: pipe-A-eDP-1
[347.342336] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.449s)
[347.352175] Starting dynamic subtest: pipe-B-eDP-1
[348.469499] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.126s)
[348.479344] Starting dynamic subtest: pipe-C-eDP-1
[349.591721] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.123s)
[349.602270] Starting dynamic subtest: pipe-D-eDP-1
[350.716259] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.123s)
[350.718583] Subtest crtc-properties-legacy: SUCCESS (3.825s)
[351.539949] [049/132] (676s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[351.622408] Starting subtest: primary-y-tiled-reflect-x-0
[351.685640] Subtest primary-y-tiled-reflect-x-0: SKIP (0.060s)
[351.801854] [050/132] (675s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[351.920810] Starting subtest: cursorA-vs-flipB-varying-size
[351.925813] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[352.106920] [051/132] (675s left) gem_mmap_wc (set-cache-level)
[352.182500] Subtest set-cache-level: SKIP (0.000s)
[352.242317] [052/132] (675s left) gem_pxp (create-regular-context-1)
[352.380261] Starting subtest: create-regular-context-1
[352.382781] Subtest create-regular-context-1: SUCCESS (0.002s)
[352.522587] [053/132] (675s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[352.625088] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[353.649132] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.023s)
[353.787313] [054/132] (674s left) i915_hangman (gt-engine-hang)
[353.851891] Starting subtest: gt-engine-hang
[353.854280] Starting dynamic subtest: rcs0
[355.893053] Dynamic subtest rcs0: SUCCESS (2.040s)
[355.905042] Starting dynamic subtest: bcs0
[357.876494] Dynamic subtest bcs0: SUCCESS (1.981s)
[357.888958] Starting dynamic subtest: vcs0
[359.859672] Dynamic subtest vcs0: SUCCESS (1.981s)
[359.873129] Starting dynamic subtest: vcs1
[361.909108] Dynamic subtest vcs1: SUCCESS (2.047s)
[361.919914] Starting dynamic subtest: vecs0
[363.828439] Dynamic subtest vecs0: SUCCESS (1.916s)
[363.840916] Starting dynamic subtest: ccs0
[365.876053] Dynamic subtest ccs0: SUCCESS (2.046s)
[365.879453] Subtest gt-engine-hang: SUCCESS (12.024s)
[365.963300] [055/132] (661s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[366.021528] Starting subtest: yf-tiled-to-vebox-yf-tiled
[366.026207] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[366.223978] [056/132] (661s left) syncobj_timeline (multi-wait-for-submit-signaled)
[366.278390] Starting subtest: multi-wait-for-submit-signaled
[366.281049] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[366.366412] [057/132] (661s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[366.763720] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[367.541602] [058/132] (660s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[367.641860] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[374.729528] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.090s)
[374.834426] [059/132] (653s left) gem_exec_capture (userptr)
[374.891866] Starting subtest: userptr
[375.710845] Subtest userptr: SUCCESS (0.816s)
[375.819365] [060/132] (652s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[375.920886] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[376.889049] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.968s)
[377.032963] [061/132] (651s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[377.132297] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[377.134635] Starting dynamic subtest: pipe-A-eDP-1
[377.156311] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[377.169257] Starting dynamic subtest: pipe-B-eDP-1
[377.185229] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[377.193789] Starting dynamic subtest: pipe-C-eDP-1
[377.209789] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[377.217854] Starting dynamic subtest: pipe-D-eDP-1
[377.233474] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[377.235213] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[379.440559] [062/132] (648s left) kms_plane_multiple (2x-tiling-x)
[379.550259] Starting subtest: 2x-tiling-x
[379.554750] Subtest 2x-tiling-x: SKIP (0.000s)
[379.624294] [063/132] (648s left) kms_async_flips (test-time-stamp-atomic)
[379.718702] Starting subtest: test-time-stamp-atomic
[380.094613] Starting dynamic subtest: pipe-A-eDP-1
[380.862608] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.767s)
[381.253990] Starting dynamic subtest: pipe-B-eDP-1
[381.994827] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.746s)
[382.380867] Starting dynamic subtest: pipe-C-eDP-1
[383.135080] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.760s)
[383.500300] Starting dynamic subtest: pipe-D-eDP-1
[384.273757] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.779s)
[384.276265] Subtest test-time-stamp-atomic: SUCCESS (4.555s)
[385.437564] [064/132] (642s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[385.536433] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[385.540765] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[385.627212] [065/132] (642s left) kms_setmode (basic-clone-single-crtc)
[385.680657] Starting subtest: basic-clone-single-crtc
[385.686984] Subtest basic-clone-single-crtc: SKIP (0.000s)
[385.791892] [066/132] (642s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[385.879459] Starting subtest: plane-upscale-factor-0-25-with-rotation
[385.881588] Starting dynamic subtest: pipe-A
[386.104657] Dynamic subtest pipe-A: SUCCESS (0.227s)
[386.117610] Starting dynamic subtest: pipe-B
[387.411784] Dynamic subtest pipe-B: SUCCESS (1.305s)
[387.423047] Starting dynamic subtest: pipe-C
[388.742883] Dynamic subtest pipe-C: SUCCESS (1.331s)
[388.752323] Starting dynamic subtest: pipe-D
[390.074597] Dynamic subtest pipe-D: SUCCESS (1.330s)
[390.077545] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.198s)
[391.256755] [067/132] (637s left) kms_big_fb (y-tiled-addfb-size-overflow)
[391.363737] Starting subtest: y-tiled-addfb-size-overflow
[391.368114] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[391.467578] [068/132] (637s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[391.578886] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[392.612964] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.034s)
[392.738699] [069/132] (635s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[392.864666] Starting subtest: flip-vs-cursor-atomic-transitions
[400.458137] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.592s)
[401.287832] [070/132] (627s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[401.386212] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[405.847647] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.465s)
[406.988112] [071/132] (621s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[407.083152] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[407.095099] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.013s)
[407.180809] [072/132] (621s left) kms_psr (fbc-pr-sprite-plane-move)
[407.271319] Starting subtest: fbc-pr-sprite-plane-move
[407.275931] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[407.350381] [073/132] (621s left) perf (polling)
[407.473430] Starting subtest: polling
[407.475311] Starting dynamic subtest: 0-rcs0
[417.560205] Dynamic subtest 0-rcs0: SUCCESS (10.033s)
[417.572031] Starting dynamic subtest: 1-vecs0
[427.578090] Dynamic subtest 1-vecs0: SUCCESS (10.019s)
[427.580419] Subtest polling: SUCCESS (20.055s)
[427.623238] [074/132] (601s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[427.729460] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[427.733736] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[427.831204] [075/132] (600s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[427.940492] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[427.944753] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[428.030185] [076/132] (600s left) gem_gpgpu_fill (offset-16x16)
[428.086045] Starting subtest: offset-16x16
[428.090577] Subtest offset-16x16: SUCCESS (0.006s)
[428.222269] [077/132] (600s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[428.312835] Starting subtest: fbc-rgb565-draw-pwrite
[432.879534] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.570s)
[434.074920] [078/132] (594s left) kms_sequence (queue-idle)
[434.166598] Starting subtest: queue-idle
[434.168966] Starting dynamic subtest: pipe-A-eDP-1
[435.982835] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.817s)
[436.001303] Starting dynamic subtest: pipe-B-eDP-1
[438.428358] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.445s)
[438.438491] Starting dynamic subtest: pipe-C-eDP-1
[440.945408] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.513s)
[440.955201] Starting dynamic subtest: pipe-D-eDP-1
[443.377882] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.429s)
[443.380121] Subtest queue-idle: SUCCESS (9.210s)
[444.179248] [079/132] (584s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[444.271429] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[451.572314] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.304s)
[451.712647] [080/132] (577s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[451.814575] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[458.681352] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.868s)
[458.821854] [081/132] (570s left) gem_exec_params (sol-reset-not-gen7)
[458.890655] Starting subtest: sol-reset-not-gen7
[458.896229] Subtest sol-reset-not-gen7: SUCCESS (0.003s)
[459.012893] [082/132] (570s left) gem_userptr_blits (sync-unmap)
[459.080583] Starting subtest: sync-unmap
[459.093473] Subtest sync-unmap: SUCCESS (0.016s)
[459.210331] [083/132] (569s left) kms_cursor_edge_walk (128x128-top-bottom)
[459.299130] Starting subtest: 128x128-top-bottom
[459.301327] Starting dynamic subtest: pipe-A-eDP-1
[462.807990] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.508s)
[462.817490] Starting dynamic subtest: pipe-D-eDP-1
[465.933870] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.125s)
[465.936170] Subtest 128x128-top-bottom: SUCCESS (6.635s)
[466.738362] [084/132] (562s left) gem_exec_capture (capture)
[466.816215] Starting subtest: capture
[466.818135] Starting dynamic subtest: rcs0-smem
[467.660672] Dynamic subtest rcs0-smem: SUCCESS (0.845s)
[467.669888] Starting dynamic subtest: bcs0-smem
[468.492950] Dynamic subtest bcs0-smem: SUCCESS (0.829s)
[468.501575] Starting dynamic subtest: vcs0-smem
[469.313847] Dynamic subtest vcs0-smem: SUCCESS (0.821s)
[469.322511] Starting dynamic subtest: vcs1-smem
[470.184905] Dynamic subtest vcs1-smem: SUCCESS (0.870s)
[470.193628] Starting dynamic subtest: vecs0-smem
[471.076742] Dynamic subtest vecs0-smem: FAIL (0.833s)
[471.087551] Starting dynamic subtest: ccs0-smem
[472.343571] Dynamic subtest ccs0-smem: SUCCESS (1.325s)
[472.345811] Subtest capture: FAIL (5.530s)
[472.455230] [085/132] (556s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[472.550833] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[472.553031] Starting dynamic subtest: A-eDP1
[476.168763] Dynamic subtest A-eDP1: SUCCESS (3.615s)
[476.178580] Starting dynamic subtest: B-eDP1
[479.387056] Dynamic subtest B-eDP1: SUCCESS (3.214s)
[479.399035] Starting dynamic subtest: C-eDP1
[482.481798] Dynamic subtest C-eDP1: SUCCESS (3.094s)
[482.491176] Starting dynamic subtest: D-eDP1
[485.607028] Dynamic subtest D-eDP1: SUCCESS (3.123s)
[485.609360] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.054s)
[486.409209] [086/132] (542s left) perf (non-zero-reason)
[486.509868] Starting subtest: non-zero-reason
[486.512433] Starting dynamic subtest: 0-rcs0
[491.989894] Dynamic subtest 0-rcs0: SUCCESS (5.427s)
[492.002128] Starting dynamic subtest: 1-vcs1
[495.862458] Dynamic subtest 1-vcs1: SUCCESS (3.922s)
[495.865289] Subtest non-zero-reason: SUCCESS (9.351s)
[495.904980] [087/132] (533s left) gem_basic (create-close)
[495.975157] Starting subtest: create-close
[495.979712] Subtest create-close: SUCCESS (0.000s)
[496.086925] [088/132] (533s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[496.179239] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[496.181574] Starting dynamic subtest: pipe-A
[496.303814] Dynamic subtest pipe-A: SKIP (0.119s)
[496.322530] Starting dynamic subtest: pipe-B
[497.471893] Dynamic subtest pipe-B: SKIP (1.169s)
[497.480957] Starting dynamic subtest: pipe-C
[498.613707] Dynamic subtest pipe-C: SUCCESS (1.147s)
[498.623760] Starting dynamic subtest: pipe-D
[499.845067] Dynamic subtest pipe-D: SUCCESS (1.231s)
[499.847301] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.669s)
[501.044248] [089/132] (528s left) gem_exec_reloc (basic-gtt-cpu)
[501.115920] Subtest basic-gtt-cpu: SKIP (0.000s)
[501.189607] [090/132] (528s left) i915_query (hwconfig_table)
[501.244295] Starting subtest: hwconfig_table
[501.542795] Subtest hwconfig_table: SUCCESS (0.001s)
[501.583775] [091/132] (527s left) gem_exec_schedule (u-semaphore-user)
[501.648618] Starting subtest: u-semaphore-user
[501.697816] Subtest u-semaphore-user: SUCCESS (0.057s)
[502.973523] [092/132] (526s left) kms_flip (flip-vs-expired-vblank-interruptible)
[503.078649] Starting subtest: flip-vs-expired-vblank-interruptible
[503.080935] Starting dynamic subtest: A-eDP1
[511.788692] Dynamic subtest A-eDP1: SUCCESS (8.672s)
[511.798691] Starting dynamic subtest: B-eDP1
[520.423148] Dynamic subtest B-eDP1: SUCCESS (8.631s)
[520.434301] Starting dynamic subtest: C-eDP1
[529.055954] Dynamic subtest C-eDP1: SUCCESS (8.619s)
[529.067730] Starting dynamic subtest: D-eDP1
[537.691041] Dynamic subtest D-eDP1: SUCCESS (8.632s)
[537.693849] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.568s)
[538.816943] [093/132] (490s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[538.886539] Starting subtest: verify-pxp-key-change-after-suspend-resume
[546.176174] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.289s)
[556.374335] [094/132] (483s left) vgem_basic (mmap)
[556.453422] Starting subtest: mmap
[556.475916] Subtest mmap: SUCCESS (0.024s)
[556.553199] [095/132] (483s left) kms_vblank (query-idle)
[556.643864] Starting subtest: query-idle
[556.645777] Starting dynamic subtest: pipe-A-eDP-1
[558.406823] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.761s)
[558.421881] Starting dynamic subtest: pipe-D-eDP-1
[560.824392] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.417s)
[560.826735] Subtest query-idle: SUCCESS (4.182s)
[561.645055] [096/132] (478s left) kms_pm_rpm (legacy-planes)
[563.169567] Starting subtest: legacy-planes
[563.172372] Starting dynamic subtest: plane-64
[571.458998] Dynamic subtest plane-64: SUCCESS (8.288s)
[571.471960] Starting dynamic subtest: plane-94
[579.751377] Dynamic subtest plane-94: SUCCESS (8.289s)
[579.764235] Starting dynamic subtest: plane-124
[588.045935] Dynamic subtest plane-124: SUCCESS (8.292s)
[588.057671] Starting dynamic subtest: plane-134
[596.316569] Dynamic subtest plane-134: SUCCESS (8.268s)
[596.319183] Subtest legacy-planes: SUCCESS (33.148s)
[596.689268] [097/132] (443s left) gem_exec_reloc (basic-cpu-read-noreloc)
[596.751936] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[596.817366] [098/132] (443s left) kms_content_protection (atomic)
[596.962056] Starting subtest: atomic
[596.966703] Subtest atomic: SKIP (0.000s)
[597.074614] [099/132] (442s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[597.198465] Starting subtest: modeset-atomic-cursor-hotspot
[597.202972] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[597.345617] [100/132] (442s left) i915_pm_rc6_residency (media-rc6-accuracy)
[597.404158] Starting subtest: media-rc6-accuracy
[597.408256] Subtest media-rc6-accuracy: SKIP (0.000s)
[597.505063] [101/132] (442s left) kms_hdr (static-toggle-suspend)
[597.598041] Starting subtest: static-toggle-suspend
[597.603751] Subtest static-toggle-suspend: SKIP (0.000s)
[597.683759] [102/132] (442s left) kms_cursor_crc (cursor-onscreen-64x21)
[597.887189] Starting subtest: cursor-onscreen-64x21
[597.942335] Subtest cursor-onscreen-64x21: SKIP (0.050s)
[598.197549] [103/132] (441s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[598.284994] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[598.286789] Starting dynamic subtest: pipe-A-eDP-1
[598.304671] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[598.315803] Starting dynamic subtest: pipe-B-eDP-1
[598.331740] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[598.340513] Starting dynamic subtest: pipe-C-eDP-1
[598.357555] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[598.366302] Starting dynamic subtest: pipe-D-eDP-1
[598.384162] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[598.387634] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.006s)
[600.563962] [104/132] (439s left) gem_workarounds (suspend-resume-context)
[600.631246] Starting subtest: suspend-resume-context
[616.897823] Subtest suspend-resume-context: SUCCESS (1.584s)
[625.041226] [105/132] (423s left) kms_psr (psr-cursor-plane-move)
[625.138010] Starting subtest: psr-cursor-plane-move
[625.140241] Starting dynamic subtest: eDP-1
[626.876584] Dynamic subtest eDP-1: SUCCESS (1.739s)
[626.878699] Subtest psr-cursor-plane-move: SUCCESS (1.740s)
[627.749515] [106/132] (420s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[627.845931] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[627.857717] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.011s)
[627.940077] [107/132] (420s left) gem_mmap_gtt (cpuset-big-copy-xy)
[627.994143] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[628.059735] [108/132] (420s left) gem_exec_whisper (basic-contexts-all)
[628.128268] Starting subtest: basic-contexts-all
[639.565205] Subtest basic-contexts-all: SUCCESS (11.228s)
[639.754284] [109/132] (408s left) syncobj_eventfd (invalid-bad-pad)
[639.817797] Starting subtest: invalid-bad-pad
[639.820077] Subtest invalid-bad-pad: SUCCESS (0.000s)
[639.908771] [110/132] (408s left) kms_psr (psr-sprite-mmap-gtt)
[640.002844] Starting subtest: psr-sprite-mmap-gtt
[640.005102] Starting dynamic subtest: eDP-1
[641.499054] Dynamic subtest eDP-1: SKIP (1.478s)
[641.504126] Subtest psr-sprite-mmap-gtt: SKIP (1.481s)
[641.694544] [111/132] (406s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[641.798270] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[641.800571] Starting dynamic subtest: pipe-A-default-mode
[642.982210] Dynamic subtest pipe-A-default-mode: SKIP (1.171s)
[642.986230] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.173s)
[643.129789] [112/132] (405s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[643.189124] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[643.297161] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.107s)
[643.389418] [113/132] (405s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[643.496816] Starting subtest: yf-tiled-8bpp-rotate-270
[643.501360] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[643.595060] [114/132] (404s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[643.658926] Starting subtest: single-wait-all-for-submit-available-submitted
[643.661134] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[643.756195] [115/132] (404s left) gem_shrink (reclaim)
[643.813498] Starting subtest: reclaim
[646.287028] Subtest reclaim: SUCCESS (2.445s)
[646.433736] [116/132] (402s left) kms_plane_cursor (overlay)
[646.533899] Starting subtest: overlay
[646.538502] Starting dynamic subtest: pipe-A-eDP-1-size-64
[649.110725] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.565s)
[649.175183] Starting dynamic subtest: pipe-A-eDP-1-size-128
[651.717714] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.549s)
[651.781979] Starting dynamic subtest: pipe-A-eDP-1-size-256
[654.346327] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.571s)
[654.707593] Starting dynamic subtest: pipe-B-eDP-1-size-64
[657.920668] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.220s)
[657.982374] Starting dynamic subtest: pipe-B-eDP-1-size-128
[660.480921] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.504s)
[660.541810] Starting dynamic subtest: pipe-B-eDP-1-size-256
[663.060787] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.527s)
[663.427154] Starting dynamic subtest: pipe-C-eDP-1-size-64
[666.288207] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.877s)
[666.326935] Starting dynamic subtest: pipe-C-eDP-1-size-128
[668.466300] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.147s)
[668.505138] Starting dynamic subtest: pipe-C-eDP-1-size-256
[670.689187] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.191s)
[671.025497] Starting dynamic subtest: pipe-D-eDP-1-size-64
[673.831019] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.817s)
[673.870674] Starting dynamic subtest: pipe-D-eDP-1-size-128
[675.921117] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.058s)
[675.960054] Starting dynamic subtest: pipe-D-eDP-1-size-256
[678.066394] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.114s)
[678.385295] Subtest overlay: SUCCESS (31.813s)
[679.247356] [117/132] (369s left) syncobj_timeline (invalid-transfer-illegal-handle)
[679.311756] Starting subtest: invalid-transfer-illegal-handle
[679.313790] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[679.395125] [118/132] (369s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[679.489543] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[679.493547] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[679.602578] [119/132] (369s left) gem_flink_basic (flink-lifetime)
[679.657020] Starting subtest: flink-lifetime
[679.659228] Subtest flink-lifetime: SUCCESS (0.002s)
[679.757119] [120/132] (369s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[679.845723] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[687.230404] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.384s)
[687.354193] [121/132] (361s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[687.447549] Starting subtest: async-flip-with-page-flip-events-linear
[687.824619] Starting dynamic subtest: pipe-A-eDP-1
[690.612151] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.732s)
[690.923660] Starting dynamic subtest: pipe-B-eDP-1
[693.746374] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.777s)
[694.068374] Starting dynamic subtest: pipe-C-eDP-1
[696.871240] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.767s)
[697.185298] Starting dynamic subtest: pipe-D-eDP-1
[700.004879] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.774s)
[700.008008] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.501s)
[701.159109] [122/132] (347s left) gem_tiled_swapping (non-threaded)
[701.213755] Subtest non-threaded: SKIP (0.000s)
[701.278208] [123/132] (347s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[701.370681] Starting subtest: fbcpsr-modesetfrombusy
[707.542436] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.173s)
[707.649099] [124/132] (341s left) gen7_exec_parse (chained-batch)
[707.706359] Subtest chained-batch: SKIP (0.000s)
[707.786185] [125/132] (341s left) prime_mmap (test_map_unmap)
[707.842240] Starting subtest: test_map_unmap
[707.843991] Starting dynamic subtest: test_map_unmap-smem
[707.875146] Dynamic subtest test_map_unmap-smem: SUCCESS (0.034s)
[707.877031] Subtest test_map_unmap: SUCCESS (0.035s)
[707.964597] [126/132] (341s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[708.013974] Starting subtest: single-wait-all-for-submit-unsubmitted
[708.119138] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.104s)
[708.216989] [127/132] (340s left) syncobj_timeline (etime-single-wait-all-submitted)
[708.300190] Starting subtest: etime-single-wait-all-submitted
[708.409143] Subtest etime-single-wait-all-submitted: SUCCESS (0.108s)
[708.542231] [128/132] (340s left) kms_psr (pr-primary-page-flip)
[708.719427] Starting subtest: pr-primary-page-flip
[708.723669] Subtest pr-primary-page-flip: SKIP (0.000s)
[708.911507] [129/132] (340s left) gem_exec_flush (basic-wb-prw-default)
[709.158110] Starting subtest: basic-wb-prw-default
[714.734712] Subtest basic-wb-prw-default: SUCCESS (5.576s)
[714.924708] [130/132] (334s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[715.024595] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[715.028774] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[715.106839] [131/132] (334s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[715.491315] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[716.318232] [132/132] (333s left) kms_big_fb (linear-32bpp-rotate-0)
[716.415372] Starting subtest: linear-32bpp-rotate-0
[717.851522] Subtest linear-32bpp-rotate-0: SUCCESS (1.436s)
[718.006960] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: prime_busy
results: parsing output: 2/ for test: gem_spin_batch
results: parsing output: 3/ for test: perf_pmu
results: parsing output: 4/ for test: gem_ctx_exec
results: parsing output: 5/ for test: kms_feature_discovery
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: gem_ctx_persistence
results: parsing output: 8/ for test: gem_exec_fence
results: parsing output: 9/ for test: sw_sync
results: parsing output: 10/ for test: kms_pm_rpm
results: parsing output: 11/ for test: gem_busy
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_color
results: parsing output: 14/ for test: gem_mmap_wc
results: parsing output: 15/ for test: gem_ctx_shared
results: parsing output: 16/ for test: api_intel_bb
results: parsing output: 17/ for test: gem_create
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: i915_drm_fdinfo
results: parsing output: 20/ for test: api_intel_bb
results: parsing output: 21/ for test: gem_exec_balancer
results: parsing output: 22/ for test: gen7_exec_parse
results: parsing output: 23/ for test: kms_lease
results: parsing output: 24/ for test: kms_plane
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: gem_eio
results: parsing output: 27/ for test: kms_psr2_sf
results: parsing output: 28/ for test: kms_cursor_crc
results: parsing output: 29/ for test: gem_ctx_bad_destroy
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_flip_event_leak
results: parsing output: 32/ for test: gem_madvise
results: parsing output: 33/ for test: perf_pmu
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_chamelium_audio
results: parsing output: 36/ for test: gem_exec_schedule
results: parsing output: 37/ for test: core_getversion
results: parsing output: 38/ for test: kms_psr2_sf
results: parsing output: 39/ for test: gem_mmap_offset
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: gem_exec_schedule
results: parsing output: 43/ for test: kms_cursor_legacy
results: parsing output: 44/ for test: kms_flip
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: kms_flip
results: parsing output: 47/ for test: kms_properties
results: parsing output: 48/ for test: kms_rotation_crc
results: parsing output: 49/ for test: kms_cursor_legacy
results: parsing output: 50/ for test: gem_mmap_wc
results: parsing output: 51/ for test: gem_pxp
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: i915_hangman
results: parsing output: 54/ for test: gem_render_copy
results: parsing output: 55/ for test: syncobj_timeline
results: parsing output: 56/ for test: kms_chamelium_frames
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: gem_exec_capture
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: kms_ccs
results: parsing output: 61/ for test: kms_plane_multiple
results: parsing output: 62/ for test: kms_async_flips
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_setmode
results: parsing output: 65/ for test: kms_plane_scaling
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: kms_cursor_legacy
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_flip
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: perf
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: gem_gpgpu_fill
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_sequence
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: gem_exec_params
results: parsing output: 81/ for test: gem_userptr_blits
results: parsing output: 82/ for test: kms_cursor_edge_walk
results: parsing output: 83/ for test: gem_exec_capture
results: parsing output: 84/ for test: kms_flip
results: parsing output: 85/ for test: perf
results: parsing output: 86/ for test: gem_basic
results: parsing output: 87/ for test: kms_plane_scaling
results: parsing output: 88/ for test: gem_exec_reloc
results: parsing output: 89/ for test: i915_query
results: parsing output: 90/ for test: gem_exec_schedule
results: parsing output: 91/ for test: kms_flip
results: parsing output: 92/ for test: gem_pxp
results: parsing output: 93/ for test: vgem_basic
results: parsing output: 94/ for test: kms_vblank
results: parsing output: 95/ for test: kms_pm_rpm
results: parsing output: 96/ for test: gem_exec_reloc
results: parsing output: 97/ for test: kms_content_protection
results: parsing output: 98/ for test: kms_cursor_legacy
results: parsing output: 99/ for test: i915_pm_rc6_residency
results: parsing output: 100/ for test: kms_hdr
results: parsing output: 101/ for test: kms_cursor_crc
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: gem_workarounds
results: parsing output: 104/ for test: kms_psr
results: parsing output: 105/ for test: kms_flip
results: parsing output: 106/ for test: gem_mmap_gtt
results: parsing output: 107/ for test: gem_exec_whisper
results: parsing output: 108/ for test: syncobj_eventfd
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: kms_flip_scaled_crc
results: parsing output: 111/ for test: syncobj_wait
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: gem_shrink
results: parsing output: 115/ for test: kms_plane_cursor
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: gem_flink_basic
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_async_flips
results: parsing output: 121/ for test: gem_tiled_swapping
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gen7_exec_parse
results: parsing output: 124/ for test: prime_mmap
results: parsing output: 125/ for test: syncobj_wait
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: gem_exec_flush
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_chamelium_hpd
results: parsing output: 131/ for test: kms_big_fb
Done.