[59.679533] Initializing watchdogs
[59.679585]   /dev/watchdog0
[59.693452] [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]
[59.697653] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.699913] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.703219] [001/133] (960s left) gem_ctx_persistence (engines-mixed-process)
[59.788249] Starting subtest: engines-mixed-process
[59.790632] Starting dynamic subtest: rcs0
[60.890953] Dynamic subtest rcs0: SUCCESS (1.102s)
[60.900564] Starting dynamic subtest: bcs0
[62.897965] Dynamic subtest bcs0: SUCCESS (2.007s)
[62.908296] Starting dynamic subtest: vcs0
[64.860065] Dynamic subtest vcs0: SUCCESS (1.961s)
[64.868443] Starting dynamic subtest: vcs1
[67.111395] Dynamic subtest vcs1: SUCCESS (2.248s)
[67.125907] Starting dynamic subtest: vecs0
[68.895035] Dynamic subtest vecs0: SUCCESS (1.784s)
[68.904624] Starting dynamic subtest: ccs0
[70.851518] Dynamic subtest ccs0: SUCCESS (1.955s)
[70.853742] Subtest engines-mixed-process: SUCCESS (11.062s)
[70.975804] [002/133] (949s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[71.379458] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[72.187923] [003/133] (948s left) kms_content_protection (atomic)
[72.336070] Starting subtest: atomic
[72.340717] Subtest atomic: SKIP (0.000s)
[72.458817] [004/133] (947s left) gem_partial_pwrite_pread (write)
[72.510837] Subtest write: SKIP (0.000s)
[72.575730] [005/133] (947s left) prime_mmap (test_correct)
[72.638545] Starting subtest: test_correct
[72.640835] Starting dynamic subtest: test_correct-smem
[72.668195] Dynamic subtest test_correct-smem: SUCCESS (0.032s)
[72.670715] Subtest test_correct: SUCCESS (0.033s)
[72.757883] [006/133] (947s left) gem_mmap_gtt (basic-read-write-distinct)
[72.806070] Subtest basic-read-write-distinct: SKIP (0.000s)
[72.863420] [007/133] (947s left) kms_properties (invalid-properties-atomic)
[72.961649] Starting subtest: invalid-properties-atomic
[73.261223] Subtest invalid-properties-atomic: SUCCESS (0.299s)
[73.332614] [008/133] (947s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[73.432836] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[73.435199] Starting dynamic subtest: pipe-A-default-mode
[76.162382] Dynamic subtest pipe-A-default-mode: SUCCESS (2.729s)
[76.164857] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.730s)
[77.012035] [009/133] (943s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[77.131124] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[77.135720] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[77.221339] [010/133] (943s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[77.343696] Starting subtest: cursor-vs-flip-atomic
[106.660293] Subtest cursor-vs-flip-atomic: SUCCESS (29.312s)
[107.468714] [011/133] (913s left) kms_prop_blob (blob-prop-core)
[107.527023] Starting subtest: blob-prop-core
[107.529460] Subtest blob-prop-core: SUCCESS (0.000s)
[107.625426] [012/133] (912s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k)
[108.020922] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s)
[108.871840] [013/133] (911s left) kms_psr (fbc-pr-sprite-plane-move)
[108.973018] Starting subtest: fbc-pr-sprite-plane-move
[108.977242] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[109.053376] [014/133] (911s left) gem_mmap_offset (clear)
[109.103693] Starting subtest: clear
[109.106849] Starting dynamic subtest: smem0
[132.616722] Dynamic subtest smem0: SUCCESS (23.507s)
[132.619385] Subtest clear: SUCCESS (23.508s)
[132.749551] [015/133] (887s left) kms_color (ctm-signed)
[132.900803] Starting subtest: ctm-signed
[132.903087] Starting dynamic subtest: pipe-A-eDP-1
[134.961280] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.061s)
[134.977814] Starting dynamic subtest: pipe-B-eDP-1
[137.741779] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.778s)
[137.749663] Starting dynamic subtest: pipe-C-eDP-1
[140.550929] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.810s)
[140.559551] Starting dynamic subtest: pipe-D-eDP-1
[143.216111] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.666s)
[143.218531] Subtest ctm-signed: SUCCESS (10.317s)
[144.047620] [016/133] (876s left) kms_hdr (bpc-switch)
[144.145197] Starting subtest: bpc-switch
[145.236779] Starting dynamic subtest: pipe-A-eDP-1
[148.724200] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.489s)
[148.726610] Subtest bpc-switch: SUCCESS (4.581s)
[148.847687] [017/133] (871s left) kms_psr (pr-basic)
[148.945226] Starting subtest: pr-basic
[148.949630] Subtest pr-basic: SKIP (0.000s)
[149.015018] [018/133] (871s left) gem_exec_parallel (userptr)
[149.072352] Starting subtest: userptr
[149.074749] Starting dynamic subtest: rcs0
[150.521869] Dynamic subtest rcs0: SUCCESS (1.449s)
[150.530722] Starting dynamic subtest: bcs0
[151.979744] Dynamic subtest bcs0: SUCCESS (1.457s)
[151.988774] Starting dynamic subtest: vcs0
[153.886494] Dynamic subtest vcs0: SUCCESS (1.904s)
[153.894471] Starting dynamic subtest: vcs1
[155.859307] Dynamic subtest vcs1: SUCCESS (1.972s)
[155.869742] Starting dynamic subtest: vecs0
[157.908825] Dynamic subtest vecs0: SUCCESS (2.048s)
[157.917077] Starting dynamic subtest: ccs0
[159.393024] Dynamic subtest ccs0: SUCCESS (1.484s)
[159.395457] Subtest userptr: SUCCESS (10.321s)
[159.589961] [019/133] (861s left) gen9_exec_parse (batch-invalid-length)
[159.652092] Subtest batch-invalid-length: SKIP (0.000s)
[159.722828] [020/133] (861s left) syncobj_timeline (single-wait-for-submit-signaled)
[159.780149] Starting subtest: single-wait-for-submit-signaled
[159.782585] Subtest single-wait-for-submit-signaled: SUCCESS (0.001s)
[159.869245] [021/133] (861s left) gem_exec_suspend (basic-s3)
[159.936575] Starting subtest: basic-S3
[159.939054] Starting dynamic subtest: smem
[180.415532] Dynamic subtest smem: SUCCESS (6.929s)
[180.418558] Subtest basic-S3: SUCCESS (6.930s)
[180.602565] [022/133] (840s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[180.713835] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[203.017395] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.303s)
[203.150562] [023/133] (817s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[203.287403] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[203.291689] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[203.428991] [024/133] (817s left) perf_pmu (enable-race)
[203.467376] Starting subtest: enable-race
[203.469387] Starting dynamic subtest: rcs0
[216.237010] Dynamic subtest rcs0: SUCCESS (12.768s)
[216.249011] Starting dynamic subtest: bcs0
[228.980033] Dynamic subtest bcs0: SUCCESS (12.740s)
[228.991031] Starting dynamic subtest: vcs0
[244.479627] Dynamic subtest vcs0: SUCCESS (15.496s)
[244.492250] Starting dynamic subtest: vcs1
[260.480002] Dynamic subtest vcs1: SUCCESS (15.996s)
[260.492154] Starting dynamic subtest: vecs0
[276.480142] Dynamic subtest vecs0: SUCCESS (15.996s)
[276.493161] Starting dynamic subtest: ccs0
[289.228960] Dynamic subtest ccs0: SUCCESS (12.748s)
[289.231959] Subtest enable-race: SUCCESS (85.755s)
[289.324979] [025/133] (731s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[289.376307] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[289.381592] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[289.607255] [026/133] (731s left) gem_ctx_shared (create-shared-gtt)
[289.678991] Starting subtest: create-shared-gtt
[291.837161] Subtest create-shared-gtt: SUCCESS (2.157s)
[292.110299] [027/133] (729s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[292.212851] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[292.215700] Starting dynamic subtest: pipe-A-eDP-1
[292.308831] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s)
[292.318920] Starting dynamic subtest: pipe-B-eDP-1
[293.451307] Dynamic subtest pipe-B-eDP-1: SKIP (1.140s)
[293.456574] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.241s)
[294.627697] [028/133] (726s left) kms_lease (lease-again)
[294.714594] Starting subtest: lease-again
[294.716954] Starting dynamic subtest: pipe-A-eDP-1
[294.719826] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.003s)
[294.730377] Starting dynamic subtest: pipe-B-eDP-1
[294.732532] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[294.741201] Starting dynamic subtest: pipe-C-eDP-1
[294.743450] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[294.751959] Starting dynamic subtest: pipe-D-eDP-1
[294.754465] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[294.756729] Subtest lease-again: SUCCESS (0.013s)
[294.838423] [029/133] (726s left) kms_cursor_crc (cursor-offscreen-512x512)
[295.113500] Starting subtest: cursor-offscreen-512x512
[295.117880] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[295.256443] [030/133] (726s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[295.359263] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[295.364504] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[295.445812] [031/133] (725s left) kms_psr (fbc-psr-primary-page-flip)
[295.544878] Starting subtest: fbc-psr-primary-page-flip
[295.547769] Starting dynamic subtest: eDP-1
[295.552999] Dynamic subtest eDP-1: SKIP (0.000s)
[295.558131] Subtest fbc-psr-primary-page-flip: SKIP (0.001s)
[295.616418] [032/133] (725s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[295.679387] Starting subtest: invalid-multi-wait-all-unsubmitted
[295.681968] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[295.785348] [033/133] (725s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[295.869119] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[295.871315] Starting dynamic subtest: pipe-A-eDP-1
[295.893018] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[295.903249] Starting dynamic subtest: pipe-B-eDP-1
[295.925693] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[295.934752] Starting dynamic subtest: pipe-C-eDP-1
[295.957013] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[295.965851] Starting dynamic subtest: pipe-D-eDP-1
[295.990234] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[295.994245] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[298.119933] [034/133] (723s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[298.219324] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[299.197613] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (0.978s)
[299.306209] [035/133] (722s left) kms_flip_tiling (flip-change-tiling)
[299.397231] Starting subtest: flip-change-tiling
[299.399883] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs
[299.573951] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.178s)
[299.586374] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs
[299.719729] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.142s)
[299.732249] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[299.864241] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.141s)
[299.877207] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4
[300.007712] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.141s)
[300.022526] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x
[300.152272] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s)
[300.165542] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear
[300.295969] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s)
[300.308897] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs
[300.429445] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s)
[300.442134] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs
[300.540318] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[300.552679] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[300.674984] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.132s)
[300.687788] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4
[300.818573] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s)
[300.833490] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x
[300.962356] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s)
[300.974304] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear
[301.106660] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s)
[301.119735] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[301.240798] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s)
[301.253587] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[301.374953] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.130s)
[301.387248] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[301.485040] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s)
[301.495723] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4
[301.629309] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.143s)
[301.641451] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x
[301.773655] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.143s)
[301.788976] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear
[301.929451] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.152s)
[301.942309] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs
[302.074347] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s)
[302.086662] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs
[302.218000] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.141s)
[302.229783] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc
[302.362815] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.144s)
[302.374718] Starting dynamic subtest: pipe-A-eDP-1-4-to-4
[302.484482] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.120s)
[302.496357] Starting dynamic subtest: pipe-A-eDP-1-4-to-x
[302.640471] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.154s)
[302.653889] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear
[302.784729] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.142s)
[302.795798] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs
[302.929375] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s)
[302.940562] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs
[303.084698] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.153s)
[303.097891] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc
[303.229353] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s)
[303.241590] Starting dynamic subtest: pipe-A-eDP-1-x-to-4
[303.373498] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.142s)
[303.385559] Starting dynamic subtest: pipe-A-eDP-1-x-to-x
[303.507013] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.131s)
[303.518320] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear
[303.651329] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.142s)
[303.662954] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs
[303.796026] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[303.808558] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs
[303.940482] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s)
[303.953340] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc
[304.085797] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s)
[304.097199] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4
[304.229629] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.142s)
[304.242020] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x
[304.374005] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.142s)
[304.386039] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear
[304.495996] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.120s)
[304.547530] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs
[305.792037] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.251s)
[305.803618] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs
[305.927000] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s)
[305.938464] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[306.060372] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[306.070803] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4
[306.203446] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s)
[306.218881] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x
[306.347794] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s)
[306.362916] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear
[306.491897] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s)
[306.504989] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs
[306.625963] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s)
[306.638994] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs
[306.736344] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.108s)
[306.748576] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[306.871353] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[306.883382] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4
[307.014658] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s)
[307.026502] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x
[307.158988] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s)
[307.171402] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear
[307.303199] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s)
[307.314675] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[307.447584] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.142s)
[307.459998] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[307.582244] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s)
[307.595000] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[307.702789] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.120s)
[307.715029] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4
[307.847759] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.143s)
[307.860754] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x
[307.992096] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s)
[308.008255] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear
[308.136636] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s)
[308.149018] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs
[308.281623] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s)
[308.294624] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs
[308.425875] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s)
[308.438545] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc
[308.570166] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s)
[308.583393] Starting dynamic subtest: pipe-B-eDP-1-4-to-4
[308.691432] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.120s)
[308.703629] Starting dynamic subtest: pipe-B-eDP-1-4-to-x
[308.836424] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.143s)
[308.848920] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear
[308.980807] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.142s)
[308.993196] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs
[309.125552] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s)
[309.137231] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs
[309.269422] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.141s)
[309.281912] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc
[309.414553] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s)
[309.426566] Starting dynamic subtest: pipe-B-eDP-1-x-to-4
[309.569868] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.153s)
[309.582148] Starting dynamic subtest: pipe-B-eDP-1-x-to-x
[309.702745] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.131s)
[309.714826] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear
[309.858717] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.154s)
[309.871019] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs
[310.003436] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[310.015687] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs
[310.147243] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s)
[310.158693] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc
[310.292234] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s)
[310.305401] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4
[310.436691] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.142s)
[310.448398] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x
[310.580988] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.142s)
[310.593523] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear
[310.714322] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.131s)
[310.766683] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs
[312.022256] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.262s)
[312.038679] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs
[312.133118] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.108s)
[312.147178] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[312.233005] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[312.243964] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4
[312.355515] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.119s)
[312.366691] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x
[312.465829] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.108s)
[312.476986] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear
[312.576946] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.110s)
[312.588553] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs
[312.678154] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.099s)
[312.690616] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs
[312.777473] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[312.790335] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[312.877564] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[312.890309] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4
[312.988206] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.110s)
[312.998449] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x
[313.137895] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.148s)
[313.149779] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear
[313.248954] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.110s)
[313.260333] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[313.348813] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.099s)
[313.363406] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[313.448983] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s)
[313.462980] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[313.549206] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s)
[313.564156] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4
[313.660583] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.110s)
[313.672290] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x
[313.771242] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s)
[313.781371] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear
[313.882307] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.110s)
[313.891912] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs
[313.993719] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.111s)
[314.004532] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs
[314.104542] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.109s)
[314.116364] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc
[314.215817] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.109s)
[314.227507] Starting dynamic subtest: pipe-C-eDP-1-4-to-4
[314.326938] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.110s)
[314.339635] Starting dynamic subtest: pipe-C-eDP-1-4-to-x
[314.437898] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.109s)
[314.450258] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear
[314.548753] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.110s)
[314.560951] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs
[314.648912] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.099s)
[314.664774] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs
[314.760952] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.110s)
[314.773028] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc
[314.870953] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.109s)
[314.882700] Starting dynamic subtest: pipe-C-eDP-1-x-to-4
[314.982575] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.110s)
[314.995003] Starting dynamic subtest: pipe-C-eDP-1-x-to-x
[315.093580] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.110s)
[315.105893] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear
[315.204463] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.109s)
[315.216481] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs
[315.315820] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s)
[315.327385] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs
[315.437959] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.120s)
[315.453896] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc
[315.548967] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.110s)
[315.561773] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4
[315.671904] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.122s)
[315.684709] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x
[315.782787] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.109s)
[315.795783] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear
[315.893790] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.110s)
[315.934847] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs
[317.152241] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.224s)
[317.164999] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs
[317.252047] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[317.266495] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[317.351999] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.099s)
[317.362598] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4
[317.463011] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.109s)
[317.479546] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x
[317.574205] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s)
[317.586257] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear
[317.685310] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.110s)
[317.697101] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs
[317.796243] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.109s)
[317.809611] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs
[317.896893] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[317.909586] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[317.996536] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[318.008695] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4
[318.107589] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.110s)
[318.121254] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x
[318.266690] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.157s)
[318.277724] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear
[318.377680] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.110s)
[318.390678] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[318.478025] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.099s)
[318.492687] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[318.578502] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.099s)
[318.589462] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[318.690122] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s)
[318.701774] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4
[318.801223] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.109s)
[318.814788] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x
[318.913434] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s)
[318.924388] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear
[319.022559] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.110s)
[319.033808] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs
[319.133868] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.110s)
[319.145488] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs
[319.245789] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.110s)
[319.256533] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc
[319.355971] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.108s)
[319.370196] Starting dynamic subtest: pipe-D-eDP-1-4-to-4
[319.466992] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.109s)
[319.480513] Starting dynamic subtest: pipe-D-eDP-1-4-to-x
[319.578259] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.109s)
[319.590649] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear
[319.689877] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.110s)
[319.705769] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs
[319.800688] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.109s)
[319.812841] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs
[319.900623] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.098s)
[319.912695] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc
[320.011628] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.110s)
[320.023581] Starting dynamic subtest: pipe-D-eDP-1-x-to-4
[320.123473] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.111s)
[320.142716] Starting dynamic subtest: pipe-D-eDP-1-x-to-x
[320.233968] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.109s)
[320.247592] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear
[320.345346] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.109s)
[320.357145] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs
[320.455853] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s)
[320.467693] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs
[320.579662] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.121s)
[320.592598] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc
[320.689909] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.110s)
[320.700033] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4
[320.800610] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.108s)
[320.811648] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x
[320.911419] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.110s)
[320.922979] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear
[321.022622] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.110s)
[321.055202] Subtest flip-change-tiling: SUCCESS (21.661s)
[322.248021] [036/133] (699s left) gem_ctx_engines (independent)
[322.313073] Starting subtest: independent
[322.315704] Starting dynamic subtest: rcs0
[322.463309] Dynamic subtest rcs0: SUCCESS (0.148s)
[322.477538] Starting dynamic subtest: bcs0
[322.608427] Dynamic subtest bcs0: SUCCESS (0.144s)
[322.618551] Starting dynamic subtest: vcs0
[322.722656] Dynamic subtest vcs0: SUCCESS (0.113s)
[322.736624] Starting dynamic subtest: vcs1
[322.844964] Dynamic subtest vcs1: SUCCESS (0.121s)
[322.854480] Starting dynamic subtest: vecs0
[322.988375] Dynamic subtest vecs0: SUCCESS (0.142s)
[323.003787] Starting dynamic subtest: ccs0
[323.108321] Dynamic subtest ccs0: SUCCESS (0.120s)
[323.119193] Starting dynamic subtest: all-engines
[323.599645] Dynamic subtest all-engines: SUCCESS (0.490s)
[323.602978] Subtest independent: SUCCESS (1.285s)
[324.620666] [037/133] (697s left) gem_pwrite_snooped
[324.748898] [038/133] (696s left) kms_pm_rpm (cursor-dpms)
[326.587969] Starting subtest: cursor-dpms
[326.593826] Subtest cursor-dpms: SKIP (0.000s)
[326.980454] [039/133] (694s left) kms_cursor_crc (cursor-random-64x64)
[327.166359] Starting subtest: cursor-random-64x64
[327.172982] Starting dynamic subtest: pipe-A-eDP-1
[330.552870] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.380s)
[330.583698] Starting dynamic subtest: pipe-D-eDP-1
[334.587803] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.008s)
[334.590686] Subtest cursor-random-64x64: SUCCESS (7.418s)
[335.440957] [040/133] (686s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[335.535157] Starting subtest: psr-rgb101010-draw-render
[342.876740] Subtest psr-rgb101010-draw-render: SUCCESS (7.345s)
[342.980529] [041/133] (678s left) kms_psr (fbc-pr-cursor-blt)
[343.085571] Starting subtest: fbc-pr-cursor-blt
[343.090703] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[343.159448] [042/133] (678s left) kms_big_fb (linear-64bpp-rotate-90)
[343.251141] Starting subtest: linear-64bpp-rotate-90
[343.268902] Subtest linear-64bpp-rotate-90: SKIP (0.018s)
[343.382314] [043/133] (678s left) gem_softpin (allocator-evict)
[343.449509] Starting subtest: allocator-evict
[343.452147] Starting dynamic subtest: rcs0
[366.755714] Dynamic subtest rcs0: SUCCESS (23.305s)
[366.764995] Starting dynamic subtest: bcs0
[390.658401] Dynamic subtest bcs0: SUCCESS (23.900s)
[390.667844] Starting dynamic subtest: vcs0
[414.212475] Dynamic subtest vcs0: SUCCESS (23.551s)
[414.223318] Starting dynamic subtest: vcs1
[437.984228] Dynamic subtest vcs1: SUCCESS (23.771s)
[437.993557] Starting dynamic subtest: vecs0
[461.618898] Dynamic subtest vecs0: SUCCESS (23.632s)
[461.629383] Starting dynamic subtest: ccs0
[485.880970] Dynamic subtest ccs0: SUCCESS (24.259s)
[485.883960] Subtest allocator-evict: SUCCESS (142.426s)
[485.968081] [044/133] (535s left) gem_bad_reloc (negative-reloc-lut)
[486.077803] Subtest negative-reloc-lut: SKIP (0.000s)
[486.138214] [045/133] (535s left) gem_wait (wait)
[486.216550] Starting subtest: wait
[486.219260] Starting dynamic subtest: all-engines
[487.488411] Dynamic subtest all-engines: SUCCESS (1.273s)
[487.501703] Starting dynamic subtest: rcs0
[488.541271] Dynamic subtest rcs0: SUCCESS (1.051s)
[488.553300] Starting dynamic subtest: bcs0
[489.593294] Dynamic subtest bcs0: SUCCESS (1.050s)
[489.605830] Starting dynamic subtest: vcs0
[490.643785] Dynamic subtest vcs0: SUCCESS (1.048s)
[490.655995] Starting dynamic subtest: vcs1
[491.693817] Dynamic subtest vcs1: SUCCESS (1.048s)
[491.706349] Starting dynamic subtest: vecs0
[492.743553] Dynamic subtest vecs0: SUCCESS (1.047s)
[492.755997] Starting dynamic subtest: ccs0
[493.796719] Dynamic subtest ccs0: SUCCESS (1.051s)
[493.799693] Subtest wait: SUCCESS (7.585s)
[493.995847] [046/133] (528s left) i915_pm_rpm (gem-execbuf)
[495.562720] Starting subtest: gem-execbuf
[495.565371] Starting dynamic subtest: smem0
[497.656271] Dynamic subtest smem0: SUCCESS (2.095s)
[497.658758] Subtest gem-execbuf: SUCCESS (2.097s)
[497.771175] [047/133] (524s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[497.876858] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[497.882597] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[497.975684] [048/133] (524s left) kms_feature_discovery (display)
[498.081108] Starting subtest: display
[498.083761] Subtest display: SUCCESS (0.000s)
[498.152266] [049/133] (523s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[498.247440] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[498.255763] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.010s)
[498.332353] [050/133] (523s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[498.431405] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[498.457768] Starting dynamic subtest: pipe-A-plane-0
[498.880137] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s)
[498.889549] Starting dynamic subtest: pipe-A-plane-3
[499.135238] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[499.144309] Starting dynamic subtest: pipe-A-plane-5
[499.148188] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[500.200257] Starting dynamic subtest: pipe-B-plane-0
[500.637642] Dynamic subtest pipe-B-plane-0: SUCCESS (0.444s)
[500.648256] Starting dynamic subtest: pipe-B-plane-3
[500.904900] Dynamic subtest pipe-B-plane-3: SUCCESS (0.265s)
[500.914719] Starting dynamic subtest: pipe-B-plane-5
[500.919949] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[501.218025] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.788s)
[502.067073] [051/133] (520s left) kms_addfb_basic (basic)
[502.125568] Starting subtest: basic
[502.128007] Subtest basic: SUCCESS (0.000s)
[502.260476] [052/133] (519s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[502.351359] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[502.353653] Starting dynamic subtest: pipe-A-eDP-1
[502.377142] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[502.388212] Starting dynamic subtest: pipe-B-eDP-1
[502.411009] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[502.420468] Starting dynamic subtest: pipe-C-eDP-1
[502.443216] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[502.452597] Starting dynamic subtest: pipe-D-eDP-1
[502.475878] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[502.478262] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s)
[504.628701] [053/133] (517s left) gen9_exec_parse (unaligned-jump)
[504.688583] Subtest unaligned-jump: SKIP (0.000s)
[504.762669] [054/133] (517s left) perf_pmu (all-busy-check-all)
[504.813486] Starting subtest: all-busy-check-all
[506.433394] Subtest all-busy-check-all: SUCCESS (1.620s)
[506.545411] [055/133] (515s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[506.665448] Starting subtest: cursorB-vs-flipA-legacy
[506.670284] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[506.809482] [056/133] (515s left) gem_pxp (create-protected-buffer)
[506.931449] Starting subtest: create-protected-buffer
[506.934629] Subtest create-protected-buffer: SUCCESS (0.001s)
[507.058349] [057/133] (515s left) i915_selftest (live)
[510.364271] Starting subtest: live
[510.366855] Starting dynamic subtest: sanitycheck
[514.040736] Dynamic subtest sanitycheck: SUCCESS (3.674s)
[514.050125] Starting dynamic subtest: uncore
[517.586940] Dynamic subtest uncore: SUCCESS (3.545s)
[517.597749] Starting dynamic subtest: workarounds
[521.488706] Dynamic subtest workarounds: SUCCESS (3.900s)
[521.498866] Starting dynamic subtest: gt_engines
[525.363164] Dynamic subtest gt_engines: SUCCESS (3.873s)
[525.377777] Starting dynamic subtest: gt_timelines
[543.965883] Dynamic subtest gt_timelines: SUCCESS (18.599s)
[543.976648] Starting dynamic subtest: gt_contexts
[547.502664] Dynamic subtest gt_contexts: SUCCESS (3.535s)
[547.513447] Starting dynamic subtest: gt_lrc
[552.644140] Dynamic subtest gt_lrc: SUCCESS (5.139s)
[552.654402] Starting dynamic subtest: gt_mocs
[556.392245] Dynamic subtest gt_mocs: SUCCESS (3.747s)
[556.401993] Starting dynamic subtest: gt_pm
[562.072826] Dynamic subtest gt_pm: SUCCESS (5.678s)
[562.082533] Starting dynamic subtest: gt_heartbeat
[565.650276] Dynamic subtest gt_heartbeat: SUCCESS (3.576s)
[565.659306] Starting dynamic subtest: gt_tlb
[575.838720] Dynamic subtest gt_tlb: SUCCESS (10.186s)
[575.848884] Starting dynamic subtest: requests
[588.426760] Dynamic subtest requests: SUCCESS (12.586s)
[588.437561] Starting dynamic subtest: migrate
[595.028308] Dynamic subtest migrate: SUCCESS (6.600s)
[595.038863] Starting dynamic subtest: active
[598.559960] Dynamic subtest active: SUCCESS (3.530s)
[598.570606] Starting dynamic subtest: objects
[602.643613] Dynamic subtest objects: SUCCESS (4.081s)
[602.654464] Starting dynamic subtest: mman
[606.824231] Dynamic subtest mman: SUCCESS (4.178s)
[606.834878] Starting dynamic subtest: dmabuf
[610.443274] Dynamic subtest dmabuf: SUCCESS (3.617s)
[610.454260] Starting dynamic subtest: vma
[616.061248] Dynamic subtest vma: SUCCESS (5.615s)
[616.071894] Starting dynamic subtest: coherency
[620.783283] Dynamic subtest coherency: SUCCESS (4.719s)
[620.794095] Starting dynamic subtest: gtt
[633.356717] Dynamic subtest gtt: SUCCESS (12.571s)
[633.367487] Starting dynamic subtest: gem
[640.074191] Dynamic subtest gem: SUCCESS (6.716s)
[640.084359] Starting dynamic subtest: evict
[646.380114] Dynamic subtest evict: SUCCESS (6.304s)
[646.391182] Starting dynamic subtest: hugepages
[655.910350] Dynamic subtest hugepages: SUCCESS (9.529s)
[655.921232] Starting dynamic subtest: gem_contexts
[683.376739] Dynamic subtest gem_contexts: SUCCESS (27.465s)
[683.387780] Starting dynamic subtest: client
[686.938263] Dynamic subtest client: SUCCESS (3.560s)
[686.949347] Starting dynamic subtest: gem_migrate
[690.423331] Dynamic subtest gem_migrate: SUCCESS (3.484s)
[690.439992] Starting dynamic subtest: reset
[695.584372] Dynamic subtest reset: SUCCESS (5.159s)
[695.600497] Starting dynamic subtest: memory_region
[700.756625] Dynamic subtest memory_region: SUCCESS (5.170s)
[700.767005] Starting dynamic subtest: hangcheck
[714.403024] Dynamic subtest hangcheck: SUCCESS (13.645s)
[714.413569] Starting dynamic subtest: execlists
[717.932449] Dynamic subtest execlists: SUCCESS (3.526s)
[717.942968] Starting dynamic subtest: ring_submission
[723.079803] Dynamic subtest ring_submission: SUCCESS (5.146s)
[723.089645] Starting dynamic subtest: perf
[726.696945] Dynamic subtest perf: SUCCESS (3.615s)
[726.707581] Starting dynamic subtest: slpc
[739.598958] Dynamic subtest slpc: SUCCESS (12.900s)
[739.609529] Starting dynamic subtest: guc
[744.321431] Dynamic subtest guc: SUCCESS (4.721s)
[744.337991] Starting dynamic subtest: guc_multi_lrc
[749.435999] Dynamic subtest guc_multi_lrc: SUCCESS (5.112s)
[749.446444] Starting dynamic subtest: guc_hang
[755.128993] Dynamic subtest guc_hang: SUCCESS (5.691s)
[755.144965] Starting dynamic subtest: late_gt_pm
[758.698004] Dynamic subtest late_gt_pm: SUCCESS (3.567s)
[758.701119] Subtest live: SUCCESS (248.322s)
[758.730589] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[758.734625] [058/133] (263s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[761.303257] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[761.308872] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[761.411047] [FACT kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)] new: kernel.kmod_is_loaded.i915: true
[761.415642] [059/133] (261s left) gem_exec_flush (basic-batch-kernel-default-uc)
[761.482629] Starting subtest: basic-batch-kernel-default-uc
[767.249979] Subtest basic-batch-kernel-default-uc: SUCCESS (5.769s)
[767.453187] [060/133] (255s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[767.565878] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[767.571941] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[767.685553] [061/133] (254s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[767.784845] Starting subtest: fbc-rgb101010-draw-pwrite
[773.225590] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.445s)
[774.329890] [062/133] (248s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[774.429988] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[781.154143] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.726s)
[781.298569] [063/133] (241s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[781.391977] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[781.394641] Starting dynamic subtest: pipe-A-eDP-1
[781.418687] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[781.430959] Starting dynamic subtest: pipe-B-eDP-1
[781.457752] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[781.466597] Starting dynamic subtest: pipe-C-eDP-1
[781.491797] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[781.500541] Starting dynamic subtest: pipe-D-eDP-1
[781.526388] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[781.531331] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[783.688580] [064/133] (239s left) gem_exec_balancer (bonded-true-hang)
[783.942605] Starting subtest: bonded-true-hang
[783.947455] Subtest bonded-true-hang: SKIP (0.000s)
[784.042935] [065/133] (238s left) gem_exec_schedule (preempt-queue-contexts)
[784.126546] Subtest preempt-queue-contexts: SKIP (0.000s)
[784.434640] [066/133] (238s left) kms_psr (psr-primary-mmap-gtt)
[784.532601] Starting subtest: psr-primary-mmap-gtt
[784.534901] Starting dynamic subtest: eDP-1
[785.986487] Dynamic subtest eDP-1: SKIP (1.451s)
[785.991852] Subtest psr-primary-mmap-gtt: SKIP (1.453s)
[786.153255] [067/133] (236s left) gem_ctx_shared (exec-shared-gtt)
[786.217395] Starting subtest: exec-shared-gtt
[786.219788] Starting dynamic subtest: rcs0
[786.227975] Dynamic subtest rcs0: SUCCESS (0.010s)
[786.241549] Starting dynamic subtest: bcs0
[786.243992] Dynamic subtest bcs0: SUCCESS (0.005s)
[786.254668] Starting dynamic subtest: vcs0
[786.256617] Dynamic subtest vcs0: SUCCESS (0.007s)
[786.266967] Starting dynamic subtest: vcs1
[786.269739] Dynamic subtest vcs1: SUCCESS (0.009s)
[786.279309] Starting dynamic subtest: vecs0
[786.281830] Dynamic subtest vecs0: SUCCESS (0.005s)
[786.291001] Starting dynamic subtest: ccs0
[786.293762] Dynamic subtest ccs0: SUCCESS (0.006s)
[786.296280] Subtest exec-shared-gtt: SUCCESS (0.048s)
[786.449157] [068/133] (236s left) kms_invalid_mode (bad-hsync-end)
[786.551781] Starting subtest: bad-hsync-end
[786.554192] Starting dynamic subtest: pipe-A-eDP-1
[786.835814] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[786.846617] Starting dynamic subtest: pipe-B-eDP-1
[786.848778] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[786.858234] Starting dynamic subtest: pipe-C-eDP-1
[786.860848] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[786.871377] Starting dynamic subtest: pipe-D-eDP-1
[786.873955] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[786.876734] Subtest bad-hsync-end: SUCCESS (0.291s)
[787.640784] [069/133] (235s left) gem_exec_capture (userptr)
[787.693634] Starting subtest: userptr
[788.537581] Subtest userptr: SUCCESS (0.841s)
[788.646302] [070/133] (234s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[788.738609] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[788.743492] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[789.865367] [071/133] (233s left) kms_cursor_legacy (torture-bo)
[790.000988] Starting subtest: torture-bo
[790.003729] Starting dynamic subtest: pipe-A
[796.345305] Dynamic subtest pipe-A: SUCCESS (6.342s)
[796.359541] Starting dynamic subtest: pipe-B
[802.053872] Dynamic subtest pipe-B: SUCCESS (5.707s)
[802.073116] Starting dynamic subtest: pipe-C
[809.638378] Dynamic subtest pipe-C: SUCCESS (7.581s)
[809.651975] Starting dynamic subtest: pipe-D
[816.161832] Dynamic subtest pipe-D: SUCCESS (6.523s)
[816.180636] Starting dynamic subtest: all-pipes
[822.630862] Dynamic subtest all-pipes: SUCCESS (6.466s)
[822.634016] Subtest torture-bo: SUCCESS (32.628s)
[822.799055] [072/133] (200s left) gem_lmem_swapping (verify-random-ccs)
[822.844771] Subtest verify-random-ccs: SKIP (0.000s)
[822.889137] [073/133] (200s left) gem_mmap_gtt (basic)
[822.939237] Subtest basic: SKIP (0.000s)
[822.997376] [074/133] (200s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[823.051711] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[823.118818] [075/133] (200s left) api_intel_bb (reset-flags)
[823.177412] Starting subtest: reset-flags
[823.184323] Subtest reset-flags: SUCCESS (0.011s)
[823.296093] [076/133] (199s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[823.390765] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[824.505593] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.116s)
[824.614027] [077/133] (198s left) gem_exec_params (sol-reset-invalid)
[824.676528] Starting subtest: sol-reset-invalid
[824.681256] Subtest sol-reset-invalid: SUCCESS (0.003s)
[826.515358] [078/133] (196s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[826.601572] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[826.604414] Starting dynamic subtest: A-eDP1
[830.194368] Dynamic subtest A-eDP1: SUCCESS (3.591s)
[830.205178] Starting dynamic subtest: B-eDP1
[833.379787] Dynamic subtest B-eDP1: SUCCESS (3.185s)
[833.391660] Starting dynamic subtest: C-eDP1
[836.475165] Dynamic subtest C-eDP1: SUCCESS (3.095s)
[836.485953] Starting dynamic subtest: D-eDP1
[839.582383] Dynamic subtest D-eDP1: SUCCESS (3.103s)
[839.584496] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.982s)
[840.371989] [079/133] (183s left) kms_flip (blocking-absolute-wf_vblank)
[840.463400] Starting subtest: blocking-absolute-wf_vblank
[840.465875] Starting dynamic subtest: A-eDP1
[849.241354] Dynamic subtest A-eDP1: SUCCESS (8.780s)
[849.251679] Starting dynamic subtest: B-eDP1
[857.980763] Dynamic subtest B-eDP1: SUCCESS (8.738s)
[857.994622] Starting dynamic subtest: C-eDP1
[866.709218] Dynamic subtest C-eDP1: SUCCESS (8.725s)
[866.721999] Starting dynamic subtest: D-eDP1
[875.428099] Dynamic subtest D-eDP1: SUCCESS (8.715s)
[875.434773] Subtest blocking-absolute-wf_vblank: SUCCESS (34.972s)
[876.642325] [080/133] (146s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[876.742090] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[876.747325] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[876.829589] [081/133] (146s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[876.915945] Starting subtest: read-crc-frame-sequence
[876.918433] Starting dynamic subtest: pipe-A-eDP-1
[877.622853] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.705s)
[877.634553] Starting dynamic subtest: pipe-B-eDP-1
[879.009722] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.387s)
[879.020967] Starting dynamic subtest: pipe-C-eDP-1
[880.294572] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.281s)
[880.305553] Starting dynamic subtest: pipe-D-eDP-1
[881.652861] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.360s)
[881.655988] Subtest read-crc-frame-sequence: SUCCESS (4.738s)
[882.484227] [082/133] (141s left) gem_gpgpu_fill (offset-16x16)
[882.543148] Starting subtest: offset-16x16
[882.551775] Subtest offset-16x16: SUCCESS (0.011s)
[882.693723] [083/133] (140s left) kms_plane_lowres (tiling-yf)
[882.789438] Starting subtest: tiling-yf
[882.794734] Subtest tiling-yf: SKIP (0.000s)
[882.857632] [084/133] (140s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[882.915968] Starting subtest: etime-multi-wait-for-submit-submitted
[883.020298] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.104s)
[883.094323] [085/133] (140s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[883.189980] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[890.428625] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.242s)
[890.539017] [086/133] (133s left) kms_busy (extended-pageflip-hang-newfb)
[890.632941] Starting subtest: extended-pageflip-hang-newfb
[890.635307] Starting dynamic subtest: pipe-A
[917.212730] Dynamic subtest pipe-A: SUCCESS (26.579s)
[917.223318] Starting dynamic subtest: pipe-D
[942.239752] Dynamic subtest pipe-D: SUCCESS (25.021s)
[942.242600] Subtest extended-pageflip-hang-newfb: SUCCESS (51.605s)
[943.065114] [087/133] ( 80s left) gem_exec_reloc (basic-write-cpu)
[943.126745] Subtest basic-write-cpu: SKIP (0.000s)
[943.191771] [088/133] ( 80s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[943.280760] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[943.283309] Starting dynamic subtest: pipe-A
[943.303257] Dynamic subtest pipe-A: SKIP (0.018s)
[943.316395] Starting dynamic subtest: pipe-B
[943.336589] Dynamic subtest pipe-B: SKIP (0.033s)
[943.349192] Starting dynamic subtest: pipe-C
[943.378302] Dynamic subtest pipe-C: SKIP (0.041s)
[943.388011] Starting dynamic subtest: pipe-D
[943.408575] Dynamic subtest pipe-D: SKIP (0.030s)
[943.412609] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.125s)
[943.526055] [089/133] ( 80s left) gem_render_copy (linear)
[943.581876] Starting subtest: linear
[943.584720] Starting dynamic subtest: smem
[943.624895] Dynamic subtest smem: SUCCESS (0.043s)
[943.627986] Subtest linear: SUCCESS (0.043s)
[943.859961] [090/133] ( 79s left) kms_getfb (getfb-handle-zero)
[943.951961] Starting subtest: getfb-handle-zero
[943.954860] Subtest getfb-handle-zero: SUCCESS (0.000s)
[944.045304] [091/133] ( 79s left) perf_pmu (busy-accuracy-50)
[944.084196] Starting subtest: busy-accuracy-50
[944.086584] Starting dynamic subtest: rcs0
[945.618886] Dynamic subtest rcs0: SUCCESS (1.532s)
[945.631492] Starting dynamic subtest: bcs0
[947.163773] Dynamic subtest bcs0: SUCCESS (1.542s)
[947.180979] Starting dynamic subtest: vcs0
[948.710774] Dynamic subtest vcs0: SUCCESS (1.545s)
[948.721567] Starting dynamic subtest: vcs1
[950.254280] Dynamic subtest vcs1: SUCCESS (1.541s)
[950.265793] Starting dynamic subtest: vecs0
[951.799598] Dynamic subtest vecs0: SUCCESS (1.542s)
[951.811824] Starting dynamic subtest: ccs0
[953.348376] Dynamic subtest ccs0: SUCCESS (1.548s)
[953.351246] Subtest busy-accuracy-50: SUCCESS (9.263s)
[953.555846] [092/133] ( 70s left) gem_exec_reloc (basic-cpu-wc-active)
[953.615012] Subtest basic-cpu-wc-active: SKIP (0.000s)
[953.672079] [093/133] ( 70s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[953.774697] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[960.777475] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (7.006s)
[960.893660] [094/133] ( 63s left) i915_query (query-topology-coherent-slice-mask)
[960.953797] Starting subtest: query-topology-coherent-slice-mask
[960.959203] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[961.062502] [095/133] ( 62s left) prime_self_import (export-vs-gem_close-race)
[961.109673] Starting subtest: export-vs-gem_close-race
[966.183014] Subtest export-vs-gem_close-race: SUCCESS (5.077s)
[966.256854] [096/133] ( 57s left) gem_exec_schedule (u-submit-early-slice)
[966.363082] Starting subtest: u-submit-early-slice
[966.365525] Starting dynamic subtest: rcs0
[966.432945] Dynamic subtest rcs0: SUCCESS (0.070s)
[966.445993] Starting dynamic subtest: bcs0
[966.489953] Dynamic subtest bcs0: SUCCESS (0.055s)
[966.500706] Starting dynamic subtest: vcs0
[966.555343] Dynamic subtest vcs0: SUCCESS (0.065s)
[966.572082] Starting dynamic subtest: vcs1
[966.621784] Dynamic subtest vcs1: SUCCESS (0.065s)
[966.638555] Starting dynamic subtest: vecs0
[966.678529] Dynamic subtest vecs0: SUCCESS (0.055s)
[966.688893] Starting dynamic subtest: ccs0
[966.746673] Dynamic subtest ccs0: SUCCESS (0.066s)
[966.749540] Subtest u-submit-early-slice: SUCCESS (0.384s)
[968.541400] [097/133] ( 55s left) kms_flip (flip-vs-dpms-on-nop)
[968.628730] Starting subtest: flip-vs-dpms-on-nop
[968.631389] Starting dynamic subtest: A-eDP1
[970.475599] Dynamic subtest A-eDP1: SUCCESS (1.848s)
[970.489287] Starting dynamic subtest: B-eDP1
[972.315828] Dynamic subtest B-eDP1: SUCCESS (1.839s)
[972.328458] Starting dynamic subtest: C-eDP1
[974.132782] Dynamic subtest C-eDP1: SUCCESS (1.815s)
[974.142859] Starting dynamic subtest: D-eDP1
[975.966008] Dynamic subtest D-eDP1: SUCCESS (1.831s)
[975.968772] Subtest flip-vs-dpms-on-nop: SUCCESS (7.343s)
[977.152092] [098/133] ( 46s left) gem_exec_reloc (basic-wc-read-noreloc)
[977.214778] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[977.298487] [099/133] ( 46s left) kms_properties (plane-properties-atomic)
[977.391911] Starting subtest: plane-properties-atomic
[977.394658] Starting dynamic subtest: pipe-A-eDP-1
[977.939975] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.548s)
[977.950715] Starting dynamic subtest: pipe-B-eDP-1
[979.224867] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.285s)
[979.236986] Starting dynamic subtest: pipe-C-eDP-1
[980.451648] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.226s)
[980.463662] Starting dynamic subtest: pipe-D-eDP-1
[981.688872] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.234s)
[981.691785] Subtest plane-properties-atomic: SUCCESS (4.298s)
[982.485912] [100/133] ( 41s left) gem_exec_reloc (basic-softpin)
[982.536417] Subtest basic-softpin: SKIP (0.000s)
[982.602104] [101/133] ( 41s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[982.703628] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[986.448789] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.750s)
[987.589156] [102/133] ( 36s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[987.685916] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu
[994.366970] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.685s)
[994.485235] [103/133] ( 29s left) drm_read (short-buffer-wakeup)
[994.625584] Starting subtest: short-buffer-wakeup
[1026.843277] Subtest short-buffer-wakeup: SUCCESS (32.215s)
[1026.968778] Overall timeout time exceeded, stopping.
[1026.982515] Closing watchdogs
results: parsing output: 0/ for test: gem_ctx_persistence
results: parsing output: 1/ for test: kms_chamelium_hpd
results: parsing output: 2/ for test: kms_content_protection
results: parsing output: 3/ for test: gem_partial_pwrite_pread
results: parsing output: 4/ for test: prime_mmap
results: parsing output: 5/ for test: gem_mmap_gtt
results: parsing output: 6/ for test: kms_properties
results: parsing output: 7/ for test: kms_flip_scaled_crc
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_cursor_legacy
results: parsing output: 10/ for test: kms_prop_blob
results: parsing output: 11/ for test: kms_chamelium_edid
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: gem_mmap_offset
results: parsing output: 14/ for test: kms_color
results: parsing output: 15/ for test: kms_hdr
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: gem_exec_parallel
results: parsing output: 18/ for test: gen9_exec_parse
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: gem_exec_suspend
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_cursor_legacy
results: parsing output: 23/ for test: perf_pmu
results: parsing output: 24/ for test: gem_render_copy
results: parsing output: 25/ for test: gem_ctx_shared
results: parsing output: 26/ for test: kms_psr2_sf
results: parsing output: 27/ for test: kms_lease
results: parsing output: 28/ for test: kms_cursor_crc
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: kms_psr
results: parsing output: 31/ for test: syncobj_wait
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: kms_flip_tiling
results: parsing output: 35/ for test: gem_ctx_engines
results: parsing output: 36/ for test: gem_pwrite_snooped
results: parsing output: 37/ for test: kms_pm_rpm
results: parsing output: 38/ for test: kms_cursor_crc
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: gem_softpin
results: parsing output: 43/ for test: gem_bad_reloc
results: parsing output: 44/ for test: gem_wait
results: parsing output: 45/ for test: i915_pm_rpm
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_feature_discovery
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: kms_plane
results: parsing output: 50/ for test: kms_addfb_basic
results: parsing output: 51/ for test: kms_ccs
results: parsing output: 52/ for test: gen9_exec_parse
results: parsing output: 53/ for test: perf_pmu
results: parsing output: 54/ for test: kms_cursor_legacy
results: parsing output: 55/ for test: gem_pxp
results: parsing output: 56/ for test: i915_selftest
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: gem_exec_flush
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_ccs
results: parsing output: 63/ for test: gem_exec_balancer
results: parsing output: 64/ for test: gem_exec_schedule
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: gem_ctx_shared
results: parsing output: 67/ for test: kms_invalid_mode
results: parsing output: 68/ for test: gem_exec_capture
results: parsing output: 69/ for test: kms_ccs
results: parsing output: 70/ for test: kms_cursor_legacy
results: parsing output: 71/ for test: gem_lmem_swapping
results: parsing output: 72/ for test: gem_mmap_gtt
results: parsing output: 73/ for test: gem_exec_reloc
results: parsing output: 74/ for test: api_intel_bb
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: gem_exec_params
results: parsing output: 77/ for test: kms_flip
results: parsing output: 78/ for test: kms_flip
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_pipe_crc_basic
results: parsing output: 81/ for test: gem_gpgpu_fill
results: parsing output: 82/ for test: kms_plane_lowres
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_busy
results: parsing output: 86/ for test: gem_exec_reloc
results: parsing output: 87/ for test: kms_plane_scaling
results: parsing output: 88/ for test: gem_render_copy
results: parsing output: 89/ for test: kms_getfb
results: parsing output: 90/ for test: perf_pmu
results: parsing output: 91/ for test: gem_exec_reloc
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: i915_query
results: parsing output: 94/ for test: prime_self_import
results: parsing output: 95/ for test: gem_exec_schedule
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: gem_exec_reloc
results: parsing output: 98/ for test: kms_properties
results: parsing output: 99/ for test: gem_exec_reloc
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: drm_read
results: parsing output: 103/ for test: vgem_basic
results: no output, setting notrun
results: parsing output: 104/ for test: prime_busy
results: no output, setting notrun
results: parsing output: 105/ for test: syncobj_timeline
results: no output, setting notrun
results: parsing output: 106/ for test: kms_big_fb
results: no output, setting notrun
results: parsing output: 107/ for test: kms_sequence
results: no output, setting notrun
results: parsing output: 108/ for test: kms_cursor_edge_walk
results: no output, setting notrun
results: parsing output: 109/ for test: kms_big_fb
results: no output, setting notrun
results: parsing output: 110/ for test: kms_vblank
results: no output, setting notrun
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 112/ for test: vgem_basic
results: no output, setting notrun
results: parsing output: 113/ for test: gem_render_copy
results: no output, setting notrun
results: parsing output: 114/ for test: kms_prime
results: no output, setting notrun
results: parsing output: 115/ for test: gem_userptr_blits
results: no output, setting notrun
results: parsing output: 116/ for test: kms_plane
results: no output, setting notrun
results: parsing output: 117/ for test: kms_async_flips
results: no output, setting notrun
results: parsing output: 118/ for test: gem_exec_whisper
results: no output, setting notrun
results: parsing output: 119/ for test: gem_exec_flush
results: no output, setting notrun
results: parsing output: 120/ for test: syncobj_wait
results: no output, setting notrun
results: parsing output: 121/ for test: i915_module_load
results: no output, setting notrun
results: parsing output: 122/ for test: syncobj_timeline
results: no output, setting notrun
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 124/ for test: api_intel_allocator
results: no output, setting notrun
results: parsing output: 125/ for test: gem_exec_fence
results: no output, setting notrun
results: parsing output: 126/ for test: syncobj_eventfd
results: no output, setting notrun
results: parsing output: 127/ for test: kms_fbcon_fbt
results: no output, setting notrun
results: parsing output: 128/ for test: kms_psr
results: no output, setting notrun
results: parsing output: 129/ for test: kms_ccs
results: no output, setting notrun
results: parsing output: 130/ for test: kms_pipe_b_c_ivb
results: no output, setting notrun
results: parsing output: 131/ for test: gem_exec_balancer
results: no output, setting notrun
results: parsing output: 132/ for test: kms_atomic
results: no output, setting notrun
Done.