[70.054848] Initializing watchdogs
[70.054895]   /dev/watchdog0
[70.069969] [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]
[70.074625] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[70.076933] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[70.080855] [001/133] (960s left) kms_chamelium_color (ctm-0-25)
[70.199247] Subtest ctm-0-25: SKIP (0.000s)
[70.243344] [002/133] (960s left) kms_psr (pr-cursor-mmap-cpu)
[70.338906] Starting subtest: pr-cursor-mmap-cpu
[70.343847] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[70.418531] [003/133] (960s left) gem_wait (busy)
[70.480299] Starting subtest: busy
[70.482649] Starting dynamic subtest: all-engines
[72.317031] Dynamic subtest all-engines: SUCCESS (1.815s)
[72.325274] Starting dynamic subtest: rcs0
[72.927478] Dynamic subtest rcs0: SUCCESS (0.588s)
[72.938969] Starting dynamic subtest: bcs0
[73.534070] Dynamic subtest bcs0: SUCCESS (0.586s)
[73.543739] Starting dynamic subtest: vcs0
[75.262960] Dynamic subtest vcs0: SUCCESS (1.678s)
[75.273727] Starting dynamic subtest: vcs1
[77.309366] Dynamic subtest vcs1: SUCCESS (2.000s)
[77.320055] Starting dynamic subtest: vecs0
[79.293500] Dynamic subtest vecs0: SUCCESS (1.949s)
[79.304464] Starting dynamic subtest: ccs0
[79.839441] Dynamic subtest ccs0: SUCCESS (0.539s)
[79.842081] Subtest busy: SUCCESS (9.161s)
[80.050667] [004/133] (950s left) i915_drm_fdinfo (memory-info-idle)
[80.101517] Starting subtest: memory-info-idle
[80.103980] Starting dynamic subtest: smem0
[80.154401] Dynamic subtest smem0: SUCCESS (0.052s)
[80.157036] Subtest memory-info-idle: SUCCESS (0.052s)
[80.227957] [005/133] (950s left) vgem_basic (dmabuf-fence)
[80.294622] Starting subtest: dmabuf-fence
[80.296971] Subtest dmabuf-fence: SUCCESS (0.001s)
[80.349522] [FACT vgem_basic (dmabuf-fence)] new: kernel.kmod_is_loaded.vgem: true
[80.353294] [006/133] (950s left) kms_fb_coherency (memset-crc)
[80.461805] Starting subtest: memset-crc
[80.464168] Starting dynamic subtest: mmap-offset-wc
[80.913102] Dynamic subtest mmap-offset-wc: SUCCESS (0.446s)
[82.015693] Starting dynamic subtest: mmap-offset-uc
[87.566193] Dynamic subtest mmap-offset-uc: SUCCESS (5.521s)
[87.868362] Subtest memset-crc: SUCCESS (7.346s)
[88.731743] [007/133] (942s left) gem_exec_await (wide-contexts)
[88.931695] Starting subtest: wide-contexts
[112.170500] Subtest wide-contexts: SUCCESS (23.205s)
[112.361127] [008/133] (918s left) gem_mmap_offset (basic-uaf)
[112.451680] Starting subtest: basic-uaf
[112.453887] Subtest basic-uaf: SUCCESS (0.001s)
[112.539399] [009/133] (918s left) gem_close (many-handles-one-vma)
[112.597052] Starting subtest: many-handles-one-vma
[112.635844] Subtest many-handles-one-vma: SUCCESS (0.038s)
[112.726482] [010/133] (918s left) gem_exec_schedule (pi-distinct-iova)
[112.926053] Starting subtest: pi-distinct-iova
[112.928464] Starting dynamic subtest: rcs0
[113.066586] Dynamic subtest rcs0: SUCCESS (0.142s)
[113.077648] Starting dynamic subtest: vcs0
[113.146245] Dynamic subtest vcs0: SUCCESS (0.081s)
[113.157917] Starting dynamic subtest: vcs1
[113.227497] Dynamic subtest vcs1: SUCCESS (0.081s)
[113.237189] Starting dynamic subtest: vecs0
[113.313359] Dynamic subtest vecs0: SUCCESS (0.086s)
[113.325344] Starting dynamic subtest: ccs0
[113.425061] Dynamic subtest ccs0: SUCCESS (0.109s)
[113.427604] Subtest pi-distinct-iova: SUCCESS (0.500s)
[114.406546] [011/133] (916s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[114.533789] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[114.538041] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[114.632110] [012/133] (916s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[114.728936] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[121.476929] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.748s)
[121.602430] [013/133] (909s left) gem_eio (in-flight-internal-immediate)
[121.845119] Starting subtest: in-flight-internal-immediate
[123.406316] Subtest in-flight-internal-immediate: SUCCESS (1.560s)
[123.521057] [014/133] (907s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[123.618121] Starting subtest: pr-cursor-plane-move-continuous-sf
[123.622395] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[123.686425] [015/133] (907s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[123.781689] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[123.786268] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[123.882238] [016/133] (907s left) i915_pm_rpm (system-suspend-devices)
[128.668445] Starting subtest: system-suspend-devices
[136.419560] Subtest system-suspend-devices: SUCCESS (7.751s)
[136.807785] [017/133] (894s left) kms_psr (psr2-primary-mmap-gtt)
[136.927657] Starting subtest: psr2-primary-mmap-gtt
[136.930068] Starting dynamic subtest: eDP-1
[138.380626] Dynamic subtest eDP-1: SKIP (1.449s)
[138.385451] Subtest psr2-primary-mmap-gtt: SKIP (1.451s)
[138.522417] [018/133] (892s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[138.619157] Starting subtest: fbc-psr2-sprite-plane-onoff
[138.621125] Starting dynamic subtest: eDP-1
[138.625293] Dynamic subtest eDP-1: SKIP (0.000s)
[138.629479] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.000s)
[138.691661] [019/133] (892s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[138.797604] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[138.801966] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[138.903559] [020/133] (892s left) gem_close_race (multigpu-basic-threads)
[138.989666] Starting subtest: multigpu-basic-threads
[138.994170] Subtest multigpu-basic-threads: SKIP (0.000s)
[139.225742] [021/133] (892s left) kms_sequence (get-forked-busy)
[139.325712] Starting subtest: get-forked-busy
[139.327629] Starting dynamic subtest: pipe-A-eDP-1
[141.264365] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.936s)
[141.275963] Starting dynamic subtest: pipe-B-eDP-1
[143.837737] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.572s)
[143.852075] Starting dynamic subtest: pipe-C-eDP-1
[146.451315] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.614s)
[146.463409] Starting dynamic subtest: pipe-D-eDP-1
[149.100369] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.646s)
[149.102728] Subtest get-forked-busy: SUCCESS (9.772s)
[149.980134] [022/133] (881s left) kms_flip (plain-flip-ts-check-interruptible)
[150.082052] Starting subtest: plain-flip-ts-check-interruptible
[150.086590] Starting dynamic subtest: A-eDP1
[158.956372] Dynamic subtest A-eDP1: SUCCESS (8.869s)
[158.971177] Starting dynamic subtest: B-eDP1
[167.788305] Dynamic subtest B-eDP1: SUCCESS (8.828s)
[167.800158] Starting dynamic subtest: C-eDP1
[176.602674] Dynamic subtest C-eDP1: SUCCESS (8.813s)
[176.612564] Starting dynamic subtest: D-eDP1
[185.440855] Dynamic subtest D-eDP1: SUCCESS (8.837s)
[185.445605] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.357s)
[186.631468] [023/133] (844s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[186.737149] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[186.739510] Starting dynamic subtest: pipe-A-eDP-1
[186.760644] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[186.772926] Starting dynamic subtest: pipe-B-eDP-1
[186.791818] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[186.801075] Starting dynamic subtest: pipe-C-eDP-1
[186.820621] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[186.831207] Starting dynamic subtest: pipe-D-eDP-1
[186.850746] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[186.852648] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.007s)
[188.983381] [024/133] (842s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[189.084643] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[189.087052] Starting dynamic subtest: pipe-A-eDP-1
[189.110094] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[189.120767] Starting dynamic subtest: pipe-B-eDP-1
[189.142442] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[189.152182] Starting dynamic subtest: pipe-C-eDP-1
[189.173505] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[189.183485] Starting dynamic subtest: pipe-D-eDP-1
[189.205020] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[189.209033] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[191.342601] [025/133] (840s left) i915_hangman (gt-engine-hang)
[191.412137] Starting subtest: gt-engine-hang
[191.414426] Starting dynamic subtest: rcs0
[193.245857] Dynamic subtest rcs0: SUCCESS (1.832s)
[193.258569] Starting dynamic subtest: bcs0
[195.292081] Dynamic subtest bcs0: SUCCESS (2.044s)
[195.306359] Starting dynamic subtest: vcs0
[197.212074] Dynamic subtest vcs0: SUCCESS (1.918s)
[197.223825] Starting dynamic subtest: vcs1
[199.260079] Dynamic subtest vcs1: SUCCESS (2.046s)
[199.275237] Starting dynamic subtest: vecs0
[201.243948] Dynamic subtest vecs0: SUCCESS (1.982s)
[201.256645] Starting dynamic subtest: ccs0
[203.229753] Dynamic subtest ccs0: SUCCESS (1.984s)
[203.232827] Subtest gt-engine-hang: SUCCESS (11.817s)
[203.386041] [026/133] (828s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[203.449781] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[203.451962] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.001s)
[203.558293] [027/133] (828s left) gem_ctx_param (invalid-size-get)
[203.620658] Starting subtest: invalid-size-get
[203.623045] Subtest invalid-size-get: SUCCESS (0.001s)
[203.742063] [028/133] (827s left) kms_async_flips (test-time-stamp)
[203.836351] Starting subtest: test-time-stamp
[204.223639] Starting dynamic subtest: pipe-A-eDP-1
[205.036681] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.811s)
[205.414283] Starting dynamic subtest: pipe-B-eDP-1
[206.172980] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.765s)
[206.539850] Starting dynamic subtest: pipe-C-eDP-1
[207.301766] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.767s)
[207.663159] Starting dynamic subtest: pipe-D-eDP-1
[208.431706] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.774s)
[208.434297] Subtest test-time-stamp: SUCCESS (4.593s)
[209.597392] [029/133] (822s left) kms_frontbuffer_tracking (basic)
[209.695350] Starting subtest: basic
[213.149310] Subtest basic: SUCCESS (3.457s)
[213.257280] [030/133] (818s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[213.372164] Starting subtest: cursorB-vs-flipB-toggle
[213.375987] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[213.515773] [031/133] (818s left) kms_getfb (getfb2-handle-zero)
[213.607680] Starting subtest: getfb2-handle-zero
[213.609630] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[213.709549] [032/133] (818s left) gem_userptr_blits (forbidden-operations)
[213.768757] Starting subtest: forbidden-operations
[213.772455] Subtest forbidden-operations: SKIP (0.000s)
[213.889311] [033/133] (818s left) gem_mmap_gtt (basic-write-read)
[213.945059] Subtest basic-write-read: SKIP (0.000s)
[214.004348] [034/133] (817s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[214.060158] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[214.062171] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[214.144617] [035/133] (817s left) perf (blocking-parameterized)
[214.281290] Starting subtest: blocking-parameterized
[234.304459] Subtest blocking-parameterized: SUCCESS (20.020s)
[234.355712] [036/133] (797s left) syncobj_wait (wait-for-submit-delayed-submit)
[234.418071] Starting subtest: wait-for-submit-delayed-submit
[234.520244] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s)
[234.618459] [037/133] (797s left) kms_content_protection (dp-mst-type-1-suspend-resume)
[234.767376] Starting subtest: dp-mst-type-1-suspend-resume
[234.771640] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s)
[234.917822] [038/133] (797s left) api_intel_bb (object-noreloc-purge-cache-simple)
[234.979332] Starting subtest: object-noreloc-purge-cache-simple
[234.981729] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.004s)
[235.100220] [039/133] (797s left) syncobj_wait (invalid-wait-bad-flags)
[235.152808] Starting subtest: invalid-wait-bad-flags
[235.155337] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[235.263154] [040/133] (796s left) gem_busy (close-race)
[235.336301] Starting subtest: close-race
[259.325222] Subtest close-race: SUCCESS (23.987s)
[259.683818] [041/133] (772s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[259.844605] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[264.462821] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.624s)
[265.591153] [042/133] (766s left) gem_exec_reloc (basic-gtt)
[265.641885] Subtest basic-gtt: SKIP (0.000s)
[265.700843] [043/133] (766s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[265.796445] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[272.708850] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.916s)
[272.826863] [044/133] (759s left) gem_lmem_swapping (smem-oom)
[272.876301] Subtest smem-oom: SKIP (0.000s)
[272.924332] [045/133] (759s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[273.034921] Starting subtest: short-flip-after-cursor-atomic-transitions
[274.021415] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.984s)
[274.821187] [046/133] (757s left) vgem_basic (debugfs)
[274.868324] Starting subtest: debugfs
[274.870716] Subtest debugfs: SUCCESS (0.001s)
[274.931521] [047/133] (757s left) gem_gpgpu_fill (basic)
[274.985148] Starting subtest: basic
[274.987103] Starting dynamic subtest: smem
[274.991959] Dynamic subtest smem: SUCCESS (0.007s)
[274.994328] Subtest basic: SUCCESS (0.008s)
[275.129898] [048/133] (757s left) syncobj_timeline (invalid-query-zero-handles)
[275.185338] Starting subtest: invalid-query-zero-handles
[275.187661] Subtest invalid-query-zero-handles: SUCCESS (0.000s)
[275.290654] [049/133] (757s left) syncobj_eventfd (invalid-bad-pad)
[275.344625] Starting subtest: invalid-bad-pad
[275.346868] Subtest invalid-bad-pad: SUCCESS (0.000s)
[275.442446] [050/133] (757s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[275.553406] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[275.557941] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[275.650895] [051/133] (757s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[275.760193] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[275.763824] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[275.875764] [052/133] (756s left) gem_exec_balancer (busy)
[275.950978] Starting subtest: busy
[277.290833] Subtest busy: SUCCESS (1.337s)
[277.612492] [053/133] (755s left) kms_pipe_crc_basic (nonblocking-crc)
[277.714094] Starting subtest: nonblocking-crc
[277.716253] Starting dynamic subtest: pipe-A-eDP-1
[278.478891] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.765s)
[278.490187] Starting dynamic subtest: pipe-B-eDP-1
[279.939344] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.458s)
[279.949664] Starting dynamic subtest: pipe-C-eDP-1
[281.318483] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.377s)
[281.329636] Starting dynamic subtest: pipe-D-eDP-1
[282.657364] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.338s)
[282.659636] Subtest nonblocking-crc: SUCCESS (4.944s)
[283.453879] [054/133] (749s left) kms_lease (lease-invalid-connector)
[283.554376] Starting subtest: lease-invalid-connector
[283.556649] Starting dynamic subtest: pipe-A-eDP-1
[283.558942] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[283.569585] Starting dynamic subtest: pipe-B-eDP-1
[283.571729] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[283.581034] Starting dynamic subtest: pipe-C-eDP-1
[283.583260] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[283.592351] Starting dynamic subtest: pipe-D-eDP-1
[283.594469] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[283.596695] Subtest lease-invalid-connector: SUCCESS (0.004s)
[283.636246] [055/133] (749s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[283.736352] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[283.738665] Starting dynamic subtest: pipe-A
[284.098178] Dynamic subtest pipe-A: SUCCESS (0.364s)
[284.112417] Starting dynamic subtest: pipe-B
[285.584979] Dynamic subtest pipe-B: SUCCESS (1.485s)
[285.595378] Starting dynamic subtest: pipe-C
[286.987334] Dynamic subtest pipe-C: SUCCESS (1.402s)
[286.997140] Starting dynamic subtest: pipe-D
[288.463343] Dynamic subtest pipe-D: SUCCESS (1.474s)
[288.465769] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.730s)
[289.628261] [056/133] (743s left) gem_madvise (dontneed-before-exec)
[289.664485] Starting subtest: dontneed-before-exec
[289.689902] Subtest dontneed-before-exec: SKIP (0.021s)
[289.766521] [057/133] (743s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[290.343806] Starting subtest: syncobj-stationary-timeline-chain-engines
[290.454816] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.111s)
[291.425451] [058/133] (741s left) gem_tiling_max_stride
[291.537320] [059/133] (741s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[291.626178] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[291.630673] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[291.724044] [060/133] (741s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[291.820372] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[291.822601] Starting dynamic subtest: pipe-A-eDP-1
[298.454279] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.636s)
[298.465144] Starting dynamic subtest: pipe-B-eDP-1
[305.398527] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.943s)
[305.401066] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.582s)
[306.288448] [061/133] (726s left) tools_test (sysfs_l3_parity)
[306.346968] Starting subtest: sysfs_l3_parity
[306.432880] Subtest sysfs_l3_parity: SKIP (0.098s)
[306.488271] [062/133] (726s left) gem_mmap_offset (pf-nonblock)
[306.544933] Starting subtest: pf-nonblock
[306.549792] Subtest pf-nonblock: SUCCESS (0.007s)
[306.664023] [063/133] (726s left) syncobj_wait (multi-wait-for-submit-signaled)
[306.717519] Starting subtest: multi-wait-for-submit-signaled
[306.719487] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[306.814395] [064/133] (726s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[306.923010] Starting subtest: cursorA-vs-flipA-legacy
[318.056998] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.134s)
[318.910124] [065/133] (714s left) kms_flip (dpms-vs-vblank-race-interruptible)
[318.998709] Starting subtest: dpms-vs-vblank-race-interruptible
[319.000951] Starting dynamic subtest: A-eDP1
[323.981436] Dynamic subtest A-eDP1: SUCCESS (4.980s)
[323.993641] Starting dynamic subtest: B-eDP1
[328.618247] Dynamic subtest B-eDP1: SUCCESS (4.635s)
[328.629349] Starting dynamic subtest: C-eDP1
[333.234531] Dynamic subtest C-eDP1: SUCCESS (4.610s)
[333.245144] Starting dynamic subtest: D-eDP1
[337.871320] Dynamic subtest D-eDP1: SUCCESS (4.634s)
[337.875953] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (18.875s)
[338.758648] [066/133] (694s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[338.865344] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[338.869592] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[338.965649] [067/133] (694s left) kms_cursor_crc (cursor-offscreen-512x170)
[339.256923] Starting subtest: cursor-offscreen-512x170
[339.261566] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[339.398069] [068/133] (694s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[339.485844] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[339.488066] Starting dynamic subtest: pipe-A-eDP-1
[339.509745] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[339.519538] Starting dynamic subtest: pipe-B-eDP-1
[339.540014] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[339.549749] Starting dynamic subtest: pipe-C-eDP-1
[339.570185] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[339.579480] Starting dynamic subtest: pipe-D-eDP-1
[339.600195] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[339.604302] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[341.727158] [069/133] (691s left) kms_properties (crtc-properties-legacy)
[341.819957] Starting subtest: crtc-properties-legacy
[341.822154] Starting dynamic subtest: pipe-A-eDP-1
[342.253875] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.434s)
[342.264591] Starting dynamic subtest: pipe-B-eDP-1
[343.389042] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.133s)
[343.399463] Starting dynamic subtest: pipe-C-eDP-1
[344.506365] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.117s)
[344.516713] Starting dynamic subtest: pipe-D-eDP-1
[345.628442] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.119s)
[345.630738] Subtest crtc-properties-legacy: SUCCESS (3.809s)
[346.447450] [070/133] (687s left) perf_pmu (gt-awake)
[346.494816] Starting subtest: gt-awake
[355.264040] Subtest gt-awake: SUCCESS (8.767s)
[355.369545] [071/133] (678s left) kms_plane_lowres (tiling-none)
[355.467907] Starting subtest: tiling-none
[355.470179] Starting dynamic subtest: pipe-A-eDP-1
[355.474693] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[355.777690] Starting dynamic subtest: pipe-B-eDP-1
[355.782350] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[355.792649] Starting dynamic subtest: pipe-C-eDP-1
[355.797288] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[355.807443] Starting dynamic subtest: pipe-D-eDP-1
[355.811810] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[355.816315] Subtest tiling-none: SKIP (0.308s)
[356.572476] [072/133] (677s left) kms_invalid_mode (bad-vsync-start)
[356.670423] Starting subtest: bad-vsync-start
[356.672605] Starting dynamic subtest: pipe-A-eDP-1
[356.968082] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.298s)
[356.983518] Starting dynamic subtest: pipe-B-eDP-1
[356.985618] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[357.000153] Starting dynamic subtest: pipe-C-eDP-1
[357.002297] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[357.012537] Starting dynamic subtest: pipe-D-eDP-1
[357.014754] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[357.017024] Subtest bad-vsync-start: SUCCESS (0.304s)
[357.832451] [073/133] (675s left) prime_busy (before)
[357.890053] Starting subtest: before
[357.895253] Starting dynamic subtest: rcs0
[357.921259] Dynamic subtest rcs0: SUCCESS (0.028s)
[357.933149] Starting dynamic subtest: bcs0
[357.959986] Dynamic subtest bcs0: SUCCESS (0.038s)
[357.970189] Starting dynamic subtest: vcs0
[358.000058] Dynamic subtest vcs0: SUCCESS (0.039s)
[358.010362] Starting dynamic subtest: vcs1
[358.041050] Dynamic subtest vcs1: SUCCESS (0.040s)
[358.051440] Starting dynamic subtest: vecs0
[358.081294] Dynamic subtest vecs0: SUCCESS (0.040s)
[358.091310] Starting dynamic subtest: ccs0
[358.122290] Dynamic subtest ccs0: SUCCESS (0.040s)
[358.231271] Subtest before: SUCCESS (0.339s)
[358.312055] [074/133] (675s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[358.406695] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[358.497492] [075/133] (675s left) kms_psr (psr-sprite-mmap-cpu)
[358.591282] Starting subtest: psr-sprite-mmap-cpu
[358.593406] Starting dynamic subtest: eDP-1
[360.329922] Dynamic subtest eDP-1: SUCCESS (1.739s)
[360.332220] Subtest psr-sprite-mmap-cpu: SUCCESS (1.740s)
[361.165222] [076/133] (672s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[361.281151] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[361.285548] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[361.428498] [077/133] (672s left) syncobj_timeline (wait-zero-handles)
[361.476932] Starting subtest: wait-zero-handles
[361.479131] Subtest wait-zero-handles: SUCCESS (0.000s)
[361.571488] [078/133] (672s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[361.657088] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[361.659196] Starting dynamic subtest: pipe-A-default-mode
[364.391628] Dynamic subtest pipe-A-default-mode: SUCCESS (2.734s)
[364.393955] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.736s)
[365.263573] [079/133] (668s left) kms_cursor_crc (cursor-sliding-128x42)
[365.504906] Starting subtest: cursor-sliding-128x42
[365.551199] Subtest cursor-sliding-128x42: SKIP (0.043s)
[365.763969] [080/133] (668s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[366.154871] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[366.974198] [081/133] (667s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[367.072708] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[367.076660] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[367.164779] [082/133] (666s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[367.258738] Starting subtest: primary-yf-tiled-reflect-x-0
[367.331724] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.071s)
[367.439201] [083/133] (666s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[367.536496] Starting subtest: yf-tiled-16bpp-rotate-90
[367.540738] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[367.662700] [084/133] (666s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[367.761449] Starting subtest: fbc-rgb565-draw-mmap-gtt
[367.765711] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[367.869174] [085/133] (666s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[367.930125] Starting subtest: yf-tiled-to-vebox-x-tiled
[367.933594] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[368.117613] [086/133] (666s left) kms_pm_rpm (dpms-non-lpsp)
[369.645042] Starting subtest: dpms-non-lpsp
[369.650503] Subtest dpms-non-lpsp: SKIP (0.001s)
[370.372155] [087/133] (663s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[370.499566] Starting subtest: 2x-long-flip-vs-cursor-atomic
[370.504082] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[370.649613] [088/133] (663s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[370.753369] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[370.757711] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[370.855030] [089/133] (663s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[370.947941] Starting subtest: plane-lut1d-pre-ctm3x4
[371.096090] Starting dynamic subtest: pipe-A-plane-0
[371.306115] Dynamic subtest pipe-A-plane-0: SUCCESS (0.211s)
[371.320965] Starting dynamic subtest: pipe-A-plane-1
[371.494443] Dynamic subtest pipe-A-plane-1: SUCCESS (0.186s)
[371.504494] Starting dynamic subtest: pipe-A-plane-2
[371.627889] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s)
[372.834459] Starting dynamic subtest: pipe-B-plane-0
[373.005658] Dynamic subtest pipe-B-plane-0: SUCCESS (0.177s)
[373.016197] Starting dynamic subtest: pipe-B-plane-1
[373.181189] Dynamic subtest pipe-B-plane-1: SUCCESS (0.177s)
[373.192059] Starting dynamic subtest: pipe-B-plane-2
[373.347697] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[374.563385] Starting dynamic subtest: pipe-C-plane-0
[374.698654] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[374.713908] Starting dynamic subtest: pipe-C-plane-1
[374.831938] Dynamic subtest pipe-C-plane-1: SUCCESS (0.133s)
[374.842647] Starting dynamic subtest: pipe-C-plane-2
[374.987487] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[376.210785] Starting dynamic subtest: pipe-D-plane-0
[376.379885] Dynamic subtest pipe-D-plane-0: SUCCESS (0.178s)
[376.390177] Starting dynamic subtest: pipe-D-plane-1
[376.546481] Dynamic subtest pipe-D-plane-1: SUCCESS (0.164s)
[376.557116] Starting dynamic subtest: pipe-D-plane-2
[376.712962] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[377.005319] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (6.058s)
[377.881457] [090/133] (656s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[378.001476] Starting subtest: 4-tiled-32bpp-rotate-90
[378.022316] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.020s)
[378.139776] [091/133] (656s left) gem_busy (busy)
[378.207270] Starting subtest: busy
[378.209591] Starting dynamic subtest: all-engines
[378.281717] Dynamic subtest all-engines: SUCCESS (0.074s)
[378.293546] Starting dynamic subtest: rcs0
[380.292658] Dynamic subtest rcs0: SUCCESS (2.008s)
[380.304977] Starting dynamic subtest: bcs0
[380.332939] Dynamic subtest bcs0: SUCCESS (0.038s)
[380.343067] Starting dynamic subtest: vcs0
[380.371884] Dynamic subtest vcs0: SUCCESS (0.038s)
[380.382157] Starting dynamic subtest: vcs1
[382.273937] Dynamic subtest vcs1: SUCCESS (1.898s)
[382.284079] Starting dynamic subtest: vecs0
[384.323203] Dynamic subtest vecs0: SUCCESS (2.047s)
[384.333622] Starting dynamic subtest: ccs0
[386.307454] Dynamic subtest ccs0: SUCCESS (1.983s)
[386.309708] Subtest busy: SUCCESS (8.097s)
[386.678474] [092/133] (647s left) gem_exec_reloc (basic-concurrent0)
[386.734278] Subtest basic-concurrent0: SKIP (0.000s)
[386.806201] [093/133] (647s left) gem_eio (create-ext)
[387.031434] Starting subtest: create-ext
[387.360912] Subtest create-ext: SUCCESS (0.330s)
[387.507946] [094/133] (647s left) gem_softpin (allocator-fork)
[387.575276] Starting subtest: allocator-fork
[389.791072] Subtest allocator-fork: SUCCESS (2.214s)
[389.910767] [095/133] (644s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[390.016174] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[397.286190] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.272s)
[397.404132] [096/133] (637s left) syncobj_timeline (single-wait-for-submit-signaled)
[397.463145] Starting subtest: single-wait-for-submit-signaled
[397.465470] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[397.558653] [097/133] (637s left) gem_exec_create (forked)
[397.629593] Starting subtest: forked
[397.631987] Starting dynamic subtest: smem
[417.804616] Dynamic subtest smem: SUCCESS (20.175s)
[417.806963] Subtest forked: SUCCESS (20.177s)
[417.996608] [098/133] (616s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[418.097991] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[418.100349] Starting dynamic subtest: pipe-A-default-mode
[420.835633] Dynamic subtest pipe-A-default-mode: SUCCESS (2.737s)
[420.837991] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.739s)
[421.695510] [099/133] (613s left) gem_exec_balancer (parallel-ordering)
[421.965060] Starting subtest: parallel-ordering
[422.937373] Subtest parallel-ordering: SUCCESS (0.972s)
[423.059812] [100/133] (611s left) i915_query (engine-info-invalid)
[423.118735] Starting subtest: engine-info-invalid
[423.120792] Subtest engine-info-invalid: SUCCESS (0.000s)
[423.213550] [101/133] (611s left) gen9_exec_parse (batch-zero-length)
[423.283966] Subtest batch-zero-length: SKIP (0.000s)
[423.358633] [102/133] (611s left) kms_dp_linktrain_fallback (dp-fallback)
[423.445761] Starting subtest: dp-fallback
[423.451969] Subtest dp-fallback: SKIP (0.000s)
[423.519854] [103/133] (611s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[423.613176] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[423.617212] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[423.726164] [104/133] (611s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[423.818717] Starting subtest: extended-modeset-hang-oldfb-with-reset
[423.821029] Starting dynamic subtest: pipe-A
[435.476522] Dynamic subtest pipe-A: SUCCESS (11.658s)
[435.488177] Starting dynamic subtest: pipe-D
[447.828730] Dynamic subtest pipe-D: SUCCESS (12.348s)
[447.830957] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.010s)
[448.624803] [105/133] (586s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[448.722662] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[448.726867] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[448.794620] [106/133] (586s left) gem_ctx_param (vm)
[448.849880] Starting subtest: vm
[448.897790] Subtest vm: SUCCESS (0.048s)
[449.029324] [107/133] (586s left) kms_vblank (query-forked-busy)
[449.117850] Starting subtest: query-forked-busy
[449.119688] Starting dynamic subtest: pipe-A-eDP-1
[451.011596] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.894s)
[451.027776] Starting dynamic subtest: pipe-D-eDP-1
[453.581959] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.566s)
[453.584167] Subtest query-forked-busy: SUCCESS (4.464s)
[454.389160] [108/133] (580s left) dumb_buffer (invalid-bpp)
[454.447199] Starting subtest: invalid-bpp
[454.449396] Subtest invalid-bpp: SUCCESS (0.000s)
[454.559329] [109/133] (580s left) gem_exec_schedule (promotion)
[454.645292] Starting subtest: promotion
[454.647343] Starting dynamic subtest: rcs0
[454.763466] Dynamic subtest rcs0: SUCCESS (0.125s)
[454.777032] Starting dynamic subtest: vcs0
[454.857648] Dynamic subtest vcs0: SUCCESS (0.094s)
[454.871187] Starting dynamic subtest: vcs1
[454.941086] Dynamic subtest vcs1: SUCCESS (0.082s)
[454.954559] Starting dynamic subtest: vecs0
[455.021984] Dynamic subtest vecs0: SUCCESS (0.080s)
[455.035820] Starting dynamic subtest: ccs0
[455.123484] Dynamic subtest ccs0: SUCCESS (0.101s)
[455.125866] Subtest promotion: SUCCESS (0.487s)
[456.421666] [110/133] (578s left) gem_exec_store (pages)
[456.491359] Starting subtest: pages
[456.493846] Starting dynamic subtest: rcs0
[456.571641] Dynamic subtest rcs0: SUCCESS (0.081s)
[456.582359] Starting dynamic subtest: bcs0
[456.641161] Dynamic subtest bcs0: SUCCESS (0.069s)
[456.652514] Starting dynamic subtest: vcs0
[456.705185] Dynamic subtest vcs0: SUCCESS (0.063s)
[456.715942] Starting dynamic subtest: vcs1
[456.771972] Dynamic subtest vcs1: SUCCESS (0.066s)
[456.782734] Starting dynamic subtest: vecs0
[456.836054] Dynamic subtest vecs0: SUCCESS (0.063s)
[456.848587] Starting dynamic subtest: ccs0
[456.912287] Dynamic subtest ccs0: SUCCESS (0.075s)
[456.915042] Subtest pages: SUCCESS (0.422s)
[457.102511] [111/133] (578s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[457.204470] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[458.317150] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.112s)
[458.444467] [112/133] (576s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[458.542125] Starting subtest: psr-indfb-scaledprimary
[464.258857] Subtest psr-indfb-scaledprimary: SUCCESS (5.718s)
[464.378597] [113/133] (571s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[464.476590] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[471.230344] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.758s)
[471.356549] [114/133] (564s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[471.421044] Subtest writes-after-reads-uncached: SKIP (0.000s)
[471.487428] [115/133] (564s left) gen3_render_linear_blits
[471.623541] [116/133] (563s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[471.716113] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[471.718347] Starting dynamic subtest: pipe-A-eDP-1
[471.996989] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.250s)
[472.008301] Starting dynamic subtest: pipe-B-eDP-1
[473.261417] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.262s)
[473.272787] Starting dynamic subtest: pipe-C-eDP-1
[474.465226] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.201s)
[474.482751] Starting dynamic subtest: pipe-D-eDP-1
[475.694258] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.231s)
[475.696465] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.950s)
[476.830446] [117/133] (558s left) prime_vgem (basic-read)
[476.906372] Starting subtest: basic-read
[476.931984] Subtest basic-read: SKIP (0.023s)
[477.044853] [118/133] (558s left) kms_atomic_interruptible (legacy-setmode)
[477.131963] Starting subtest: legacy-setmode
[477.134432] Starting dynamic subtest: pipe-A-eDP-1
[484.015461] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.884s)
[484.017744] Subtest legacy-setmode: SUCCESS (6.886s)
[484.896340] [119/133] (550s left) kms_chamelium_color (gamma)
[484.995583] Subtest gamma: SKIP (0.000s)
[485.043174] [120/133] (550s left) gem_ctx_persistence (legacy-engines-hostile)
[485.103262] Starting subtest: legacy-engines-hostile
[485.105753] Starting dynamic subtest: render
[485.164992] Dynamic subtest render: SUCCESS (0.061s)
[485.179307] Starting dynamic subtest: bsd1
[485.252930] Dynamic subtest bsd1: SUCCESS (0.085s)
[485.264980] Starting dynamic subtest: bsd2
[485.343651] Dynamic subtest bsd2: SUCCESS (0.088s)
[485.358582] Starting dynamic subtest: blt
[485.432822] Dynamic subtest blt: SUCCESS (0.086s)
[485.448859] Starting dynamic subtest: vebox
[485.554947] Dynamic subtest vebox: SUCCESS (0.119s)
[485.557742] Subtest legacy-engines-hostile: SUCCESS (0.453s)
[485.655999] [121/133] (550s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite)
[485.770567] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite
[493.042634] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (7.275s)
[494.211478] [122/133] (541s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[494.316252] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[494.318530] Starting dynamic subtest: A-eDP1
[497.918514] Dynamic subtest A-eDP1: SUCCESS (3.598s)
[497.932579] Starting dynamic subtest: B-eDP1
[501.227400] Dynamic subtest B-eDP1: SUCCESS (3.310s)
[501.238163] Starting dynamic subtest: C-eDP1
[504.315613] Dynamic subtest C-eDP1: SUCCESS (3.086s)
[504.327587] Starting dynamic subtest: D-eDP1
[507.407017] Dynamic subtest D-eDP1: SUCCESS (3.087s)
[507.409275] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.090s)
[508.211148] [123/133] (527s left) kms_cursor_crc (cursor-tearing-position-change)
[508.312774] Starting subtest: cursor-tearing-position-change
[508.315134] Starting dynamic subtest: pipe-A-eDP-1
[508.892510] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.576s)
[508.903491] Starting dynamic subtest: pipe-D-eDP-1
[510.146172] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.253s)
[510.148411] Subtest cursor-tearing-position-change: SUCCESS (1.832s)
[510.986997] [124/133] (524s left) gem_render_copy (linear-to-vebox-y-tiled)
[511.044563] Starting subtest: linear-to-vebox-y-tiled
[511.049284] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[511.225865] [125/133] (524s left) gem_tiled_partial_pwrite_pread (reads)
[511.286928] Subtest reads: SKIP (0.000s)
[511.368043] [126/133] (524s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[511.474037] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[511.500132] Starting dynamic subtest: pipe-A-plane-0
[511.800512] Dynamic subtest pipe-A-plane-0: SUCCESS (0.300s)
[511.812019] Starting dynamic subtest: pipe-A-plane-3
[512.045976] Dynamic subtest pipe-A-plane-3: SUCCESS (0.243s)
[512.057171] Starting dynamic subtest: pipe-A-plane-5
[512.061766] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[513.149984] Starting dynamic subtest: pipe-B-plane-0
[513.440167] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[513.454305] Starting dynamic subtest: pipe-B-plane-3
[513.673403] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[513.684631] Starting dynamic subtest: pipe-B-plane-5
[513.689167] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[513.989973] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.515s)
[514.840478] [127/133] (521s left) kms_psr (fbc-psr2-sprite-blt)
[514.935255] Starting subtest: fbc-psr2-sprite-blt
[514.937458] Starting dynamic subtest: eDP-1
[514.941497] Dynamic subtest eDP-1: SKIP (0.000s)
[514.945543] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[515.012259] [128/133] (521s left) prime_vgem (fence-write-hang)
[515.074990] Subtest fence-write-hang: SKIP (0.000s)
[515.198376] [129/133] (521s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[515.284204] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[515.286486] Starting dynamic subtest: pipe-A
[515.306071] Dynamic subtest pipe-A: SKIP (0.017s)
[515.321066] Starting dynamic subtest: pipe-B
[515.336553] Dynamic subtest pipe-B: SKIP (0.031s)
[515.347366] Starting dynamic subtest: pipe-C
[515.369942] Dynamic subtest pipe-C: SKIP (0.032s)
[515.380607] Starting dynamic subtest: pipe-D
[515.401340] Dynamic subtest pipe-D: SKIP (0.030s)
[515.405640] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.113s)
[515.506394] [130/133] (520s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[515.609024] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[516.787758] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.178s)
[516.944913] [131/133] (519s left) prime_mmap (test_reprime)
[517.007202] Starting subtest: test_reprime
[517.009570] Starting dynamic subtest: test_reprime-smem
[517.039481] Dynamic subtest test_reprime-smem: SUCCESS (0.032s)
[517.041917] Subtest test_reprime: SUCCESS (0.033s)
[517.152822] [132/133] (519s left) kms_prime (basic-crc-vgem)
[517.238808] Starting subtest: basic-crc-vgem
[517.240468] Starting dynamic subtest: second-to-first
[518.229083] Dynamic subtest second-to-first: SUCCESS (0.992s)
[518.231104] Subtest basic-crc-vgem: SUCCESS (0.994s)
[518.336777] [133/133] (518s left) gem_close_race (basic-process)
[518.433734] Starting subtest: basic-process
[518.490464] Subtest basic-process: SUCCESS (0.057s)
[518.685970] Closing watchdogs
results: parsing output: 0/ for test: kms_chamelium_color
results: parsing output: 1/ for test: kms_psr
results: parsing output: 2/ for test: gem_wait
results: parsing output: 3/ for test: i915_drm_fdinfo
results: parsing output: 4/ for test: vgem_basic
results: parsing output: 5/ for test: kms_fb_coherency
results: parsing output: 6/ for test: gem_exec_await
results: parsing output: 7/ for test: gem_mmap_offset
results: parsing output: 8/ for test: gem_close
results: parsing output: 9/ for test: gem_exec_schedule
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_eio
results: parsing output: 13/ for test: kms_psr2_sf
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: i915_pm_rpm
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: kms_psr
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_close_race
results: parsing output: 20/ for test: kms_sequence
results: parsing output: 21/ for test: kms_flip
results: parsing output: 22/ for test: kms_ccs
results: parsing output: 23/ for test: kms_ccs
results: parsing output: 24/ for test: i915_hangman
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: gem_ctx_param
results: parsing output: 27/ for test: kms_async_flips
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_cursor_legacy
results: parsing output: 30/ for test: kms_getfb
results: parsing output: 31/ for test: gem_userptr_blits
results: parsing output: 32/ for test: gem_mmap_gtt
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: perf
results: parsing output: 35/ for test: syncobj_wait
results: parsing output: 36/ for test: kms_content_protection
results: parsing output: 37/ for test: api_intel_bb
results: parsing output: 38/ for test: syncobj_wait
results: parsing output: 39/ for test: gem_busy
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_exec_reloc
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gem_lmem_swapping
results: parsing output: 44/ for test: kms_cursor_legacy
results: parsing output: 45/ for test: vgem_basic
results: parsing output: 46/ for test: gem_gpgpu_fill
results: parsing output: 47/ for test: syncobj_timeline
results: parsing output: 48/ for test: syncobj_eventfd
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: gem_exec_balancer
results: parsing output: 52/ for test: kms_pipe_crc_basic
results: parsing output: 53/ for test: kms_lease
results: parsing output: 54/ for test: kms_plane_scaling
results: parsing output: 55/ for test: gem_madvise
results: parsing output: 56/ for test: gem_exec_fence
results: parsing output: 57/ for test: gem_tiling_max_stride
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_psr2_sf
results: parsing output: 60/ for test: tools_test
results: parsing output: 61/ for test: gem_mmap_offset
results: parsing output: 62/ for test: syncobj_wait
results: parsing output: 63/ for test: kms_cursor_legacy
results: parsing output: 64/ for test: kms_flip
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_cursor_crc
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: kms_properties
results: parsing output: 69/ for test: perf_pmu
results: parsing output: 70/ for test: kms_plane_lowres
results: parsing output: 71/ for test: kms_invalid_mode
results: parsing output: 72/ for test: prime_busy
results: parsing output: 73/ for test: kms_addfb_basic
results: parsing output: 74/ for test: kms_psr
results: parsing output: 75/ for test: kms_cursor_legacy
results: parsing output: 76/ for test: syncobj_timeline
results: parsing output: 77/ for test: kms_flip_scaled_crc
results: parsing output: 78/ for test: kms_cursor_crc
results: parsing output: 79/ for test: kms_chamelium_hpd
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_rotation_crc
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: gem_render_copy
results: parsing output: 85/ for test: kms_pm_rpm
results: parsing output: 86/ for test: kms_cursor_legacy
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_color_pipeline
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: gem_busy
results: parsing output: 91/ for test: gem_exec_reloc
results: parsing output: 92/ for test: gem_eio
results: parsing output: 93/ for test: gem_softpin
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: syncobj_timeline
results: parsing output: 96/ for test: gem_exec_create
results: parsing output: 97/ for test: kms_flip_scaled_crc
results: parsing output: 98/ for test: gem_exec_balancer
results: parsing output: 99/ for test: i915_query
results: parsing output: 100/ for test: gen9_exec_parse
results: parsing output: 101/ for test: kms_dp_linktrain_fallback
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_busy
results: parsing output: 104/ for test: kms_psr2_sf
results: parsing output: 105/ for test: gem_ctx_param
results: parsing output: 106/ for test: kms_vblank
results: parsing output: 107/ for test: dumb_buffer
results: parsing output: 108/ for test: gem_exec_schedule
results: parsing output: 109/ for test: gem_exec_store
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_partial_pwrite_pread
results: parsing output: 114/ for test: gen3_render_linear_blits
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: prime_vgem
results: parsing output: 117/ for test: kms_atomic_interruptible
results: parsing output: 118/ for test: kms_chamelium_color
results: parsing output: 119/ for test: gem_ctx_persistence
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_flip
results: parsing output: 122/ for test: kms_cursor_crc
results: parsing output: 123/ for test: gem_render_copy
results: parsing output: 124/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 125/ for test: kms_plane
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: prime_vgem
results: parsing output: 128/ for test: kms_plane_scaling
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: prime_mmap
results: parsing output: 131/ for test: kms_prime
results: parsing output: 132/ for test: gem_close_race
Done.