[57.141996] Initializing watchdogs
[57.142051]   /dev/watchdog0
[57.156627] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.160997] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.163275] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.166601] [001/133] (960s left) kms_chamelium_hpd (hdmi-hpd-fast)
[57.588207] Subtest hdmi-hpd-fast: SKIP (0.000s)
[58.360903] [002/133] (959s left) kms_properties (plane-properties-legacy)
[58.456151] Starting subtest: plane-properties-legacy
[58.458727] Starting dynamic subtest: pipe-A-eDP-1
[59.032627] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.577s)
[59.045894] Starting dynamic subtest: pipe-B-eDP-1
[60.358432] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.329s)
[60.366905] Starting dynamic subtest: pipe-C-eDP-1
[61.587836] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.229s)
[61.595696] Starting dynamic subtest: pipe-D-eDP-1
[62.820331] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.234s)
[62.822825] Subtest plane-properties-legacy: SUCCESS (4.373s)
[63.623679] [003/133] (954s left) gem_mmap (basic)
[63.694192] Subtest basic: SKIP (0.000s)
[63.753063] [004/133] (954s left) gem_exec_schedule (u-fairslice)
[63.821167] Starting subtest: u-fairslice
[63.823268] Starting dynamic subtest: rcs0
[65.840588] Dynamic subtest rcs0: SUCCESS (2.022s)
[65.849496] Starting dynamic subtest: bcs0
[67.860525] Dynamic subtest bcs0: SUCCESS (2.021s)
[67.868942] Starting dynamic subtest: vcs0
[69.882759] Dynamic subtest vcs0: SUCCESS (2.024s)
[69.892300] Starting dynamic subtest: vcs1
[71.908802] Dynamic subtest vcs1: SUCCESS (2.026s)
[71.917307] Starting dynamic subtest: vecs0
[73.928643] Dynamic subtest vecs0: SUCCESS (2.021s)
[73.937402] Starting dynamic subtest: ccs0
[75.951113] Dynamic subtest ccs0: SUCCESS (2.022s)
[75.953459] Subtest u-fairslice: SUCCESS (12.137s)
[76.239310] [005/133] (941s left) gem_workarounds (suspend-resume)
[76.305525] Starting subtest: suspend-resume
[92.446331] Subtest suspend-resume: SUCCESS (1.403s)
[92.553067] [006/133] (925s left) kms_color (gamma)
[92.660934] Starting subtest: gamma
[92.663088] Starting dynamic subtest: pipe-A-eDP-1
[93.373230] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.720s)
[93.382706] Starting dynamic subtest: pipe-B-eDP-1
[95.545966] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.192s)
[95.555542] Starting dynamic subtest: pipe-C-eDP-1
[96.422987] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.885s)
[96.439570] Starting dynamic subtest: pipe-D-eDP-1
[97.739774] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.326s)
[97.741768] Subtest gamma: SUCCESS (5.125s)
[98.542042] [007/133] (919s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[98.650418] Starting subtest: yf-tiled-64bpp-rotate-180
[98.654760] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[98.751134] [008/133] (919s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[98.847165] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[98.851624] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[98.975041] [009/133] (919s left) gem_exec_balancer (bonded-sync)
[99.041225] Starting subtest: bonded-sync
[99.045945] Subtest bonded-sync: SKIP (0.000s)
[99.336641] [010/133] (918s left) kms_invalid_mode (bad-hsync-end)
[99.422794] Starting subtest: bad-hsync-end
[99.425271] Starting dynamic subtest: pipe-A-eDP-1
[99.707467] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[99.716112] Starting dynamic subtest: pipe-B-eDP-1
[99.718404] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[99.726266] Starting dynamic subtest: pipe-C-eDP-1
[99.728627] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[99.739018] Starting dynamic subtest: pipe-D-eDP-1
[99.741263] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[99.743553] Subtest bad-hsync-end: SUCCESS (0.291s)
[100.553328] [011/133] (917s left) gem_tiled_pread_basic (basic)
[100.614111] Subtest basic: SKIP (0.000s)
[100.673520] [012/133] (917s left) gem_exec_balancer (parallel-keep-in-fence)
[100.938288] Starting subtest: parallel-keep-in-fence
[102.054138] Subtest parallel-keep-in-fence: SUCCESS (1.120s)
[102.165014] [013/133] (915s left) kms_pm_backlight (brightness-with-dpms)
[102.259828] Starting subtest: brightness-with-dpms
[102.307017] Starting dynamic subtest: eDP-1
[104.725540] Dynamic subtest eDP-1: SUCCESS (2.426s)
[104.728109] Subtest brightness-with-dpms: SUCCESS (2.476s)
[105.596690] [014/133] (912s left) i915_drm_fdinfo (memory-info-active)
[105.638913] Starting subtest: memory-info-active
[105.641280] Starting dynamic subtest: smem0
[108.041699] Dynamic subtest smem0: SUCCESS (2.408s)
[108.043956] Subtest memory-info-active: SUCCESS (2.410s)
[108.117215] [015/133] (910s left) perf (polling-parameterized)
[108.232177] Starting subtest: polling-parameterized
[128.256934] Subtest polling-parameterized: SUCCESS (20.038s)
[128.302686] [016/133] (889s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[128.406375] Starting subtest: psr2-cursor-plane-move-continuous-sf
[128.408672] Starting dynamic subtest: pipe-A-eDP-1
[138.752029] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.347s)
[138.761551] Starting dynamic subtest: pipe-B-eDP-1
[149.853059] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.099s)
[149.855040] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (21.448s)
[150.729265] [017/133] (867s left) kms_flip_tiling (flip-change-tiling)
[150.826465] Starting subtest: flip-change-tiling
[150.828451] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs
[151.005322] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.180s)
[151.017517] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs
[151.140236] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.132s)
[151.151785] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[151.284942] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.144s)
[151.296460] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4
[151.428071] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.143s)
[151.439254] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x
[151.572069] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.143s)
[151.584035] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear
[151.715991] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.144s)
[151.727734] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs
[151.850143] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.132s)
[151.862121] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs
[151.971685] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.121s)
[151.982114] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[152.117722] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.143s)
[152.129332] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4
[152.261192] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.143s)
[152.272642] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x
[152.404762] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.143s)
[152.416400] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear
[152.549169] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.143s)
[152.559905] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[152.682445] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.132s)
[152.694102] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[152.817388] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.132s)
[152.827924] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[152.927685] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.110s)
[152.938727] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4
[153.072160] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.144s)
[153.083451] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x
[153.215628] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.143s)
[153.225931] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear
[153.360244] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.143s)
[153.371535] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs
[153.504608] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.143s)
[153.516225] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs
[153.649412] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.143s)
[153.661563] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc
[153.793565] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.143s)
[153.805775] Starting dynamic subtest: pipe-A-eDP-1-4-to-4
[153.915616] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.121s)
[153.926579] Starting dynamic subtest: pipe-A-eDP-1-4-to-x
[154.059411] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.143s)
[154.070588] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear
[154.203615] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.143s)
[154.215102] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs
[154.348434] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.144s)
[154.359785] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs
[154.493007] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.143s)
[154.503115] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc
[154.636899] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.143s)
[154.647600] Starting dynamic subtest: pipe-A-eDP-1-x-to-4
[154.781381] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.144s)
[154.792893] Starting dynamic subtest: pipe-A-eDP-1-x-to-x
[154.903859] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.121s)
[154.914863] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear
[155.049066] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.144s)
[155.059728] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs
[155.192634] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.143s)
[155.202841] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs
[155.337077] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.143s)
[155.347328] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc
[155.482583] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.143s)
[155.496556] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4
[155.625803] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.143s)
[155.636574] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x
[155.770977] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.143s)
[155.782184] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear
[155.892728] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.121s)
[155.945116] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs
[157.200572] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.262s)
[157.214175] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs
[157.335165] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.132s)
[157.344793] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[157.468664] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.133s)
[157.478770] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4
[157.611310] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.143s)
[157.621036] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x
[157.755725] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.143s)
[157.765804] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear
[157.900081] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.143s)
[157.911416] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs
[158.034045] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.132s)
[158.048168] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs
[158.155696] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.121s)
[158.167298] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[158.290441] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.133s)
[158.302313] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4
[158.433749] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.144s)
[158.445312] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x
[158.577505] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.143s)
[158.588803] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear
[158.722326] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.143s)
[158.735217] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[158.867009] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.143s)
[158.880660] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[159.001434] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.132s)
[159.012146] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[159.111439] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.110s)
[159.122869] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4
[159.256000] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.143s)
[159.269275] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x
[159.399556] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.143s)
[159.410103] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear
[159.543986] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.143s)
[159.555695] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs
[159.677396] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.132s)
[159.689441] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs
[159.810689] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.132s)
[159.822388] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc
[159.955715] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.144s)
[159.967927] Starting dynamic subtest: pipe-B-eDP-1-4-to-4
[160.077232] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.121s)
[160.087708] Starting dynamic subtest: pipe-B-eDP-1-4-to-x
[160.221126] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.143s)
[160.231919] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear
[160.365287] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.143s)
[160.376958] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs
[160.509975] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.143s)
[160.521412] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs
[160.654152] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.144s)
[160.665472] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc
[160.798815] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.143s)
[160.810272] Starting dynamic subtest: pipe-B-eDP-1-x-to-4
[160.943209] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.143s)
[160.954297] Starting dynamic subtest: pipe-B-eDP-1-x-to-x
[161.065959] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.121s)
[161.076699] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear
[161.210326] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.143s)
[161.221680] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs
[161.354319] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.143s)
[161.365462] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs
[161.498593] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.143s)
[161.509882] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc
[161.643357] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.144s)
[161.657681] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4
[161.787416] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.143s)
[161.798914] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x
[161.932287] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.144s)
[161.944233] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear
[162.054132] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.121s)
[162.107661] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs
[163.337936] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.237s)
[163.349280] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs
[163.436999] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.099s)
[163.448224] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[163.537327] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.099s)
[163.548572] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4
[163.648160] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.110s)
[163.662948] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x
[163.758797] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.111s)
[163.769890] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear
[163.870137] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.110s)
[163.880313] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs
[163.970435] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.099s)
[163.982059] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs
[164.070928] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[164.082511] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[164.170681] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.099s)
[164.181386] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4
[164.320043] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.149s)
[164.330551] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x
[164.430540] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.110s)
[164.441149] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear
[164.541349] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.110s)
[164.551864] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[164.641764] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.099s)
[164.652527] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[164.741972] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.099s)
[164.753275] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[164.842191] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.099s)
[164.852991] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4
[164.952629] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.110s)
[164.963595] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x
[165.063420] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.110s)
[165.074232] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear
[165.174726] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.110s)
[165.185861] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs
[165.275009] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.099s)
[165.286417] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs
[165.386734] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.110s)
[165.398414] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc
[165.486219] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.099s)
[165.498042] Starting dynamic subtest: pipe-C-eDP-1-4-to-4
[165.597270] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.110s)
[165.607915] Starting dynamic subtest: pipe-C-eDP-1-4-to-x
[165.746524] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.149s)
[165.760074] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear
[165.857649] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.110s)
[165.867545] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs
[165.968419] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.110s)
[165.979083] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs
[166.068603] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.099s)
[166.078897] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc
[166.168585] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.099s)
[166.179133] Starting dynamic subtest: pipe-C-eDP-1-x-to-4
[166.279728] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.111s)
[166.290952] Starting dynamic subtest: pipe-C-eDP-1-x-to-x
[166.391271] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.110s)
[166.402404] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear
[166.513473] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.120s)
[166.524073] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs
[166.623921] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.110s)
[166.636648] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs
[166.735605] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.110s)
[166.749107] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc
[166.846256] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.110s)
[166.859903] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4
[166.968354] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.121s)
[166.978905] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x
[167.118273] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.149s)
[167.129172] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear
[167.229421] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.110s)
[167.272083] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs
[168.467348] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.202s)
[168.481687] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs
[168.567309] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.099s)
[168.578217] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[168.666780] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.099s)
[168.678277] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4
[168.778575] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.110s)
[168.790114] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x
[168.888231] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.110s)
[168.898025] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear
[168.999784] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.110s)
[169.011116] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs
[169.100395] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.099s)
[169.111578] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs
[169.199947] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.099s)
[169.211404] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[169.300039] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.099s)
[169.311314] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4
[169.399973] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.099s)
[169.411274] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x
[169.509972] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.110s)
[169.521059] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear
[169.621431] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.110s)
[169.632001] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[169.721820] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.099s)
[169.737417] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[169.821836] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s)
[169.832635] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[169.921951] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.099s)
[169.933234] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4
[170.032885] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.110s)
[170.043730] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x
[170.143443] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.110s)
[170.154434] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear
[170.254632] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.110s)
[170.264302] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs
[170.365960] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.110s)
[170.377466] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs
[170.476993] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.110s)
[170.488155] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc
[170.577199] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.099s)
[170.589197] Starting dynamic subtest: pipe-D-eDP-1-4-to-4
[170.688199] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.110s)
[170.700448] Starting dynamic subtest: pipe-D-eDP-1-4-to-x
[170.798440] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.110s)
[170.809175] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear
[170.909614] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.110s)
[170.920485] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs
[171.009611] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.099s)
[171.019344] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs
[171.109335] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.099s)
[171.120081] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc
[171.220708] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.110s)
[171.231806] Starting dynamic subtest: pipe-D-eDP-1-x-to-4
[171.331741] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.110s)
[171.342718] Starting dynamic subtest: pipe-D-eDP-1-x-to-x
[171.443141] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.110s)
[171.454365] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear
[171.554087] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.110s)
[171.565165] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs
[171.664879] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.110s)
[171.676121] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs
[171.777037] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.110s)
[171.787856] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc
[171.887443] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.110s)
[171.897940] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4
[171.998446] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.110s)
[172.009101] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x
[172.109682] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.110s)
[172.121146] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear
[172.221019] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.110s)
[172.253806] Subtest flip-change-tiling: SUCCESS (21.436s)
[173.457100] [018/133] (844s left) kms_dsc (dsc-with-bpc)
[173.560069] Starting subtest: dsc-with-bpc
[173.589571] Subtest dsc-with-bpc: SKIP (0.001s)
[173.642836] [019/133] (844s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[173.743553] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[173.745808] Starting dynamic subtest: A-eDP1
[177.391890] Dynamic subtest A-eDP1: SUCCESS (3.650s)
[177.402066] Starting dynamic subtest: B-eDP1
[180.610536] Dynamic subtest B-eDP1: SUCCESS (3.217s)
[180.619173] Starting dynamic subtest: C-eDP1
[183.737020] Dynamic subtest C-eDP1: SUCCESS (3.128s)
[183.749221] Starting dynamic subtest: D-eDP1
[186.871759] Dynamic subtest D-eDP1: SUCCESS (3.134s)
[186.873801] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.136s)
[187.674480] [020/133] (830s left) gem_ctx_persistence (engines-hang)
[187.743981] Starting subtest: engines-hang
[187.746361] Starting dynamic subtest: rcs0
[187.862116] Dynamic subtest rcs0: SUCCESS (0.117s)
[187.874279] Starting dynamic subtest: bcs0
[187.959162] Dynamic subtest bcs0: SUCCESS (0.096s)
[187.970949] Starting dynamic subtest: vcs0
[188.054176] Dynamic subtest vcs0: SUCCESS (0.093s)
[188.065629] Starting dynamic subtest: vcs1
[188.146163] Dynamic subtest vcs1: SUCCESS (0.091s)
[188.157963] Starting dynamic subtest: vecs0
[188.233142] Dynamic subtest vecs0: SUCCESS (0.086s)
[188.244007] Starting dynamic subtest: ccs0
[188.322155] Dynamic subtest ccs0: SUCCESS (0.088s)
[188.324531] Subtest engines-hang: SUCCESS (0.578s)
[188.411498] [021/133] (830s left) kms_cursor_crc (cursor-alpha-transparent)
[188.515058] Starting subtest: cursor-alpha-transparent
[188.517604] Starting dynamic subtest: pipe-A-eDP-1
[189.134052] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.616s)
[189.143111] Starting dynamic subtest: pipe-D-eDP-1
[190.437467] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.300s)
[190.439720] Subtest cursor-alpha-transparent: SUCCESS (1.921s)
[191.229593] [022/133] (827s left) gem_mmap_offset (bad-extensions)
[191.278517] Starting subtest: bad-extensions
[191.280870] Subtest bad-extensions: SUCCESS (0.000s)
[191.366391] [023/133] (827s left) kms_addfb_basic (invalid-set-prop)
[191.421081] Starting subtest: invalid-set-prop
[191.423528] Subtest invalid-set-prop: SUCCESS (0.000s)
[191.548567] [024/133] (827s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[191.651676] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[191.653842] Starting dynamic subtest: pipe-A
[191.714150] Dynamic subtest pipe-A: SUCCESS (0.065s)
[191.725290] Starting dynamic subtest: pipe-B
[192.857995] Dynamic subtest pipe-B: SUCCESS (1.142s)
[192.869177] Starting dynamic subtest: pipe-C
[193.970078] Dynamic subtest pipe-C: SUCCESS (1.110s)
[193.979890] Starting dynamic subtest: pipe-D
[195.124192] Dynamic subtest pipe-D: SUCCESS (1.153s)
[195.126608] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.474s)
[196.270690] [025/133] (822s left) syncobj_timeline (reset-signaled)
[196.325803] Starting subtest: reset-signaled
[196.328221] Subtest reset-signaled: SUCCESS (0.001s)
[196.424410] [026/133] (822s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[196.534954] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[196.539016] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[196.631876] [027/133] (822s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[196.729580] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[196.731910] Starting dynamic subtest: pipe-A-eDP-1
[196.754732] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[196.766602] Starting dynamic subtest: pipe-B-eDP-1
[196.788015] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[196.796273] Starting dynamic subtest: pipe-C-eDP-1
[196.817526] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[196.828077] Starting dynamic subtest: pipe-D-eDP-1
[196.850433] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[196.854829] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.004s)
[199.023295] [028/133] (819s left) kms_hdr (invalid-metadata-sizes)
[199.108579] Starting subtest: invalid-metadata-sizes
[199.115035] Subtest invalid-metadata-sizes: SKIP (0.000s)
[199.181767] [029/133] (819s left) gem_fence_thrash (bo-write-verify-y)
[199.219825] Starting subtest: bo-write-verify-y
[199.256780] Subtest bo-write-verify-y: SKIP (0.035s)
[199.319105] [030/133] (819s left) gem_render_copy (linear-to-vebox-y-tiled)
[199.373707] Starting subtest: linear-to-vebox-y-tiled
[199.378224] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[199.555435] [031/133] (819s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[199.645762] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[199.650354] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[199.716868] [032/133] (819s left) i915_query (query-regions-garbage-items)
[199.778023] Starting subtest: query-regions-garbage-items
[199.780422] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[199.887748] [033/133] (819s left) syncobj_timeline (invalid-wait-illegal-handle)
[199.938973] Starting subtest: invalid-wait-illegal-handle
[199.941195] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[200.040990] [034/133] (818s left) kms_prop_blob (invalid-set-prop)
[200.101697] Starting subtest: invalid-set-prop
[200.103981] Subtest invalid-set-prop: SUCCESS (0.000s)
[200.193327] [035/133] (818s left) gem_gpgpu_fill (offset-16x16)
[200.251797] Starting subtest: offset-16x16
[200.256855] Subtest offset-16x16: SUCCESS (0.007s)
[200.395243] [036/133] (818s left) gem_ctx_shared (q-out-order)
[200.454923] Starting subtest: Q-out-order
[200.457059] Starting dynamic subtest: rcs0
[200.614854] Dynamic subtest rcs0: SUCCESS (0.159s)
[200.631089] Starting dynamic subtest: vcs0
[200.695977] Dynamic subtest vcs0: SUCCESS (0.080s)
[200.712301] Starting dynamic subtest: vcs1
[200.772015] Dynamic subtest vcs1: SUCCESS (0.075s)
[200.788330] Starting dynamic subtest: vecs0
[200.844263] Dynamic subtest vecs0: SUCCESS (0.072s)
[200.859684] Starting dynamic subtest: ccs0
[200.924422] Dynamic subtest ccs0: SUCCESS (0.079s)
[200.927119] Subtest Q-out-order: SUCCESS (0.469s)
[202.747922] [FACT gem_ctx_shared (q-out-order)] new: kernel.kmod_is_loaded.vgem: true
[202.751344] [037/133] (816s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[202.846980] Starting subtest: fbc-rgb565-draw-render
[207.034973] Subtest fbc-rgb565-draw-render: SUCCESS (4.190s)
[208.162125] [038/133] (810s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[208.263431] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[208.268034] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[208.355332] [039/133] (810s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[208.455128] Starting subtest: fbc-rgb101010-draw-pwrite
[213.831705] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.379s)
[214.961306] [040/133] (804s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping)
[215.061347] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping
[215.065768] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[215.137754] [041/133] (804s left) gem_linear_blits (normal)
[215.507308] Starting subtest: normal
[219.065224] Subtest normal: SUCCESS (3.556s)
[219.188837] [042/133] (800s left) sysfs_heartbeat_interval (precise)
[219.291161] Starting subtest: precise
[219.293585] Starting dynamic subtest: vecs0
[226.676915] Dynamic subtest vecs0: SUCCESS (7.385s)
[226.689062] Starting dynamic subtest: ccs0
[227.810503] Dynamic subtest ccs0: SUCCESS (1.130s)
[227.822278] Starting dynamic subtest: vcs0
[235.633807] Dynamic subtest vcs0: SUCCESS (7.824s)
[235.644508] Starting dynamic subtest: bcs0
[236.732140] Dynamic subtest bcs0: SUCCESS (1.094s)
[236.743564] Starting dynamic subtest: rcs0
[237.803326] Dynamic subtest rcs0: SUCCESS (1.072s)
[237.813253] Starting dynamic subtest: vcs1
[244.645086] Dynamic subtest vcs1: SUCCESS (6.838s)
[244.648040] Subtest precise: SUCCESS (25.354s)
[244.738668] [043/133] (774s left) sw_sync (sync_busy_fork_unixsocket)
[244.787904] Starting subtest: sync_busy_fork_unixsocket
[244.795725] Subtest sync_busy_fork_unixsocket: SUCCESS (0.010s)
[244.864298] [044/133] (774s left) prime_mmap (test_reprime)
[244.919341] Starting subtest: test_reprime
[244.921322] Starting dynamic subtest: test_reprime-smem
[244.948969] Dynamic subtest test_reprime-smem: SUCCESS (0.032s)
[244.951402] Subtest test_reprime: SUCCESS (0.032s)
[245.063467] [045/133] (774s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[245.200457] Starting subtest: cursorA-vs-flipA-atomic-transitions
[256.640150] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.440s)
[257.476667] [046/133] (762s left) kms_psr (psr2-dpms)
[257.574550] Starting subtest: psr2-dpms
[257.576822] Starting dynamic subtest: eDP-1
[260.483128] Dynamic subtest eDP-1: SUCCESS (2.910s)
[260.485524] Subtest psr2-dpms: SUCCESS (2.912s)
[261.354435] [047/133] (758s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[261.457207] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[261.461331] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[261.546773] [048/133] (758s left) dmabuf (all-tests)
[261.591993] Starting subtest: all-tests
[261.594335] Starting dynamic subtest: sanitycheck
[261.730676] Dynamic subtest sanitycheck: SUCCESS (0.138s)
[261.743448] Starting dynamic subtest: dma_fence
[261.930948] Dynamic subtest dma_fence: SUCCESS (0.198s)
[261.943936] Starting dynamic subtest: dma_fence_chain
[271.293780] Dynamic subtest dma_fence_chain: SUCCESS (9.361s)
[271.306083] Starting dynamic subtest: dma_fence_unwrap
[271.384633] Dynamic subtest dma_fence_unwrap: SUCCESS (0.090s)
[271.396451] Starting dynamic subtest: dma_resv
[271.484653] Dynamic subtest dma_resv: SUCCESS (0.097s)
[271.487428] Subtest all-tests: SUCCESS (9.895s)
[271.548413] [049/133] (748s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[271.691520] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[272.692027] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.999s)
[273.492120] [050/133] (746s left) kms_force_connector_basic (force-edid)
[273.567471] Starting subtest: force-edid
[273.941056] Subtest force-edid: SUCCESS (0.374s)
[274.080638] [051/133] (745s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[274.193593] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[274.198017] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[274.290868] [052/133] (745s left) i915_pm_rc6_residency (rc6-idle)
[274.358514] Starting subtest: rc6-idle
[274.384730] Starting dynamic subtest: gt0-rcs0
[298.673973] Dynamic subtest gt0-rcs0: SUCCESS (24.295s)
[298.685974] Starting dynamic subtest: gt0-bcs0
[323.020122] Dynamic subtest gt0-bcs0: SUCCESS (24.346s)
[323.029611] Starting dynamic subtest: gt0-ccs0
[347.391439] Dynamic subtest gt0-ccs0: SUCCESS (24.362s)
[347.402950] Starting dynamic subtest: gt1-vcs0
[353.567290] Dynamic subtest gt1-vcs0: SUCCESS (6.170s)
[353.579199] Starting dynamic subtest: gt1-vecs0
[359.740193] Dynamic subtest gt1-vecs0: SUCCESS (6.169s)
[359.742884] Subtest rc6-idle: SUCCESS (85.382s)
[359.835197] [053/133] (659s left) kms_async_flips (crc-atomic)
[359.936112] Starting subtest: crc-atomic
[360.326001] Starting dynamic subtest: pipe-A-eDP-1
[363.198439] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.869s)
[363.588659] Starting dynamic subtest: pipe-B-eDP-1
[366.490672] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.909s)
[366.866289] Starting dynamic subtest: pipe-C-eDP-1
[369.784187] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.925s)
[370.155326] Starting dynamic subtest: pipe-D-eDP-1
[373.082533] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.937s)
[373.084928] Subtest crc-atomic: SUCCESS (13.147s)
[374.312318] [054/133] (645s left) api_intel_allocator (reserve-simple)
[374.367181] Starting subtest: reserve-simple
[374.369499] Subtest reserve-simple: SUCCESS (0.003s)
[374.483777] [055/133] (645s left) kms_big_fb (linear-8bpp-rotate-90)
[374.589265] Starting subtest: linear-8bpp-rotate-90
[374.615634] Subtest linear-8bpp-rotate-90: SKIP (0.023s)
[374.716386] [056/133] (645s left) kms_joiner (invalid-modeset-ultra-joiner)
[374.819910] Starting subtest: invalid-modeset-ultra-joiner
[374.824344] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[374.894584] [057/133] (645s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[375.024985] Starting subtest: cursorA-vs-flipB-varying-size
[375.029617] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[375.195539] [058/133] (644s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[375.297846] Starting subtest: fbc-2p-pri-indfb-multidraw
[375.301330] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[375.406207] [059/133] (644s left) kms_flip (plain-flip-ts-check-interruptible)
[375.509696] Starting subtest: plain-flip-ts-check-interruptible
[375.511515] Starting dynamic subtest: A-eDP1
[384.365207] Dynamic subtest A-eDP1: SUCCESS (8.852s)
[384.381631] Starting dynamic subtest: B-eDP1
[393.176713] Dynamic subtest B-eDP1: SUCCESS (8.809s)
[393.189210] Starting dynamic subtest: C-eDP1
[401.988843] Dynamic subtest C-eDP1: SUCCESS (8.810s)
[402.000425] Starting dynamic subtest: D-eDP1
[410.866967] Dynamic subtest D-eDP1: SUCCESS (8.877s)
[410.869458] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.360s)
[412.104079] [060/133] (607s left) syncobj_wait (invalid-signal-illegal-handle)
[412.172597] Starting subtest: invalid-signal-illegal-handle
[412.175140] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[412.270799] [061/133] (607s left) gem_basic (create-close)
[412.343224] Starting subtest: create-close
[412.348366] Subtest create-close: SUCCESS (0.000s)
[412.461808] [062/133] (607s left) gem_exec_schedule (wide)
[412.637922] Starting subtest: wide
[412.640154] Starting dynamic subtest: rcs0
[422.701428] Dynamic subtest rcs0: SUCCESS (10.063s)
[422.718321] Starting dynamic subtest: vcs0
[432.712779] Dynamic subtest vcs0: SUCCESS (10.010s)
[432.725178] Starting dynamic subtest: vcs1
[443.693022] Dynamic subtest vcs1: SUCCESS (10.981s)
[443.705805] Starting dynamic subtest: vecs0
[454.246642] Dynamic subtest vecs0: SUCCESS (10.554s)
[454.259593] Starting dynamic subtest: ccs0
[468.329288] Dynamic subtest ccs0: SUCCESS (14.084s)
[468.331700] Subtest wide: SUCCESS (55.697s)
[471.423908] [063/133] (548s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[471.476315] Starting subtest: y-tiled-ccs-to-yf-tiled
[471.480956] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[471.679675] [064/133] (548s left) gem_exec_reloc (basic-cpu)
[471.740142] Subtest basic-cpu: SKIP (0.000s)
[471.814285] [065/133] (548s left) gem_exec_reloc (basic-gtt-cpu-active)
[471.871258] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[471.935710] [066/133] (548s left) i915_drm_fdinfo (virtual-idle)
[471.977933] Starting subtest: virtual-idle
[475.041691] Subtest virtual-idle: SUCCESS (3.062s)
[475.122534] [067/133] (545s left) kms_psr (fbc-pr-primary-mmap-cpu)
[475.226494] Starting subtest: fbc-pr-primary-mmap-cpu
[475.230817] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[475.307871] [068/133] (545s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[475.426778] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[475.430853] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[475.510624] [069/133] (544s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[475.582179] Starting subtest: etime-single-wait-for-submit-unsubmitted
[475.684796] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[475.765837] [070/133] (544s left) gem_mmap_gtt (basic-write-read)
[475.824177] Subtest basic-write-read: SKIP (0.000s)
[475.880486] [071/133] (544s left) i915_query (query-topology-matches-eu-total)
[475.937698] Starting subtest: query-topology-matches-eu-total
[475.940328] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[476.044665] [072/133] (544s left) kms_psr (pr-cursor-render)
[476.140898] Starting subtest: pr-cursor-render
[476.144546] Subtest pr-cursor-render: SKIP (0.000s)
[476.215792] [073/133] (544s left) kms_frontbuffer_tracking (fbc-tiling-y)
[476.308655] Starting subtest: fbc-tiling-y
[476.312059] Subtest fbc-tiling-y: SKIP (0.000s)
[476.404889] [074/133] (544s left) gem_reg_read (timestamp-monotonic)
[476.458137] Starting subtest: timestamp-monotonic
[480.760695] Subtest timestamp-monotonic: SUCCESS (4.303s)
[480.875517] [075/133] (539s left) gem_tiled_partial_pwrite_pread (reads)
[480.941325] Subtest reads: SKIP (0.000s)
[481.069855] [076/133] (539s left) gem_softpin (evict-snoop-interruptible)
[481.138886] Starting subtest: evict-snoop-interruptible
[481.143538] Subtest evict-snoop-interruptible: SKIP (0.000s)
[481.262573] [077/133] (539s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[481.368498] Starting subtest: fbc-psr2-cursor-plane-onoff
[481.370793] Starting dynamic subtest: eDP-1
[481.375053] Dynamic subtest eDP-1: SKIP (0.000s)
[481.379207] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s)
[481.454930] [078/133] (539s left) syncobj_basic (bad-destroy-pad)
[481.509570] Starting subtest: bad-destroy-pad
[481.511461] Subtest bad-destroy-pad: SUCCESS (0.000s)
[481.652510] [079/133] (539s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[481.744613] Starting subtest: async-flip-with-page-flip-events-tiled
[482.129281] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[484.928219] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.799s)
[484.940909] Starting dynamic subtest: pipe-A-eDP-1-4
[487.168044] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.238s)
[487.177939] Starting dynamic subtest: pipe-A-eDP-1-4
[489.177576] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s)
[489.187384] Starting dynamic subtest: pipe-A-eDP-1-x
[491.367455] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.189s)
[491.751959] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[494.527795] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.784s)
[494.539360] Starting dynamic subtest: pipe-B-eDP-1-4
[496.712891] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.184s)
[496.723030] Starting dynamic subtest: pipe-B-eDP-1-4
[498.722443] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[498.732096] Starting dynamic subtest: pipe-B-eDP-1-x
[500.912209] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[501.277420] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[504.022284] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.753s)
[504.032308] Starting dynamic subtest: pipe-C-eDP-1-4
[506.197192] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s)
[506.207772] Starting dynamic subtest: pipe-C-eDP-1-4
[508.206300] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.008s)
[508.217127] Starting dynamic subtest: pipe-C-eDP-1-x
[510.384583] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[510.750839] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[513.513711] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.771s)
[513.524330] Starting dynamic subtest: pipe-D-eDP-1-4
[515.687682] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.173s)
[515.697963] Starting dynamic subtest: pipe-D-eDP-1-4
[517.697549] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[517.708855] Starting dynamic subtest: pipe-D-eDP-1-x
[519.876034] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.177s)
[519.878445] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.140s)
[521.070337] [080/133] (499s left) kms_chamelium_edid (vga-edid-read)
[521.458963] Subtest vga-edid-read: SKIP (0.000s)
[522.253032] [081/133] (498s left) kms_psr (fbc-psr-no-drrs)
[522.349952] Starting subtest: fbc-psr-no-drrs
[522.352390] Starting dynamic subtest: eDP-1
[522.356825] Dynamic subtest eDP-1: SKIP (0.000s)
[522.361407] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[522.419275] [082/133] (498s left) kms_pipe_crc_basic (hang-read-crc)
[522.513485] Starting subtest: hang-read-crc
[522.515836] Starting dynamic subtest: pipe-A-eDP-1
[524.648594] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.137s)
[524.661439] Starting dynamic subtest: pipe-B-eDP-1
[527.423068] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.769s)
[527.433471] Starting dynamic subtest: pipe-C-eDP-1
[530.090661] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.666s)
[530.102057] Starting dynamic subtest: pipe-D-eDP-1
[532.768198] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.678s)
[532.770553] Subtest hang-read-crc: SUCCESS (10.259s)
[533.570708] [083/133] (487s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[533.678094] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[533.682542] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[533.773337] [084/133] (487s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[535.830421] Starting subtest: modeset-lpsp-stress-no-wait
[546.018238] Subtest modeset-lpsp-stress-no-wait: SUCCESS (10.190s)
[546.157846] [085/133] (475s left) fbdev (nullptr)
[546.221143] Starting subtest: nullptr
[546.223971] Subtest nullptr: SUCCESS (0.000s)
[546.282805] [086/133] (475s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[546.378629] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[546.382808] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[546.486559] [087/133] (474s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[546.535316] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[546.644049] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.108s)
[546.734045] [088/133] (474s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[546.821455] Starting subtest: primary-x-tiled-reflect-x-0
[553.881436] Subtest primary-x-tiled-reflect-x-0: SUCCESS (7.059s)
[555.069929] [089/133] (466s left) gem_exec_schedule (pi-userfault)
[555.261076] Starting subtest: pi-userfault
[555.263150] Starting dynamic subtest: rcs0
[555.269145] Dynamic subtest rcs0: SUCCESS (0.011s)
[555.279561] Starting dynamic subtest: bcs0
[555.282013] Dynamic subtest bcs0: SUCCESS (0.010s)
[555.292440] Starting dynamic subtest: vcs0
[555.294838] Dynamic subtest vcs0: SUCCESS (0.010s)
[555.305367] Starting dynamic subtest: vcs1
[555.307937] Dynamic subtest vcs1: SUCCESS (0.009s)
[555.318603] Starting dynamic subtest: vecs0
[555.320586] Dynamic subtest vecs0: SUCCESS (0.008s)
[555.331134] Starting dynamic subtest: ccs0
[555.333291] Dynamic subtest ccs0: SUCCESS (0.013s)
[555.335490] Subtest pi-userfault: SUCCESS (0.067s)
[555.522608] [090/133] (465s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[555.633550] Starting subtest: x-tiled-32bpp-rotate-90
[555.653063] Subtest x-tiled-32bpp-rotate-90: SKIP (0.019s)
[555.791715] [091/133] (465s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[555.888982] Starting subtest: y-tiled-64bpp-rotate-270
[555.893273] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[555.976296] [092/133] (465s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier)
[556.067330] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier
[556.071429] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (0.000s)
[556.142664] [093/133] (465s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[556.247455] Starting subtest: yf-tiled-32bpp-rotate-0
[556.251934] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[556.351456] [094/133] (465s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[556.460201] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[556.463723] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[556.590481] [095/133] (465s left) kms_universal_plane (universal-plane-functional)
[556.691073] Starting subtest: universal-plane-functional
[556.692926] Starting dynamic subtest: pipe-A-eDP-1
[560.703809] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.013s)
[560.714339] Starting dynamic subtest: pipe-B-eDP-1
[565.380874] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.677s)
[565.391839] Starting dynamic subtest: pipe-C-eDP-1
[569.754297] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.372s)
[569.766174] Starting dynamic subtest: pipe-D-eDP-1
[574.166694] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.407s)
[574.168961] Subtest universal-plane-functional: SUCCESS (17.476s)
[574.983688] [096/133] (446s left) kms_cursor_legacy (single-move)
[575.107735] Starting subtest: single-move
[575.110107] Starting dynamic subtest: pipe-A
[580.495287] Dynamic subtest pipe-A: SUCCESS (5.380s)
[580.507364] Starting dynamic subtest: pipe-B
[585.881416] Dynamic subtest pipe-B: SUCCESS (5.379s)
[585.892985] Starting dynamic subtest: pipe-C
[591.266659] Dynamic subtest pipe-C: SUCCESS (5.379s)
[591.278588] Starting dynamic subtest: pipe-D
[596.651404] Dynamic subtest pipe-D: SUCCESS (5.379s)
[596.661274] Starting dynamic subtest: all-pipes
[602.042836] Dynamic subtest all-pipes: SUCCESS (5.386s)
[602.045251] Subtest single-move: SUCCESS (26.917s)
[602.190943] [097/133] (419s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[602.325692] Starting subtest: short-flip-after-cursor-atomic-transitions
[603.285698] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.957s)
[604.085172] [098/133] (417s left) gem_exec_params (invalid-ring)
[604.136962] Starting subtest: invalid-ring
[604.139337] Subtest invalid-ring: SUCCESS (0.000s)
[604.238213] [099/133] (417s left) gem_pread (self)
[604.293035] Subtest self: SKIP (0.000s)
[604.347676] [100/133] (417s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[604.445038] Starting subtest: primary-4-tiled-reflect-x-180
[611.509344] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.063s)
[612.679101] [101/133] (409s left) gem_spin_batch (spin-each)
[612.749300] Starting subtest: spin-each
[616.107352] Subtest spin-each: SUCCESS (3.357s)
[616.700148] [102/133] (405s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[616.796417] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[616.798678] Starting dynamic subtest: pipe-A-eDP-1
[616.821748] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[616.834268] Starting dynamic subtest: pipe-B-eDP-1
[616.856124] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[616.865939] Starting dynamic subtest: pipe-C-eDP-1
[616.886858] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[616.896572] Starting dynamic subtest: pipe-D-eDP-1
[616.918692] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[616.922723] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[619.077520] [103/133] (403s left) kms_cursor_edge_walk (128x128-top-edge)
[619.168336] Starting subtest: 128x128-top-edge
[619.170582] Starting dynamic subtest: pipe-A-eDP-1
[622.607139] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.438s)
[622.617932] Starting dynamic subtest: pipe-D-eDP-1
[625.809922] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.200s)
[625.812097] Subtest 128x128-top-edge: SUCCESS (6.640s)
[626.685683] [104/133] (395s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[626.792293] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[633.881689] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.091s)
[633.998379] [105/133] (388s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[634.091680] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[634.095649] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[634.165679] [106/133] (388s left) kms_cursor_crc (cursor-random-32x10)
[634.325511] Starting subtest: cursor-random-32x10
[634.379160] Subtest cursor-random-32x10: SKIP (0.048s)
[634.663408] [107/133] (387s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[634.768643] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[634.770942] Starting dynamic subtest: pipe-A-eDP-1
[634.793561] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[634.805887] Starting dynamic subtest: pipe-B-eDP-1
[634.823579] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[634.833216] Starting dynamic subtest: pipe-C-eDP-1
[634.848753] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[634.859044] Starting dynamic subtest: pipe-D-eDP-1
[634.874938] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[634.876748] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s)
[636.982766] [108/133] (385s left) perf_pmu (busy)
[637.027965] Starting subtest: busy
[637.030321] Starting dynamic subtest: rcs0
[637.617633] Dynamic subtest rcs0: SUCCESS (0.590s)
[637.630904] Starting dynamic subtest: bcs0
[638.185405] Dynamic subtest bcs0: SUCCESS (0.565s)
[638.199565] Starting dynamic subtest: vcs0
[639.656460] Dynamic subtest vcs0: SUCCESS (1.467s)
[639.669623] Starting dynamic subtest: vcs1
[641.640409] Dynamic subtest vcs1: SUCCESS (1.981s)
[641.653227] Starting dynamic subtest: vecs0
[643.623748] Dynamic subtest vecs0: SUCCESS (1.980s)
[643.635334] Starting dynamic subtest: ccs0
[644.188607] Dynamic subtest ccs0: SUCCESS (0.563s)
[644.191594] Subtest busy: SUCCESS (7.161s)
[644.309459] [109/133] (378s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[644.401304] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[644.403480] Starting dynamic subtest: pipe-A-eDP-1
[645.649644] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.249s)
[645.660321] Starting dynamic subtest: pipe-B-eDP-1
[647.987566] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.336s)
[647.998390] Starting dynamic subtest: pipe-C-eDP-1
[650.297618] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.308s)
[650.308364] Starting dynamic subtest: pipe-D-eDP-1
[652.584477] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.285s)
[652.586867] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.184s)
[653.784714] [110/133] (368s left) kms_content_protection (atomic)
[653.934470] Starting subtest: atomic
[653.938539] Subtest atomic: SKIP (0.000s)
[654.082510] [111/133] (368s left) gem_exec_schedule (deep)
[654.277364] Starting subtest: deep
[654.280122] Starting dynamic subtest: rcs0
[659.853222] Dynamic subtest rcs0: SKIP (5.571s)
[659.865222] Starting dynamic subtest: vcs0
[670.883110] Dynamic subtest vcs0: SUCCESS (11.028s)
[670.901113] Starting dynamic subtest: vcs1
[682.455285] Dynamic subtest vcs1: SUCCESS (11.570s)
[682.470279] Starting dynamic subtest: vecs0
[694.031387] Dynamic subtest vecs0: SUCCESS (11.574s)
[694.044443] Starting dynamic subtest: ccs0
[706.552022] Dynamic subtest ccs0: SUCCESS (12.516s)
[706.554846] Subtest deep: SUCCESS (52.269s)
[708.009259] [112/133] (314s left) syncobj_wait (multi-wait-for-submit-signaled)
[708.071065] Starting subtest: multi-wait-for-submit-signaled
[708.073652] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[708.174046] [113/133] (314s left) gem_exec_fence (submit3)
[708.378146] Starting subtest: submit3
[708.383413] Subtest submit3: SKIP (0.000s)
[710.716443] [114/133] (311s left) gem_mmap_wc (write)
[710.769494] Subtest write: SKIP (0.000s)
[710.832381] [115/133] (311s left) gem_create (create-ext-placement-sanity-check)
[710.996125] Starting subtest: create-ext-placement-sanity-check
[710.998691] Subtest create-ext-placement-sanity-check: SUCCESS (0.004s)
[711.092090] [116/133] (311s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[711.191302] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[711.193609] Starting dynamic subtest: pipe-A-eDP-1
[712.120450] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.922s)
[712.136251] Starting dynamic subtest: pipe-B-eDP-1
[713.817426] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.693s)
[713.829249] Starting dynamic subtest: pipe-C-eDP-1
[715.423516] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.607s)
[715.435500] Starting dynamic subtest: pipe-D-eDP-1
[716.957537] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.534s)
[716.959756] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.762s)
[718.187335] [117/133] (304s left) gem_lmem_swapping (parallel-random-verify-ccs)
[718.234144] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[718.280780] [118/133] (304s left) api_intel_bb (object-reloc-keep-cache)
[718.335494] Starting subtest: object-reloc-keep-cache
[718.342889] Subtest object-reloc-keep-cache: SKIP (0.006s)
[718.463183] [119/133] (304s left) kms_rotation_crc (primary-rotation-90)
[718.559207] Starting subtest: primary-rotation-90
[718.563435] Subtest primary-rotation-90: SKIP (0.001s)
[718.646353] [120/133] (304s left) sw_sync (alloc_merge_fence)
[718.687106] Starting subtest: alloc_merge_fence
[718.689229] Subtest alloc_merge_fence: SUCCESS (0.000s)
[718.741235] [121/133] (304s left) kms_flip (2x-flip-vs-panning)
[718.826150] Starting subtest: 2x-flip-vs-panning
[718.837619] Subtest 2x-flip-vs-panning: SKIP (0.011s)
[718.916863] [122/133] (303s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[719.016503] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[719.020497] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[719.117933] [123/133] (303s left) perf_pmu (busy-no-semaphores)
[719.163500] Starting subtest: busy-no-semaphores
[719.165389] Starting dynamic subtest: rcs0
[719.726455] Dynamic subtest rcs0: SUCCESS (0.560s)
[719.739333] Starting dynamic subtest: bcs0
[720.277367] Dynamic subtest bcs0: SUCCESS (0.547s)
[720.288303] Starting dynamic subtest: vcs0
[720.826890] Dynamic subtest vcs0: SUCCESS (0.546s)
[720.839872] Starting dynamic subtest: vcs1
[722.155030] Dynamic subtest vcs1: SUCCESS (1.324s)
[722.167572] Starting dynamic subtest: vecs0
[724.137873] Dynamic subtest vecs0: SUCCESS (1.980s)
[724.149083] Starting dynamic subtest: ccs0
[726.188092] Dynamic subtest ccs0: SUCCESS (2.047s)
[726.191072] Subtest busy-no-semaphores: SUCCESS (7.024s)
[726.303646] [124/133] (296s left) sw_sync (alloc_fence)
[726.348053] Starting subtest: alloc_fence
[726.350556] Subtest alloc_fence: SUCCESS (0.000s)
[726.404725] [125/133] (296s left) gem_eio (in-flight-contexts-immediate)
[726.616834] Starting subtest: in-flight-contexts-immediate
[740.684248] Subtest in-flight-contexts-immediate: SUCCESS (14.066s)
[740.846528] [126/133] (282s left) syncobj_timeline (wait-all-interrupted)
[740.905671] Starting subtest: wait-all-interrupted
[741.012780] Subtest wait-all-interrupted: SUCCESS (0.108s)
[741.105982] [127/133] (282s left) gem_ctx_shared (create-shared-gtt)
[741.177009] Starting subtest: create-shared-gtt
[743.330328] Subtest create-shared-gtt: SUCCESS (2.153s)
[743.867437] [128/133] (279s left) kms_vrr (flip-basic-fastset)
[743.967227] Starting subtest: flip-basic-fastset
[743.973511] Subtest flip-basic-fastset: SKIP (0.000s)
[744.052028] [129/133] (279s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[744.154073] Starting subtest: psr-rgb565-draw-mmap-gtt
[744.158067] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[744.253009] [130/133] (278s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[744.353803] Starting subtest: 4-tiled-16bpp-rotate-90
[744.373961] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.019s)
[744.492231] [131/133] (278s left) kms_flip (dpms-off-confusion)
[744.582362] Starting subtest: dpms-off-confusion
[744.584661] Starting dynamic subtest: A-eDP1
[753.261008] Dynamic subtest A-eDP1: SUCCESS (8.678s)
[753.275953] Starting dynamic subtest: B-eDP1
[761.965262] Dynamic subtest B-eDP1: SUCCESS (8.701s)
[761.977586] Starting dynamic subtest: C-eDP1
[770.641624] Dynamic subtest C-eDP1: SUCCESS (8.674s)
[770.651848] Starting dynamic subtest: D-eDP1
[779.338426] Dynamic subtest D-eDP1: SUCCESS (8.696s)
[779.343692] Subtest dpms-off-confusion: SUCCESS (34.761s)
[780.575740] [132/133] (242s left) gen9_exec_parse (basic-rejected-ctx-param)
[780.637250] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[780.712951] [133/133] (242s left) gem_mmap_wc (set-cache-level)
[780.767856] Subtest set-cache-level: SKIP (0.000s)
[780.828777] Closing watchdogs
results: parsing output: 0/ for test: kms_chamelium_hpd
results: parsing output: 1/ for test: kms_properties
results: parsing output: 2/ for test: gem_mmap
results: parsing output: 3/ for test: gem_exec_schedule
results: parsing output: 4/ for test: gem_workarounds
results: parsing output: 5/ for test: kms_color
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: gem_exec_balancer
results: parsing output: 9/ for test: kms_invalid_mode
results: parsing output: 10/ for test: gem_tiled_pread_basic
results: parsing output: 11/ for test: gem_exec_balancer
results: parsing output: 12/ for test: kms_pm_backlight
results: parsing output: 13/ for test: i915_drm_fdinfo
results: parsing output: 14/ for test: perf
results: parsing output: 15/ for test: kms_psr2_sf
results: parsing output: 16/ for test: kms_flip_tiling
results: parsing output: 17/ for test: kms_dsc
results: parsing output: 18/ for test: kms_flip
results: parsing output: 19/ for test: gem_ctx_persistence
results: parsing output: 20/ for test: kms_cursor_crc
results: parsing output: 21/ for test: gem_mmap_offset
results: parsing output: 22/ for test: kms_addfb_basic
results: parsing output: 23/ for test: kms_plane_scaling
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_ccs
results: parsing output: 27/ for test: kms_hdr
results: parsing output: 28/ for test: gem_fence_thrash
results: parsing output: 29/ for test: gem_render_copy
results: parsing output: 30/ for test: kms_plane
results: parsing output: 31/ for test: i915_query
results: parsing output: 32/ for test: syncobj_timeline
results: parsing output: 33/ for test: kms_prop_blob
results: parsing output: 34/ for test: gem_gpgpu_fill
results: parsing output: 35/ for test: gem_ctx_shared
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_plane
results: parsing output: 40/ for test: gem_linear_blits
results: parsing output: 41/ for test: sysfs_heartbeat_interval
results: parsing output: 42/ for test: sw_sync
results: parsing output: 43/ for test: prime_mmap
results: parsing output: 44/ for test: kms_cursor_legacy
results: parsing output: 45/ for test: kms_psr
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: dmabuf
results: parsing output: 48/ for test: kms_cursor_legacy
results: parsing output: 49/ for test: kms_force_connector_basic
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: i915_pm_rc6_residency
results: parsing output: 52/ for test: kms_async_flips
results: parsing output: 53/ for test: api_intel_allocator
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: kms_joiner
results: parsing output: 56/ for test: kms_cursor_legacy
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_flip
results: parsing output: 59/ for test: syncobj_wait
results: parsing output: 60/ for test: gem_basic
results: parsing output: 61/ for test: gem_exec_schedule
results: parsing output: 62/ for test: gem_render_copy
results: parsing output: 63/ for test: gem_exec_reloc
results: parsing output: 64/ for test: gem_exec_reloc
results: parsing output: 65/ for test: i915_drm_fdinfo
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: kms_flip_scaled_crc
results: parsing output: 68/ for test: syncobj_timeline
results: parsing output: 69/ for test: gem_mmap_gtt
results: parsing output: 70/ for test: i915_query
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: gem_reg_read
results: parsing output: 74/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 75/ for test: gem_softpin
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: syncobj_basic
results: parsing output: 78/ for test: kms_async_flips
results: parsing output: 79/ for test: kms_chamelium_edid
results: parsing output: 80/ for test: kms_psr
results: parsing output: 81/ for test: kms_pipe_crc_basic
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_pm_rpm
results: parsing output: 84/ for test: fbdev
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: syncobj_timeline
results: parsing output: 87/ for test: kms_rotation_crc
results: parsing output: 88/ for test: gem_exec_schedule
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: kms_plane
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_universal_plane
results: parsing output: 95/ for test: kms_cursor_legacy
results: parsing output: 96/ for test: kms_cursor_legacy
results: parsing output: 97/ for test: gem_exec_params
results: parsing output: 98/ for test: gem_pread
results: parsing output: 99/ for test: kms_rotation_crc
results: parsing output: 100/ for test: gem_spin_batch
results: parsing output: 101/ for test: kms_ccs
results: parsing output: 102/ for test: kms_cursor_edge_walk
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_flip_scaled_crc
results: parsing output: 105/ for test: kms_cursor_crc
results: parsing output: 106/ for test: kms_ccs
results: parsing output: 107/ for test: perf_pmu
results: parsing output: 108/ for test: kms_ccs
results: parsing output: 109/ for test: kms_content_protection
results: parsing output: 110/ for test: gem_exec_schedule
results: parsing output: 111/ for test: syncobj_wait
results: parsing output: 112/ for test: gem_exec_fence
results: parsing output: 113/ for test: gem_mmap_wc
results: parsing output: 114/ for test: gem_create
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: gem_lmem_swapping
results: parsing output: 117/ for test: api_intel_bb
results: parsing output: 118/ for test: kms_rotation_crc
results: parsing output: 119/ for test: sw_sync
results: parsing output: 120/ for test: kms_flip
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: perf_pmu
results: parsing output: 123/ for test: sw_sync
results: parsing output: 124/ for test: gem_eio
results: parsing output: 125/ for test: syncobj_timeline
results: parsing output: 126/ for test: gem_ctx_shared
results: parsing output: 127/ for test: kms_vrr
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: kms_flip
results: parsing output: 131/ for test: gen9_exec_parse
results: parsing output: 132/ for test: gem_mmap_wc
Done.