[63.029464] Initializing watchdogs
[63.029511]   /dev/watchdog0
[63.044952] [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]
[63.049985] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[63.052251] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.055711] [001/133] (960s left) kms_flip (flip-vs-dpms-on-nop)
[63.185326] Starting subtest: flip-vs-dpms-on-nop
[63.187694] Starting dynamic subtest: A-eDP1
[65.143820] Dynamic subtest A-eDP1: SUCCESS (1.960s)
[65.153516] Starting dynamic subtest: B-eDP1
[66.963499] Dynamic subtest B-eDP1: SUCCESS (1.818s)
[66.973520] Starting dynamic subtest: C-eDP1
[68.875914] Dynamic subtest C-eDP1: SUCCESS (1.911s)
[68.883742] Starting dynamic subtest: D-eDP1
[70.721808] Dynamic subtest D-eDP1: SUCCESS (1.844s)
[70.726681] Subtest flip-vs-dpms-on-nop: SUCCESS (7.544s)
[71.905013] [002/133] (951s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier)
[71.998359] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier
[72.002344] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (0.000s)
[72.079274] [003/133] (951s left) kms_psr (psr2-cursor-mmap-cpu)
[72.163532] Starting subtest: psr2-cursor-mmap-cpu
[72.165885] Starting dynamic subtest: eDP-1
[73.887202] Dynamic subtest eDP-1: SUCCESS (1.724s)
[73.889643] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.724s)
[74.684755] [004/133] (948s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[74.786521] Starting subtest: psr-rgb565-draw-mmap-cpu
[81.693994] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.913s)
[81.819784] [005/133] (941s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[81.934437] Starting subtest: fb-8bpc-vs-panel-6bpc
[81.936895] Starting dynamic subtest: pipe-A-eDP-1
[83.325964] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.391s)
[83.328321] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.392s)
[84.190968] [006/133] (939s left) gem_spin_batch (resubmit)
[84.257970] Starting subtest: resubmit
[84.260417] Starting dynamic subtest: rcs0
[84.265054] Dynamic subtest rcs0: SUCCESS (0.006s)
[84.275849] Starting dynamic subtest: bcs0
[84.278201] Dynamic subtest bcs0: SUCCESS (0.005s)
[84.285875] Starting dynamic subtest: vcs0
[84.288289] Dynamic subtest vcs0: SUCCESS (0.005s)
[84.296102] Starting dynamic subtest: vcs1
[84.298236] Dynamic subtest vcs1: SUCCESS (0.005s)
[84.305448] Starting dynamic subtest: vecs0
[84.307665] Dynamic subtest vecs0: SUCCESS (0.003s)
[84.314979] Starting dynamic subtest: ccs0
[84.317349] Dynamic subtest ccs0: SUCCESS (0.003s)
[84.319539] Subtest resubmit: SUCCESS (0.031s)
[84.515760] [007/133] (939s left) kms_vblank (accuracy-idle)
[84.622301] Starting subtest: accuracy-idle
[84.624653] Starting dynamic subtest: pipe-A-eDP-1
[86.394422] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.769s)
[86.408115] Starting dynamic subtest: pipe-D-eDP-1
[88.868136] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.472s)
[88.870565] Subtest accuracy-idle: SUCCESS (4.244s)
[89.676435] [008/133] (934s left) syncobj_timeline (etime-single-wait-submitted)
[89.745076] Starting subtest: etime-single-wait-submitted
[89.852098] Subtest etime-single-wait-submitted: SUCCESS (0.106s)
[89.926909] [009/133] (933s left) kms_content_protection (dp-mst-lic-type-1)
[90.060426] Starting subtest: dp-mst-lic-type-1
[90.065314] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[90.183742] [010/133] (933s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[90.283200] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[91.306581] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.025s)
[91.450228] [011/133] (932s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[91.548825] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[91.553624] Starting dynamic subtest: A-eDP1
[95.106107] Dynamic subtest A-eDP1: SUCCESS (3.553s)
[95.115784] Starting dynamic subtest: B-eDP1
[98.299855] Dynamic subtest B-eDP1: SUCCESS (3.192s)
[98.308933] Starting dynamic subtest: C-eDP1
[101.413215] Dynamic subtest C-eDP1: SUCCESS (3.113s)
[101.422261] Starting dynamic subtest: D-eDP1
[104.541096] Dynamic subtest D-eDP1: SUCCESS (3.128s)
[104.543462] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.993s)
[105.339450] [012/133] (918s left) gem_ccs (large-ctrl-surf-copy)
[105.403028] Starting subtest: large-ctrl-surf-copy
[105.407324] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[105.501653] [013/133] (918s left) syncobj_timeline (signal-point-0)
[105.562611] Starting subtest: signal-point-0
[105.564825] Subtest signal-point-0: SUCCESS (0.000s)
[105.674129] [014/133] (918s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[105.771554] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[105.775975] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[105.855753] [015/133] (918s left) gem_render_copy (yf-tiled-to-vebox-linear)
[105.929421] Starting subtest: yf-tiled-to-vebox-linear
[105.933464] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[106.113032] [016/133] (918s left) kms_cursor_crc (cursor-offscreen-64x64)
[106.289147] Starting subtest: cursor-offscreen-64x64
[106.291504] Starting dynamic subtest: pipe-A-eDP-1
[108.266676] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.975s)
[108.295776] Starting dynamic subtest: pipe-D-eDP-1
[110.857425] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.566s)
[110.859384] Subtest cursor-offscreen-64x64: SUCCESS (4.568s)
[111.706361] [017/133] (912s left) gem_exec_reloc (basic-wc-gtt)
[111.768236] Subtest basic-wc-gtt: SKIP (0.000s)
[111.831643] [018/133] (912s left) i915_suspend (fence-restore-untiled)
[111.900126] Starting subtest: fence-restore-untiled
[111.904320] Subtest fence-restore-untiled: SKIP (0.000s)
[112.010162] [019/133] (912s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[112.118753] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[112.123228] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[112.221466] [020/133] (912s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[112.328488] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[118.858138] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.533s)
[118.980861] [021/133] (905s left) kms_getfb (getfb2-handle-protection)
[119.075443] Starting subtest: getfb2-handle-protection
[119.091651] Subtest getfb2-handle-protection: SUCCESS (0.018s)
[119.186977] [022/133] (905s left) gem_exec_balancer (parallel-balancer)
[119.442926] Starting subtest: parallel-balancer
[120.330376] Subtest parallel-balancer: SUCCESS (0.887s)
[120.431950] [023/133] (903s left) kms_plane_lowres (tiling-yf)
[120.528874] Starting subtest: tiling-yf
[120.533078] Subtest tiling-yf: SKIP (0.000s)
[120.604732] [024/133] (903s left) gen9_exec_parse (valid-registers)
[120.667113] Subtest valid-registers: SKIP (0.000s)
[120.737093] [025/133] (903s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[120.836955] Starting subtest: sprite-rotation-90-pos-100-0
[120.845136] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[120.901879] [026/133] (903s left) kms_getfb (getfb-handle-closed)
[120.992942] Starting subtest: getfb-handle-closed
[120.995207] Subtest getfb-handle-closed: SUCCESS (0.000s)
[121.097921] [027/133] (903s left) kms_explicit_fence (multiplane-atomic-fence-wait)
[121.256593] Starting subtest: multiplane-atomic-fence-wait
[121.576036] Subtest multiplane-atomic-fence-wait: SUCCESS (0.318s)
[122.755748] [028/133] (901s left) syncobj_timeline (wait-for-submit-complex)
[122.821071] Starting subtest: wait-for-submit-complex
[122.881357] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[122.954729] [029/133] (901s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[123.053652] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[123.058055] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[123.123973] [030/133] (901s left) gem_ccs (ctrl-surf-copy)
[123.180234] Starting subtest: ctrl-surf-copy
[123.184836] Subtest ctrl-surf-copy: SKIP (0.000s)
[123.295174] [031/133] (901s left) i915_pm_rps (reset)
[123.364745] Starting subtest: reset
[131.818157] Subtest reset: SUCCESS (8.451s)
[131.956146] [032/133] (892s left) kms_addfb_basic (bad-pitch-0)
[132.014146] Starting subtest: bad-pitch-0
[132.016402] Subtest bad-pitch-0: SUCCESS (0.000s)
[132.173630] [033/133] (892s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[132.276603] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[132.281072] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[132.367136] [034/133] (892s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[132.477030] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[132.479373] Starting dynamic subtest: pipe-A
[132.826272] Dynamic subtest pipe-A: SUCCESS (0.351s)
[132.834441] Starting dynamic subtest: pipe-B
[134.270075] Dynamic subtest pipe-B: SUCCESS (1.443s)
[134.278904] Starting dynamic subtest: pipe-C
[135.692089] Dynamic subtest pipe-C: SUCCESS (1.421s)
[135.700339] Starting dynamic subtest: pipe-D
[137.137777] Dynamic subtest pipe-D: SUCCESS (1.445s)
[137.140071] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.663s)
[138.294679] [035/133] (886s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[138.385435] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[138.387775] Starting dynamic subtest: pipe-A-eDP-1
[138.411314] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.023s)
[138.420674] Starting dynamic subtest: pipe-B-eDP-1
[138.440705] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s)
[138.449078] Starting dynamic subtest: pipe-C-eDP-1
[138.469410] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s)
[138.477754] Starting dynamic subtest: pipe-D-eDP-1
[138.498116] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[138.500386] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.093s)
[140.783016] [036/133] (884s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[140.871434] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[140.875791] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[141.978129] [037/133] (882s left) perf (enable-disable)
[142.094076] Starting subtest: enable-disable
[142.096295] Starting dynamic subtest: 0-rcs0
[144.365674] Dynamic subtest 0-rcs0: SUCCESS (2.270s)
[144.374786] Starting dynamic subtest: 1-vcs0
[148.835780] Dynamic subtest 1-vcs0: SUCCESS (4.470s)
[148.838126] Subtest enable-disable: SUCCESS (6.742s)
[148.885599] [038/133] (876s left) kms_flip (2x-wf_vblank-ts-check)
[148.990181] Starting subtest: 2x-wf_vblank-ts-check
[149.000466] Subtest 2x-wf_vblank-ts-check: SKIP (0.011s)
[149.080372] [039/133] (875s left) gem_exec_endless (dispatch)
[149.157385] Starting subtest: dispatch
[149.159794] Starting dynamic subtest: rcs0
[149.167177] Dynamic subtest rcs0: SUCCESS (0.005s)
[149.178933] Starting dynamic subtest: bcs0
[149.183114] Dynamic subtest bcs0: SUCCESS (0.005s)
[149.191625] Starting dynamic subtest: vcs0
[149.196044] Dynamic subtest vcs0: SUCCESS (0.004s)
[149.205492] Starting dynamic subtest: vcs1
[149.209754] Dynamic subtest vcs1: SUCCESS (0.006s)
[149.217879] Starting dynamic subtest: vecs0
[149.222223] Dynamic subtest vecs0: SUCCESS (0.006s)
[149.230831] Starting dynamic subtest: ccs0
[149.235167] Dynamic subtest ccs0: SUCCESS (0.007s)
[149.237260] Subtest dispatch: SUCCESS (0.038s)
[150.968337] [040/133] (874s left) gem_readwrite (read-write)
[151.019110] Subtest read-write: SKIP (0.000s)
[151.070104] [041/133] (874s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[151.156835] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[151.161163] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[151.280481] [042/133] (873s left) gem_busy (close-race)
[151.340932] Starting subtest: close-race
[176.919066] Subtest close-race: SUCCESS (25.577s)
[177.277419] [FACT gem_busy (close-race)] new: kernel.kmod_is_loaded.vgem: true
[177.282374] [043/133] (847s left) kms_color (ctm-green-to-red)
[177.420860] Starting subtest: ctm-green-to-red
[177.422769] Starting dynamic subtest: pipe-A-eDP-1
[178.181849] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.761s)
[178.191231] Starting dynamic subtest: pipe-B-eDP-1
[179.564818] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.380s)
[179.574530] Starting dynamic subtest: pipe-C-eDP-1
[180.895076] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.330s)
[180.904484] Starting dynamic subtest: pipe-D-eDP-1
[182.225242] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s)
[182.227196] Subtest ctm-green-to-red: SUCCESS (4.803s)
[183.027835] [044/133] (842s left) perf_pmu (busy-accuracy-2)
[183.076727] Starting subtest: busy-accuracy-2
[183.079044] Starting dynamic subtest: rcs0
[186.120537] Dynamic subtest rcs0: SUCCESS (3.041s)
[186.132184] Starting dynamic subtest: bcs0
[189.180945] Dynamic subtest bcs0: SUCCESS (3.057s)
[189.190841] Starting dynamic subtest: vcs0
[192.227570] Dynamic subtest vcs0: SUCCESS (3.045s)
[192.238648] Starting dynamic subtest: vcs1
[195.275093] Dynamic subtest vcs1: SUCCESS (3.045s)
[195.286285] Starting dynamic subtest: vecs0
[198.323074] Dynamic subtest vecs0: SUCCESS (3.046s)
[198.334683] Starting dynamic subtest: ccs0
[201.381674] Dynamic subtest ccs0: SUCCESS (3.056s)
[201.384226] Subtest busy-accuracy-2: SUCCESS (18.303s)
[201.498456] [045/133] (823s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[201.597340] Starting subtest: psr-1p-primscrn-cur-indfb-move
[209.026099] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.431s)
[209.153312] [046/133] (816s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[209.269124] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[209.271429] Starting dynamic subtest: pipe-A-eDP-1
[209.368454] Dynamic subtest pipe-A-eDP-1: SKIP (0.101s)
[209.379201] Starting dynamic subtest: pipe-B-eDP-1
[210.534279] Dynamic subtest pipe-B-eDP-1: SKIP (1.161s)
[210.538852] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.266s)
[211.730419] [047/133] (813s left) dumb_buffer (create-clear)
[211.798957] Starting subtest: create-clear
[246.033090] Subtest create-clear: SUCCESS (34.230s)
[246.143441] [048/133] (779s left) syncobj_basic (bad-handle-to-fd)
[246.197427] Starting subtest: bad-handle-to-fd
[246.199687] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[246.312763] [049/133] (779s left) gem_exec_schedule (submit-golden-slice)
[246.394664] Starting subtest: submit-golden-slice
[246.396942] Starting dynamic subtest: rcs0
[246.455938] Dynamic subtest rcs0: SUCCESS (0.066s)
[246.468554] Starting dynamic subtest: bcs0
[246.519977] Dynamic subtest bcs0: SUCCESS (0.063s)
[246.532042] Starting dynamic subtest: vcs0
[246.580874] Dynamic subtest vcs0: SUCCESS (0.060s)
[246.592744] Starting dynamic subtest: vcs1
[246.634834] Dynamic subtest vcs1: SUCCESS (0.054s)
[246.645757] Starting dynamic subtest: vecs0
[246.687469] Dynamic subtest vecs0: SUCCESS (0.052s)
[246.697986] Starting dynamic subtest: ccs0
[246.756236] Dynamic subtest ccs0: SUCCESS (0.067s)
[246.758864] Subtest submit-golden-slice: SUCCESS (0.368s)
[247.990501] [050/133] (777s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[248.112335] Starting subtest: cursorA-vs-flipB-atomic
[248.116785] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[248.260664] [051/133] (777s left) kms_psr (psr2-basic)
[248.350690] Starting subtest: psr2-basic
[248.353066] Starting dynamic subtest: eDP-1
[249.991792] Dynamic subtest eDP-1: SUCCESS (1.641s)
[249.994090] Subtest psr2-basic: SUCCESS (1.642s)
[250.785708] [052/133] (774s left) gem_exec_schedule (wide)
[250.973187] Starting subtest: wide
[250.975412] Starting dynamic subtest: rcs0
[261.211383] Dynamic subtest rcs0: SUCCESS (10.239s)
[261.222727] Starting dynamic subtest: vcs0
[273.021887] Dynamic subtest vcs0: SUCCESS (11.809s)
[273.034187] Starting dynamic subtest: vcs1
[284.393589] Dynamic subtest vcs1: SUCCESS (11.370s)
[284.403065] Starting dynamic subtest: vecs0
[296.986305] Dynamic subtest vecs0: SUCCESS (12.591s)
[296.996899] Starting dynamic subtest: ccs0
[311.830375] Dynamic subtest ccs0: SUCCESS (14.841s)
[311.833223] Subtest wide: SUCCESS (60.855s)
[314.563942] [053/133] (711s left) syncobj_wait (invalid-wait-illegal-handle)
[314.629403] Starting subtest: invalid-wait-illegal-handle
[314.631813] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[314.745946] [054/133] (710s left) api_intel_bb (render)
[314.813549] Starting subtest: render
[314.815575] Starting dynamic subtest: render-none-512
[314.924082] Dynamic subtest render-none-512: SUCCESS (0.110s)
[314.935707] Starting dynamic subtest: render-none-1024
[315.309637] Dynamic subtest render-none-1024: SUCCESS (0.384s)
[315.321239] Starting dynamic subtest: render-x-512
[315.397991] Dynamic subtest render-x-512: SUCCESS (0.088s)
[315.409626] Starting dynamic subtest: render-x-1024
[315.745926] Dynamic subtest render-x-1024: SUCCESS (0.346s)
[315.757819] Starting dynamic subtest: render-y-512
[315.836612] Dynamic subtest render-y-512: SUCCESS (0.088s)
[315.846419] Starting dynamic subtest: render-y-1024
[316.189530] Dynamic subtest render-y-1024: SUCCESS (0.353s)
[316.192369] Subtest render: SUCCESS (1.376s)
[316.315100] [055/133] (709s left) kms_psr (fbc-psr2-suspend)
[316.424119] Starting subtest: fbc-psr2-suspend
[316.426350] Starting dynamic subtest: eDP-1
[316.430428] Dynamic subtest eDP-1: SKIP (0.000s)
[316.434515] Subtest fbc-psr2-suspend: SKIP (0.001s)
[316.514744] [056/133] (709s left) gem_eio (in-flight-10ms)
[316.750123] Starting subtest: in-flight-10ms
[324.868867] Subtest in-flight-10ms: SUCCESS (8.116s)
[325.023130] [057/133] (700s left) kms_psr (fbc-psr2-cursor-plane-move)
[325.121525] Starting subtest: fbc-psr2-cursor-plane-move
[325.123438] Starting dynamic subtest: eDP-1
[325.127522] Dynamic subtest eDP-1: SKIP (0.000s)
[325.131576] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[325.198777] [058/133] (700s left) perf_pmu (init-wait)
[325.241364] Starting subtest: init-wait
[325.243692] Starting dynamic subtest: rcs0
[325.245854] Dynamic subtest rcs0: SUCCESS (0.002s)
[325.257219] Starting dynamic subtest: bcs0
[325.259364] Dynamic subtest bcs0: SUCCESS (0.000s)
[325.268110] Starting dynamic subtest: vcs0
[325.270188] Dynamic subtest vcs0: SUCCESS (0.000s)
[325.279124] Starting dynamic subtest: vcs1
[325.281314] Dynamic subtest vcs1: SUCCESS (0.000s)
[325.290402] Starting dynamic subtest: vecs0
[325.292666] Dynamic subtest vecs0: SUCCESS (0.000s)
[325.301272] Starting dynamic subtest: ccs0
[325.303579] Dynamic subtest ccs0: SUCCESS (0.000s)
[325.305653] Subtest init-wait: SUCCESS (0.006s)
[325.351465] [059/133] (700s left) prime_self_import (basic-with_two_bos)
[325.397396] Starting subtest: basic-with_two_bos
[325.411130] Subtest basic-with_two_bos: SUCCESS (0.015s)
[325.512982] [060/133] (700s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[325.606132] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[325.609992] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[325.696180] [061/133] (700s left) kms_psr (fbc-pr-cursor-render)
[325.786290] Starting subtest: fbc-pr-cursor-render
[325.789821] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[325.860092] [062/133] (700s left) kms_getfb (getfb-handle-valid)
[325.945989] Starting subtest: getfb-handle-valid
[325.947975] Subtest getfb-handle-valid: SUCCESS (0.000s)
[326.051703] [063/133] (699s left) gem_pxp (create-regular-buffer)
[326.170113] Starting subtest: create-regular-buffer
[326.172233] Subtest create-regular-buffer: SUCCESS (0.000s)
[326.288240] [064/133] (699s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[326.666573] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[327.498454] [065/133] (698s left) gem_exec_reloc (basic-gtt)
[327.548721] Subtest basic-gtt: SKIP (0.000s)
[327.630186] [066/133] (698s left) gem_sync (basic-each)
[327.712459] Starting subtest: basic-each
[330.020549] Subtest basic-each: SUCCESS (2.318s)
[330.205068] [067/133] (696s left) gem_exec_reloc (basic-wc-read-active)
[330.277785] Subtest basic-wc-read-active: SKIP (0.000s)
[330.360333] [068/133] (695s left) prime_vgem (shrink)
[330.444045] Starting subtest: shrink
[330.461970] Subtest shrink: SUCCESS (0.016s)
[330.569512] [069/133] (695s left) kms_cursor_crc (cursor-suspend)
[330.712738] Starting subtest: cursor-suspend
[330.715230] Starting dynamic subtest: pipe-A-eDP-1
[363.375169] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.120s)
[363.389726] Starting dynamic subtest: pipe-D-eDP-1
[397.340168] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.788s)
[397.342376] Subtest cursor-suspend: SUCCESS (7.914s)
[398.205339] [070/133] (628s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[398.347275] Starting subtest: cursorB-vs-flipA-atomic-transitions
[398.351815] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[398.496354] [071/133] (627s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[398.604258] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[398.608451] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[398.701594] [072/133] (627s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[398.804626] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[399.806378] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.001s)
[399.934808] [073/133] (626s left) gem_exec_parallel (fds)
[399.988897] Starting subtest: fds
[399.991501] Starting dynamic subtest: rcs0
[402.645567] Dynamic subtest rcs0: SUCCESS (2.652s)
[402.658376] Starting dynamic subtest: bcs0
[406.165133] Dynamic subtest bcs0: SUCCESS (3.515s)
[406.176653] Starting dynamic subtest: vcs0
[409.964651] Dynamic subtest vcs0: SUCCESS (3.796s)
[409.975666] Starting dynamic subtest: vcs1
[413.875285] Dynamic subtest vcs1: SUCCESS (3.906s)
[413.885942] Starting dynamic subtest: vecs0
[417.875551] Dynamic subtest vecs0: SUCCESS (3.996s)
[417.888366] Starting dynamic subtest: ccs0
[421.501496] Dynamic subtest ccs0: SUCCESS (3.620s)
[421.504681] Subtest fds: SUCCESS (21.497s)
[421.700275] [074/133] (604s left) gem_eio (kms)
[421.990033] Starting subtest: kms
[441.675117] Subtest kms: SUCCESS (19.679s)
[442.858660] [075/133] (583s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[442.986183] Starting subtest: short-flip-after-cursor-atomic-transitions
[443.934866] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.949s)
[444.778246] [076/133] (581s left) perf (sysctl-defaults)
[444.857769] Starting subtest: sysctl-defaults
[444.860335] Subtest sysctl-defaults: SUCCESS (0.000s)
[444.935574] [077/133] (581s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[445.036344] Starting subtest: 4-tiled-8bpp-rotate-270
[445.057456] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.020s)
[445.171784] [078/133] (581s left) kms_atomic (plane-cursor-legacy)
[445.265051] Starting subtest: plane-cursor-legacy
[445.267317] Starting dynamic subtest: pipe-A-eDP-1
[445.660279] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.393s)
[445.662696] Subtest plane-cursor-legacy: SUCCESS (0.395s)
[446.530062] [079/133] (580s left) kms_hdmi_inject (inject-4k)
[446.877486] Starting subtest: inject-4k
[447.191801] Subtest inject-4k: SUCCESS (0.317s)
[447.791981] [080/133] (579s left) kms_big_fb (linear-8bpp-rotate-270)
[447.897873] Starting subtest: linear-8bpp-rotate-270
[447.920317] Subtest linear-8bpp-rotate-270: SKIP (0.022s)
[448.041259] [081/133] (578s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[448.134444] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[448.138477] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[448.243668] [082/133] (578s left) gem_ctx_persistence (engines-hostile-preempt)
[448.297848] Starting subtest: engines-hostile-preempt
[448.300084] Starting dynamic subtest: rcs0
[448.371249] Dynamic subtest rcs0: SUCCESS (0.073s)
[448.383465] Starting dynamic subtest: bcs0
[448.423764] Dynamic subtest bcs0: SUCCESS (0.050s)
[448.434551] Starting dynamic subtest: vcs0
[449.573124] Dynamic subtest vcs0: SUCCESS (1.146s)
[449.586362] Starting dynamic subtest: vcs1
[451.618278] Dynamic subtest vcs1: SUCCESS (2.042s)
[451.630761] Starting dynamic subtest: vecs0
[453.603082] Dynamic subtest vecs0: SUCCESS (1.982s)
[453.617018] Starting dynamic subtest: ccs0
[453.647453] Dynamic subtest ccs0: SUCCESS (0.044s)
[453.649813] Subtest engines-hostile-preempt: SUCCESS (5.349s)
[453.734904] [083/133] (573s left) gem_gpgpu_fill (offset-16x16)
[453.804236] Starting subtest: offset-16x16
[453.817343] Subtest offset-16x16: SUCCESS (0.012s)
[453.954906] [084/133] (573s left) gem_exec_params (readonly)
[454.018230] Starting subtest: readonly
[454.020665] Subtest readonly: SUCCESS (0.003s)
[454.153254] [085/133] (572s left) gem_ppgtt (blt-vs-render-ctxn)
[454.216916] Starting subtest: blt-vs-render-ctxN
[487.036005] Subtest blt-vs-render-ctxN: SUCCESS (32.806s)
[487.157652] [086/133] (539s left) syncobj_wait (multi-wait-submitted)
[487.251558] Starting subtest: multi-wait-submitted
[487.356319] Subtest multi-wait-submitted: SUCCESS (0.106s)
[487.436134] [087/133] (539s left) gem_vm_create (invalid-create)
[487.493682] Starting subtest: invalid-create
[487.496292] Subtest invalid-create: SUCCESS (0.002s)
[487.622339] [088/133] (539s left) kms_tv_load_detect (load-detect)
[487.673946] Subtest load-detect: SKIP (0.000s)
[487.740113] [089/133] (539s left) kms_plane_scaling (planes-upscale-factor-0-25)
[487.851703] Starting subtest: planes-upscale-factor-0-25
[487.853942] Starting dynamic subtest: pipe-A
[487.913937] Dynamic subtest pipe-A: SUCCESS (0.064s)
[487.924423] Starting dynamic subtest: pipe-B
[489.046662] Dynamic subtest pipe-B: SUCCESS (1.130s)
[489.058661] Starting dynamic subtest: pipe-C
[490.115753] Dynamic subtest pipe-C: SUCCESS (1.069s)
[490.127106] Starting dynamic subtest: pipe-D
[491.219227] Dynamic subtest pipe-D: SUCCESS (1.102s)
[491.221504] Subtest planes-upscale-factor-0-25: SUCCESS (3.369s)
[492.354482] [090/133] (534s left) syncobj_timeline (multi-wait-all-available-submitted)
[492.414518] Starting subtest: multi-wait-all-available-submitted
[492.416615] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s)
[492.508017] [091/133] (534s left) perf (per-context-mode-unprivileged)
[492.622611] Starting subtest: per-context-mode-unprivileged
[492.626991] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[492.672220] [092/133] (534s left) kms_flip (2x-flip-vs-expired-vblank)
[492.773907] Starting subtest: 2x-flip-vs-expired-vblank
[492.785440] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s)
[492.895538] [093/133] (534s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[493.026301] Starting subtest: flip-vs-cursor-crc-atomic
[493.732208] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.705s)
[494.541472] [094/133] (532s left) kms_plane_alpha_blend (constant-alpha-max)
[494.634167] Starting subtest: constant-alpha-max
[494.928780] Starting dynamic subtest: pipe-A-eDP-1
[495.983773] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.054s)
[495.994991] Starting dynamic subtest: pipe-D-eDP-1
[497.644891] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.662s)
[497.647293] Subtest constant-alpha-max: SUCCESS (3.013s)
[498.445643] [095/133] (529s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[498.555804] Starting subtest: fbcpsr-tiling-y
[498.560013] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[498.654499] [096/133] (528s left) i915_hangman (engine-engine-error)
[498.723333] Starting subtest: engine-engine-error
[498.725517] Starting dynamic subtest: rcs0
[500.551228] Dynamic subtest rcs0: SUCCESS (1.828s)
[500.565360] Starting dynamic subtest: bcs0
[502.599325] Dynamic subtest bcs0: SUCCESS (2.046s)
[502.610746] Starting dynamic subtest: vcs0
[504.581893] Dynamic subtest vcs0: SUCCESS (1.980s)
[504.595867] Starting dynamic subtest: vcs1
[506.567167] Dynamic subtest vcs1: SUCCESS (1.983s)
[506.580544] Starting dynamic subtest: vecs0
[508.551057] Dynamic subtest vecs0: SUCCESS (1.981s)
[508.564517] Starting dynamic subtest: ccs0
[510.599104] Dynamic subtest ccs0: SUCCESS (2.046s)
[510.602488] Subtest engine-engine-error: SUCCESS (11.882s)
[510.735720] [097/133] (516s left) gem_lmem_swapping (random)
[510.788874] Subtest random: SKIP (0.000s)
[510.836669] [098/133] (516s left) kms_invalid_mode (clock-too-high)
[510.936631] Starting subtest: clock-too-high
[510.938574] Starting dynamic subtest: pipe-A-eDP-1
[510.942666] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[510.954536] Starting dynamic subtest: pipe-B-eDP-1
[510.959012] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[510.969459] Starting dynamic subtest: pipe-C-eDP-1
[510.973537] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[510.983753] Starting dynamic subtest: pipe-D-eDP-1
[510.987871] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[510.991872] Subtest clock-too-high: SKIP (0.005s)
[511.031148] [099/133] (516s left) gem_exec_schedule (preempt-engines)
[511.107565] Starting subtest: preempt-engines
[511.109642] Starting dynamic subtest: rcs0
[513.349167] Dynamic subtest rcs0: SUCCESS (2.242s)
[513.361718] Starting dynamic subtest: bcs0
[515.566135] Dynamic subtest bcs0: SUCCESS (2.215s)
[515.577139] Starting dynamic subtest: vcs0
[517.856478] Dynamic subtest vcs0: SUCCESS (2.288s)
[517.867608] Starting dynamic subtest: vcs1
[520.144860] Dynamic subtest vcs1: SUCCESS (2.287s)
[520.155601] Starting dynamic subtest: vecs0
[522.415593] Dynamic subtest vecs0: SUCCESS (2.269s)
[522.426591] Starting dynamic subtest: ccs0
[524.809790] Dynamic subtest ccs0: SUCCESS (2.392s)
[524.812448] Subtest preempt-engines: SUCCESS (13.707s)
[525.115727] [100/133] (502s left) gem_exec_fence (syncobj-invalid-flags)
[525.612782] Starting subtest: syncobj-invalid-flags
[525.614857] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[526.730674] [101/133] (500s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[526.793454] Starting subtest: etime-multi-wait-all-for-submit-submitted
[526.901280] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.107s)
[526.980627] [102/133] (500s left) gem_ctx_create (basic-files)
[527.049079] Starting subtest: basic-files
[529.060688] Subtest basic-files: SUCCESS (2.011s)
[530.645585] [103/133] (497s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[530.744419] Starting subtest: fbcpsr-1p-rte
[537.666400] Subtest fbcpsr-1p-rte: SUCCESS (6.926s)
[537.816020] [104/133] (490s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[537.916039] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[537.919984] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[538.020979] [105/133] (489s left) kms_pm_dc (dc5-retention-flops)
[539.138105] Starting subtest: dc5-retention-flops
[539.143310] Subtest dc5-retention-flops: SKIP (0.000s)
[539.212371] [106/133] (488s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[539.264455] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[539.266913] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[539.400417] [107/133] (488s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[540.928872] Starting subtest: modeset-lpsp-stress-no-wait
[551.466307] Subtest modeset-lpsp-stress-no-wait: SUCCESS (10.540s)
[551.557167] [108/133] (476s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[551.661185] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[551.663367] Starting dynamic subtest: pipe-A-eDP-1
[551.683269] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[551.697889] Starting dynamic subtest: pipe-B-eDP-1
[551.717621] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[551.728103] Starting dynamic subtest: pipe-C-eDP-1
[551.747917] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[551.757810] Starting dynamic subtest: pipe-D-eDP-1
[551.776794] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[551.779002] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[553.940345] [109/133] (474s left) kms_cursor_crc (cursor-random-32x32)
[554.097688] Starting subtest: cursor-random-32x32
[554.144029] Subtest cursor-random-32x32: SKIP (0.043s)
[554.429957] [110/133] (473s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[554.541382] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[554.545559] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[554.639890] [111/133] (473s left) kms_chamelium_edid (dp-edid-resolution-list)
[555.015357] Subtest dp-edid-resolution-list: SKIP (0.000s)
[555.805918] [112/133] (472s left) gem_ctx_param (basic)
[555.863765] Starting subtest: basic
[555.866119] Subtest basic: SUCCESS (0.001s)
[555.987444] [113/133] (472s left) kms_psr (psr-sprite-render)
[556.083994] Starting subtest: psr-sprite-render
[556.086254] Starting dynamic subtest: eDP-1
[557.825814] Dynamic subtest eDP-1: SUCCESS (1.741s)
[557.828292] Subtest psr-sprite-render: SUCCESS (1.742s)
[558.639622] [114/133] (469s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[558.750873] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[558.755467] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[558.863345] [115/133] (469s left) kms_lease (page-flip-implicit-plane)
[558.961875] Starting subtest: page-flip-implicit-plane
[558.964099] Starting dynamic subtest: pipe-A-eDP-1
[559.438098] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.476s)
[559.449921] Starting dynamic subtest: pipe-B-eDP-1
[560.557614] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.117s)
[560.568592] Starting dynamic subtest: pipe-C-eDP-1
[561.728509] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.169s)
[561.739549] Starting dynamic subtest: pipe-D-eDP-1
[562.814802] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.082s)
[562.817534] Subtest page-flip-implicit-plane: SUCCESS (3.852s)
[563.636902] [116/133] (464s left) api_intel_allocator (reloc-allocator)
[563.704052] Starting subtest: reloc-allocator
[563.706393] Starting dynamic subtest: basic
[563.708553] Dynamic subtest basic: SUCCESS (0.003s)
[563.720967] Starting dynamic subtest: parallel-one
[563.723446] Dynamic subtest parallel-one: SUCCESS (0.008s)
[563.736788] Starting dynamic subtest: print
[563.738703] Dynamic subtest print: SUCCESS (0.000s)
[563.749020] Starting dynamic subtest: reuse
[563.750906] Dynamic subtest reuse: SUCCESS (0.000s)
[563.761002] Starting dynamic subtest: fork-reopen-allocator
[563.762911] Dynamic subtest fork-reopen-allocator: SUCCESS (0.011s)
[563.764772] Subtest reloc-allocator: SUCCESS (0.024s)
[563.858489] [117/133] (464s left) gem_ctx_persistence (heartbeat-hostile)
[563.918571] Starting subtest: heartbeat-hostile
[563.923058] Subtest heartbeat-hostile: SKIP (0.000s)
[564.028547] [118/133] (464s left) kms_flip (flip-vs-blocking-wf-vblank)
[564.117175] Starting subtest: flip-vs-blocking-wf-vblank
[564.119463] Starting dynamic subtest: A-eDP1
[573.044088] Dynamic subtest A-eDP1: SUCCESS (8.925s)
[573.057069] Starting dynamic subtest: B-eDP1
[581.950001] Dynamic subtest B-eDP1: SUCCESS (8.902s)
[581.962957] Starting dynamic subtest: C-eDP1
[590.831252] Dynamic subtest C-eDP1: SUCCESS (8.876s)
[590.843746] Starting dynamic subtest: D-eDP1
[599.726734] Dynamic subtest D-eDP1: SUCCESS (8.892s)
[599.729500] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.606s)
[600.937672] [119/133] (427s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[601.038225] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[605.239441] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.203s)
[606.435835] [120/133] (422s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[606.544433] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[606.548853] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[606.630495] [121/133] (421s left) gem_mmap_wc (close)
[606.689341] Subtest close: SKIP (0.000s)
[606.760388] [122/133] (421s left) gem_pxp (reject-modify-context-protection-off-1)
[606.865454] Starting subtest: reject-modify-context-protection-off-1
[606.867813] Subtest reject-modify-context-protection-off-1: SUCCESS (0.001s)
[606.998796] [123/133] (421s left) gen7_exec_parse (basic-offset)
[607.066302] Subtest basic-offset: SKIP (0.000s)
[607.143960] [124/133] (421s left) kms_chamelium_color (ctm-0-75)
[607.260053] Subtest ctm-0-75: SKIP (0.000s)
[607.309491] [125/133] (421s left) gem_mmap_gtt (hang-user)
[607.371468] Subtest hang-user: SKIP (0.000s)
[607.443631] [126/133] (421s left) kms_vblank (wait-forked-busy-hang)
[607.541422] Starting subtest: wait-forked-busy-hang
[607.543347] Starting dynamic subtest: pipe-A-eDP-1
[634.347336] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.804s)
[634.362538] Starting dynamic subtest: pipe-D-eDP-1
[659.378579] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.031s)
[659.380952] Subtest wait-forked-busy-hang: SUCCESS (51.840s)
[660.228065] [127/133] (368s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[660.314033] Starting subtest: async-flip-with-page-flip-events-linear
[660.700729] Starting dynamic subtest: pipe-A-eDP-1
[663.467321] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.765s)
[663.832420] Starting dynamic subtest: pipe-B-eDP-1
[666.572078] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.747s)
[666.976787] Starting dynamic subtest: pipe-C-eDP-1
[669.761241] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.795s)
[670.126546] Starting dynamic subtest: pipe-D-eDP-1
[672.870588] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.751s)
[672.873674] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.558s)
[674.031708] [128/133] (354s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[674.136417] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[674.140448] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[674.243568] [129/133] (354s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[674.345069] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[674.349273] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[674.439953] [130/133] (354s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[674.529851] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[674.532078] Starting dynamic subtest: pipe-A-eDP-1
[707.150546] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.924s)
[707.162234] Starting dynamic subtest: pipe-B-eDP-1
[740.099693] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.731s)
[740.111432] Starting dynamic subtest: pipe-C-eDP-1
[773.042438] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.687s)
[773.059207] Starting dynamic subtest: pipe-D-eDP-1
[806.049334] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.691s)
[806.052342] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (14.038s)
[807.279213] [131/133] (221s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[807.394571] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[807.397358] Starting dynamic subtest: pipe-A-default-mode
[810.174642] Dynamic subtest pipe-A-default-mode: SUCCESS (2.775s)
[810.177458] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.776s)
[810.990048] [132/133] (218s left) gem_workarounds (reset-context)
[811.059886] Starting subtest: reset-context
[811.219353] Subtest reset-context: SUCCESS (0.157s)
[811.344028] [133/133] (217s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[811.437137] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[811.442176] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[811.535912] Closing watchdogs
results: parsing output: 0/ for test: kms_flip
results: parsing output: 1/ for test: kms_plane
results: parsing output: 2/ for test: kms_psr
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_dither
results: parsing output: 5/ for test: gem_spin_batch
results: parsing output: 6/ for test: kms_vblank
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: kms_content_protection
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: kms_flip
results: parsing output: 11/ for test: gem_ccs
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_render_copy
results: parsing output: 15/ for test: kms_cursor_crc
results: parsing output: 16/ for test: gem_exec_reloc
results: parsing output: 17/ for test: i915_suspend
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_getfb
results: parsing output: 21/ for test: gem_exec_balancer
results: parsing output: 22/ for test: kms_plane_lowres
results: parsing output: 23/ for test: gen9_exec_parse
results: parsing output: 24/ for test: kms_rotation_crc
results: parsing output: 25/ for test: kms_getfb
results: parsing output: 26/ for test: kms_explicit_fence
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: kms_psr2_sf
results: parsing output: 29/ for test: gem_ccs
results: parsing output: 30/ for test: i915_pm_rps
results: parsing output: 31/ for test: kms_addfb_basic
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_plane_scaling
results: parsing output: 34/ for test: kms_ccs
results: parsing output: 35/ for test: kms_ccs
results: parsing output: 36/ for test: perf
results: parsing output: 37/ for test: kms_flip
results: parsing output: 38/ for test: gem_exec_endless
results: parsing output: 39/ for test: gem_readwrite
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_busy
results: parsing output: 42/ for test: kms_color
results: parsing output: 43/ for test: perf_pmu
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_psr2_sf
results: parsing output: 46/ for test: dumb_buffer
results: parsing output: 47/ for test: syncobj_basic
results: parsing output: 48/ for test: gem_exec_schedule
results: parsing output: 49/ for test: kms_cursor_legacy
results: parsing output: 50/ for test: kms_psr
results: parsing output: 51/ for test: gem_exec_schedule
results: parsing output: 52/ for test: syncobj_wait
results: parsing output: 53/ for test: api_intel_bb
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: gem_eio
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: perf_pmu
results: parsing output: 58/ for test: prime_self_import
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: kms_getfb
results: parsing output: 62/ for test: gem_pxp
results: parsing output: 63/ for test: kms_chamelium_hpd
results: parsing output: 64/ for test: gem_exec_reloc
results: parsing output: 65/ for test: gem_sync
results: parsing output: 66/ for test: gem_exec_reloc
results: parsing output: 67/ for test: prime_vgem
results: parsing output: 68/ for test: kms_cursor_crc
results: parsing output: 69/ for test: kms_cursor_legacy
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: gem_exec_parallel
results: parsing output: 73/ for test: gem_eio
results: parsing output: 74/ for test: kms_cursor_legacy
results: parsing output: 75/ for test: perf
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: kms_atomic
results: parsing output: 78/ for test: kms_hdmi_inject
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_ctx_persistence
results: parsing output: 82/ for test: gem_gpgpu_fill
results: parsing output: 83/ for test: gem_exec_params
results: parsing output: 84/ for test: gem_ppgtt
results: parsing output: 85/ for test: syncobj_wait
results: parsing output: 86/ for test: gem_vm_create
results: parsing output: 87/ for test: kms_tv_load_detect
results: parsing output: 88/ for test: kms_plane_scaling
results: parsing output: 89/ for test: syncobj_timeline
results: parsing output: 90/ for test: perf
results: parsing output: 91/ for test: kms_flip
results: parsing output: 92/ for test: kms_cursor_legacy
results: parsing output: 93/ for test: kms_plane_alpha_blend
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: i915_hangman
results: parsing output: 96/ for test: gem_lmem_swapping
results: parsing output: 97/ for test: kms_invalid_mode
results: parsing output: 98/ for test: gem_exec_schedule
results: parsing output: 99/ for test: gem_exec_fence
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: gem_ctx_create
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: kms_pm_dc
results: parsing output: 105/ for test: syncobj_timeline
results: parsing output: 106/ for test: kms_pm_rpm
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: kms_cursor_crc
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_chamelium_edid
results: parsing output: 111/ for test: gem_ctx_param
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: kms_lease
results: parsing output: 115/ for test: api_intel_allocator
results: parsing output: 116/ for test: gem_ctx_persistence
results: parsing output: 117/ for test: kms_flip
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: gem_mmap_wc
results: parsing output: 121/ for test: gem_pxp
results: parsing output: 122/ for test: gen7_exec_parse
results: parsing output: 123/ for test: kms_chamelium_color
results: parsing output: 124/ for test: gem_mmap_gtt
results: parsing output: 125/ for test: kms_vblank
results: parsing output: 126/ for test: kms_async_flips
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_ccs
results: parsing output: 130/ for test: kms_flip_scaled_crc
results: parsing output: 131/ for test: gem_workarounds
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.