[57.239291] Initializing watchdogs
[57.239336]   /dev/watchdog0
[57.253773] [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.258115] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.260823] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.264130] [001/130] (960s left) perf_pmu (gt-awake)
[57.329679] Starting subtest: gt-awake
[65.879572] Subtest gt-awake: SUCCESS (8.588s)
[66.001177] [002/130] (951s left) i915_getparams_basic (basic-eu-total)
[66.060901] Starting subtest: basic-eu-total
[66.065506] Subtest basic-eu-total: SUCCESS (0.000s)
[66.182914] [003/130] (951s left) kms_psr (fbc-psr2-sprite-plane-move)
[66.294851] Starting subtest: fbc-psr2-sprite-plane-move
[66.297133] Starting dynamic subtest: eDP-1
[66.301225] Dynamic subtest eDP-1: SKIP (0.000s)
[66.305346] Subtest fbc-psr2-sprite-plane-move: SKIP (0.000s)
[66.390200] [004/130] (951s left) kms_getfb (getfb2-accept-nv12)
[66.493228] Starting subtest: getfb2-accept-nv12
[66.495387] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[66.631090] [005/130] (951s left) syncobj_timeline (etime-single-wait-submitted)
[66.761464] Starting subtest: etime-single-wait-submitted
[66.865215] Subtest etime-single-wait-submitted: SUCCESS (0.104s)
[66.966342] [006/130] (950s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[67.249499] Starting subtest: fbcpsr-tiling-4
[74.370939] Subtest fbcpsr-tiling-4: SUCCESS (7.135s)
[74.552244] [007/130] (943s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[74.656845] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[74.661047] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[74.784449] [008/130] (943s left) gem_create (create-size-update)
[74.844857] Starting subtest: create-size-update
[74.846740] Subtest create-size-update: SUCCESS (0.000s)
[75.066290] [009/130] (943s left) gem_exec_nop (basic-parallel)
[75.148307] Starting subtest: basic-parallel
[89.942367] Subtest basic-parallel: SUCCESS (14.803s)
[90.210334] [010/130] (927s left) perf_pmu (rc6)
[90.258321] Starting subtest: rc6
[90.260482] Starting dynamic subtest: gt0
[96.624398] Dynamic subtest gt0: SUCCESS (6.365s)
[96.632067] Starting dynamic subtest: runtime-pm-gt0
[104.333911] Dynamic subtest runtime-pm-gt0: SUCCESS (7.708s)
[104.342030] Starting dynamic subtest: runtime-pm-long-gt0
[116.780922] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.445s)
[116.790795] Starting dynamic subtest: other-idle-gt0
[123.123601] Dynamic subtest other-idle-gt0: SUCCESS (6.341s)
[123.132277] Starting dynamic subtest: gt1
[129.464968] Dynamic subtest gt1: SUCCESS (6.340s)
[129.474994] Starting dynamic subtest: runtime-pm-gt1
[136.912050] Dynamic subtest runtime-pm-gt1: SUCCESS (7.446s)
[136.920913] Starting dynamic subtest: runtime-pm-long-gt1
[149.351087] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.437s)
[149.361297] Starting dynamic subtest: other-idle-gt1
[155.693280] Dynamic subtest other-idle-gt1: SUCCESS (6.341s)
[155.696239] Subtest rc6: SUCCESS (65.432s)
[156.830536] [011/130] (861s left) kms_cursor_crc (cursor-sliding-64x64)
[157.008214] Starting subtest: cursor-sliding-64x64
[157.012180] Starting dynamic subtest: pipe-A-eDP-1
[160.283379] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.270s)
[160.312097] Starting dynamic subtest: pipe-D-eDP-1
[164.182064] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.875s)
[164.184599] Subtest cursor-sliding-64x64: SUCCESS (7.172s)
[165.002825] [012/130] (853s left) perf (rc6-disable)
[165.105337] Starting subtest: rc6-disable
[165.277830] Subtest rc6-disable: SUCCESS (0.173s)
[165.329536] [013/130] (852s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[165.387643] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[165.490065] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.101s)
[165.547497] [014/130] (852s left) gem_workarounds (suspend-resume-fd)
[165.621185] Starting subtest: suspend-resume-fd
[182.314358] Subtest suspend-resume-fd: SUCCESS (6.054s)
[189.437804] [015/130] (835s left) gem_basic (create-close)
[189.515902] Starting subtest: create-close
[189.520500] Subtest create-close: SUCCESS (0.000s)
[189.598601] [016/130] (835s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[189.653850] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[189.758777] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.108s)
[189.809329] [017/130] (835s left) gen7_exec_parse (basic-allowed)
[189.877806] Subtest basic-allowed: SKIP (0.000s)
[189.970506] [018/130] (835s left) prime_busy (after-wait)
[190.034522] Starting subtest: after-wait
[190.036790] Starting dynamic subtest: rcs0
[190.090890] Dynamic subtest rcs0: SUCCESS (0.057s)
[190.101099] Starting dynamic subtest: bcs0
[190.157654] Dynamic subtest bcs0: SUCCESS (0.069s)
[190.167387] Starting dynamic subtest: vcs0
[190.201580] Dynamic subtest vcs0: SUCCESS (0.045s)
[190.210719] Starting dynamic subtest: vcs1
[190.243777] Dynamic subtest vcs1: SUCCESS (0.043s)
[190.252784] Starting dynamic subtest: vecs0
[190.285842] Dynamic subtest vecs0: SUCCESS (0.044s)
[190.295021] Starting dynamic subtest: ccs0
[190.329466] Dynamic subtest ccs0: SUCCESS (0.045s)
[190.436130] Subtest after-wait: SUCCESS (0.416s)
[190.496291] [019/130] (834s left) i915_query (engine-info-invalid)
[190.565104] Starting subtest: engine-info-invalid
[190.567105] Subtest engine-info-invalid: SUCCESS (0.000s)
[190.654796] [020/130] (834s left) kms_flip (2x-flip-vs-dpms-on-nop)
[190.752253] Starting subtest: 2x-flip-vs-dpms-on-nop
[190.761333] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.011s)
[190.814426] [021/130] (834s left) gem_eio (in-flight-internal-1us)
[191.037073] Starting subtest: in-flight-internal-1us
[192.623034] Subtest in-flight-internal-1us: SUCCESS (1.627s)
[192.755431] [022/130] (832s left) kms_psr2_su (page_flip-xrgb8888)
[192.813114] Subtest page_flip-XRGB8888: SKIP (0.000s)
[192.867702] [023/130] (832s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[192.930826] Starting subtest: x-tiled-to-vebox-yf-tiled
[192.935296] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[193.089586] [024/130] (832s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[193.205415] Starting subtest: yf-tiled-16bpp-rotate-270
[193.209594] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[193.287211] [025/130] (832s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[193.374176] Starting subtest: bad-pixel-format-y-tiled-ccs
[193.376426] Starting dynamic subtest: pipe-A-eDP-1
[193.398455] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[193.407960] Starting dynamic subtest: pipe-B-eDP-1
[193.427879] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[193.435777] Starting dynamic subtest: pipe-C-eDP-1
[193.455823] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[193.463794] Starting dynamic subtest: pipe-D-eDP-1
[193.484216] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[193.488221] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.003s)
[195.568551] [026/130] (830s left) gem_exec_params (dr1-dirt)
[195.628336] Starting subtest: DR1-dirt
[195.630624] Subtest DR1-dirt: SUCCESS (0.000s)
[195.710996] [027/130] (830s left) kms_color (legacy-gamma)
[195.809093] Starting subtest: legacy-gamma
[195.811251] Starting dynamic subtest: pipe-A-eDP-1
[196.541252] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.744s)
[196.552283] Starting dynamic subtest: pipe-B-eDP-1
[197.949676] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.426s)
[197.958520] Starting dynamic subtest: pipe-C-eDP-1
[199.321822] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.387s)
[199.336640] Starting dynamic subtest: pipe-D-eDP-1
[200.626099] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.313s)
[200.628455] Subtest legacy-gamma: SUCCESS (4.872s)
[201.418505] [028/130] (824s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[201.516159] Starting subtest: x-tiled-8bpp-rotate-0
[202.735784] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.230s)
[202.857551] [029/130] (823s left) prime_mmap (test_correct)
[202.930510] Starting subtest: test_correct
[202.932540] Starting dynamic subtest: test_correct-smem
[202.965857] Dynamic subtest test_correct-smem: SUCCESS (0.037s)
[202.967852] Subtest test_correct: SUCCESS (0.038s)
[203.068189] [030/130] (822s left) kms_pm_backlight (fade-with-suspend)
[203.156537] Starting subtest: fade-with-suspend
[220.302849] Starting dynamic subtest: eDP-1
[222.980186] Dynamic subtest eDP-1: SUCCESS (2.692s)
[222.982537] Subtest fade-with-suspend: SUCCESS (4.322s)
[228.785350] [031/130] (802s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[233.670830] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area
[233.675338] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.002s)
[234.478359] [032/130] (796s left) gem_ppgtt (blt-vs-render-ctx0)
[234.544750] Starting subtest: blt-vs-render-ctx0
[267.349715] Subtest blt-vs-render-ctx0: SUCCESS (32.921s)
[267.451328] [033/130] (763s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[267.594760] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[267.597016] Starting dynamic subtest: pipe-A-eDP-1
[267.655757] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[267.667012] Starting dynamic subtest: pipe-B-eDP-1
[267.723451] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[267.733981] Starting dynamic subtest: pipe-C-eDP-1
[267.790658] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[267.799958] Starting dynamic subtest: pipe-D-eDP-1
[267.853754] Dynamic subtest pipe-D-eDP-1: SKIP (0.003s)
[267.858043] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.010s)
[269.818224] [034/130] (761s left) gem_lmem_swapping (verify-random-ccs)
[269.871389] Subtest verify-random-ccs: SKIP (0.000s)
[269.919079] [035/130] (761s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[270.011331] Starting subtest: plane-primary-toggle-with-vblank-wait
[270.013637] Starting dynamic subtest: pipe-A-eDP-1
[270.184205] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.174s)
[270.511027] Starting dynamic subtest: pipe-B-eDP-1
[271.457460] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.955s)
[271.757532] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.747s)
[272.596242] [036/130] (758s left) gem_exec_alignment (pi-isolated)
[272.667874] Starting subtest: pi-isolated
[323.558200] Subtest pi-isolated: SUCCESS (50.899s)
[324.717715] [037/130] (706s left) kms_pm_rpm (modeset-stress-extra-wait)
[326.308700] Starting subtest: modeset-stress-extra-wait
[380.601406] Subtest modeset-stress-extra-wait: SUCCESS (54.286s)
[380.669448] [038/130] (650s left) gem_exec_params (cliprects_ptr-dirt)
[380.737260] Starting subtest: cliprects_ptr-dirt
[380.739208] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[380.831669] [039/130] (650s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[380.929237] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[380.933476] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[381.010220] [040/130] (650s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[381.102288] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[381.104598] Starting dynamic subtest: pipe-A-eDP-1
[381.126740] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[381.138136] Starting dynamic subtest: pipe-B-eDP-1
[381.158818] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[381.167874] Starting dynamic subtest: pipe-C-eDP-1
[381.188221] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[381.196975] Starting dynamic subtest: pipe-D-eDP-1
[381.218553] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[381.222836] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[383.306244] [041/130] (648s left) kms_busy (extended-modeset-hang-newfb)
[383.415183] Starting subtest: extended-modeset-hang-newfb
[383.417190] Starting dynamic subtest: pipe-A
[417.938779] Dynamic subtest pipe-A: SUCCESS (34.529s)
[417.949107] Starting dynamic subtest: pipe-D
[441.034838] Dynamic subtest pipe-D: SUCCESS (23.098s)
[441.037145] Subtest extended-modeset-hang-newfb: SUCCESS (57.632s)
[441.809550] [042/130] (589s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[441.902180] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[441.906326] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[441.973463] [043/130] (589s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[442.039204] Starting subtest: multi-wait-available-unsubmitted-signaled
[442.041465] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.001s)
[442.091627] [044/130] (589s left) gem_softpin (evict-prime)
[442.157175] Starting subtest: evict-prime
[442.159529] Starting dynamic subtest: rcs0
[443.343987] Dynamic subtest rcs0: SUCCESS (1.186s)
[443.356406] Starting dynamic subtest: bcs0
[444.494785] Dynamic subtest bcs0: SUCCESS (1.149s)
[444.506909] Starting dynamic subtest: vcs0
[446.023299] Dynamic subtest vcs0: SUCCESS (1.526s)
[446.038738] Starting dynamic subtest: vcs1
[448.039487] Dynamic subtest vcs1: SUCCESS (2.015s)
[448.052112] Starting dynamic subtest: vecs0
[450.065791] Dynamic subtest vecs0: SUCCESS (2.025s)
[450.078208] Starting dynamic subtest: ccs0
[451.220967] Dynamic subtest ccs0: SUCCESS (1.154s)
[451.233113] Starting dynamic subtest: all
[453.004816] Dynamic subtest all: SUCCESS (1.779s)
[453.007743] Subtest evict-prime: SUCCESS (10.847s)
[453.060782] [045/130] (578s left) gem_exec_schedule (preempt-queue)
[453.134107] Subtest preempt-queue: SKIP (0.000s)
[453.400444] [046/130] (578s left) gem_userptr_blits (coherency-unsync)
[453.471094] Subtest coherency-unsync: SKIP (0.000s)
[453.574300] [047/130] (578s left) kms_cursor_legacy (single-move)
[453.701241] Starting subtest: single-move
[453.703611] Starting dynamic subtest: pipe-A
[459.086569] Dynamic subtest pipe-A: SUCCESS (5.378s)
[459.098851] Starting dynamic subtest: pipe-B
[464.469695] Dynamic subtest pipe-B: SUCCESS (5.380s)
[464.479903] Starting dynamic subtest: pipe-C
[469.855858] Dynamic subtest pipe-C: SUCCESS (5.382s)
[469.871578] Starting dynamic subtest: pipe-D
[475.238573] Dynamic subtest pipe-D: SUCCESS (5.381s)
[475.250350] Starting dynamic subtest: all-pipes
[480.626830] Dynamic subtest all-pipes: SUCCESS (5.385s)
[480.629314] Subtest single-move: SUCCESS (26.916s)
[480.758505] [048/130] (550s left) kms_vblank (query-forked-busy)
[480.851000] Starting subtest: query-forked-busy
[480.853079] Starting dynamic subtest: pipe-A-eDP-1
[482.733378] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.881s)
[482.748225] Starting dynamic subtest: pipe-D-eDP-1
[485.288428] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.554s)
[485.290921] Subtest query-forked-busy: SUCCESS (4.439s)
[486.081593] [049/130] (545s left) gem_pwrite (basic-exhaustion)
[486.140235] Subtest basic-exhaustion: SKIP (0.000s)
[486.212028] [050/130] (545s left) gem_userptr_blits (sync-unmap)
[486.285017] Starting subtest: sync-unmap
[486.298647] Subtest sync-unmap: SUCCESS (0.015s)
[486.414052] [051/130] (545s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[486.522171] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[487.402920] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.881s)
[487.573694] [052/130] (544s left) perf_pmu (busy-double-start)
[487.611114] Starting subtest: busy-double-start
[487.613531] Starting dynamic subtest: rcs0
[491.251740] Dynamic subtest rcs0: FAIL (3.587s)
[491.263096] Starting dynamic subtest: bcs0
[494.833393] Dynamic subtest bcs0: FAIL (3.565s)
[494.844709] Starting dynamic subtest: vcs0
[498.610822] Dynamic subtest vcs0: SUCCESS (3.846s)
[498.622893] Starting dynamic subtest: vcs1
[502.650098] Dynamic subtest vcs1: SUCCESS (4.036s)
[502.662525] Starting dynamic subtest: vecs0
[506.598843] Dynamic subtest vecs0: SUCCESS (3.947s)
[506.611001] Starting dynamic subtest: ccs0
[510.233182] Dynamic subtest ccs0: FAIL (3.564s)
[510.235195] Subtest busy-double-start: FAIL (22.553s)
[510.275400] [053/130] (521s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[510.344224] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[510.449428] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.102s)
[510.504111] [054/130] (521s left) gem_exec_fence (basic-wait)
[510.685163] Starting subtest: basic-wait
[510.687803] Starting dynamic subtest: rcs0
[510.794809] Dynamic subtest rcs0: SUCCESS (0.110s)
[510.806778] Starting dynamic subtest: bcs0
[510.862159] Dynamic subtest bcs0: SUCCESS (0.065s)
[510.873761] Starting dynamic subtest: vcs0
[510.926992] Dynamic subtest vcs0: SUCCESS (0.064s)
[510.938573] Starting dynamic subtest: vcs1
[510.995921] Dynamic subtest vcs1: SUCCESS (0.067s)
[511.007322] Starting dynamic subtest: vecs0
[511.066626] Dynamic subtest vecs0: SUCCESS (0.069s)
[511.078565] Starting dynamic subtest: ccs0
[511.134119] Dynamic subtest ccs0: SUCCESS (0.066s)
[511.136509] Subtest basic-wait: SUCCESS (0.450s)
[513.166521] [FACT gem_exec_fence (basic-wait)] new: kernel.kmod_is_loaded.vgem: true
[513.169945] [055/130] (518s left) kms_addfb_basic (addfb25-modifier-no-flag)
[513.280263] Starting subtest: addfb25-modifier-no-flag
[513.282234] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[513.355219] [056/130] (518s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[513.459992] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[513.462243] Starting dynamic subtest: pipe-A-eDP-1
[513.521295] Dynamic subtest pipe-A-eDP-1: SKIP (0.003s)
[513.533199] Starting dynamic subtest: pipe-B-eDP-1
[513.589067] Dynamic subtest pipe-B-eDP-1: SKIP (0.003s)
[513.599891] Starting dynamic subtest: pipe-C-eDP-1
[513.656070] Dynamic subtest pipe-C-eDP-1: SKIP (0.003s)
[513.666916] Starting dynamic subtest: pipe-D-eDP-1
[513.722789] Dynamic subtest pipe-D-eDP-1: SKIP (0.003s)
[513.727271] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.023s)
[515.667515] [057/130] (516s left) kms_fb_coherency (memset-crc)
[515.768230] Starting subtest: memset-crc
[515.770601] Starting dynamic subtest: mmap-offset-wc
[516.441667] Dynamic subtest mmap-offset-wc: CRASH (0.149s)
[516.913740] Subtest memset-crc: CRASH (0.614s)
[516.950617] [058/130] (515s left) gem_lmem_swapping (massive)
[516.997985] Subtest massive: SKIP (0.000s)
[517.043833] [059/130] (515s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[517.421948] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[518.197109] [060/130] (513s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[518.293314] Starting subtest: async-flip-with-page-flip-events-linear
[518.673629] Starting dynamic subtest: pipe-A-eDP-1
[521.490301] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.815s)
[521.861696] Starting dynamic subtest: pipe-B-eDP-1
[524.620121] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.768s)
[524.992786] Starting dynamic subtest: pipe-C-eDP-1
[527.756645] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.771s)
[528.118809] Starting dynamic subtest: pipe-D-eDP-1
[530.886830] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.775s)
[530.889336] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.596s)
[532.059777] [061/130] (500s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[532.133946] Starting subtest: stress-mm-invalidate-close-overlap
[534.280249] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s)
[534.405149] [062/130] (497s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[534.502524] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[538.949399] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.451s)
[540.051033] [063/130] (492s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[540.149393] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[540.161410] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.011s)
[540.216097] [064/130] (492s left) kms_flip (plain-flip-fb-recreate-interruptible)
[540.329968] Starting subtest: plain-flip-fb-recreate-interruptible
[540.332219] Starting dynamic subtest: A-eDP1
[549.158396] Dynamic subtest A-eDP1: SUCCESS (8.828s)
[549.169708] Starting dynamic subtest: B-eDP1
[557.983367] Dynamic subtest B-eDP1: SUCCESS (8.824s)
[557.996131] Starting dynamic subtest: C-eDP1
[566.801271] Dynamic subtest C-eDP1: SUCCESS (8.817s)
[566.812151] Starting dynamic subtest: D-eDP1
[575.638019] Dynamic subtest D-eDP1: SUCCESS (8.837s)
[575.642565] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.314s)
[576.785897] [065/130] (455s left) gem_exec_fence (syncobj-repeat)
[577.213320] Starting subtest: syncobj-repeat
[577.391467] Subtest syncobj-repeat: SUCCESS (0.177s)
[579.156571] [066/130] (453s left) i915_query (query-topology-coherent-slice-mask)
[579.219241] Starting subtest: query-topology-coherent-slice-mask
[579.223772] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[579.290660] [067/130] (453s left) kms_cursor_crc (cursor-onscreen-512x512)
[579.549779] Starting subtest: cursor-onscreen-512x512
[579.554311] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[579.689339] [068/130] (452s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[579.801182] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[579.805543] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[579.890746] [069/130] (452s left) kms_plane_scaling (invalid-num-scalers)
[579.990052] Starting subtest: invalid-num-scalers
[579.992294] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[580.008047] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.018s)
[580.017784] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[580.039034] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.031s)
[580.049229] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[580.070808] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.031s)
[580.080535] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[580.105268] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.031s)
[580.107511] Subtest invalid-num-scalers: SUCCESS (0.116s)
[580.190467] [070/130] (452s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[580.254431] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[580.322140] [071/130] (452s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[582.236780] Starting subtest: gem-execbuf-stress-pc8
[582.274581] Subtest gem-execbuf-stress-pc8: SKIP (0.038s)
[582.594343] [072/130] (449s left) syncobj_timeline (wait-any-interrupted)
[582.665410] Starting subtest: wait-any-interrupted
[582.767984] Subtest wait-any-interrupted: SUCCESS (0.102s)
[582.821726] [073/130] (449s left) sw_sync (sync_merge_same)
[582.861538] Starting subtest: sync_merge_same
[582.863491] Subtest sync_merge_same: SUCCESS (0.000s)
[582.906909] [074/130] (449s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[583.008696] Starting subtest: psr-2p-pri-indfb-multidraw
[583.012954] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[583.075382] [075/130] (449s left) kms_hdr (bpc-switch-suspend)
[583.182048] Starting subtest: bpc-switch-suspend
[584.283451] Starting dynamic subtest: pipe-A-eDP-1
[604.451980] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.001s)
[604.454402] Subtest bpc-switch-suspend: SUCCESS (6.103s)
[613.571914] [076/130] (428s left) api_intel_bb (blit-noreloc-keep-cache)
[613.651035] Starting subtest: blit-noreloc-keep-cache
[613.663592] Subtest blit-noreloc-keep-cache: SUCCESS (0.015s)
[613.815565] [077/130] (428s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[613.920189] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[613.924608] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[613.995493] [078/130] (427s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[614.102824] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[614.105142] Starting dynamic subtest: pipe-A-default-mode
[614.389438] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[614.394053] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.286s)
[615.178547] [079/130] (426s left) kms_chamelium_frames (hdmi-crc-fast)
[615.574753] Subtest hdmi-crc-fast: SKIP (0.000s)
[616.384963] [080/130] (425s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[616.484706] Starting subtest: primary-4-tiled-reflect-x-0
[623.515843] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.153s)
[624.719386] [081/130] (417s left) sw_sync (sync_merge)
[624.755330] Starting subtest: sync_merge
[624.757737] Subtest sync_merge: SUCCESS (0.000s)
[624.798256] [082/130] (417s left) gem_ctx_persistence (engines-mixed-process)
[624.855854] Starting subtest: engines-mixed-process
[624.858247] Starting dynamic subtest: rcs0
[626.260337] Dynamic subtest rcs0: SUCCESS (1.416s)
[626.272298] Starting dynamic subtest: bcs0
[628.174499] Dynamic subtest bcs0: SUCCESS (1.924s)
[628.186362] Starting dynamic subtest: vcs0
[630.233306] Dynamic subtest vcs0: SUCCESS (2.067s)
[630.245478] Starting dynamic subtest: vcs1
[632.202181] Dynamic subtest vcs1: SUCCESS (1.975s)
[632.213086] Starting dynamic subtest: vecs0
[634.276495] Dynamic subtest vecs0: SUCCESS (2.079s)
[634.288447] Starting dynamic subtest: ccs0
[636.260326] Dynamic subtest ccs0: SUCCESS (1.987s)
[636.262880] Subtest engines-mixed-process: SUCCESS (11.460s)
[636.318945] [083/130] (405s left) gem_exec_parallel (userptr)
[636.387864] Starting subtest: userptr
[636.390243] Starting dynamic subtest: rcs0
[637.920297] Dynamic subtest rcs0: SUCCESS (1.532s)
[637.931533] Starting dynamic subtest: bcs0
[639.446567] Dynamic subtest bcs0: SUCCESS (1.525s)
[639.459318] Starting dynamic subtest: vcs0
[641.234262] Dynamic subtest vcs0: SUCCESS (1.785s)
[641.251437] Starting dynamic subtest: vcs1
[643.207391] Dynamic subtest vcs1: SUCCESS (1.972s)
[643.219130] Starting dynamic subtest: vecs0
[645.189512] Dynamic subtest vecs0: SUCCESS (1.980s)
[645.201811] Starting dynamic subtest: ccs0
[646.695276] Dynamic subtest ccs0: SUCCESS (1.506s)
[646.697679] Subtest userptr: SUCCESS (10.315s)
[646.863798] [084/130] (395s left) kms_flip (absolute-wf_vblank-interruptible)
[646.956766] Starting subtest: absolute-wf_vblank-interruptible
[646.959117] Starting dynamic subtest: A-eDP1
[655.707909] Dynamic subtest A-eDP1: SUCCESS (8.754s)
[655.719860] Starting dynamic subtest: B-eDP1
[664.442040] Dynamic subtest B-eDP1: SUCCESS (8.737s)
[664.455355] Starting dynamic subtest: C-eDP1
[673.157221] Dynamic subtest C-eDP1: SUCCESS (8.717s)
[673.170042] Starting dynamic subtest: D-eDP1
[681.879685] Dynamic subtest D-eDP1: SUCCESS (8.724s)
[681.884941] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.946s)
[683.077365] [085/130] (359s left) kms_force_connector_basic (prune-stale-modes)
[683.151424] Starting subtest: prune-stale-modes
[683.596650] Subtest prune-stale-modes: SUCCESS (0.445s)
[683.710745] [086/130] (358s left) gem_ctx_persistence (processes)
[683.775390] Starting subtest: processes
[685.259057] Subtest processes: SUCCESS (1.484s)
[685.318584] [087/130] (356s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[685.435202] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[692.327468] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (6.899s)
[692.441201] [088/130] (349s left) gem_exec_flush (basic-uc-ro-default)
[692.512432] Starting subtest: basic-uc-ro-default
[697.968289] Subtest basic-uc-ro-default: SUCCESS (5.460s)
[698.136906] [089/130] (344s left) kms_psr (pr-dpms)
[698.230874] Starting subtest: pr-dpms
[698.235198] Subtest pr-dpms: SKIP (0.000s)
[698.279077] [090/130] (344s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[698.390413] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[698.394865] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[698.478888] [091/130] (343s left) kms_lease (lease-invalid-crtc)
[698.575728] Starting subtest: lease-invalid-crtc
[698.577996] Starting dynamic subtest: pipe-A-eDP-1
[698.580284] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[698.590624] Starting dynamic subtest: pipe-B-eDP-1
[698.592896] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[698.602890] Starting dynamic subtest: pipe-C-eDP-1
[698.605074] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[698.615187] Starting dynamic subtest: pipe-D-eDP-1
[698.617381] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[698.619590] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[698.657135] [092/130] (343s left) i915_query (query-topology-unsupported)
[698.722149] Starting subtest: query-topology-unsupported
[698.726795] Subtest query-topology-unsupported: SKIP (0.000s)
[698.819650] [093/130] (343s left) prime_self_import (export-vs-gem_close-race)
[698.856254] Starting subtest: export-vs-gem_close-race
[703.953071] Subtest export-vs-gem_close-race: SUCCESS (5.098s)
[704.007722] [094/130] (338s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[704.120055] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[709.406844] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.287s)
[710.511813] [095/130] (332s left) gem_exec_reloc (basic-cpu-active)
[710.568327] Subtest basic-cpu-active: SKIP (0.000s)
[710.660265] [096/130] (331s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[710.767098] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[717.220973] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.455s)
[717.297848] [097/130] (325s left) syncobj_timeline (invalid-transfer-non-existent-point)
[717.362790] Starting subtest: invalid-transfer-non-existent-point
[717.365164] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[717.464321] [098/130] (325s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[717.578545] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[717.583085] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[717.677243] [099/130] (325s left) kms_vblank (query-idle-hang)
[717.772401] Starting subtest: query-idle-hang
[717.774188] Starting dynamic subtest: pipe-A-eDP-1
[744.963961] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.189s)
[744.979813] Starting dynamic subtest: pipe-D-eDP-1
[760.019824] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.053s)
[760.021964] Subtest query-idle-hang: SUCCESS (42.247s)
[760.795803] [100/130] (282s left) i915_drm_fdinfo (busy-idle)
[760.838379] Starting subtest: busy-idle
[760.840446] Starting dynamic subtest: rcs0
[760.860344] Dynamic subtest rcs0: SKIP (0.022s)
[760.871894] Starting dynamic subtest: bcs0
[760.885388] Dynamic subtest bcs0: SKIP (0.024s)
[760.895113] Starting dynamic subtest: vcs0
[760.899367] Dynamic subtest vcs0: SKIP (0.001s)
[760.908717] Starting dynamic subtest: vcs1
[760.912630] Dynamic subtest vcs1: SKIP (0.000s)
[760.921376] Starting dynamic subtest: vecs0
[760.926059] Dynamic subtest vecs0: SKIP (0.000s)
[760.935369] Starting dynamic subtest: ccs0
[760.939641] Dynamic subtest ccs0: SKIP (0.000s)
[760.943766] Subtest busy-idle: SKIP (0.053s)
[760.981873] [101/130] (281s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[761.072726] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[765.496420] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.428s)
[766.601595] [102/130] (276s left) kms_psr (psr-primary-mmap-cpu)
[766.707688] Starting subtest: psr-primary-mmap-cpu
[766.710049] Starting dynamic subtest: eDP-1
[768.474602] Dynamic subtest eDP-1: SUCCESS (1.766s)
[768.476735] Subtest psr-primary-mmap-cpu: SUCCESS (1.767s)
[769.294708] [103/130] (273s left) kms_pm_rpm (dpms-non-lpsp)
[771.326284] Starting subtest: dpms-non-lpsp
[771.331114] Subtest dpms-non-lpsp: SKIP (0.001s)
[771.680332] [104/130] (271s left) device_reset (unbind-reset-rebind)
[771.736175] Starting subtest: unbind-reset-rebind
[776.185256] Subtest unbind-reset-rebind: SUCCESS (4.448s)
[776.235009] [105/130] (266s left) kms_pipe_crc_basic (read-crc)
[776.338289] Starting subtest: read-crc
[776.340216] Starting dynamic subtest: pipe-A-eDP-1
[777.051968] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.716s)
[777.063026] Starting dynamic subtest: pipe-B-eDP-1
[778.431024] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.375s)
[778.442601] Starting dynamic subtest: pipe-C-eDP-1
[779.722167] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.291s)
[779.733240] Starting dynamic subtest: pipe-D-eDP-1
[781.054381] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.331s)
[781.056543] Subtest read-crc: SUCCESS (4.719s)
[781.870702] [106/130] (261s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[781.961617] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[781.965545] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[782.052817] [107/130] (261s left) kms_async_flips (test-time-stamp)
[782.144638] Starting subtest: test-time-stamp
[782.515425] Starting dynamic subtest: pipe-A-eDP-1
[783.286092] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.768s)
[783.674239] Starting dynamic subtest: pipe-B-eDP-1
[784.429147] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.763s)
[784.812895] Starting dynamic subtest: pipe-C-eDP-1
[785.573666] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.767s)
[785.940128] Starting dynamic subtest: pipe-D-eDP-1
[786.704328] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.771s)
[786.706772] Subtest test-time-stamp: SUCCESS (4.561s)
[787.838080] [108/130] (255s left) api_intel_bb (reset-bb)
[787.896958] Starting subtest: reset-bb
[787.899301] Subtest reset-bb: SUCCESS (0.003s)
[788.015178] [109/130] (255s left) gem_exec_whisper (basic-normal-all)
[788.083177] Starting subtest: basic-normal-all
[790.362856] Subtest basic-normal-all: SUCCESS (2.278s)
[790.523529] [110/130] (252s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[795.528186] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[795.532793] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.002s)
[796.358390] [111/130] (246s left) fbdev (eof)
[796.401045] Starting subtest: eof
[796.403428] Subtest eof: SUCCESS (0.000s)
[796.443603] [112/130] (246s left) kms_psr (pr-cursor-blt)
[796.540648] Starting subtest: pr-cursor-blt
[796.544885] Subtest pr-cursor-blt: SKIP (0.000s)
[796.590177] [113/130] (246s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[796.665932] Starting subtest: y-tiled-to-vebox-yf-tiled
[796.670290] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[796.828727] [114/130] (246s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[796.943671] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[796.947634] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[797.062874] [115/130] (246s left) kms_plane (pixel-format-source-clamping)
[797.149849] Starting subtest: pixel-format-source-clamping
[797.176155] Starting dynamic subtest: pipe-A-plane-0
[801.951760] Dynamic subtest pipe-A-plane-0: SUCCESS (4.777s)
[801.964323] Starting dynamic subtest: pipe-A-plane-3
[804.262072] Dynamic subtest pipe-A-plane-3: SUCCESS (2.309s)
[804.272939] Starting dynamic subtest: pipe-A-plane-5
[804.274786] Dynamic subtest pipe-A-plane-5: SUCCESS (0.000s)
[805.357625] Starting dynamic subtest: pipe-B-plane-0
[810.313353] Dynamic subtest pipe-B-plane-0: SUCCESS (4.966s)
[810.326603] Starting dynamic subtest: pipe-B-plane-3
[812.646118] Dynamic subtest pipe-B-plane-3: SUCCESS (2.333s)
[812.658902] Starting dynamic subtest: pipe-B-plane-5
[812.661065] Dynamic subtest pipe-B-plane-5: SUCCESS (0.000s)
[812.953242] Subtest pixel-format-source-clamping: SUCCESS (15.810s)
[813.812757] [116/130] (229s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[813.923951] Starting subtest: 4-tiled-addfb-size-offset-overflow
[813.926180] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[814.019896] [117/130] (229s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[814.123939] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[814.126171] Starting dynamic subtest: pipe-A-default-mode
[815.281998] Dynamic subtest pipe-A-default-mode: SKIP (1.157s)
[815.286094] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.158s)
[815.440728] [118/130] (228s left) gem_mmap_offset (oob-read)
[815.505437] Starting subtest: oob-read
[815.507733] Subtest oob-read: SUCCESS (0.001s)
[815.600968] [119/130] (228s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[815.687231] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[815.691333] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[815.815007] [120/130] (227s left) kms_chamelium_color (ctm-blue-to-red)
[815.911486] Subtest ctm-blue-to-red: SKIP (0.000s)
[815.961850] [121/130] (227s left) gem_eio (wait-immediate)
[816.187920] Starting subtest: wait-immediate
[816.563390] Subtest wait-immediate: SUCCESS (0.376s)
[816.664793] [122/130] (227s left) gem_exec_suspend (basic-s3-devices)
[816.740335] Starting subtest: basic-S3-devices
[816.742303] Starting dynamic subtest: smem
[828.229881] Dynamic subtest smem: SUCCESS (11.492s)
[828.232981] Subtest basic-S3-devices: SUCCESS (11.493s)
[832.403086] [123/130] (215s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[832.464728] Starting subtest: invalid-multi-wait-unsubmitted
[832.467146] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[832.538944] [124/130] (215s left) gem_exec_balancer (full-late-pulse)
[832.602156] Starting subtest: full-late-pulse
[837.112301] Subtest full-late-pulse: SUCCESS (4.507s)
[837.442600] [125/130] (210s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[837.571816] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[837.576084] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[837.662634] [126/130] (210s left) syncobj_wait (single-wait-for-submit-submitted)
[837.717747] Starting subtest: single-wait-for-submit-submitted
[837.826415] Subtest single-wait-for-submit-submitted: SUCCESS (0.108s)
[837.881987] [127/130] (210s left) gem_exec_schedule (semaphore-resolve)
[837.959199] Starting subtest: semaphore-resolve
[837.987296] Subtest semaphore-resolve: SUCCESS (0.037s)
[838.303343] [128/130] (209s left) syncobj_basic (bad-pad-handle-to-fd)
[838.364073] Starting subtest: bad-pad-handle-to-fd
[838.366045] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[838.447905] [129/130] (209s left) gen7_exec_parse (chained-batch)
[838.513374] Subtest chained-batch: SKIP (0.000s)
[838.599917] [130/130] (209s left) kms_cursor_crc (cursor-onscreen-256x256)
[838.825807] Starting subtest: cursor-onscreen-256x256
[838.828240] Starting dynamic subtest: pipe-A-eDP-1
[840.918908] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.089s)
[840.964519] Starting dynamic subtest: pipe-D-eDP-1
[843.667050] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.710s)
[843.669397] Subtest cursor-onscreen-256x256: SUCCESS (4.841s)
[844.449295] Closing watchdogs
results: parsing output: 0/ for test: perf_pmu
results: parsing output: 1/ for test: i915_getparams_basic
results: parsing output: 2/ for test: kms_psr
results: parsing output: 3/ for test: kms_getfb
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: gem_create
results: parsing output: 8/ for test: gem_exec_nop
results: parsing output: 9/ for test: perf_pmu
results: parsing output: 10/ for test: kms_cursor_crc
results: parsing output: 11/ for test: perf
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: gem_workarounds
results: parsing output: 14/ for test: gem_basic
results: parsing output: 15/ for test: syncobj_wait
results: parsing output: 16/ for test: gen7_exec_parse
results: parsing output: 17/ for test: prime_busy
results: parsing output: 18/ for test: i915_query
results: parsing output: 19/ for test: kms_flip
results: parsing output: 20/ for test: gem_eio
results: parsing output: 21/ for test: kms_psr2_su
results: parsing output: 22/ for test: gem_render_copy
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: gem_exec_params
results: parsing output: 26/ for test: kms_color
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: prime_mmap
results: parsing output: 29/ for test: kms_pm_backlight
results: parsing output: 30/ for test: kms_psr2_sf
results: parsing output: 31/ for test: gem_ppgtt
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: gem_lmem_swapping
results: parsing output: 34/ for test: kms_atomic_transition
results: parsing output: 35/ for test: gem_exec_alignment
results: parsing output: 36/ for test: kms_pm_rpm
results: parsing output: 37/ for test: gem_exec_params
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: kms_busy
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: gem_softpin
results: parsing output: 44/ for test: gem_exec_schedule
results: parsing output: 45/ for test: gem_userptr_blits
results: parsing output: 46/ for test: kms_cursor_legacy
results: parsing output: 47/ for test: kms_vblank
results: parsing output: 48/ for test: gem_pwrite
results: parsing output: 49/ for test: gem_userptr_blits
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: perf_pmu
results: parsing output: 52/ for test: syncobj_wait
results: parsing output: 53/ for test: gem_exec_fence
results: parsing output: 54/ for test: kms_addfb_basic
results: parsing output: 55/ for test: kms_ccs
results: parsing output: 56/ for test: kms_fb_coherency
results: parsing output: 57/ for test: gem_lmem_swapping
results: parsing output: 58/ for test: kms_chamelium_hpd
results: parsing output: 59/ for test: kms_async_flips
results: parsing output: 60/ for test: gem_userptr_blits
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_flip
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: gem_exec_fence
results: parsing output: 65/ for test: i915_query
results: parsing output: 66/ for test: kms_cursor_crc
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_plane_scaling
results: parsing output: 69/ for test: kms_pipe_b_c_ivb
results: parsing output: 70/ for test: i915_pm_rpm
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: sw_sync
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_hdr
results: parsing output: 75/ for test: api_intel_bb
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_flip_scaled_crc
results: parsing output: 78/ for test: kms_chamelium_frames
results: parsing output: 79/ for test: kms_rotation_crc
results: parsing output: 80/ for test: sw_sync
results: parsing output: 81/ for test: gem_ctx_persistence
results: parsing output: 82/ for test: gem_exec_parallel
results: parsing output: 83/ for test: kms_flip
results: parsing output: 84/ for test: kms_force_connector_basic
results: parsing output: 85/ for test: gem_ctx_persistence
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_exec_flush
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_lease
results: parsing output: 91/ for test: i915_query
results: parsing output: 92/ for test: prime_self_import
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_exec_reloc
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_vblank
results: parsing output: 99/ for test: i915_drm_fdinfo
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: kms_pm_rpm
results: parsing output: 103/ for test: device_reset
results: parsing output: 104/ for test: kms_pipe_crc_basic
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_async_flips
results: parsing output: 107/ for test: api_intel_bb
results: parsing output: 108/ for test: gem_exec_whisper
results: parsing output: 109/ for test: kms_psr2_sf
results: parsing output: 110/ for test: fbdev
results: parsing output: 111/ for test: kms_psr
results: parsing output: 112/ for test: gem_render_copy
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_plane
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: kms_flip_scaled_crc
results: parsing output: 117/ for test: gem_mmap_offset
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_chamelium_color
results: parsing output: 120/ for test: gem_eio
results: parsing output: 121/ for test: gem_exec_suspend
results: parsing output: 122/ for test: syncobj_wait
results: parsing output: 123/ for test: gem_exec_balancer
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: syncobj_wait
results: parsing output: 126/ for test: gem_exec_schedule
results: parsing output: 127/ for test: syncobj_basic
results: parsing output: 128/ for test: gen7_exec_parse
results: parsing output: 129/ for test: kms_cursor_crc
Done.