[66.313807] Initializing watchdogs
[66.313852]   /dev/watchdog0
[66.328136] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[66.332337] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[66.334323] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[66.338176] [001/133] (960s left) syncobj_timeline (multi-wait-available-signaled)
[66.420976] Starting subtest: multi-wait-available-signaled
[66.423357] Subtest multi-wait-available-signaled: SUCCESS (0.001s)
[66.511185] [002/133] (960s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[66.585890] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[66.588161] Starting dynamic subtest: pipe-A-eDP-1
[66.608265] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[66.615569] Starting dynamic subtest: pipe-B-eDP-1
[66.634594] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[66.641838] Starting dynamic subtest: pipe-C-eDP-1
[66.661415] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[66.668380] Starting dynamic subtest: pipe-D-eDP-1
[66.688240] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[66.690116] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.004s)
[68.796350] [003/133] (958s left) kms_pm_backlight (fade-with-dpms)
[68.873149] Starting subtest: fade-with-dpms
[71.363320] Starting dynamic subtest: eDP-1
[73.842264] Dynamic subtest eDP-1: SUCCESS (2.481s)
[73.844601] Subtest fade-with-dpms: SUCCESS (4.975s)
[74.638473] [004/133] (952s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[74.718063] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[74.745039] Starting dynamic subtest: pipe-A-plane-0
[75.033475] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[75.041625] Starting dynamic subtest: pipe-A-plane-3
[75.255084] Dynamic subtest pipe-A-plane-3: SUCCESS (0.222s)
[75.263122] Starting dynamic subtest: pipe-A-plane-5
[75.267489] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[76.332667] Starting dynamic subtest: pipe-B-plane-0
[76.636929] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s)
[76.645615] Starting dynamic subtest: pipe-B-plane-3
[76.870622] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[76.879868] Starting dynamic subtest: pipe-B-plane-5
[76.884406] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[77.194069] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.479s)
[77.998173] [005/133] (948s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[78.087693] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[79.144223] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.057s)
[79.262306] [006/133] (947s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[79.345814] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[79.349516] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[79.442027] [007/133] (947s left) gem_exec_schedule (manyslice)
[79.504468] Starting subtest: manyslice
[79.506430] Starting dynamic subtest: rcs0
[84.622603] Dynamic subtest rcs0: SUCCESS (5.119s)
[84.634149] Starting dynamic subtest: bcs0
[90.209642] Dynamic subtest bcs0: SUCCESS (5.586s)
[90.220150] Starting dynamic subtest: vcs0
[95.776710] Dynamic subtest vcs0: SUCCESS (5.566s)
[95.786278] Starting dynamic subtest: vcs1
[100.831598] Dynamic subtest vcs1: SUCCESS (5.054s)
[100.842444] Starting dynamic subtest: vecs0
[106.894506] Dynamic subtest vecs0: SUCCESS (6.062s)
[106.905027] Starting dynamic subtest: ccs0
[112.512926] Dynamic subtest ccs0: SUCCESS (5.618s)
[112.515697] Subtest manyslice: SUCCESS (33.010s)
[112.819104] [008/133] (914s left) vgem_basic (dmabuf-fence-before)
[112.904069] Starting subtest: dmabuf-fence-before
[112.906315] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[112.956190] [FACT vgem_basic (dmabuf-fence-before)] new: kernel.kmod_is_loaded.vgem: true
[112.959280] [009/133] (914s left) kms_cursor_crc (cursor-suspend)
[113.075968] Starting subtest: cursor-suspend
[113.078353] Starting dynamic subtest: pipe-A-eDP-1
[146.622536] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.077s)
[146.632303] Starting dynamic subtest: pipe-D-eDP-1
[180.607007] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.836s)
[180.609368] Subtest cursor-suspend: SUCCESS (7.916s)
[181.411063] [010/133] (845s left) gem_eio (in-flight-contexts-1us)
[181.645691] Starting subtest: in-flight-contexts-1us
[195.567243] Subtest in-flight-contexts-1us: SUCCESS (14.083s)
[195.706834] [011/133] (831s left) gem_exec_balancer (full-late)
[195.778573] Starting subtest: full-late
[200.445917] Subtest full-late: SUCCESS (4.682s)
[200.759251] [012/133] (826s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[200.853181] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[200.857191] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[200.949822] [013/133] (826s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[201.004779] Starting subtest: single-wait-for-submit-available-signaled
[201.006650] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[201.131827] [014/133] (826s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[201.229228] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[201.233301] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[201.331005] [015/133] (826s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[201.406314] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[208.805938] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.414s)
[208.940477] [016/133] (818s left) gem_reg_read (bad-register)
[208.994580] Starting subtest: bad-register
[208.996861] Subtest bad-register: SUCCESS (0.000s)
[209.094312] [017/133] (818s left) gem_exec_schedule (deep)
[209.267069] Starting subtest: deep
[209.269472] Starting dynamic subtest: rcs0
[214.770116] Dynamic subtest rcs0: SKIP (5.499s)
[214.792094] Starting dynamic subtest: vcs0
[225.734984] Dynamic subtest vcs0: SUCCESS (10.962s)
[225.747674] Starting dynamic subtest: vcs1
[237.537990] Dynamic subtest vcs1: SUCCESS (11.804s)
[237.550826] Starting dynamic subtest: vecs0
[249.937125] Dynamic subtest vecs0: SUCCESS (12.401s)
[249.950218] Starting dynamic subtest: ccs0
[262.683764] Dynamic subtest ccs0: SUCCESS (12.748s)
[262.686285] Subtest deep: SUCCESS (53.422s)
[263.645179] [018/133] (763s left) gem_mmap (basic)
[263.713529] Subtest basic: SKIP (0.000s)
[263.774782] [019/133] (763s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[263.868817] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[270.876171] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.011s)
[270.985553] [020/133] (756s left) kms_plane_alpha_blend (alpha-transparent-fb)
[271.063065] Starting subtest: alpha-transparent-fb
[271.361494] Starting dynamic subtest: pipe-A-eDP-1
[271.989111] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.625s)
[271.999236] Starting dynamic subtest: pipe-D-eDP-1
[273.307707] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.318s)
[273.309968] Subtest alpha-transparent-fb: SUCCESS (2.246s)
[274.123107] [021/133] (753s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[274.179841] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[274.182055] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[274.259423] [022/133] (753s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[274.307832] Starting subtest: x-tiled-to-vebox-y-tiled
[274.312229] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[274.487417] [023/133] (753s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[274.564727] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[274.569115] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[274.657289] [024/133] (753s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[274.727975] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[274.730187] Starting dynamic subtest: pipe-A-default-mode
[277.476144] Dynamic subtest pipe-A-default-mode: SUCCESS (2.747s)
[277.478584] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.748s)
[278.319091] [025/133] (749s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[278.380256] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[278.508801] [026/133] (749s left) kms_rotation_crc (primary-rotation-90)
[278.587338] Starting subtest: primary-rotation-90
[278.591686] Subtest primary-rotation-90: SKIP (0.001s)
[278.656720] [027/133] (749s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[278.738893] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[285.478944] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.742s)
[285.603181] [028/133] (742s left) gem_exec_flush (basic-batch-kernel-default-wb)
[285.660546] Starting subtest: basic-batch-kernel-default-wb
[293.202163] Subtest basic-batch-kernel-default-wb: SUCCESS (7.539s)
[293.393881] [029/133] (734s left) kms_psr (psr-suspend)
[293.481942] Starting subtest: psr-suspend
[293.484320] Starting dynamic subtest: eDP-1
[311.577529] Dynamic subtest eDP-1: SUCCESS (2.982s)
[311.579641] Subtest psr-suspend: SUCCESS (2.983s)
[312.419411] [030/133] (715s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[312.508505] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[313.515362] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.035s)
[313.638233] [031/133] (714s left) gem_flink_race (flink_name)
[313.669858] Starting subtest: flink_name
[318.990216] Subtest flink_name: SUCCESS (5.410s)
[319.092672] [032/133] (708s left) syncobj_timeline (invalid-wait-illegal-handle)
[319.151937] Starting subtest: invalid-wait-illegal-handle
[319.154066] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[319.243412] [033/133] (708s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[319.299670] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[319.404719] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.106s)
[319.479908] [034/133] (708s left) kms_vblank (query-idle)
[319.552678] Starting subtest: query-idle
[319.554821] Starting dynamic subtest: pipe-A-eDP-1
[321.309081] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.774s)
[321.322993] Starting dynamic subtest: pipe-D-eDP-1
[323.699965] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.406s)
[323.702293] Subtest query-idle: SUCCESS (4.184s)
[324.563993] [035/133] (703s left) kms_lease (setcrtc-implicit-plane)
[324.640156] Starting subtest: setcrtc-implicit-plane
[324.642249] Starting dynamic subtest: pipe-A-eDP-1
[325.122964] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.484s)
[325.133633] Starting dynamic subtest: pipe-B-eDP-1
[326.251623] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.132s)
[326.262484] Starting dynamic subtest: pipe-C-eDP-1
[327.367620] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.121s)
[327.378129] Starting dynamic subtest: pipe-D-eDP-1
[328.503555] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.139s)
[328.505838] Subtest setcrtc-implicit-plane: SUCCESS (3.883s)
[329.334498] [036/133] (698s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[329.427399] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[336.477843] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.071s)
[336.603449] [037/133] (691s left) gem_close_race (multigpu-basic-process)
[336.660522] Starting subtest: multigpu-basic-process
[336.664667] Subtest multigpu-basic-process: SKIP (0.000s)
[336.879814] [038/133] (691s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[336.955272] Starting subtest: primary-yf-tiled-reflect-x-0
[337.017657] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.059s)
[337.117807] [039/133] (691s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[337.200877] Starting subtest: psr2-plane-move-sf-dmg-area
[337.202991] Starting dynamic subtest: pipe-A-eDP-1
[341.700796] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.510s)
[341.710898] Starting dynamic subtest: pipe-B-eDP-1
[347.019355] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.316s)
[347.021678] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.829s)
[347.890785] [040/133] (680s left) gem_ctx_persistence (heartbeat-stop)
[347.942502] Starting subtest: heartbeat-stop
[347.946898] Subtest heartbeat-stop: SKIP (0.000s)
[348.036760] [041/133] (680s left) kms_addfb_basic (invalid-get-prop-any)
[348.094591] Starting subtest: invalid-get-prop-any
[348.096772] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[348.210799] [042/133] (680s left) kms_cursor_crc (cursor-offscreen-64x64)
[348.362255] Starting subtest: cursor-offscreen-64x64
[348.364600] Starting dynamic subtest: pipe-A-eDP-1
[350.351502] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.986s)
[350.378906] Starting dynamic subtest: pipe-D-eDP-1
[353.004385] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.629s)
[353.006359] Subtest cursor-offscreen-64x64: SUCCESS (4.640s)
[353.860147] [043/133] (674s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[353.947227] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[353.949417] Starting dynamic subtest: pipe-A-eDP-1
[354.664226] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.709s)
[354.674018] Starting dynamic subtest: pipe-B-eDP-1
[356.469627] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.800s)
[356.478781] Starting dynamic subtest: pipe-C-eDP-1
[358.277698] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.808s)
[358.289809] Starting dynamic subtest: pipe-D-eDP-1
[360.017595] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.739s)
[360.019487] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.063s)
[361.207880] [044/133] (667s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[361.298888] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[361.302996] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[361.380195] [045/133] (667s left) api_intel_bb (render)
[361.435086] Starting subtest: render
[361.437359] Starting dynamic subtest: render-none-512
[361.541779] Dynamic subtest render-none-512: SUCCESS (0.108s)
[361.556107] Starting dynamic subtest: render-none-1024
[361.910759] Dynamic subtest render-none-1024: SUCCESS (0.367s)
[361.927401] Starting dynamic subtest: render-x-512
[361.994345] Dynamic subtest render-x-512: SUCCESS (0.084s)
[362.011320] Starting dynamic subtest: render-x-1024
[362.320740] Dynamic subtest render-x-1024: SUCCESS (0.326s)
[362.335151] Starting dynamic subtest: render-y-512
[362.406984] Dynamic subtest render-y-512: SUCCESS (0.084s)
[362.418398] Starting dynamic subtest: render-y-1024
[362.735969] Dynamic subtest render-y-1024: SUCCESS (0.326s)
[362.739131] Subtest render: SUCCESS (1.302s)
[362.872572] [046/133] (665s left) perf_pmu (busy)
[362.914902] Starting subtest: busy
[362.917115] Starting dynamic subtest: rcs0
[363.492697] Dynamic subtest rcs0: SUCCESS (0.579s)
[363.507911] Starting dynamic subtest: bcs0
[364.056502] Dynamic subtest bcs0: SUCCESS (0.561s)
[364.069891] Starting dynamic subtest: vcs0
[365.672865] Dynamic subtest vcs0: SUCCESS (1.612s)
[365.683626] Starting dynamic subtest: vcs1
[367.655973] Dynamic subtest vcs1: SUCCESS (1.981s)
[367.669044] Starting dynamic subtest: vecs0
[369.704373] Dynamic subtest vecs0: SUCCESS (2.046s)
[369.717831] Starting dynamic subtest: ccs0
[370.272175] Dynamic subtest ccs0: SUCCESS (0.567s)
[370.274828] Subtest busy: SUCCESS (7.361s)
[370.393982] [047/133] (658s left) gem_lmem_swapping (massive)
[370.438843] Subtest massive: SKIP (0.000s)
[370.477695] [048/133] (658s left) gem_exec_params (invalid-bsd1-flag-on-render)
[370.534501] Starting subtest: invalid-bsd1-flag-on-render
[370.536417] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[370.630495] [049/133] (658s left) syncobj_basic (create-signaled)
[370.683407] Starting subtest: create-signaled
[370.685738] Subtest create-signaled: SUCCESS (0.000s)
[370.789086] [050/133] (658s left) gem_exec_schedule (submit-late-slice)
[370.875115] Starting subtest: submit-late-slice
[370.877366] Starting dynamic subtest: rcs0
[370.919104] Dynamic subtest rcs0: SUCCESS (0.052s)
[370.931214] Starting dynamic subtest: bcs0
[370.964609] Dynamic subtest bcs0: SUCCESS (0.044s)
[370.973953] Starting dynamic subtest: vcs0
[371.011818] Dynamic subtest vcs0: SUCCESS (0.045s)
[371.022066] Starting dynamic subtest: vcs1
[371.056020] Dynamic subtest vcs1: SUCCESS (0.045s)
[371.066334] Starting dynamic subtest: vecs0
[371.100904] Dynamic subtest vecs0: SUCCESS (0.043s)
[371.112853] Starting dynamic subtest: ccs0
[371.143533] Dynamic subtest ccs0: SUCCESS (0.042s)
[371.145916] Subtest submit-late-slice: SUCCESS (0.277s)
[372.735972] [051/133] (656s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[372.813380] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[372.817953] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[372.926043] [052/133] (656s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[373.000302] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[373.002628] Starting dynamic subtest: pipe-A-eDP-1
[373.025790] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[373.036988] Starting dynamic subtest: pipe-B-eDP-1
[373.058853] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[373.068222] Starting dynamic subtest: pipe-C-eDP-1
[373.090070] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[373.099192] Starting dynamic subtest: pipe-D-eDP-1
[373.121044] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[373.125156] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[375.242548] [053/133] (653s left) prime_vgem (basic-fence-mmap)
[375.310187] Starting subtest: basic-fence-mmap
[375.314787] Subtest basic-fence-mmap: SKIP (0.000s)
[375.412578] [054/133] (653s left) gem_ctx_shared (q-smoketest)
[375.477451] Starting subtest: Q-smoketest
[375.480086] Starting dynamic subtest: rcs0
[381.019970] Dynamic subtest rcs0: SUCCESS (5.496s)
[381.031753] Starting dynamic subtest: bcs0
[386.524471] Dynamic subtest bcs0: SUCCESS (5.508s)
[386.536820] Starting dynamic subtest: vcs0
[392.006031] Dynamic subtest vcs0: SUCCESS (5.482s)
[392.016900] Starting dynamic subtest: vcs1
[397.477704] Dynamic subtest vcs1: SUCCESS (5.468s)
[397.490501] Starting dynamic subtest: vecs0
[402.965208] Dynamic subtest vecs0: SUCCESS (5.490s)
[402.977552] Starting dynamic subtest: ccs0
[408.475861] Dynamic subtest ccs0: SUCCESS (5.509s)
[408.477807] Subtest Q-smoketest: SUCCESS (32.962s)
[408.623548] [055/133] (620s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[408.729112] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[408.733629] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[408.826569] [056/133] (620s left) gem_ctx_exec (basic)
[408.888912] Starting subtest: basic
[408.894012] Subtest basic: SUCCESS (0.007s)
[409.016811] [057/133] (620s left) gem_ppgtt (blt-vs-render-ctxn)
[409.079706] Starting subtest: blt-vs-render-ctxN
[442.071297] Subtest blt-vs-render-ctxN: SUCCESS (32.983s)
[442.193007] [058/133] (586s left) gem_mmap_wc (bad-offset)
[442.283796] Subtest bad-offset: SKIP (0.000s)
[442.344481] [059/133] (586s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[442.421411] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[442.423607] Starting dynamic subtest: pipe-A
[442.760836] Dynamic subtest pipe-A: SUCCESS (0.341s)
[442.776296] Starting dynamic subtest: pipe-B
[444.233683] Dynamic subtest pipe-B: SUCCESS (1.471s)
[444.244008] Starting dynamic subtest: pipe-C
[445.675493] Dynamic subtest pipe-C: SUCCESS (1.441s)
[445.687386] Starting dynamic subtest: pipe-D
[447.090127] Dynamic subtest pipe-D: SUCCESS (1.414s)
[447.092402] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.672s)
[448.257430] [060/133] (581s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[448.357847] Starting subtest: cursorA-vs-flipA-atomic
[459.532745] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.174s)
[460.385714] [061/133] (568s left) kms_feature_discovery (display-1x)
[460.454449] Starting subtest: display-1x
[460.456580] Subtest display-1x: SUCCESS (0.000s)
[460.542867] [062/133] (568s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[460.616475] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[460.618814] Starting dynamic subtest: pipe-A-eDP-1
[460.719021] Dynamic subtest pipe-A-eDP-1: SKIP (0.101s)
[460.731336] Starting dynamic subtest: pipe-B-eDP-1
[461.861065] Dynamic subtest pipe-B-eDP-1: SKIP (1.137s)
[461.865284] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.244s)
[463.041952] [063/133] (566s left) kms_chamelium_frames (dp-crc-fast)
[463.419718] Subtest dp-crc-fast: SKIP (0.000s)
[464.255769] [064/133] (565s left) sw_sync (timeline_closed)
[464.301097] Starting subtest: timeline_closed
[464.303471] Subtest timeline_closed: SUCCESS (0.000s)
[464.364553] [065/133] (565s left) kms_invalid_mode (zero-hdisplay)
[464.438399] Starting subtest: zero-hdisplay
[464.440740] Starting dynamic subtest: pipe-A-eDP-1
[464.729731] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.291s)
[464.739862] Starting dynamic subtest: pipe-B-eDP-1
[464.741767] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[464.751182] Starting dynamic subtest: pipe-C-eDP-1
[464.753342] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[464.762238] Starting dynamic subtest: pipe-D-eDP-1
[464.764105] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[464.766019] Subtest zero-hdisplay: SUCCESS (0.297s)
[465.525515] [066/133] (563s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[465.594648] Starting subtest: 2x-plain-flip-ts-check-interruptible
[465.602874] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.007s)
[465.691262] [067/133] (563s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[465.773330] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[465.775604] Starting dynamic subtest: pipe-A
[465.793014] Dynamic subtest pipe-A: SKIP (0.017s)
[465.806308] Starting dynamic subtest: pipe-B
[465.823734] Dynamic subtest pipe-B: SKIP (0.029s)
[465.833786] Starting dynamic subtest: pipe-C
[465.851895] Dynamic subtest pipe-C: SKIP (0.029s)
[465.862014] Starting dynamic subtest: pipe-D
[465.882209] Dynamic subtest pipe-D: SKIP (0.029s)
[465.885947] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.106s)
[465.979181] [068/133] (563s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[466.088726] Starting subtest: flip-vs-cursor-legacy
[473.117168] Subtest flip-vs-cursor-legacy: SUCCESS (7.030s)
[473.968755] [069/133] (555s left) kms_cursor_crc (cursor-random-32x32)
[474.093045] Starting subtest: cursor-random-32x32
[474.137485] Subtest cursor-random-32x32: SKIP (0.039s)
[474.424693] [070/133] (555s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[474.501774] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[474.504102] Starting dynamic subtest: pipe-A-eDP-1
[474.527738] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[474.539801] Starting dynamic subtest: pipe-B-eDP-1
[474.561613] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[474.571051] Starting dynamic subtest: pipe-C-eDP-1
[474.592796] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[474.602182] Starting dynamic subtest: pipe-D-eDP-1
[474.624211] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[474.628224] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[476.746370] [071/133] (552s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[476.837609] Starting subtest: crc-primary-basic-yf-tiled-ccs
[476.839838] Starting dynamic subtest: pipe-A-eDP-1
[476.862674] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[476.875324] Starting dynamic subtest: pipe-B-eDP-1
[476.897098] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[476.906675] Starting dynamic subtest: pipe-C-eDP-1
[476.927814] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[476.937499] Starting dynamic subtest: pipe-D-eDP-1
[476.959242] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[476.963321] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.005s)
[479.020071] [072/133] (550s left) kms_psr (pr-sprite-blt)
[479.101404] Starting subtest: pr-sprite-blt
[479.105916] Subtest pr-sprite-blt: SKIP (0.000s)
[479.175202] [073/133] (550s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[479.261648] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[486.056785] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (6.798s)
[486.173612] [074/133] (543s left) kms_getfb (getfb-addfb-different-handles)
[486.255526] Starting subtest: getfb-addfb-different-handles
[486.257732] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[486.354785] [075/133] (543s left) i915_pm_rpm (gem-execbuf-stress)
[487.852926] Starting subtest: gem-execbuf-stress
[487.855486] Starting dynamic subtest: smem0
[500.784439] Dynamic subtest smem0: SUCCESS (12.932s)
[500.795322] Starting dynamic subtest: extra-wait-smem0
[562.911259] Dynamic subtest extra-wait-smem0: SUCCESS (62.104s)
[562.913990] Subtest gem-execbuf-stress: SUCCESS (75.042s)
[563.264106] [076/133] (466s left) kms_dp_link_training (non-uhbr-mst)
[563.347475] Starting subtest: non-uhbr-mst
[563.356530] Subtest non-uhbr-mst: SKIP (0.000s)
[563.436656] [077/133] (466s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[563.500007] Starting subtest: basic-modeset-with-all-modifiers-formats
[563.884097] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[564.643371] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.762s)
[564.653879] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[564.665687] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[564.675394] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[564.687770] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.021s)
[564.698557] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[564.843186] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.155s)
[564.854718] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[564.865639] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s)
[564.876096] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[564.887537] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.022s)
[564.897639] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[564.910291] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.022s)
[564.925722] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[564.932459] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.021s)
[564.942577] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[564.954608] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.021s)
[564.964438] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[564.976758] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.021s)
[564.986812] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[564.999029] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.021s)
[565.008987] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[565.021301] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.022s)
[565.031241] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[565.176781] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.155s)
[565.187416] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[565.199120] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.021s)
[565.209166] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[565.221380] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.022s)
[565.231481] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[565.243708] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.021s)
[565.253944] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[565.265748] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.021s)
[565.275860] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[565.288029] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.022s)
[565.298095] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[565.310314] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.022s)
[565.320542] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[565.332510] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.021s)
[565.342154] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[565.354857] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.021s)
[565.364845] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[565.510714] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.155s)
[565.520883] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[565.532791] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.021s)
[565.542725] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[565.555229] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.021s)
[565.565079] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[565.577000] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.021s)
[565.594363] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[565.599977] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.022s)
[565.610752] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[565.621335] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.021s)
[565.630940] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[565.643593] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s)
[565.655664] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[565.665891] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.022s)
[565.675818] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[565.687914] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.021s)
[566.073725] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.573s)
[566.918541] [078/133] (463s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs)
[566.978899] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs
[566.983519] Subtest yf-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[567.167461] [079/133] (462s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[567.260672] Starting subtest: yf-tiled-64bpp-rotate-180
[567.265228] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[567.365938] [080/133] (462s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[567.450953] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[574.231086] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.780s)
[574.370376] [081/133] (455s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[574.457689] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[574.461983] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[574.566236] [082/133] (455s left) gem_softpin (allocator-basic-reserve)
[574.620238] Starting subtest: allocator-basic-reserve
[574.694389] Subtest allocator-basic-reserve: SUCCESS (0.074s)
[574.857991] [083/133] (455s left) gem_ctx_param (set-priority-range)
[574.911252] Starting subtest: set-priority-range
[574.925692] Subtest set-priority-range: SUCCESS (0.014s)
[575.034514] [084/133] (455s left) api_intel_allocator (reloc-allocator)
[575.095214] Starting subtest: reloc-allocator
[575.097617] Starting dynamic subtest: basic
[575.099884] Dynamic subtest basic: SUCCESS (0.004s)
[575.112211] Starting dynamic subtest: parallel-one
[575.114324] Dynamic subtest parallel-one: SUCCESS (0.008s)
[575.125127] Starting dynamic subtest: print
[575.127193] Dynamic subtest print: SUCCESS (0.000s)
[575.137479] Starting dynamic subtest: reuse
[575.140019] Dynamic subtest reuse: SUCCESS (0.000s)
[575.149401] Starting dynamic subtest: fork-reopen-allocator
[575.151631] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s)
[575.153705] Subtest reloc-allocator: SUCCESS (0.027s)
[575.262482] [085/133] (455s left) syncobj_wait (invalid-reset-one-illegal-handle)
[575.319809] Starting subtest: invalid-reset-one-illegal-handle
[575.321807] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[575.415161] [086/133] (454s left) gem_exec_suspend (basic)
[575.485689] Starting subtest: basic
[575.487748] Starting dynamic subtest: smem
[576.680020] Dynamic subtest smem: SUCCESS (1.191s)
[576.683011] Subtest basic: SUCCESS (1.193s)
[576.868709] [087/133] (453s left) kms_pm_rpm (modeset-non-lpsp)
[578.777078] Starting subtest: modeset-non-lpsp
[579.937687] Subtest modeset-non-lpsp: SKIP (1.157s)
[580.305796] [088/133] (450s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[580.418964] Starting subtest: basic-flip-after-cursor-atomic
[581.347578] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.927s)
[582.130889] [089/133] (448s left) kms_flip (2x-busy-flip)
[582.203968] Starting subtest: 2x-busy-flip
[582.209510] Subtest 2x-busy-flip: SKIP (0.008s)
[582.287154] [090/133] (448s left) kms_sequence (get-forked-busy)
[582.368572] Starting subtest: get-forked-busy
[582.370881] Starting dynamic subtest: pipe-A-eDP-1
[584.300586] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.931s)
[584.311248] Starting dynamic subtest: pipe-B-eDP-1
[586.924387] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.622s)
[586.936352] Starting dynamic subtest: pipe-C-eDP-1
[589.548088] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.621s)
[589.562764] Starting dynamic subtest: pipe-D-eDP-1
[592.169834] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.620s)
[592.171825] Subtest get-forked-busy: SUCCESS (9.800s)
[593.057065] [091/133] (437s left) gem_mmap_gtt (pf-nonblock)
[593.121926] Subtest pf-nonblock: SKIP (0.000s)
[593.182420] [092/133] (437s left) gem_ctx_param (vm)
[593.227986] Starting subtest: vm
[593.281370] Subtest vm: SUCCESS (0.052s)
[593.398614] [093/133] (437s left) gen9_exec_parse (unaligned-access)
[593.448735] Subtest unaligned-access: SKIP (0.000s)
[593.518580] [094/133] (437s left) perf (polling-parameterized)
[593.647609] Starting subtest: polling-parameterized
[613.672747] Subtest polling-parameterized: SUCCESS (20.024s)
[613.724182] [095/133] (417s left) gem_exec_capture (capture-invisible)
[613.774530] Starting subtest: capture-invisible
[613.776854] Starting dynamic subtest: smem0
[613.781272] Dynamic subtest smem0: SKIP (0.000s)
[613.785364] Subtest capture-invisible: SKIP (0.001s)
[613.873390] [096/133] (416s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[613.951413] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[613.954158] Starting dynamic subtest: pipe-A-default-mode
[615.098703] Dynamic subtest pipe-A-default-mode: SKIP (1.143s)
[615.102822] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.145s)
[615.276336] [097/133] (415s left) syncobj_wait (wait-all-snapshot)
[615.322716] Starting subtest: wait-all-snapshot
[615.402353] Subtest wait-all-snapshot: SUCCESS (0.081s)
[615.481630] [098/133] (415s left) kms_psr (psr2-sprite-plane-move)
[615.554270] Starting subtest: psr2-sprite-plane-move
[615.556551] Starting dynamic subtest: eDP-1
[617.289119] Dynamic subtest eDP-1: SUCCESS (1.733s)
[617.291412] Subtest psr2-sprite-plane-move: SUCCESS (1.734s)
[618.141566] [099/133] (412s left) kms_psr (fbc-psr2-sprite-blt)
[618.223811] Starting subtest: fbc-psr2-sprite-blt
[618.226001] Starting dynamic subtest: eDP-1
[618.230092] Dynamic subtest eDP-1: SKIP (0.000s)
[618.234179] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[618.307403] [100/133] (412s left) dmabuf_sync_file (import-basic)
[618.364756] Starting subtest: import-basic
[618.366985] Subtest import-basic: SUCCESS (0.002s)
[618.425508] [101/133] (412s left) gem_mmap (bad-size)
[618.481230] Subtest bad-size: SKIP (0.000s)
[618.538377] [102/133] (412s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[618.613001] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[618.616715] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[618.725236] [103/133] (412s left) gem_ctx_param (get-priority-new-ctx)
[618.775188] Starting subtest: get-priority-new-ctx
[618.777364] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[618.873321] [104/133] (412s left) gem_fence_thrash (bo-write-verify-threaded-none)
[618.911913] Starting subtest: bo-write-verify-threaded-none
[618.924494] Subtest bo-write-verify-threaded-none: SKIP (0.014s)
[618.981610] [105/133] (412s left) kms_flip (flip-vs-rmfb)
[619.046548] Starting subtest: flip-vs-rmfb
[619.048713] Starting dynamic subtest: A-eDP1
[627.706945] Dynamic subtest A-eDP1: SUCCESS (8.662s)
[627.717005] Starting dynamic subtest: B-eDP1
[636.327507] Dynamic subtest B-eDP1: SUCCESS (8.619s)
[636.340014] Starting dynamic subtest: C-eDP1
[644.981707] Dynamic subtest C-eDP1: SUCCESS (8.652s)
[644.994994] Starting dynamic subtest: D-eDP1
[653.709469] Dynamic subtest D-eDP1: SUCCESS (8.726s)
[653.713897] Subtest flip-vs-rmfb: SUCCESS (34.673s)
[654.861668] [106/133] (376s left) gen7_exec_parse (chained-batch)
[654.924645] Subtest chained-batch: SKIP (0.000s)
[654.993324] [107/133] (376s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[655.362666] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[656.165370] [108/133] (375s left) kms_color (ctm-0-25)
[656.247910] Starting subtest: ctm-0-25
[656.250262] Starting dynamic subtest: pipe-A-eDP-1
[660.048064] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.800s)
[660.059289] Starting dynamic subtest: pipe-B-eDP-1
[664.332881] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.285s)
[664.343977] Starting dynamic subtest: pipe-C-eDP-1
[668.387662] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.053s)
[668.399192] Starting dynamic subtest: pipe-D-eDP-1
[672.371017] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.985s)
[672.373275] Subtest ctm-0-25: SUCCESS (16.127s)
[673.199896] [109/133] (358s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[673.272585] Starting subtest: fbc-psr-cursor-mmap-cpu
[673.274790] Starting dynamic subtest: eDP-1
[673.278850] Dynamic subtest eDP-1: SKIP (0.000s)
[673.282952] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.001s)
[673.344013] [110/133] (358s left) kms_atomic (plane-invalid-params-fence)
[673.418375] Starting subtest: plane-invalid-params-fence
[673.420621] Starting dynamic subtest: pipe-A-eDP-1
[673.780357] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.360s)
[673.782618] Subtest plane-invalid-params-fence: SUCCESS (0.362s)
[674.611731] [111/133] (356s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[674.699088] Starting subtest: extended-modeset-hang-oldfb-with-reset
[674.701302] Starting dynamic subtest: pipe-A
[686.862487] Dynamic subtest pipe-A: SUCCESS (12.161s)
[686.873824] Starting dynamic subtest: pipe-D
[699.336028] Dynamic subtest pipe-D: SUCCESS (12.473s)
[699.338595] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.639s)
[700.137948] [112/133] (331s left) kms_big_fb (linear-64bpp-rotate-0)
[700.227616] Starting subtest: linear-64bpp-rotate-0
[701.872792] Subtest linear-64bpp-rotate-0: SUCCESS (1.646s)
[702.033140] [113/133] (329s left) i915_query (engine-info)
[702.089144] Starting subtest: engine-info
[702.091137] Subtest engine-info: SUCCESS (0.004s)
[702.214532] [114/133] (329s left) kms_flip (plain-flip-interruptible)
[702.282622] Starting subtest: plain-flip-interruptible
[702.284469] Starting dynamic subtest: A-eDP1
[703.945870] Dynamic subtest A-eDP1: SUCCESS (1.663s)
[703.956301] Starting dynamic subtest: B-eDP1
[705.554227] Dynamic subtest B-eDP1: SUCCESS (1.607s)
[705.567286] Starting dynamic subtest: C-eDP1
[707.173157] Dynamic subtest C-eDP1: SUCCESS (1.617s)
[707.185165] Starting dynamic subtest: D-eDP1
[708.802395] Dynamic subtest D-eDP1: SUCCESS (1.628s)
[708.807917] Subtest plain-flip-interruptible: SUCCESS (6.526s)
[709.975292] [115/133] (321s left) kms_plane_multiple (2x-tiling-x)
[710.059569] Starting subtest: 2x-tiling-x
[710.063617] Subtest 2x-tiling-x: SKIP (0.000s)
[710.145405] [116/133] (321s left) syncobj_wait (multi-wait-for-submit-submitted)
[710.207377] Starting subtest: multi-wait-for-submit-submitted
[710.316480] Subtest multi-wait-for-submit-submitted: SUCCESS (0.108s)
[710.395977] [117/133] (321s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[710.463261] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[710.572479] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.107s)
[710.658230] [118/133] (321s left) i915_drm_fdinfo (virtual-busy-idle-all)
[710.699068] Starting subtest: virtual-busy-idle-all
[710.703705] Subtest virtual-busy-idle-all: SKIP (0.000s)
[710.773397] [119/133] (321s left) sysfs_preempt_timeout (invalid)
[710.826902] Starting subtest: invalid
[710.829418] Starting dynamic subtest: vecs0
[710.831875] Dynamic subtest vecs0: SUCCESS (0.000s)
[710.845329] Starting dynamic subtest: ccs0
[710.848209] Dynamic subtest ccs0: SUCCESS (0.000s)
[710.858606] Starting dynamic subtest: vcs0
[710.860471] Dynamic subtest vcs0: SUCCESS (0.000s)
[710.870396] Starting dynamic subtest: bcs0
[710.872345] Dynamic subtest bcs0: SUCCESS (0.000s)
[710.882202] Starting dynamic subtest: rcs0
[710.884113] Dynamic subtest rcs0: SUCCESS (0.000s)
[710.894071] Starting dynamic subtest: vcs1
[710.896006] Dynamic subtest vcs1: SUCCESS (0.000s)
[710.897909] Subtest invalid: SUCCESS (0.005s)
[710.938636] [120/133] (320s left) gem_exec_fence (syncobj-timeline-repeat)
[711.508835] Starting subtest: syncobj-timeline-repeat
[711.738384] Subtest syncobj-timeline-repeat: SUCCESS (0.230s)
[712.789337] [121/133] (319s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[712.878348] Starting subtest: 4-tiled-64bpp-rotate-270
[712.898668] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.020s)
[713.038243] [122/133] (318s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[713.155106] Starting subtest: y-tiled-8bpp-rotate-270
[713.159780] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[713.256933] [123/133] (318s left) gem_exec_flush (basic-uc-prw-default)
[713.321735] Starting subtest: basic-uc-prw-default
[718.819704] Subtest basic-uc-prw-default: SUCCESS (5.500s)
[719.001628] [124/133] (313s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[719.084478] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[723.057684] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (3.977s)
[724.170235] [125/133] (307s left) gem_exec_schedule (u-submit-golden-slice)
[724.241517] Starting subtest: u-submit-golden-slice
[724.243756] Starting dynamic subtest: rcs0
[724.274767] Dynamic subtest rcs0: SUCCESS (0.042s)
[724.285463] Starting dynamic subtest: bcs0
[724.308195] Dynamic subtest bcs0: SUCCESS (0.033s)
[724.319394] Starting dynamic subtest: vcs0
[724.344654] Dynamic subtest vcs0: SUCCESS (0.036s)
[724.357618] Starting dynamic subtest: vcs1
[724.378382] Dynamic subtest vcs1: SUCCESS (0.033s)
[724.389578] Starting dynamic subtest: vecs0
[724.409810] Dynamic subtest vecs0: SUCCESS (0.031s)
[724.420338] Starting dynamic subtest: ccs0
[724.438305] Dynamic subtest ccs0: SUCCESS (0.028s)
[724.440482] Subtest u-submit-golden-slice: SUCCESS (0.207s)
[725.765903] [126/133] (306s left) kms_properties (crtc-properties-atomic)
[725.844730] Starting subtest: crtc-properties-atomic
[725.846968] Starting dynamic subtest: pipe-A-eDP-1
[726.285350] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.440s)
[726.297724] Starting dynamic subtest: pipe-B-eDP-1
[727.438847] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.152s)
[727.449453] Starting dynamic subtest: pipe-C-eDP-1
[728.561270] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.120s)
[728.572586] Starting dynamic subtest: pipe-D-eDP-1
[729.688519] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.125s)
[729.690418] Subtest crtc-properties-atomic: SUCCESS (3.844s)
[730.492080] [127/133] (301s left) perf_pmu (busy-no-semaphores)
[730.539595] Starting subtest: busy-no-semaphores
[730.541528] Starting dynamic subtest: rcs0
[731.095840] Dynamic subtest rcs0: SUCCESS (0.556s)
[731.109449] Starting dynamic subtest: bcs0
[731.647786] Dynamic subtest bcs0: SUCCESS (0.550s)
[731.661222] Starting dynamic subtest: vcs0
[732.198092] Dynamic subtest vcs0: SUCCESS (0.548s)
[732.211358] Starting dynamic subtest: vcs1
[734.189204] Dynamic subtest vcs1: SUCCESS (1.988s)
[734.202177] Starting dynamic subtest: vecs0
[736.171943] Dynamic subtest vecs0: SUCCESS (1.980s)
[736.186026] Starting dynamic subtest: ccs0
[738.156469] Dynamic subtest ccs0: SUCCESS (1.982s)
[738.159215] Subtest busy-no-semaphores: SUCCESS (7.619s)
[738.278151] [128/133] (293s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[738.364542] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[738.368737] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[738.467533] [129/133] (293s left) gem_ccs (block-multicopy-inplace)
[738.530160] Starting subtest: block-multicopy-inplace
[738.534823] Subtest block-multicopy-inplace: SKIP (0.000s)
[738.643230] [130/133] (293s left) gem_exec_reloc (basic-wc-active)
[738.704614] Subtest basic-wc-active: SKIP (0.000s)
[738.770723] [131/133] (293s left) kms_content_protection (legacy-hdcp14)
[738.900590] Starting subtest: legacy-hdcp14
[738.904989] Subtest legacy-hdcp14: SKIP (0.000s)
[739.012809] [132/133] (293s left) gem_exec_reloc (basic-wc-cpu-active)
[739.081194] Subtest basic-wc-cpu-active: SKIP (0.000s)
[739.149163] [133/133] (293s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[739.234926] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[739.238586] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[739.355841] Closing watchdogs
results: parsing output: 0/ for test: syncobj_timeline
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: kms_pm_backlight
results: parsing output: 3/ for test: kms_plane
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: gem_exec_schedule
results: parsing output: 7/ for test: vgem_basic
results: parsing output: 8/ for test: kms_cursor_crc
results: parsing output: 9/ for test: gem_eio
results: parsing output: 10/ for test: gem_exec_balancer
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_reg_read
results: parsing output: 16/ for test: gem_exec_schedule
results: parsing output: 17/ for test: gem_mmap
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_plane_alpha_blend
results: parsing output: 20/ for test: syncobj_wait
results: parsing output: 21/ for test: gem_render_copy
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_flip_scaled_crc
results: parsing output: 24/ for test: gem_userptr_blits
results: parsing output: 25/ for test: kms_rotation_crc
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_exec_flush
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: gem_flink_race
results: parsing output: 31/ for test: syncobj_timeline
results: parsing output: 32/ for test: syncobj_timeline
results: parsing output: 33/ for test: kms_vblank
results: parsing output: 34/ for test: kms_lease
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: gem_close_race
results: parsing output: 37/ for test: kms_rotation_crc
results: parsing output: 38/ for test: kms_psr2_sf
results: parsing output: 39/ for test: gem_ctx_persistence
results: parsing output: 40/ for test: kms_addfb_basic
results: parsing output: 41/ for test: kms_cursor_crc
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: kms_psr2_sf
results: parsing output: 44/ for test: api_intel_bb
results: parsing output: 45/ for test: perf_pmu
results: parsing output: 46/ for test: gem_lmem_swapping
results: parsing output: 47/ for test: gem_exec_params
results: parsing output: 48/ for test: syncobj_basic
results: parsing output: 49/ for test: gem_exec_schedule
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_ccs
results: parsing output: 52/ for test: prime_vgem
results: parsing output: 53/ for test: gem_ctx_shared
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: gem_ctx_exec
results: parsing output: 56/ for test: gem_ppgtt
results: parsing output: 57/ for test: gem_mmap_wc
results: parsing output: 58/ for test: kms_plane_scaling
results: parsing output: 59/ for test: kms_cursor_legacy
results: parsing output: 60/ for test: kms_feature_discovery
results: parsing output: 61/ for test: kms_psr2_sf
results: parsing output: 62/ for test: kms_chamelium_frames
results: parsing output: 63/ for test: sw_sync
results: parsing output: 64/ for test: kms_invalid_mode
results: parsing output: 65/ for test: kms_flip
results: parsing output: 66/ for test: kms_plane_scaling
results: parsing output: 67/ for test: kms_cursor_legacy
results: parsing output: 68/ for test: kms_cursor_crc
results: parsing output: 69/ for test: kms_ccs
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_getfb
results: parsing output: 74/ for test: i915_pm_rpm
results: parsing output: 75/ for test: kms_dp_link_training
results: parsing output: 76/ for test: kms_async_flips
results: parsing output: 77/ for test: gem_render_copy
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_softpin
results: parsing output: 82/ for test: gem_ctx_param
results: parsing output: 83/ for test: api_intel_allocator
results: parsing output: 84/ for test: syncobj_wait
results: parsing output: 85/ for test: gem_exec_suspend
results: parsing output: 86/ for test: kms_pm_rpm
results: parsing output: 87/ for test: kms_cursor_legacy
results: parsing output: 88/ for test: kms_flip
results: parsing output: 89/ for test: kms_sequence
results: parsing output: 90/ for test: gem_mmap_gtt
results: parsing output: 91/ for test: gem_ctx_param
results: parsing output: 92/ for test: gen9_exec_parse
results: parsing output: 93/ for test: perf
results: parsing output: 94/ for test: gem_exec_capture
results: parsing output: 95/ for test: kms_flip_scaled_crc
results: parsing output: 96/ for test: syncobj_wait
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: kms_psr
results: parsing output: 99/ for test: dmabuf_sync_file
results: parsing output: 100/ for test: gem_mmap
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_ctx_param
results: parsing output: 103/ for test: gem_fence_thrash
results: parsing output: 104/ for test: kms_flip
results: parsing output: 105/ for test: gen7_exec_parse
results: parsing output: 106/ for test: kms_chamelium_hpd
results: parsing output: 107/ for test: kms_color
results: parsing output: 108/ for test: kms_psr
results: parsing output: 109/ for test: kms_atomic
results: parsing output: 110/ for test: kms_busy
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: i915_query
results: parsing output: 113/ for test: kms_flip
results: parsing output: 114/ for test: kms_plane_multiple
results: parsing output: 115/ for test: syncobj_wait
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: i915_drm_fdinfo
results: parsing output: 118/ for test: sysfs_preempt_timeout
results: parsing output: 119/ for test: gem_exec_fence
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: gem_exec_flush
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_exec_schedule
results: parsing output: 125/ for test: kms_properties
results: parsing output: 126/ for test: perf_pmu
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: gem_ccs
results: parsing output: 129/ for test: gem_exec_reloc
results: parsing output: 130/ for test: kms_content_protection
results: parsing output: 131/ for test: gem_exec_reloc
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.