[57.589498] Initializing watchdogs
[57.589548]   /dev/watchdog0
[57.603917] [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]
[57.608108] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.610288] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.613701] [001/130] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[57.743142] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[57.747406] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[57.870194] [002/130] (960s left) kms_vblank (crtc-id)
[57.963602] Starting subtest: crtc-id
[57.965783] Starting dynamic subtest: pipe-A-eDP-1
[58.426922] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.464s)
[58.440787] Starting dynamic subtest: pipe-D-eDP-1
[59.548502] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.125s)
[59.550831] Subtest crtc-id: SUCCESS (1.592s)
[60.404309] [003/130] (957s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[60.499596] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[60.503784] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[60.628078] [004/130] (957s left) perf (gen12-mi-rpc)
[60.757158] Starting subtest: gen12-mi-rpc
[60.759061] Starting dynamic subtest: rcs0
[60.775702] Dynamic subtest rcs0: SUCCESS (0.018s)
[60.778054] Subtest gen12-mi-rpc: SUCCESS (0.018s)
[60.809201] [005/130] (957s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[60.958821] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[60.963171] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[61.062358] [006/130] (957s left) gen7_exec_parse (chained-batch)
[61.125761] Subtest chained-batch: SKIP (0.000s)
[61.213641] [007/130] (957s left) vgem_basic (bad-flag)
[61.270763] Starting subtest: bad-flag
[61.273043] Subtest bad-flag: SUCCESS (0.000s)
[61.347143] [FACT vgem_basic (bad-flag)] new: kernel.kmod_is_loaded.vgem: true
[61.349817] [008/130] (957s left) kms_psr (psr-no-drrs)
[61.445037] Starting subtest: psr-no-drrs
[61.447033] Starting dynamic subtest: eDP-1
[63.054559] Dynamic subtest eDP-1: SUCCESS (1.611s)
[63.057033] Subtest psr-no-drrs: SUCCESS (1.611s)
[63.960605] [009/130] (954s left) gem_spin_batch (resubmit)
[64.025231] Starting subtest: resubmit
[64.027657] Starting dynamic subtest: rcs0
[64.032098] Dynamic subtest rcs0: SUCCESS (0.006s)
[64.041945] Starting dynamic subtest: bcs0
[64.044213] Dynamic subtest bcs0: SUCCESS (0.002s)
[64.051256] Starting dynamic subtest: vcs0
[64.053094] Dynamic subtest vcs0: SUCCESS (0.002s)
[64.059361] Starting dynamic subtest: vcs1
[64.061260] Dynamic subtest vcs1: SUCCESS (0.002s)
[64.067916] Starting dynamic subtest: vecs0
[64.069892] Dynamic subtest vecs0: SUCCESS (0.003s)
[64.076311] Starting dynamic subtest: ccs0
[64.078236] Dynamic subtest ccs0: SUCCESS (0.002s)
[64.080098] Subtest resubmit: SUCCESS (0.019s)
[64.305535] [010/130] (954s left) kms_chamelium_hpd (hdmi-hpd)
[64.698186] Subtest hdmi-hpd: SKIP (0.000s)
[65.549926] [011/130] (952s left) gem_userptr_blits (nohangcheck)
[65.616922] Starting subtest: nohangcheck
[65.866748] Subtest nohangcheck: SUCCESS (0.249s)
[66.028439] [012/130] (952s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[66.125571] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[66.130088] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[66.230271] [013/130] (952s left) kms_fb_coherency (memset-crc)
[66.320599] Starting subtest: memset-crc
[66.322609] Starting dynamic subtest: mmap-offset-wc
[66.956487] Dynamic subtest mmap-offset-wc: CRASH (0.147s)
[67.423352] Subtest memset-crc: CRASH (0.590s)
[67.660112] [014/130] (950s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[67.825276] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[74.554974] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.736s)
[74.758166] [015/130] (943s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[79.756481] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[79.758964] Starting dynamic subtest: pipe-A-eDP-1
[80.567325] Dynamic subtest pipe-A-eDP-1: SKIP (0.807s)
[80.576096] Starting dynamic subtest: pipe-B-eDP-1
[81.695075] Dynamic subtest pipe-B-eDP-1: SKIP (1.127s)
[81.699423] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.937s)
[82.911866] [016/130] (935s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[83.027417] Starting subtest: 4-tiled-8bpp-rotate-270
[83.047671] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.020s)
[83.187272] [017/130] (935s left) perf_pmu (invalid-open)
[83.224951] Starting subtest: invalid-open
[83.227222] Subtest invalid-open: SUCCESS (0.000s)
[83.365369] [018/130] (935s left) gem_render_copy (linear)
[83.427649] Starting subtest: linear
[83.430041] Starting dynamic subtest: smem
[83.466236] Dynamic subtest smem: SUCCESS (0.038s)
[83.468572] Subtest linear: SUCCESS (0.038s)
[83.719907] [019/130] (935s left) kms_vblank (query-forked-hang)
[83.803192] Starting subtest: query-forked-hang
[83.805628] Starting dynamic subtest: pipe-A-eDP-1
[110.671920] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.865s)
[110.686211] Starting dynamic subtest: pipe-D-eDP-1
[135.637514] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.965s)
[135.639525] Subtest query-forked-hang: SUCCESS (51.835s)
[136.460640] [020/130] (882s left) gem_exec_whisper (basic-fds-priority-all)
[136.526923] Starting subtest: basic-fds-priority-all
[158.284968] Subtest basic-fds-priority-all: SUCCESS (21.752s)
[158.491130] [021/130] (860s left) gem_exec_balancer (smoke)
[158.558812] Starting subtest: smoke
[181.148238] Subtest smoke: SUCCESS (22.586s)
[183.007236] [022/130] (835s left) gem_bad_reloc (negative-reloc)
[183.062366] Subtest negative-reloc: SKIP (0.000s)
[183.137490] [023/130] (835s left) kms_lease (master-vs-lease)
[183.228250] Starting subtest: master-vs-lease
[183.232889] Subtest master-vs-lease: SUCCESS (0.003s)
[183.368621] [024/130] (835s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[183.473050] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[183.475262] Starting dynamic subtest: pipe-A-default-mode
[183.785154] Dynamic subtest pipe-A-default-mode: SKIP (0.311s)
[183.789571] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.312s)
[184.590821] [025/130] (834s left) kms_psr (pr-cursor-plane-onoff)
[184.694694] Starting subtest: pr-cursor-plane-onoff
[184.698669] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[184.790927] [026/130] (834s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[184.884392] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[184.886630] Starting dynamic subtest: pipe-A-default-mode
[185.175513] Dynamic subtest pipe-A-default-mode: SKIP (0.286s)
[185.180244] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.287s)
[186.019551] [027/130] (833s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[186.116973] Starting subtest: bad-aux-stride-y-tiled-ccs
[186.119256] Starting dynamic subtest: pipe-A-eDP-1
[186.141850] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[186.152441] Starting dynamic subtest: pipe-B-eDP-1
[186.173318] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[186.180996] Starting dynamic subtest: pipe-C-eDP-1
[186.201251] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[186.208548] Starting dynamic subtest: pipe-D-eDP-1
[186.229734] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[186.234034] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.003s)
[188.380899] [028/130] (830s left) kms_psr2_su (page_flip-nv12)
[188.435710] Subtest page_flip-NV12: SKIP (0.000s)
[188.490766] [029/130] (830s left) kms_addfb_basic (addfb25-4-tiled)
[188.588166] Starting subtest: addfb25-4-tiled
[188.590074] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[188.708669] [030/130] (830s left) syncobj_wait (wait-any-complex)
[188.772037] Starting subtest: wait-any-complex
[188.832447] Subtest wait-any-complex: SUCCESS (0.062s)
[188.934108] [031/130] (830s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[189.021176] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[189.023865] Starting dynamic subtest: pipe-A-eDP-1
[189.050328] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[189.064207] Starting dynamic subtest: pipe-B-eDP-1
[189.088653] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[189.097619] Starting dynamic subtest: pipe-C-eDP-1
[189.121192] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[189.129092] Starting dynamic subtest: pipe-D-eDP-1
[189.152769] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[189.157656] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s)
[191.333498] [032/130] (828s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[191.429247] Starting subtest: plane-scaler-unity-scaling-with-rotation
[191.431283] Starting dynamic subtest: pipe-A
[191.657978] Dynamic subtest pipe-A: SUCCESS (0.231s)
[191.676047] Starting dynamic subtest: pipe-B
[193.022703] Dynamic subtest pipe-B: SUCCESS (1.363s)
[193.032680] Starting dynamic subtest: pipe-C
[194.341454] Dynamic subtest pipe-C: SUCCESS (1.319s)
[194.351262] Starting dynamic subtest: pipe-D
[195.673333] Dynamic subtest pipe-D: SUCCESS (1.331s)
[195.675528] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.247s)
[196.858426] [033/130] (822s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[196.979965] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[196.984092] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[197.116854] [034/130] (822s left) gem_exec_schedule (semaphore-resolve)
[197.199862] Starting subtest: semaphore-resolve
[197.236334] Subtest semaphore-resolve: SUCCESS (0.045s)
[197.622240] [035/130] (821s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[197.805889] Starting subtest: cursor-rapid-movement-128x128
[197.811443] Starting dynamic subtest: pipe-A-eDP-1
[198.367268] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.556s)
[198.393612] Starting dynamic subtest: pipe-D-eDP-1
[199.561938] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.175s)
[199.564355] Subtest cursor-rapid-movement-128x128: SUCCESS (1.755s)
[200.412956] [036/130] (819s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[200.524847] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[200.527134] Starting dynamic subtest: pipe-A-eDP-1
[201.841227] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.313s)
[202.123675] Starting dynamic subtest: pipe-B-eDP-1
[203.164226] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.048s)
[203.432276] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.906s)
[204.293982] [037/130] (815s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[204.392447] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[204.396845] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[204.523231] [038/130] (815s left) gem_mmap_gtt (fault-concurrent-x)
[204.579046] Subtest fault-concurrent-X: SKIP (0.000s)
[204.666383] [039/130] (814s left) kms_pipe_crc_basic (suspend-read-crc)
[204.777142] Starting subtest: suspend-read-crc
[204.779286] Starting dynamic subtest: pipe-A-eDP-1
[222.794950] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.131s)
[222.805610] Starting dynamic subtest: pipe-B-eDP-1
[240.751726] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.198s)
[240.766984] Starting dynamic subtest: pipe-C-eDP-1
[258.683341] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.038s)
[258.692672] Starting dynamic subtest: pipe-D-eDP-1
[276.690443] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.060s)
[276.692728] Subtest suspend-read-crc: SUCCESS (15.431s)
[277.549839] [040/130] (742s left) gem_eio (wait-immediate)
[277.777076] Starting subtest: wait-immediate
[278.134903] Subtest wait-immediate: SUCCESS (0.361s)
[278.309501] [041/130] (741s left) kms_big_fb (linear-64bpp-rotate-270)
[278.413527] Starting subtest: linear-64bpp-rotate-270
[278.433017] Subtest linear-64bpp-rotate-270: SKIP (0.019s)
[278.591829] [042/130] (741s left) kms_plane (pixel-format)
[278.686476] Starting subtest: pixel-format
[278.714274] Starting dynamic subtest: pipe-A-plane-0
[283.651942] Dynamic subtest pipe-A-plane-0: SUCCESS (4.978s)
[283.663196] Starting dynamic subtest: pipe-A-plane-3
[285.896047] Dynamic subtest pipe-A-plane-3: SUCCESS (2.255s)
[285.906116] Starting dynamic subtest: pipe-A-plane-5
[286.106284] Dynamic subtest pipe-A-plane-5: SUCCESS (0.211s)
[287.237802] Starting dynamic subtest: pipe-B-plane-0
[292.042990] Dynamic subtest pipe-B-plane-0: SUCCESS (4.832s)
[292.052278] Starting dynamic subtest: pipe-B-plane-3
[294.316189] Dynamic subtest pipe-B-plane-3: SUCCESS (2.277s)
[294.325707] Starting dynamic subtest: pipe-B-plane-5
[294.527157] Dynamic subtest pipe-B-plane-5: SUCCESS (0.210s)
[294.859168] Subtest pixel-format: SUCCESS (16.249s)
[295.723421] [043/130] (724s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[295.790208] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[295.896613] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.105s)
[295.995373] [044/130] (723s left) kms_debugfs (display-on-read-all)
[296.095274] Starting subtest: display-on-read-all
[296.255547] Subtest display-on-read-all: SUCCESS (0.163s)
[296.427848] [045/130] (723s left) gem_mmap_wc (pf-nonblock)
[296.494448] Subtest pf-nonblock: SKIP (0.000s)
[296.561141] [046/130] (723s left) kms_psr (psr-suspend)
[296.643822] Starting subtest: psr-suspend
[296.646145] Starting dynamic subtest: eDP-1
[314.303130] Dynamic subtest eDP-1: SUCCESS (2.923s)
[314.305031] Subtest psr-suspend: SUCCESS (2.924s)
[315.170894] [047/130] (704s left) kms_rotation_crc (sprite-rotation-270)
[315.267533] Starting subtest: sprite-rotation-270
[315.272281] Subtest sprite-rotation-270: SKIP (0.002s)
[315.369336] [048/130] (704s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[315.469345] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[321.902920] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.498s)
[322.071703] [049/130] (698s left) gem_render_copy (yf-tiled-ccs-to-linear)
[322.118933] Starting subtest: yf-tiled-ccs-to-linear
[322.123446] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[322.328002] [050/130] (697s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[322.420897] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[322.423141] Starting dynamic subtest: pipe-A-eDP-1
[324.600175] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.191s)
[324.609653] Starting dynamic subtest: pipe-B-eDP-1
[326.783483] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.190s)
[326.793606] Starting dynamic subtest: pipe-C-eDP-1
[328.875029] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.098s)
[328.884888] Starting dynamic subtest: pipe-D-eDP-1
[330.866145] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.994s)
[330.868491] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.479s)
[332.133507] [051/130] (688s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[332.231473] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[332.235756] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[332.346513] [052/130] (687s left) kms_psr (fbc-psr-cursor-blt)
[332.436562] Starting subtest: fbc-psr-cursor-blt
[332.438881] Starting dynamic subtest: eDP-1
[332.443131] Dynamic subtest eDP-1: SKIP (0.000s)
[332.447282] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[332.535223] [053/130] (687s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[332.629963] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[332.633905] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[332.760572] [054/130] (687s left) gem_close_race (multigpu-basic-process)
[332.824741] Starting subtest: multigpu-basic-process
[332.829092] Subtest multigpu-basic-process: SKIP (0.000s)
[333.085506] [055/130] (687s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[335.422424] Starting subtest: modeset-non-lpsp-stress-no-wait
[335.486780] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.064s)
[335.850180] [056/130] (684s left) gem_render_copy_redux (flink-interruptible)
[335.912153] Starting subtest: flink-interruptible
[336.626544] Subtest flink-interruptible: SUCCESS (0.716s)
[336.793602] [057/130] (683s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[336.894070] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[341.513511] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (4.626s)
[342.654889] [058/130] (677s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[342.764852] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[342.768490] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[342.895978] [059/130] (677s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[342.995387] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[342.999772] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[343.109049] [060/130] (677s left) kms_cursor_crc (cursor-onscreen-32x32)
[343.251116] Starting subtest: cursor-onscreen-32x32
[343.301764] Subtest cursor-onscreen-32x32: SKIP (0.044s)
[343.595542] [061/130] (676s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[343.685298] Starting subtest: y-tiled-addfb-size-offset-overflow
[343.689033] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[343.804356] [062/130] (676s left) kms_chamelium_color (ctm-blue-to-red)
[343.892399] Subtest ctm-blue-to-red: SKIP (0.000s)
[343.934973] [063/130] (676s left) gem_partial_pwrite_pread (reads)
[344.012057] Subtest reads: SKIP (0.000s)
[344.115057] [064/130] (676s left) kms_flip (2x-blocking-wf_vblank)
[344.214618] Starting subtest: 2x-blocking-wf_vblank
[344.223089] Subtest 2x-blocking-wf_vblank: SKIP (0.010s)
[344.369880] [065/130] (676s left) gem_exec_balancer (parallel)
[344.632642] Starting subtest: parallel
[345.522071] Subtest parallel: SUCCESS (0.890s)
[346.320823] [066/130] (674s left) prime_busy (after-wait)
[346.383465] Starting subtest: after-wait
[346.388240] Starting dynamic subtest: rcs0
[346.406637] Dynamic subtest rcs0: SUCCESS (0.020s)
[346.416692] Starting dynamic subtest: bcs0
[346.480385] Dynamic subtest bcs0: SUCCESS (0.072s)
[346.491840] Starting dynamic subtest: vcs0
[346.520522] Dynamic subtest vcs0: SUCCESS (0.041s)
[346.530286] Starting dynamic subtest: vcs1
[346.559825] Dynamic subtest vcs1: SUCCESS (0.039s)
[346.569460] Starting dynamic subtest: vecs0
[346.601471] Dynamic subtest vecs0: SUCCESS (0.041s)
[346.611295] Starting dynamic subtest: ccs0
[346.640577] Dynamic subtest ccs0: SUCCESS (0.038s)
[346.746212] Subtest after-wait: SUCCESS (0.363s)
[346.850300] [067/130] (673s left) syncobj_wait (multi-wait-submitted-signaled)
[346.900681] Starting subtest: multi-wait-submitted-signaled
[346.902841] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[347.040573] [068/130] (673s left) gem_ctx_sseu (invalid-sseu)
[347.107292] Subtest invalid-sseu: SKIP (0.000s)
[347.187528] [069/130] (673s left) kms_flip (basic-flip-vs-dpms)
[347.284216] Starting subtest: basic-flip-vs-dpms
[347.286286] Starting dynamic subtest: A-eDP1
[349.829968] Dynamic subtest A-eDP1: SUCCESS (2.543s)
[349.841021] Starting dynamic subtest: B-eDP1
[351.972921] Dynamic subtest B-eDP1: SUCCESS (2.141s)
[351.983785] Starting dynamic subtest: C-eDP1
[354.042680] Dynamic subtest C-eDP1: SUCCESS (2.069s)
[354.053522] Starting dynamic subtest: D-eDP1
[356.116229] Dynamic subtest D-eDP1: SUCCESS (2.072s)
[356.118472] Subtest basic-flip-vs-dpms: SUCCESS (8.832s)
[356.963423] [070/130] (664s left) gem_pwrite_snooped
[357.105325] [071/130] (663s left) kms_panel_fitting (legacy)
[357.201751] Starting subtest: legacy
[357.203986] Starting dynamic subtest: pipe-A-eDP-1
[357.728437] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.528s)
[357.758533] Starting dynamic subtest: pipe-B-eDP-1
[359.258659] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.509s)
[359.287043] Starting dynamic subtest: pipe-C-eDP-1
[360.762880] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.483s)
[360.795137] Starting dynamic subtest: pipe-D-eDP-1
[362.297987] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.515s)
[362.300337] Subtest legacy: SUCCESS (5.097s)
[363.564171] [072/130] (657s left) kms_flip_tiling (flip-change-tiling)
[363.669616] Starting subtest: flip-change-tiling
[363.671793] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs
[363.841647] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.173s)
[363.854661] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs
[363.975818] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s)
[363.986702] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[364.109001] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.132s)
[364.120229] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4
[364.252643] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s)
[364.265798] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x
[364.396132] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.141s)
[364.408665] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear
[364.540882] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s)
[364.553535] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs
[364.674987] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s)
[364.687538] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs
[364.786063] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[364.798354] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[364.920273] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[364.935900] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4
[365.052926] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.131s)
[365.065928] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x
[365.196607] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s)
[365.209230] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear
[365.340898] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s)
[365.352994] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[365.474289] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s)
[365.486736] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[365.609292] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s)
[365.621549] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[365.719524] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.108s)
[365.730968] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4
[365.863676] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.142s)
[365.876469] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x
[366.007678] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s)
[366.022715] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear
[366.179250] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.169s)
[366.191721] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs
[366.313489] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.131s)
[366.327878] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs
[366.446529] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.130s)
[366.459180] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc
[366.579849] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.131s)
[366.592774] Starting dynamic subtest: pipe-A-eDP-1-4-to-4
[366.729267] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.147s)
[366.741939] Starting dynamic subtest: pipe-A-eDP-1-4-to-x
[366.901077] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.170s)
[366.915826] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear
[367.045087] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.142s)
[367.058347] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs
[367.178742] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.131s)
[367.190801] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs
[367.323007] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[367.337825] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc
[367.467219] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s)
[367.480357] Starting dynamic subtest: pipe-A-eDP-1-x-to-4
[367.611911] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.142s)
[367.626022] Starting dynamic subtest: pipe-A-eDP-1-x-to-x
[367.734648] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.120s)
[367.744575] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear
[367.878939] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.142s)
[367.891179] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs
[368.023062] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[368.037140] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs
[368.168082] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s)
[368.181933] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc
[368.312409] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s)
[368.323910] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4
[368.456602] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.142s)
[368.470894] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x
[368.628853] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.170s)
[368.643570] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear
[368.790637] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.159s)
[368.843667] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs
[370.094033] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.258s)
[370.106480] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs
[370.228670] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s)
[370.242245] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[370.362064] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[370.375501] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4
[370.505300] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s)
[370.517329] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x
[370.649188] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s)
[370.661755] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear
[370.793579] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s)
[370.806097] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs
[370.927370] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s)
[370.942661] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs
[371.038639] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[371.050910] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[371.172962] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[371.186142] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4
[371.316680] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s)
[371.329559] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x
[371.460309] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s)
[371.472217] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear
[371.604206] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s)
[371.618428] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[371.738558] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.132s)
[371.750649] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[371.873294] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s)
[371.885663] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[371.994110] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.120s)
[372.006448] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4
[372.138393] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.142s)
[372.150313] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x
[372.282210] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s)
[372.294217] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear
[372.426627] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s)
[372.439027] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs
[372.560166] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.131s)
[372.573165] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs
[372.693690] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.131s)
[372.706305] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc
[372.827495] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.131s)
[372.840243] Starting dynamic subtest: pipe-B-eDP-1-4-to-4
[372.948702] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.119s)
[372.960918] Starting dynamic subtest: pipe-B-eDP-1-4-to-x
[373.092547] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.142s)
[373.105338] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear
[373.237160] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.142s)
[373.252035] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs
[373.381497] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s)
[373.396580] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs
[373.526242] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.140s)
[373.540654] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc
[373.670581] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.141s)
[373.685409] Starting dynamic subtest: pipe-B-eDP-1-x-to-4
[373.814748] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.142s)
[373.829617] Starting dynamic subtest: pipe-B-eDP-1-x-to-x
[373.937336] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.120s)
[373.949789] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear
[374.082468] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.143s)
[374.095285] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs
[374.226667] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[374.238558] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs
[374.370561] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s)
[374.382904] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc
[374.514907] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s)
[374.529482] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4
[374.659209] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.142s)
[374.673043] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x
[374.804172] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.142s)
[374.816532] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear
[374.926359] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.120s)
[374.979410] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs
[376.227440] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.255s)
[376.240363] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs
[376.327384] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[376.339883] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[376.427101] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[376.438678] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4
[376.538179] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.109s)
[376.550633] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x
[376.648733] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s)
[376.660418] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear
[376.798143] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.148s)
[376.810270] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs
[376.899048] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.098s)
[376.911238] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs
[376.999134] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[377.011182] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[377.098642] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[377.110633] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4
[377.209396] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.109s)
[377.221442] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x
[377.320093] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s)
[377.331071] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear
[377.431228] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.109s)
[377.443074] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[377.531874] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.098s)
[377.543897] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[377.631995] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s)
[377.643163] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[377.731940] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s)
[377.743152] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4
[377.831913] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.098s)
[377.843869] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x
[377.942102] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.110s)
[377.953475] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear
[378.041980] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.098s)
[378.053871] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs
[378.142378] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.099s)
[378.154714] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs
[378.242646] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.098s)
[378.255497] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc
[378.342800] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.099s)
[378.356053] Starting dynamic subtest: pipe-C-eDP-1-4-to-4
[378.454069] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.109s)
[378.466823] Starting dynamic subtest: pipe-C-eDP-1-4-to-x
[378.564135] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.109s)
[378.575970] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear
[378.675534] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.109s)
[378.687109] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs
[378.775489] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.099s)
[378.787437] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs
[378.875120] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.099s)
[378.887384] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc
[378.975391] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.099s)
[378.987281] Starting dynamic subtest: pipe-C-eDP-1-x-to-4
[379.086585] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.110s)
[379.102100] Starting dynamic subtest: pipe-C-eDP-1-x-to-x
[379.197907] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.110s)
[379.211046] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear
[379.308847] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.109s)
[379.323099] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs
[379.419805] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s)
[379.432092] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs
[379.519608] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.098s)
[379.534794] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc
[379.630830] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.110s)
[379.642943] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4
[379.741830] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.109s)
[379.756891] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x
[379.863997] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.121s)
[379.883313] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear
[379.975316] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.109s)
[380.016660] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs
[381.259645] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.249s)
[381.271429] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs
[381.359408] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[381.370639] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[381.459561] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[381.470867] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4
[381.570444] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.109s)
[381.582523] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x
[381.680988] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s)
[381.693051] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear
[381.803331] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.121s)
[381.817243] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs
[381.926134] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.120s)
[381.938012] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs
[382.037459] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[382.049779] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[382.137180] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.097s)
[382.149639] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4
[382.247612] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.109s)
[382.259064] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x
[382.358884] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s)
[382.370641] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear
[382.469446] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.109s)
[382.481135] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[382.570091] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.098s)
[382.582284] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[382.669665] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s)
[382.681535] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[382.769818] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s)
[382.780474] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4
[382.880906] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.109s)
[382.892323] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x
[382.991523] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s)
[383.003672] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear
[383.102280] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.109s)
[383.114140] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs
[383.214116] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.109s)
[383.226840] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs
[383.325460] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.109s)
[383.337108] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc
[383.425650] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.098s)
[383.438067] Starting dynamic subtest: pipe-D-eDP-1-4-to-4
[383.536457] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.109s)
[383.548796] Starting dynamic subtest: pipe-D-eDP-1-4-to-x
[383.646515] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.109s)
[383.657579] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear
[383.757960] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.109s)
[383.769656] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs
[383.857853] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.098s)
[383.869855] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs
[383.957584] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.098s)
[383.969664] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc
[384.069030] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.110s)
[384.079617] Starting dynamic subtest: pipe-D-eDP-1-x-to-4
[384.180079] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.109s)
[384.192268] Starting dynamic subtest: pipe-D-eDP-1-x-to-x
[384.291439] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.109s)
[384.305292] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear
[384.402694] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.110s)
[384.415731] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs
[384.513111] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s)
[384.524904] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs
[384.625082] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.110s)
[384.636604] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc
[384.735619] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.109s)
[384.746218] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4
[384.857437] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.120s)
[384.869036] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x
[384.968822] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.110s)
[384.980827] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear
[385.102334] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.131s)
[385.135318] Subtest flip-change-tiling: SUCCESS (21.472s)
[386.373887] [073/130] (634s left) gem_userptr_blits (forbidden-operations)
[386.445394] Starting subtest: forbidden-operations
[386.449624] Subtest forbidden-operations: SKIP (0.000s)
[386.613600] [074/130] (634s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[386.722365] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[393.679656] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (6.962s)
[393.821545] [075/130] (627s left) gem_eio (in-flight-contexts-10ms)
[394.067443] Starting subtest: in-flight-contexts-10ms
[405.299482] Subtest in-flight-contexts-10ms: SUCCESS (11.238s)
[405.509187] [076/130] (615s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[405.597821] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[405.602340] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[406.689841] [077/130] (614s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[406.753801] Starting subtest: multi-wait-all-for-submit-available-submitted
[406.756218] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[406.898674] [078/130] (614s left) kms_chamelium_frames (vga-frame-dump)
[407.282226] Subtest vga-frame-dump: SKIP (0.000s)
[408.076548] [079/130] (613s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[408.178217] Starting subtest: fbc-rgb565-draw-mmap-gtt
[408.182506] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[408.312104] [080/130] (613s left) i915_drm_fdinfo (most-busy-check-all)
[408.351369] Starting subtest: most-busy-check-all
[408.353647] Starting dynamic subtest: rcs0
[408.358228] Dynamic subtest rcs0: SKIP (0.004s)
[408.372913] Starting dynamic subtest: bcs0
[408.377428] Dynamic subtest bcs0: SKIP (0.000s)
[408.388936] Starting dynamic subtest: vcs0
[408.393312] Dynamic subtest vcs0: SKIP (0.000s)
[408.402552] Starting dynamic subtest: vcs1
[408.407069] Dynamic subtest vcs1: SKIP (0.000s)
[408.418525] Starting dynamic subtest: vecs0
[408.422716] Dynamic subtest vecs0: SKIP (0.000s)
[408.431233] Starting dynamic subtest: ccs0
[408.435426] Dynamic subtest ccs0: SKIP (0.000s)
[408.439714] Subtest most-busy-check-all: SKIP (0.009s)
[408.477113] [081/130] (612s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[413.575363] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[413.577603] Starting dynamic subtest: pipe-A-eDP-1
[414.353976] Dynamic subtest pipe-A-eDP-1: SKIP (0.774s)
[414.364790] Starting dynamic subtest: pipe-B-eDP-1
[415.488403] Dynamic subtest pipe-B-eDP-1: SKIP (1.130s)
[415.493130] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.909s)
[416.694115] [082/130] (604s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[416.812069] Starting subtest: flip-vs-cursor-atomic-transitions
[424.282578] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.469s)
[425.131568] [083/130] (596s left) gem_mmap_gtt (medium-copy-odd)
[425.195536] Subtest medium-copy-odd: SKIP (0.000s)
[425.261361] [084/130] (596s left) gem_ctx_persistence (engines-hostile)
[425.322631] Starting subtest: engines-hostile
[425.324978] Starting dynamic subtest: rcs0
[425.485958] Dynamic subtest rcs0: SUCCESS (0.162s)
[425.498681] Starting dynamic subtest: bcs0
[425.609459] Dynamic subtest bcs0: SUCCESS (0.122s)
[425.622661] Starting dynamic subtest: vcs0
[425.724452] Dynamic subtest vcs0: SUCCESS (0.113s)
[425.736826] Starting dynamic subtest: vcs1
[425.838521] Dynamic subtest vcs1: SUCCESS (0.112s)
[425.850848] Starting dynamic subtest: vecs0
[425.955291] Dynamic subtest vecs0: SUCCESS (0.115s)
[425.967929] Starting dynamic subtest: ccs0
[426.083135] Dynamic subtest ccs0: SUCCESS (0.125s)
[426.085366] Subtest engines-hostile: SUCCESS (0.762s)
[426.185207] [085/130] (595s left) core_auth (basic-auth)
[426.237370] Starting subtest: basic-auth
[426.239451] Subtest basic-auth: SUCCESS (0.001s)
[426.375145] [086/130] (595s left) kms_cursor_edge_walk (256x256-right-edge)
[426.467005] Starting subtest: 256x256-right-edge
[426.468862] Starting dynamic subtest: pipe-A-eDP-1
[429.960882] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.491s)
[429.971391] Starting dynamic subtest: pipe-D-eDP-1
[433.087220] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.125s)
[433.089555] Subtest 256x256-right-edge: SUCCESS (6.619s)
[433.927364] [087/130] (587s left) syncobj_wait (invalid-single-wait-unsubmitted)
[433.989976] Starting subtest: invalid-single-wait-unsubmitted
[433.992309] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[434.134404] [088/130] (587s left) prime_vgem (coherency-gtt)
[434.218035] Starting subtest: coherency-gtt
[434.222211] Subtest coherency-gtt: SKIP (0.000s)
[434.363381] [089/130] (587s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[434.454447] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[434.456648] Starting dynamic subtest: pipe-A-eDP-1
[435.334804] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.873s)
[435.344760] Starting dynamic subtest: pipe-B-eDP-1
[436.815718] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.479s)
[436.825966] Starting dynamic subtest: pipe-C-eDP-1
[438.337632] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.519s)
[438.348839] Starting dynamic subtest: pipe-D-eDP-1
[439.864783] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.527s)
[439.867115] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.403s)
[441.065126] [090/130] (580s left) i915_pm_rc6_residency (rc6-idle)
[441.118211] Starting subtest: rc6-idle
[441.146292] Starting dynamic subtest: gt0-rcs0
[465.487829] Dynamic subtest gt0-rcs0: SUCCESS (24.343s)
[465.499431] Starting dynamic subtest: gt0-bcs0
[489.813422] Dynamic subtest gt0-bcs0: SUCCESS (24.328s)
[489.825339] Starting dynamic subtest: gt0-ccs0
[514.227907] Dynamic subtest gt0-ccs0: SUCCESS (24.418s)
[514.240097] Starting dynamic subtest: gt1-vcs0
[520.401817] Dynamic subtest gt1-vcs0: SUCCESS (6.171s)
[520.412346] Starting dynamic subtest: gt1-vecs0
[526.576012] Dynamic subtest gt1-vecs0: SUCCESS (6.171s)
[526.578448] Subtest rc6-idle: SUCCESS (85.473s)
[526.679237] [091/130] (495s left) gem_exec_reloc (basic-wc-read-noreloc)
[526.752119] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[526.821867] [092/130] (495s left) gem_create (create-valid-nonaligned)
[526.879459] Starting subtest: create-valid-nonaligned
[526.881307] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[527.090400] [093/130] (494s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[527.197167] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[527.201404] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[527.323734] [094/130] (494s left) syncobj_basic (bad-flags-handle-to-fd)
[527.376389] Starting subtest: bad-flags-handle-to-fd
[527.378387] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[527.515311] [095/130] (494s left) gem_exec_fence (syncobj-signal)
[528.008322] Starting subtest: syncobj-signal
[528.014432] Subtest syncobj-signal: SUCCESS (0.006s)
[529.355838] [096/130] (492s left) syncobj_timeline (multi-wait-signaled)
[529.421891] Starting subtest: multi-wait-signaled
[529.424202] Subtest multi-wait-signaled: SUCCESS (0.001s)
[529.561011] [097/130] (492s left) kms_async_flips (invalid-async-flip-atomic)
[529.668576] Starting subtest: invalid-async-flip-atomic
[530.040643] Starting dynamic subtest: pipe-A-eDP-1
[531.391958] Dynamic subtest pipe-A-eDP-1: FAIL (0.768s)
[531.403233] Starting dynamic subtest: pipe-B-eDP-1
[532.317424] Dynamic subtest pipe-B-eDP-1: FAIL (0.754s)
[532.329579] Starting dynamic subtest: pipe-C-eDP-1
[533.084535] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.779s)
[533.438496] Starting dynamic subtest: pipe-D-eDP-1
[534.211046] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.782s)
[534.213431] Subtest invalid-async-flip-atomic: FAIL (4.546s)
[535.383415] [098/130] (486s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[535.488909] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[536.345687] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.859s)
[536.545107] [099/130] (485s left) i915_hangman (engine-error-state-capture)
[536.621542] Starting subtest: engine-error-state-capture
[536.623878] Starting dynamic subtest: rcs0
[540.204543] Dynamic subtest rcs0: SUCCESS (3.583s)
[540.217868] Starting dynamic subtest: bcs0
[546.222085] Dynamic subtest bcs0: SUCCESS (6.013s)
[546.234828] Starting dynamic subtest: vcs0
[552.173175] Dynamic subtest vcs0: SUCCESS (5.946s)
[552.186774] Starting dynamic subtest: vcs1
[557.165857] Dynamic subtest vcs1: SUCCESS (4.988s)
[557.179260] Starting dynamic subtest: vecs0
[562.158419] Dynamic subtest vecs0: SUCCESS (4.988s)
[562.173309] Starting dynamic subtest: ccs0
[568.237655] Dynamic subtest ccs0: SUCCESS (6.075s)
[568.240646] Subtest engine-error-state-capture: SUCCESS (31.609s)
[568.408127] [100/130] (453s left) i915_pm_rps (waitboost)
[568.472661] Starting subtest: waitboost
[574.588857] Subtest waitboost: SUCCESS (6.115s)
[574.748170] [101/130] (447s left) kms_flip (modeset-vs-vblank-race-interruptible)
[574.850314] Starting subtest: modeset-vs-vblank-race-interruptible
[574.852447] Starting dynamic subtest: A-eDP1
[579.492652] Dynamic subtest A-eDP1: SUCCESS (4.640s)
[579.508709] Starting dynamic subtest: B-eDP1
[584.148556] Dynamic subtest B-eDP1: SUCCESS (4.653s)
[584.161697] Starting dynamic subtest: C-eDP1
[588.751837] Dynamic subtest C-eDP1: SUCCESS (4.601s)
[588.762929] Starting dynamic subtest: D-eDP1
[593.368296] Dynamic subtest D-eDP1: SUCCESS (4.615s)
[593.370618] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.519s)
[594.649262] [102/130] (427s left) kms_pm_dc (dc5-retention-flops)
[595.749634] Starting subtest: dc5-retention-flops
[595.754082] Subtest dc5-retention-flops: SKIP (0.000s)
[595.849569] [103/130] (426s left) perf_pmu (rc6)
[595.888223] Starting subtest: rc6
[595.890341] Starting dynamic subtest: gt0
[602.247177] Dynamic subtest gt0: SUCCESS (6.357s)
[602.259935] Starting dynamic subtest: runtime-pm-gt0
[609.958179] Dynamic subtest runtime-pm-gt0: SUCCESS (7.708s)
[609.970834] Starting dynamic subtest: runtime-pm-long-gt0
[622.404496] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.444s)
[622.417665] Starting dynamic subtest: other-idle-gt0
[628.747915] Dynamic subtest other-idle-gt0: SUCCESS (6.341s)
[628.760460] Starting dynamic subtest: gt1
[635.089927] Dynamic subtest gt1: SUCCESS (6.340s)
[635.103104] Starting dynamic subtest: runtime-pm-gt1
[642.538518] Dynamic subtest runtime-pm-gt1: SUCCESS (7.446s)
[642.551456] Starting dynamic subtest: runtime-pm-long-gt1
[654.986400] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.446s)
[654.999428] Starting dynamic subtest: other-idle-gt1
[661.329234] Dynamic subtest other-idle-gt1: SUCCESS (6.341s)
[661.332121] Subtest rc6: SUCCESS (65.443s)
[662.468512] [104/130] (359s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[662.590867] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[662.595360] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[662.677887] [105/130] (359s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[662.732730] Starting subtest: legacy-engines-hostile-preempt
[662.734479] Starting dynamic subtest: render
[662.860488] Dynamic subtest render: SUCCESS (0.129s)
[662.874830] Starting dynamic subtest: bsd1
[664.252954] Dynamic subtest bsd1: SUCCESS (1.388s)
[664.265410] Starting dynamic subtest: bsd2
[666.230978] Dynamic subtest bsd2: SUCCESS (1.975s)
[666.243769] Starting dynamic subtest: blt
[666.366468] Dynamic subtest blt: SUCCESS (0.134s)
[666.382526] Starting dynamic subtest: vebox
[668.256890] Dynamic subtest vebox: SUCCESS (1.886s)
[668.259462] Subtest legacy-engines-hostile-preempt: SUCCESS (5.526s)
[668.312742] [106/130] (354s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[668.423766] Starting subtest: fbc-psr2-sprite-mmap-cpu
[668.426096] Starting dynamic subtest: eDP-1
[668.430440] Dynamic subtest eDP-1: SKIP (0.000s)
[668.434888] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[668.473654] [107/130] (354s left) kms_color (degamma)
[668.568874] Starting subtest: degamma
[668.570745] Starting dynamic subtest: pipe-A-eDP-1
[669.287984] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.719s)
[669.298075] Starting dynamic subtest: pipe-B-eDP-1
[670.709642] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.422s)
[670.720563] Starting dynamic subtest: pipe-C-eDP-1
[672.061483] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.351s)
[672.072183] Starting dynamic subtest: pipe-D-eDP-1
[673.398220] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.336s)
[673.400347] Subtest degamma: SUCCESS (4.831s)
[674.174525] [108/130] (348s left) gem_exec_fence (syncobj-timeline-signal)
[674.755248] Starting subtest: syncobj-timeline-signal
[674.761508] Subtest syncobj-timeline-signal: SUCCESS (0.007s)
[676.317990] [109/130] (346s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[676.429052] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[677.407642] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (0.978s)
[677.540453] [110/130] (345s left) gem_exec_reloc (basic-cpu-wc)
[677.609277] Subtest basic-cpu-wc: SKIP (0.000s)
[677.682281] [111/130] (344s left) gem_mmap_gtt (close-race)
[677.751446] Subtest close-race: SKIP (0.000s)
[677.819742] [112/130] (344s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[677.916518] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[677.918588] Starting dynamic subtest: pipe-A
[677.938655] Dynamic subtest pipe-A: SKIP (0.017s)
[677.948930] Starting dynamic subtest: pipe-B
[677.969041] Dynamic subtest pipe-B: SKIP (0.030s)
[677.978733] Starting dynamic subtest: pipe-C
[678.001221] Dynamic subtest pipe-C: SKIP (0.030s)
[678.011218] Starting dynamic subtest: pipe-D
[678.030775] Dynamic subtest pipe-D: SKIP (0.029s)
[678.033918] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.109s)
[678.117818] [113/130] (344s left) kms_getfb (getfb2-handle-closed)
[678.214951] Starting subtest: getfb2-handle-closed
[678.216891] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[678.311612] [114/130] (344s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[678.400933] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[682.713970] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.315s)
[683.888693] [115/130] (338s left) api_intel_bb (render)
[683.955174] Starting subtest: render
[683.957424] Starting dynamic subtest: render-none-512
[684.055976] Dynamic subtest render-none-512: SUCCESS (0.102s)
[684.067362] Starting dynamic subtest: render-none-1024
[684.432047] Dynamic subtest render-none-1024: SUCCESS (0.373s)
[684.445991] Starting dynamic subtest: render-x-512
[684.513655] Dynamic subtest render-x-512: SUCCESS (0.083s)
[684.526278] Starting dynamic subtest: render-x-1024
[684.853335] Dynamic subtest render-x-1024: SUCCESS (0.337s)
[684.865825] Starting dynamic subtest: render-y-512
[684.940821] Dynamic subtest render-y-512: SUCCESS (0.088s)
[684.952758] Starting dynamic subtest: render-y-1024
[685.413642] Dynamic subtest render-y-1024: SUCCESS (0.471s)
[685.416479] Subtest render: SUCCESS (1.460s)
[685.517550] [116/130] (337s left) gem_exec_reloc (basic-write-gtt)
[685.585481] Subtest basic-write-gtt: SKIP (0.000s)
[685.688683] [117/130] (337s left) syncobj_timeline (wait-any-snapshot)
[685.751560] Starting subtest: wait-any-snapshot
[685.833539] Subtest wait-any-snapshot: SUCCESS (0.081s)
[685.887918] [118/130] (337s left) api_intel_allocator (default-alignment)
[685.946122] Starting subtest: default-alignment
[685.951012] Subtest default-alignment: SUCCESS (0.004s)
[686.061185] [119/130] (336s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[686.169526] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[686.173697] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[686.271401] [120/130] (336s left) gem_mmap_gtt (basic-copy)
[686.324293] Subtest basic-copy: SKIP (0.000s)
[686.394248] [121/130] (336s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[686.455484] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[686.563478] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.107s)
[686.617032] [122/130] (336s left) gem_exec_schedule (preempt-queue)
[686.692350] Subtest preempt-queue: SKIP (0.000s)
[686.955249] [123/130] (336s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[687.027967] Starting subtest: yf-tiled-ccs-to-y-tiled
[687.032235] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[687.187544] [124/130] (336s left) kms_hdr (static-toggle-dpms)
[687.291654] Starting subtest: static-toggle-dpms
[687.298290] Subtest static-toggle-dpms: SKIP (0.001s)
[687.349176] [125/130] (335s left) gem_lmem_swapping (heavy-verify-random-ccs)
[687.391208] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[687.432361] [126/130] (335s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[687.498822] Starting subtest: invalid-multi-wait-unsubmitted
[687.501218] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[687.589683] [127/130] (335s left) drm_buddy (drm_buddy)
[687.622514] Starting subtest: drm_buddy
[687.633368] Starting dynamic subtest: drm_test_buddy_alloc_limit
[687.775829] Dynamic subtest drm_test_buddy_alloc_limit: SUCCESS (0.142s)
[687.785612] Starting dynamic subtest: drm_test_buddy_alloc_optimistic
[687.899942] Dynamic subtest drm_test_buddy_alloc_optimistic: SUCCESS (0.121s)
[687.910731] Starting dynamic subtest: drm_test_buddy_alloc_pessimistic
[688.022114] Dynamic subtest drm_test_buddy_alloc_pessimistic: SUCCESS (0.122s)
[688.031468] Starting dynamic subtest: drm_test_buddy_alloc_pathological
[688.156038] Dynamic subtest drm_test_buddy_alloc_pathological: SUCCESS (0.133s)
[688.165441] Starting dynamic subtest: drm_test_buddy_alloc_contiguous
[688.313537] Dynamic subtest drm_test_buddy_alloc_contiguous: SUCCESS (0.158s)
[688.324344] Starting dynamic subtest: drm_test_buddy_alloc_clear
[688.501552] Dynamic subtest drm_test_buddy_alloc_clear: SUCCESS (0.186s)
[688.511322] Starting dynamic subtest: drm_test_buddy_alloc_range_bias
[688.654087] Dynamic subtest drm_test_buddy_alloc_range_bias: SUCCESS (0.151s)
[688.663186] Starting dynamic subtest: drm_test_buddy_fragmentation_performance
[692.894209] Dynamic subtest drm_test_buddy_fragmentation_performance: SUCCESS (4.239s)
[692.896225] Subtest drm_buddy: SUCCESS (5.272s)
[693.071364] [128/130] (330s left) kms_vrr (flipline)
[693.172652] Starting subtest: flipline
[693.179249] Subtest flipline: SKIP (0.000s)
[693.220320] [129/130] (330s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[693.317638] Starting subtest: 2x-absolute-wf_vblank-interruptible
[693.327869] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.010s)
[693.386676] [130/130] (330s left) gem_userptr_blits (process-exit-busy)
[693.442589] Starting subtest: process-exit-busy
[693.457308] Subtest process-exit-busy: SUCCESS (0.015s)
[693.560619] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_vblank
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: perf
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: gen7_exec_parse
results: parsing output: 6/ for test: vgem_basic
results: parsing output: 7/ for test: kms_psr
results: parsing output: 8/ for test: gem_spin_batch
results: parsing output: 9/ for test: kms_chamelium_hpd
results: parsing output: 10/ for test: gem_userptr_blits
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_fb_coherency
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_psr2_sf
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: perf_pmu
results: parsing output: 17/ for test: gem_render_copy
results: parsing output: 18/ for test: kms_vblank
results: parsing output: 19/ for test: gem_exec_whisper
results: parsing output: 20/ for test: gem_exec_balancer
results: parsing output: 21/ for test: gem_bad_reloc
results: parsing output: 22/ for test: kms_lease
results: parsing output: 23/ for test: kms_flip_scaled_crc
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: kms_flip_scaled_crc
results: parsing output: 26/ for test: kms_ccs
results: parsing output: 27/ for test: kms_psr2_su
results: parsing output: 28/ for test: kms_addfb_basic
results: parsing output: 29/ for test: syncobj_wait
results: parsing output: 30/ for test: kms_ccs
results: parsing output: 31/ for test: kms_plane_scaling
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: gem_exec_schedule
results: parsing output: 34/ for test: kms_cursor_crc
results: parsing output: 35/ for test: kms_atomic_transition
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_mmap_gtt
results: parsing output: 38/ for test: kms_pipe_crc_basic
results: parsing output: 39/ for test: gem_eio
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: kms_plane
results: parsing output: 42/ for test: syncobj_wait
results: parsing output: 43/ for test: kms_debugfs
results: parsing output: 44/ for test: gem_mmap_wc
results: parsing output: 45/ for test: kms_psr
results: parsing output: 46/ for test: kms_rotation_crc
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gem_render_copy
results: parsing output: 49/ for test: kms_ccs
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gem_close_race
results: parsing output: 54/ for test: kms_pm_rpm
results: parsing output: 55/ for test: gem_render_copy_redux
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: kms_cursor_crc
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: kms_chamelium_color
results: parsing output: 62/ for test: gem_partial_pwrite_pread
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: gem_exec_balancer
results: parsing output: 65/ for test: prime_busy
results: parsing output: 66/ for test: syncobj_wait
results: parsing output: 67/ for test: gem_ctx_sseu
results: parsing output: 68/ for test: kms_flip
results: parsing output: 69/ for test: gem_pwrite_snooped
results: parsing output: 70/ for test: kms_panel_fitting
results: parsing output: 71/ for test: kms_flip_tiling
results: parsing output: 72/ for test: gem_userptr_blits
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_eio
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: syncobj_timeline
results: parsing output: 77/ for test: kms_chamelium_frames
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: i915_drm_fdinfo
results: parsing output: 80/ for test: kms_psr2_sf
results: parsing output: 81/ for test: kms_cursor_legacy
results: parsing output: 82/ for test: gem_mmap_gtt
results: parsing output: 83/ for test: gem_ctx_persistence
results: parsing output: 84/ for test: core_auth
results: parsing output: 85/ for test: kms_cursor_edge_walk
results: parsing output: 86/ for test: syncobj_wait
results: parsing output: 87/ for test: prime_vgem
results: parsing output: 88/ for test: kms_ccs
results: parsing output: 89/ for test: i915_pm_rc6_residency
results: parsing output: 90/ for test: gem_exec_reloc
results: parsing output: 91/ for test: gem_create
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: syncobj_basic
results: parsing output: 94/ for test: gem_exec_fence
results: parsing output: 95/ for test: syncobj_timeline
results: parsing output: 96/ for test: kms_async_flips
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: i915_hangman
results: parsing output: 99/ for test: i915_pm_rps
results: parsing output: 100/ for test: kms_flip
results: parsing output: 101/ for test: kms_pm_dc
results: parsing output: 102/ for test: perf_pmu
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_ctx_persistence
results: parsing output: 105/ for test: kms_psr
results: parsing output: 106/ for test: kms_color
results: parsing output: 107/ for test: gem_exec_fence
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: gem_exec_reloc
results: parsing output: 110/ for test: gem_mmap_gtt
results: parsing output: 111/ for test: kms_plane_scaling
results: parsing output: 112/ for test: kms_getfb
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: api_intel_bb
results: parsing output: 115/ for test: gem_exec_reloc
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: api_intel_allocator
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: gem_mmap_gtt
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: gem_exec_schedule
results: parsing output: 122/ for test: gem_render_copy
results: parsing output: 123/ for test: kms_hdr
results: parsing output: 124/ for test: gem_lmem_swapping
results: parsing output: 125/ for test: syncobj_timeline
results: parsing output: 126/ for test: drm_buddy
results: parsing output: 127/ for test: kms_vrr
results: parsing output: 128/ for test: kms_flip
results: parsing output: 129/ for test: gem_userptr_blits
Done.