[49.336327] Initializing watchdogs
[49.336385]   /dev/watchdog0
[49.350747] [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]
[49.355519] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[49.357829] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[49.361202] [001/131] (960s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[49.497146] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[49.501663] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[49.585120] [002/131] (960s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[49.699312] Starting subtest: psr-1p-primscrn-spr-indfb-move
[57.051674] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.355s)
[57.258274] [003/131] (952s left) kms_frontbuffer_tracking (fbc-suspend)
[57.366224] Starting subtest: fbc-suspend
[95.435294] Subtest fbc-suspend: SUCCESS (7.287s)
[96.628759] [004/131] (913s left) gen7_exec_parse (chained-batch)
[96.695695] Subtest chained-batch: SKIP (0.000s)
[96.765582] [005/131] (913s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[96.825580] Starting subtest: invalid-single-wait-all-unsubmitted
[96.827925] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[96.936195] [006/131] (913s left) kms_big_fb (linear-64bpp-rotate-90)
[97.035709] Starting subtest: linear-64bpp-rotate-90
[97.054794] Subtest linear-64bpp-rotate-90: SKIP (0.019s)
[97.153757] [007/131] (912s left) i915_pm_rpm (reg-read-ioctl)
[98.816971] Starting subtest: reg-read-ioctl
[101.123451] Subtest reg-read-ioctl: SUCCESS (2.305s)
[101.495673] [008/131] (908s left) gem_create (create-size-update)
[101.554496] Starting subtest: create-size-update
[101.556516] Subtest create-size-update: SUCCESS (0.000s)
[101.771750] [009/131] (908s left) syncobj_timeline (host-signal-ordered)
[102.067583] Starting subtest: host-signal-ordered
[102.070267] Subtest host-signal-ordered: SUCCESS (0.001s)
[102.286932] [010/131] (907s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[102.526648] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[102.530954] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[102.691568] [011/131] (907s left) gem_eio (in-flight-internal-10ms)
[102.918324] Starting subtest: in-flight-internal-10ms
[104.705976] Subtest in-flight-internal-10ms: SUCCESS (1.788s)
[104.854380] [012/131] (905s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[104.908537] Starting subtest: single-wait-all-for-submit-unsubmitted
[105.007355] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.100s)
[105.077651] [013/131] (905s left) kms_psr (psr-primary-mmap-cpu)
[105.170751] Starting subtest: psr-primary-mmap-cpu
[105.173127] Starting dynamic subtest: eDP-1
[106.895725] Dynamic subtest eDP-1: SUCCESS (1.724s)
[106.897958] Subtest psr-primary-mmap-cpu: SUCCESS (1.725s)
[107.749314] [014/131] (902s left) gem_pwrite (basic-random)
[107.814349] Subtest basic-random: SKIP (0.000s)
[107.877704] [015/131] (902s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[107.967153] Starting subtest: random-ccs-data-y-tiled-ccs
[107.969493] Starting dynamic subtest: pipe-A-eDP-1
[107.994686] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[108.005083] Starting dynamic subtest: pipe-B-eDP-1
[108.029630] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[108.037948] Starting dynamic subtest: pipe-C-eDP-1
[108.061487] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[108.069477] Starting dynamic subtest: pipe-D-eDP-1
[108.093998] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[108.098246] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.002s)
[110.138132] [016/131] (900s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[115.115494] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[115.117836] Starting dynamic subtest: pipe-A-eDP-1
[132.292141] Dynamic subtest pipe-A-eDP-1: SUCCESS (17.174s)
[132.302067] Starting dynamic subtest: pipe-B-eDP-1
[149.430690] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.135s)
[149.432990] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (34.313s)
[150.222633] [017/131] (860s left) perf_pmu (init-wait)
[150.264187] Starting subtest: init-wait
[150.266948] Starting dynamic subtest: rcs0
[150.269416] Dynamic subtest rcs0: SUCCESS (0.001s)
[150.279173] Starting dynamic subtest: bcs0
[150.281064] Dynamic subtest bcs0: SUCCESS (0.000s)
[150.288689] Starting dynamic subtest: vcs0
[150.290630] Dynamic subtest vcs0: SUCCESS (0.000s)
[150.298208] Starting dynamic subtest: vcs1
[150.300151] Dynamic subtest vcs1: SUCCESS (0.000s)
[150.308170] Starting dynamic subtest: vecs0
[150.310066] Dynamic subtest vecs0: SUCCESS (0.000s)
[150.318807] Starting dynamic subtest: ccs0
[150.321132] Dynamic subtest ccs0: SUCCESS (0.000s)
[150.323325] Subtest init-wait: SUCCESS (0.004s)
[150.373223] [018/131] (860s left) gem_exec_alignment (pi-isolated)
[150.431869] Starting subtest: pi-isolated
[200.954907] Subtest pi-isolated: SUCCESS (50.513s)
[201.291430] [019/131] (809s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[201.431783] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[201.440467] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[201.544751] [020/131] (809s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[201.609914] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[201.614596] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[201.788361] [021/131] (808s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[201.893453] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[201.897819] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[202.007800] [022/131] (808s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[202.099272] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[202.101657] Starting dynamic subtest: pipe-A-eDP-1
[202.122570] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[202.131755] Starting dynamic subtest: pipe-B-eDP-1
[202.150396] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[202.158475] Starting dynamic subtest: pipe-C-eDP-1
[202.177141] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[202.185038] Starting dynamic subtest: pipe-D-eDP-1
[202.204079] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[202.205939] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.004s)
[204.371069] [023/131] (806s left) gem_softpin (allocator-fork)
[204.434496] Starting subtest: allocator-fork
[206.644001] Subtest allocator-fork: SUCCESS (2.208s)
[206.761593] [024/131] (804s left) gem_exec_parallel (engines)
[206.829523] Starting subtest: engines
[206.831871] Starting dynamic subtest: basic
[208.742840] Dynamic subtest basic: SUCCESS (1.911s)
[208.753347] Starting dynamic subtest: contexts
[213.166462] Dynamic subtest contexts: SUCCESS (4.422s)
[213.175503] Starting dynamic subtest: fds
[216.941967] Dynamic subtest fds: SUCCESS (3.774s)
[216.951668] Starting dynamic subtest: userptr
[218.737201] Dynamic subtest userptr: SUCCESS (1.794s)
[218.739691] Subtest engines: SUCCESS (11.906s)
[218.925356] [025/131] (791s left) device_reset (unbind-cold-reset-rebind)
[218.975797] Starting subtest: unbind-cold-reset-rebind
[218.979768] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[219.048995] [026/131] (791s left) i915_hangman (gt-engine-error)
[219.120676] Starting subtest: gt-engine-error
[219.123050] Starting dynamic subtest: rcs0
[220.660278] Dynamic subtest rcs0: SUCCESS (1.538s)
[220.672180] Starting dynamic subtest: bcs0
[222.641995] Dynamic subtest bcs0: SUCCESS (1.981s)
[222.656727] Starting dynamic subtest: vcs0
[224.691817] Dynamic subtest vcs0: SUCCESS (2.048s)
[224.703466] Starting dynamic subtest: vcs1
[226.674638] Dynamic subtest vcs1: SUCCESS (1.981s)
[226.685135] Starting dynamic subtest: vecs0
[228.659241] Dynamic subtest vecs0: SUCCESS (1.983s)
[228.672923] Starting dynamic subtest: ccs0
[230.644409] Dynamic subtest ccs0: SUCCESS (1.984s)
[230.646846] Subtest gt-engine-error: SUCCESS (11.524s)
[230.786767] [027/131] (780s left) kms_plane_cursor (primary)
[230.897223] Starting subtest: primary
[230.902356] Starting dynamic subtest: pipe-A-eDP-1-size-64
[233.555992] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.656s)
[233.580355] Starting dynamic subtest: pipe-A-eDP-1-size-128
[236.324588] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.751s)
[236.349124] Starting dynamic subtest: pipe-A-eDP-1-size-256
[239.092204] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.752s)
[239.406791] Starting dynamic subtest: pipe-B-eDP-1-size-64
[242.722634] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.325s)
[242.747639] Starting dynamic subtest: pipe-B-eDP-1-size-128
[245.434045] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.693s)
[245.458814] Starting dynamic subtest: pipe-B-eDP-1-size-256
[248.123295] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.671s)
[248.439579] Starting dynamic subtest: pipe-C-eDP-1-size-64
[251.356473] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.928s)
[251.383792] Starting dynamic subtest: pipe-C-eDP-1-size-128
[253.567534] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.191s)
[253.594998] Starting dynamic subtest: pipe-C-eDP-1-size-256
[255.734584] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.146s)
[256.048873] Starting dynamic subtest: pipe-D-eDP-1-size-64
[259.033432] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.996s)
[259.060601] Starting dynamic subtest: pipe-D-eDP-1-size-128
[261.256802] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.202s)
[261.283071] Starting dynamic subtest: pipe-D-eDP-1-size-256
[263.468528] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.191s)
[263.779446] Subtest primary: SUCCESS (32.879s)
[264.591958] [028/131] (746s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[264.695549] Starting subtest: fbc-indfb-scaledprimary
[269.799651] Subtest fbc-indfb-scaledprimary: SUCCESS (5.107s)
[271.002447] [029/131] (739s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[271.116447] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[271.120543] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[271.231106] [030/131] (739s left) gem_userptr_blits (invalid-null-pointer)
[271.286724] Starting subtest: invalid-null-pointer
[271.289138] Subtest invalid-null-pointer: SUCCESS (0.001s)
[271.421789] [031/131] (739s left) prime_vgem (sync)
[271.589903] Starting subtest: sync
[271.592146] Starting dynamic subtest: rcs0
[271.644409] Dynamic subtest rcs0: SUCCESS (0.056s)
[271.653536] Starting dynamic subtest: bcs0
[271.718844] Dynamic subtest bcs0: SUCCESS (0.073s)
[271.727867] Starting dynamic subtest: vcs0
[271.765053] Dynamic subtest vcs0: SUCCESS (0.045s)
[271.773972] Starting dynamic subtest: vcs1
[271.809801] Dynamic subtest vcs1: SUCCESS (0.044s)
[271.818596] Starting dynamic subtest: vecs0
[271.857142] Dynamic subtest vecs0: SUCCESS (0.047s)
[271.865899] Starting dynamic subtest: ccs0
[271.901764] Dynamic subtest ccs0: SUCCESS (0.044s)
[271.904015] Subtest sync: SUCCESS (0.314s)
[272.026566] [FACT prime_vgem (sync)] new: kernel.kmod_is_loaded.vgem: true
[272.029496] [032/131] (739s left) gem_create (create-ext-set-pat)
[272.193594] Starting subtest: create-ext-set-pat
[272.195798] Subtest create-ext-set-pat: SUCCESS (0.001s)
[272.294758] [033/131] (738s left) gem_pipe_control_store_loop (reused-buffer)
[272.353593] Starting subtest: reused-buffer
[274.508787] Subtest reused-buffer: SUCCESS (2.153s)
[274.656622] [034/131] (736s left) syncobj_timeline (wait-zero-handles)
[274.718903] Starting subtest: wait-zero-handles
[274.721180] Subtest wait-zero-handles: SUCCESS (0.000s)
[274.835647] [035/131] (736s left) gem_exec_flush (basic-wb-ro-before-default)
[274.912057] Starting subtest: basic-wb-ro-before-default
[280.365678] Subtest basic-wb-ro-before-default: SUCCESS (5.454s)
[280.575466] [036/131] (730s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[280.675672] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[284.988745] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.316s)
[286.178851] [037/131] (725s left) kms_chamelium_frames (dp-crc-multiple)
[286.576167] Subtest dp-crc-multiple: SKIP (0.000s)
[287.379156] [038/131] (723s left) gem_userptr_blits (vma-merge)
[287.455732] Starting subtest: vma-merge
[287.497617] Subtest vma-merge: SUCCESS (0.042s)
[287.640081] [039/131] (723s left) kms_vrr (flip-suspend)
[287.739158] Starting subtest: flip-suspend
[287.745197] Subtest flip-suspend: SKIP (0.000s)
[287.812277] [040/131] (723s left) gem_exec_capture (pi)
[287.878506] Starting subtest: pi
[287.880932] Starting dynamic subtest: rcs0
[291.997323] Dynamic subtest rcs0: SUCCESS (4.118s)
[292.008962] Starting dynamic subtest: bcs0
[295.983173] Dynamic subtest bcs0: SUCCESS (3.985s)
[295.992697] Starting dynamic subtest: vcs0
[299.903812] Dynamic subtest vcs0: SUCCESS (3.919s)
[299.914133] Starting dynamic subtest: vcs1
[303.843938] Dynamic subtest vcs1: SUCCESS (3.938s)
[303.859242] Starting dynamic subtest: vecs0
[307.818009] Dynamic subtest vecs0: SUCCESS (3.974s)
[307.829840] Starting dynamic subtest: ccs0
[311.817008] Dynamic subtest ccs0: SUCCESS (3.997s)
[311.819443] Subtest pi: SUCCESS (23.939s)
[311.899850] [041/131] (699s left) gem_madvise (dontneed-before-pwrite)
[311.976345] Starting subtest: dontneed-before-pwrite
[311.999147] Subtest dontneed-before-pwrite: SKIP (0.019s)
[312.057628] [042/131] (699s left) gem_sync (basic-store-all)
[312.140193] Starting subtest: basic-store-all
[315.131158] Subtest basic-store-all: SUCCESS (3.000s)
[315.315992] [043/131] (696s left) gem_exec_reloc (basic-write-read-active)
[315.377252] Subtest basic-write-read-active: SKIP (0.000s)
[315.449147] [044/131] (696s left) kms_flip (2x-plain-flip)
[315.551437] Starting subtest: 2x-plain-flip
[315.562412] Subtest 2x-plain-flip: SKIP (0.011s)
[315.641441] [045/131] (696s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[315.709053] Starting subtest: rel-constants-invalid-rel-gen5
[315.711535] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[315.811182] [046/131] (695s left) kms_psr (pr-suspend)
[315.917165] Starting subtest: pr-suspend
[315.921678] Subtest pr-suspend: SKIP (0.000s)
[315.989121] [047/131] (695s left) prime_mmap_coherency (write)
[316.043377] Starting subtest: write
[321.419004] Subtest write: SUCCESS (5.375s)
[321.573068] [048/131] (690s left) gem_userptr_blits (unsync-unmap-cycles)
[321.639713] Subtest unsync-unmap-cycles: SKIP (0.000s)
[321.782527] [049/131] (690s left) kms_content_protection (atomic)
[321.932848] Starting subtest: atomic
[325.331888] Subtest atomic: SKIP (3.397s)
[326.518979] [050/131] (685s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[326.628433] Starting subtest: yf-tiled-8bpp-rotate-270
[326.632861] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[326.735633] [051/131] (685s left) kms_psr (fbc-psr-sprite-blt)
[326.821129] Starting subtest: fbc-psr-sprite-blt
[326.823415] Starting dynamic subtest: eDP-1
[326.827734] Dynamic subtest eDP-1: SKIP (0.000s)
[326.832209] Subtest fbc-psr-sprite-blt: SKIP (0.001s)
[326.893682] [052/131] (685s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[327.051586] Starting subtest: cursor-rapid-movement-32x10
[327.097053] Subtest cursor-rapid-movement-32x10: SKIP (0.040s)
[327.386434] [053/131] (684s left) i915_drm_fdinfo (busy)
[327.422940] Starting subtest: busy
[327.424864] Starting dynamic subtest: rcs0
[327.447049] Dynamic subtest rcs0: SKIP (0.023s)
[327.456876] Starting dynamic subtest: bcs0
[327.472064] Dynamic subtest bcs0: SKIP (0.025s)
[327.480137] Starting dynamic subtest: vcs0
[327.483823] Dynamic subtest vcs0: SKIP (0.000s)
[327.491807] Starting dynamic subtest: vcs1
[327.495179] Dynamic subtest vcs1: SKIP (0.000s)
[327.503137] Starting dynamic subtest: vecs0
[327.506813] Dynamic subtest vecs0: SKIP (0.000s)
[327.515809] Starting dynamic subtest: ccs0
[327.519257] Dynamic subtest ccs0: SKIP (0.000s)
[327.522672] Subtest busy: SKIP (0.054s)
[327.556480] [054/131] (684s left) drm_buddy (drm_buddy)
[327.593500] Starting subtest: drm_buddy
[327.632178] Starting dynamic subtest: drm_test_buddy_alloc_limit
[327.750401] Dynamic subtest drm_test_buddy_alloc_limit: SUCCESS (0.119s)
[327.759431] Starting dynamic subtest: drm_test_buddy_alloc_optimistic
[327.892871] Dynamic subtest drm_test_buddy_alloc_optimistic: SUCCESS (0.141s)
[327.902841] Starting dynamic subtest: drm_test_buddy_alloc_pessimistic
[328.036157] Dynamic subtest drm_test_buddy_alloc_pessimistic: SUCCESS (0.144s)
[328.045666] Starting dynamic subtest: drm_test_buddy_alloc_pathological
[328.159622] Dynamic subtest drm_test_buddy_alloc_pathological: SUCCESS (0.122s)
[328.170819] Starting dynamic subtest: drm_test_buddy_alloc_contiguous
[328.292393] Dynamic subtest drm_test_buddy_alloc_contiguous: SUCCESS (0.134s)
[328.306998] Starting dynamic subtest: drm_test_buddy_alloc_clear
[328.493484] Dynamic subtest drm_test_buddy_alloc_clear: SUCCESS (0.200s)
[328.503445] Starting dynamic subtest: drm_test_buddy_alloc_range_bias
[328.597954] Dynamic subtest drm_test_buddy_alloc_range_bias: SUCCESS (0.101s)
[328.600183] Subtest drm_buddy: SUCCESS (1.001s)
[328.773811] [055/131] (683s left) syncobj_wait (wait-any-interrupted)
[328.837596] Starting subtest: wait-any-interrupted
[328.939157] Subtest wait-any-interrupted: SUCCESS (0.102s)
[329.016173] [056/131] (683s left) gem_mmap_gtt (basic-small-bo-tiledx)
[329.059121] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[329.120986] [057/131] (683s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-wc)
[329.215866] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-wc
[335.886314] Subtest psr-1p-offscren-pri-indfb-draw-mmap-wc: SUCCESS (6.672s)
[336.014201] [058/131] (676s left) kms_dp_aux_dev
[336.374907] [059/131] (675s left) gem_exec_schedule (preempt-other)
[336.455419] Starting subtest: preempt-other
[336.457338] Starting dynamic subtest: rcs0
[336.516013] Dynamic subtest rcs0: SUCCESS (0.072s)
[336.525474] Starting dynamic subtest: bcs0
[336.584408] Dynamic subtest bcs0: SUCCESS (0.068s)
[336.595147] Starting dynamic subtest: vcs0
[336.650935] Dynamic subtest vcs0: SUCCESS (0.066s)
[336.660356] Starting dynamic subtest: vcs1
[336.717390] Dynamic subtest vcs1: SUCCESS (0.065s)
[336.727912] Starting dynamic subtest: vecs0
[336.784634] Dynamic subtest vecs0: SUCCESS (0.067s)
[336.794521] Starting dynamic subtest: ccs0
[336.853814] Dynamic subtest ccs0: SUCCESS (0.068s)
[336.856446] Subtest preempt-other: SUCCESS (0.411s)
[337.791558] [060/131] (674s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[337.848759] Starting subtest: wait-all-for-submit-delayed-submit
[337.951439] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[338.028216] [061/131] (674s left) kms_addfb_basic (basic-x-tiled-legacy)
[338.092540] Starting subtest: basic-x-tiled-legacy
[338.097109] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[338.250625] [062/131] (674s left) kms_big_fb (linear-16bpp-rotate-270)
[338.342686] Starting subtest: linear-16bpp-rotate-270
[338.362380] Subtest linear-16bpp-rotate-270: SKIP (0.019s)
[338.473393] [063/131] (673s left) kms_panel_fitting (legacy)
[338.575251] Starting subtest: legacy
[338.577468] Starting dynamic subtest: pipe-A-eDP-1
[339.128952] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.556s)
[339.156963] Starting dynamic subtest: pipe-B-eDP-1
[340.717937] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.568s)
[340.745740] Starting dynamic subtest: pipe-C-eDP-1
[342.305051] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.565s)
[342.333399] Starting dynamic subtest: pipe-D-eDP-1
[343.854993] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.528s)
[343.857764] Subtest legacy: SUCCESS (5.280s)
[345.073039] [064/131] (667s left) gem_reg_read (timestamp-monotonic)
[345.133368] Starting subtest: timestamp-monotonic
[349.718036] Subtest timestamp-monotonic: SUCCESS (4.585s)
[349.794847] [065/131] (662s left) gem_exec_basic (basic)
[349.846810] Starting subtest: basic
[349.849288] Starting dynamic subtest: rcs0-smem
[349.851509] Dynamic subtest rcs0-smem: SUCCESS (0.004s)
[349.862576] Starting dynamic subtest: bcs0-smem
[349.865765] Dynamic subtest bcs0-smem: SUCCESS (0.004s)
[349.877083] Starting dynamic subtest: vcs0-smem
[349.879240] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[349.887734] Starting dynamic subtest: vcs1-smem
[349.889850] Dynamic subtest vcs1-smem: SUCCESS (0.003s)
[349.898257] Starting dynamic subtest: vecs0-smem
[349.900359] Dynamic subtest vecs0-smem: SUCCESS (0.003s)
[349.908913] Starting dynamic subtest: ccs0-smem
[349.911127] Dynamic subtest ccs0-smem: SUCCESS (0.004s)
[349.913306] Subtest basic: SUCCESS (0.024s)
[351.739364] [066/131] (660s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[351.832493] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[351.836887] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[351.940595] [067/131] (660s left) kms_vblank (invalid)
[352.031166] Starting subtest: invalid
[352.033002] Starting dynamic subtest: pipe-A-eDP-1
[352.428964] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.397s)
[352.431427] Subtest invalid: SUCCESS (0.399s)
[353.302981] [068/131] (659s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[353.403520] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[354.083063] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.681s)
[354.243237] [069/131] (658s left) kms_flip (busy-flip)
[354.337258] Starting subtest: busy-flip
[354.339402] Starting dynamic subtest: A-eDP1
[356.013804] Dynamic subtest A-eDP1: SUCCESS (1.676s)
[356.023175] Starting dynamic subtest: B-eDP1
[357.735747] Dynamic subtest B-eDP1: SUCCESS (1.720s)
[357.744980] Starting dynamic subtest: C-eDP1
[359.452506] Dynamic subtest C-eDP1: SUCCESS (1.715s)
[359.462346] Starting dynamic subtest: D-eDP1
[361.103117] Dynamic subtest D-eDP1: SUCCESS (1.648s)
[361.105473] Subtest busy-flip: SUCCESS (6.769s)
[362.376596] [070/131] (650s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[362.468418] Starting subtest: bad-rotation-90-yf-tiled-ccs
[362.470730] Starting dynamic subtest: pipe-A-eDP-1
[362.492906] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[362.503546] Starting dynamic subtest: pipe-B-eDP-1
[362.524246] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[362.532547] Starting dynamic subtest: pipe-C-eDP-1
[362.553691] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[362.562176] Starting dynamic subtest: pipe-D-eDP-1
[362.584064] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[362.588480] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.004s)
[364.720660] [071/131] (647s left) perf (low-oa-exponent-permissions)
[364.853318] Starting subtest: low-oa-exponent-permissions
[364.896423] Subtest low-oa-exponent-permissions: SUCCESS (0.045s)
[364.948433] [072/131] (647s left) kms_lease (cursor-implicit-plane)
[365.053165] Starting subtest: cursor-implicit-plane
[365.055332] Starting dynamic subtest: pipe-A-eDP-1
[365.505567] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.453s)
[365.517161] Starting dynamic subtest: pipe-B-eDP-1
[366.632014] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.126s)
[366.641484] Starting dynamic subtest: pipe-C-eDP-1
[367.751379] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.118s)
[367.761803] Starting dynamic subtest: pipe-D-eDP-1
[368.897752] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.145s)
[368.900289] Subtest cursor-implicit-plane: SUCCESS (3.847s)
[369.757047] [073/131] (643s left) kms_async_flips (alternate-sync-async-flip-atomic)
[369.853260] Starting subtest: alternate-sync-async-flip-atomic
[370.236142] Starting dynamic subtest: pipe-A-eDP-1
[373.064160] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.828s)
[373.435160] Starting dynamic subtest: pipe-B-eDP-1
[376.192685] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.769s)
[376.572702] Starting dynamic subtest: pipe-C-eDP-1
[379.320109] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.758s)
[379.689423] Starting dynamic subtest: pipe-D-eDP-1
[382.461793] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.780s)
[382.464760] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.610s)
[383.651603] [074/131] (629s left) kms_cursor_crc (cursor-random-64x64)
[383.845493] Starting subtest: cursor-random-64x64
[383.850520] Starting dynamic subtest: pipe-A-eDP-1
[387.180017] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.330s)
[387.211622] Starting dynamic subtest: pipe-D-eDP-1
[391.210574] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.011s)
[391.212800] Subtest cursor-random-64x64: SUCCESS (7.364s)
[392.097059] [075/131] (620s left) kms_plane_scaling (planes-downscale-factor-0-75)
[392.190186] Starting subtest: planes-downscale-factor-0-75
[392.192419] Starting dynamic subtest: pipe-A
[392.209792] Dynamic subtest pipe-A: SKIP (0.017s)
[392.219317] Starting dynamic subtest: pipe-B
[392.243363] Dynamic subtest pipe-B: SKIP (0.032s)
[392.253292] Starting dynamic subtest: pipe-C
[392.278626] Dynamic subtest pipe-C: SKIP (0.031s)
[392.287619] Starting dynamic subtest: pipe-D
[392.307279] Dynamic subtest pipe-D: SKIP (0.031s)
[392.311015] Subtest planes-downscale-factor-0-75: SKIP (0.115s)
[392.418933] [076/131] (620s left) gen3_render_mixed_blits
[392.536839] [077/131] (620s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[392.635641] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[392.639753] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[392.724996] [078/131] (620s left) gem_mmap_gtt (hang-user)
[392.777079] Subtest hang-user: SKIP (0.000s)
[392.848116] [079/131] (620s left) kms_cursor_legacy (single-bo)
[392.957959] Starting subtest: single-bo
[392.960196] Starting dynamic subtest: pipe-A
[398.341475] Dynamic subtest pipe-A: SUCCESS (5.379s)
[398.351369] Starting dynamic subtest: pipe-B
[403.723293] Dynamic subtest pipe-B: SUCCESS (5.379s)
[403.733968] Starting dynamic subtest: pipe-C
[409.104604] Dynamic subtest pipe-C: SUCCESS (5.379s)
[409.114625] Starting dynamic subtest: pipe-D
[414.486283] Dynamic subtest pipe-D: SUCCESS (5.379s)
[414.495492] Starting dynamic subtest: all-pipes
[419.875427] Dynamic subtest all-pipes: SUCCESS (5.386s)
[419.878134] Subtest single-bo: SUCCESS (26.913s)
[420.021478] [080/131] (593s left) kms_psr (fbc-psr2-primary-render)
[420.119174] Starting subtest: fbc-psr2-primary-render
[420.121436] Starting dynamic subtest: eDP-1
[420.125685] Dynamic subtest eDP-1: SKIP (0.000s)
[420.129953] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[420.192077] [081/131] (592s left) kms_atomic (plane-overlay-legacy)
[420.283336] Starting subtest: plane-overlay-legacy
[420.285784] Starting dynamic subtest: pipe-A-eDP-1
[420.723371] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.441s)
[420.725615] Subtest plane-overlay-legacy: SUCCESS (0.443s)
[421.540477] [082/131] (591s left) gem_exec_schedule (u-semaphore-resolve)
[421.613663] Starting subtest: u-semaphore-resolve
[421.648084] Subtest u-semaphore-resolve: SUCCESS (0.044s)
[421.985529] [083/131] (591s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[422.100582] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[423.501148] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.399s)
[424.283565] [084/131] (588s left) kms_writeback (writeback-pixel-formats)
[424.382685] Subtest writeback-pixel-formats: SKIP (0.000s)
[424.426275] [085/131] (588s left) gem_exec_whisper (basic-queues)
[424.492695] Starting subtest: basic-queues
[431.737026] Subtest basic-queues: SUCCESS (7.240s)
[431.919319] [086/131] (581s left) kms_pipe_crc_basic (hang-read-crc)
[432.016004] Starting subtest: hang-read-crc
[432.018298] Starting dynamic subtest: pipe-A-eDP-1
[434.053409] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.035s)
[434.063827] Starting dynamic subtest: pipe-B-eDP-1
[436.731374] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.677s)
[436.740883] Starting dynamic subtest: pipe-C-eDP-1
[439.333158] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.598s)
[439.343311] Starting dynamic subtest: pipe-D-eDP-1
[442.019056] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.686s)
[442.021363] Subtest hang-read-crc: SUCCESS (10.003s)
[442.859863] [087/131] (570s left) kms_flip (2x-flip-vs-dpms-on-nop)
[442.963274] Starting subtest: 2x-flip-vs-dpms-on-nop
[442.972303] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.011s)
[443.050563] [088/131] (570s left) kms_hdr (static-toggle-dpms)
[443.156219] Starting subtest: static-toggle-dpms
[443.162453] Subtest static-toggle-dpms: SKIP (0.000s)
[443.228165] [089/131] (570s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[443.326897] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[443.331058] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[443.434585] [090/131] (570s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[443.538680] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[450.893163] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.356s)
[451.051061] [091/131] (562s left) kms_flip (2x-blocking-wf_vblank)
[451.144361] Starting subtest: 2x-blocking-wf_vblank
[451.153241] Subtest 2x-blocking-wf_vblank: SKIP (0.011s)
[451.238177] [092/131] (562s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[451.332724] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[451.336983] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[451.441906] [093/131] (562s left) i915_query (query-topology-kernel-writes)
[451.498965] Starting subtest: query-topology-kernel-writes
[451.501021] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[451.598595] [094/131] (562s left) gem_ctx_param (root-set)
[451.656957] Starting subtest: root-set
[451.659585] Subtest root-set: SUCCESS (0.001s)
[451.771444] [095/131] (561s left) gem_lmem_swapping (heavy-verify-random-ccs)
[451.813337] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[451.867016] [096/131] (561s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[451.981853] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[452.934920] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.954s)
[453.815139] [097/131] (559s left) syncobj_timeline (single-wait-available-submitted)
[453.875760] Starting subtest: single-wait-available-submitted
[453.878117] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[453.981354] [098/131] (559s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[454.081401] Starting subtest: primary-4-tiled-reflect-x-0
[461.184556] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.103s)
[462.386798] [099/131] (551s left) gem_exec_schedule (noreorder)
[462.560048] Starting subtest: noreorder
[462.561975] Starting dynamic subtest: rcs0
[462.646705] Dynamic subtest rcs0: SUCCESS (0.089s)
[462.659480] Starting dynamic subtest: vcs0
[464.743346] Dynamic subtest vcs0: SUCCESS (2.093s)
[464.756597] Starting dynamic subtest: vcs1
[466.692854] Dynamic subtest vcs1: SUCCESS (1.947s)
[466.704527] Starting dynamic subtest: vecs0
[468.674903] Dynamic subtest vecs0: SUCCESS (1.979s)
[468.687314] Starting dynamic subtest: ccs0
[468.745838] Dynamic subtest ccs0: SUCCESS (0.071s)
[468.748291] Subtest noreorder: SUCCESS (6.189s)
[468.929524] [100/131] (544s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[469.037722] Starting subtest: flip-vs-cursor-atomic
[476.139687] Subtest flip-vs-cursor-atomic: SUCCESS (7.102s)
[477.017408] [101/131] (536s left) kms_addfb_basic (unused-handle)
[477.076778] Starting subtest: unused-handle
[477.079145] Subtest unused-handle: SUCCESS (0.000s)
[477.215918] [102/131] (536s left) syncobj_basic (illegal-fd-to-handle)
[477.277737] Starting subtest: illegal-fd-to-handle
[477.280163] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[477.384993] [103/131] (536s left) syncobj_eventfd (invalid-illegal-eventfd)
[477.436658] Starting subtest: invalid-illegal-eventfd
[477.438893] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[477.551152] [104/131] (536s left) kms_prop_blob (invalid-set-prop)
[477.604166] Starting subtest: invalid-set-prop
[477.606397] Subtest invalid-set-prop: SUCCESS (0.000s)
[477.702049] [105/131] (536s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[477.781316] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[477.783602] Starting dynamic subtest: pipe-A-eDP-1
[479.856271] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.073s)
[479.865534] Starting dynamic subtest: pipe-B-eDP-1
[482.013999] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.157s)
[482.023409] Starting dynamic subtest: pipe-C-eDP-1
[484.068962] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.053s)
[484.079179] Starting dynamic subtest: pipe-D-eDP-1
[486.104548] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.035s)
[486.106899] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.322s)
[487.339324] [106/131] (526s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[492.356482] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[492.360921] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.002s)
[493.189599] [107/131] (521s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[493.288540] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[493.292845] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[493.397907] [108/131] (520s left) gem_mmap_offset (partial-unmap)
[493.451549] Starting subtest: partial-unmap
[493.453487] Starting dynamic subtest: smem0
[493.956498] Dynamic subtest smem0: SUCCESS (0.505s)
[493.959197] Subtest partial-unmap: SUCCESS (0.506s)
[494.085536] [109/131] (520s left) api_intel_allocator (open-vm)
[494.142313] Starting subtest: open-vm
[494.144596] Subtest open-vm: SUCCESS (0.003s)
[494.287629] [110/131] (520s left) i915_module_load (reload-with-fault-injection)
[494.323695] Starting subtest: reload-with-fault-injection
[529.081705] Subtest reload-with-fault-injection: SUCCESS (34.757s)
[529.113627] [FACT i915_module_load (reload-with-fault-injection)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[529.114346] [FACT i915_module_load (reload-with-fault-injection)] deleted: kernel.kmod_is_loaded.i915: true
[529.117471] [111/131] (485s left) kms_color (ctm-0-75)
[530.638397] Starting subtest: ctm-0-75
[530.640359] Starting dynamic subtest: pipe-A-eDP-1
[535.415927] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.780s)
[535.424714] Starting dynamic subtest: pipe-B-eDP-1
[540.909306] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.492s)
[540.918510] Starting dynamic subtest: pipe-C-eDP-1
[546.210968] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.300s)
[546.220101] Starting dynamic subtest: pipe-D-eDP-1
[551.526165] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.313s)
[551.528493] Subtest ctm-0-75: SUCCESS (20.887s)
[552.402146] [FACT kms_color (ctm-0-75)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[552.403388] [FACT kms_color (ctm-0-75)] new: kernel.kmod_is_loaded.i915: true
[552.407143] [112/131] (461s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[552.543968] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[569.816107] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.273s)
[570.604040] [113/131] (443s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[570.704072] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[570.708161] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[570.831491] [114/131] (443s left) prime_mmap (test_correct_cpu_write)
[570.894998] Starting subtest: test_correct_cpu_write
[570.897485] Starting dynamic subtest: test_correct_cpu_write-smem
[570.899707] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[570.901894] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[571.012087] [115/131] (443s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[571.114632] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[571.118962] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[571.226417] [116/131] (443s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[571.325264] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[571.327524] Starting dynamic subtest: pipe-A-eDP-1
[571.759149] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.408s)
[571.769263] Starting dynamic subtest: pipe-B-eDP-1
[573.111175] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.349s)
[573.121417] Starting dynamic subtest: pipe-C-eDP-1
[574.516158] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.404s)
[574.527928] Starting dynamic subtest: pipe-D-eDP-1
[575.863268] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.345s)
[575.865271] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.511s)
[577.049622] [117/131] (437s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[577.149457] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[577.151760] Starting dynamic subtest: pipe-A-default-mode
[577.438685] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[577.443315] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.287s)
[578.281755] [118/131] (436s left) syncobj_timeline (signal)
[578.347763] Starting subtest: signal
[578.350464] Subtest signal: SUCCESS (0.000s)
[578.460529] [119/131] (436s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[578.556064] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[578.560177] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[578.640247] [120/131] (436s left) kms_pm_lpsp (kms-lpsp)
[579.739427] Starting subtest: kms-lpsp
[579.741708] Starting dynamic subtest: pipe-A-eDP-1
[579.884532] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.148s)
[580.179376] Subtest kms-lpsp: SUCCESS (0.442s)
[581.006856] [121/131] (433s left) gem_ctx_shared (disjoint-timelines)
[581.078656] Starting subtest: disjoint-timelines
[581.098403] Subtest disjoint-timelines: SUCCESS (0.020s)
[581.345931] [122/131] (433s left) api_intel_allocator (reopen-fork)
[581.403408] Starting subtest: reopen-fork
[585.007989] Subtest reopen-fork: SUCCESS (3.604s)
[585.083888] [123/131] (429s left) kms_psr (fbc-pr-primary-render)
[585.178897] Starting subtest: fbc-pr-primary-render
[585.182876] Subtest fbc-pr-primary-render: SKIP (0.000s)
[585.252248] [124/131] (429s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[585.340512] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[585.342844] Starting dynamic subtest: pipe-A
[585.675890] Dynamic subtest pipe-A: SUCCESS (0.338s)
[585.687886] Starting dynamic subtest: pipe-B
[587.107246] Dynamic subtest pipe-B: SUCCESS (1.431s)
[587.115989] Starting dynamic subtest: pipe-C
[588.545721] Dynamic subtest pipe-C: SUCCESS (1.438s)
[588.555303] Starting dynamic subtest: pipe-D
[589.970235] Dynamic subtest pipe-D: SUCCESS (1.424s)
[589.972545] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.632s)
[591.143972] [125/131] (423s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[591.240619] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[591.245070] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[591.343350] [126/131] (423s left) gem_ctx_persistence (heartbeat-hostile)
[591.412012] Starting subtest: heartbeat-hostile
[591.416706] Subtest heartbeat-hostile: SKIP (0.000s)
[591.525080] [127/131] (423s left) prime_mmap (test_userptr)
[591.579891] Starting subtest: test_userptr
[591.582233] Starting dynamic subtest: test_userptr-smem
[591.584209] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[591.586172] Subtest test_userptr: SUCCESS (0.002s)
[591.681788] [128/131] (423s left) syncobj_wait (single-wait-all-for-submit-submitted)
[591.736002] Starting subtest: single-wait-all-for-submit-submitted
[591.841582] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.105s)
[591.918827] [129/131] (423s left) gem_eio (hibernate)
[592.137916] Starting subtest: hibernate
[606.711812] Subtest hibernate: SUCCESS (14.572s)
[613.842566] [130/131] (408s left) kms_chamelium_frames (hdmi-crc-fast)
[614.224269] Subtest hdmi-crc-fast: SKIP (0.000s)
[615.001701] [131/131] (407s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[615.105769] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[622.407763] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.303s)
[622.539198] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gen7_exec_parse
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: i915_pm_rpm
results: parsing output: 7/ for test: gem_create
results: parsing output: 8/ for test: syncobj_timeline
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gem_eio
results: parsing output: 11/ for test: syncobj_wait
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: gem_pwrite
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: kms_psr2_sf
results: parsing output: 16/ for test: perf_pmu
results: parsing output: 17/ for test: gem_exec_alignment
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_render_copy
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: gem_softpin
results: parsing output: 23/ for test: gem_exec_parallel
results: parsing output: 24/ for test: device_reset
results: parsing output: 25/ for test: i915_hangman
results: parsing output: 26/ for test: kms_plane_cursor
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: gem_userptr_blits
results: parsing output: 30/ for test: prime_vgem
results: parsing output: 31/ for test: gem_create
results: parsing output: 32/ for test: gem_pipe_control_store_loop
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: gem_exec_flush
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_chamelium_frames
results: parsing output: 37/ for test: gem_userptr_blits
results: parsing output: 38/ for test: kms_vrr
results: parsing output: 39/ for test: gem_exec_capture
results: parsing output: 40/ for test: gem_madvise
results: parsing output: 41/ for test: gem_sync
results: parsing output: 42/ for test: gem_exec_reloc
results: parsing output: 43/ for test: kms_flip
results: parsing output: 44/ for test: gem_exec_params
results: parsing output: 45/ for test: kms_psr
results: parsing output: 46/ for test: prime_mmap_coherency
results: parsing output: 47/ for test: gem_userptr_blits
results: parsing output: 48/ for test: kms_content_protection
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: kms_psr
results: parsing output: 51/ for test: kms_cursor_crc
results: parsing output: 52/ for test: i915_drm_fdinfo
results: parsing output: 53/ for test: drm_buddy
results: parsing output: 54/ for test: syncobj_wait
results: parsing output: 55/ for test: gem_mmap_gtt
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_dp_aux_dev
results: parsing output: 58/ for test: gem_exec_schedule
results: parsing output: 59/ for test: syncobj_wait
results: parsing output: 60/ for test: kms_addfb_basic
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_panel_fitting
results: parsing output: 63/ for test: gem_reg_read
results: parsing output: 64/ for test: gem_exec_basic
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_vblank
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: kms_flip
results: parsing output: 69/ for test: kms_ccs
results: parsing output: 70/ for test: perf
results: parsing output: 71/ for test: kms_lease
results: parsing output: 72/ for test: kms_async_flips
results: parsing output: 73/ for test: kms_cursor_crc
results: parsing output: 74/ for test: kms_plane_scaling
results: parsing output: 75/ for test: gen3_render_mixed_blits
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_mmap_gtt
results: parsing output: 78/ for test: kms_cursor_legacy
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: kms_atomic
results: parsing output: 81/ for test: gem_exec_schedule
results: parsing output: 82/ for test: kms_cursor_legacy
results: parsing output: 83/ for test: kms_writeback
results: parsing output: 84/ for test: gem_exec_whisper
results: parsing output: 85/ for test: kms_pipe_crc_basic
results: parsing output: 86/ for test: kms_flip
results: parsing output: 87/ for test: kms_hdr
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_flip
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: i915_query
results: parsing output: 93/ for test: gem_ctx_param
results: parsing output: 94/ for test: gem_lmem_swapping
results: parsing output: 95/ for test: kms_cursor_legacy
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: kms_rotation_crc
results: parsing output: 98/ for test: gem_exec_schedule
results: parsing output: 99/ for test: kms_cursor_legacy
results: parsing output: 100/ for test: kms_addfb_basic
results: parsing output: 101/ for test: syncobj_basic
results: parsing output: 102/ for test: syncobj_eventfd
results: parsing output: 103/ for test: kms_prop_blob
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: kms_psr2_sf
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_mmap_offset
results: parsing output: 108/ for test: api_intel_allocator
results: parsing output: 109/ for test: i915_module_load
results: parsing output: 110/ for test: kms_color
results: parsing output: 111/ for test: kms_cursor_legacy
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: prime_mmap
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: kms_flip_scaled_crc
results: parsing output: 117/ for test: syncobj_timeline
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_pm_lpsp
results: parsing output: 120/ for test: gem_ctx_shared
results: parsing output: 121/ for test: api_intel_allocator
results: parsing output: 122/ for test: kms_psr
results: parsing output: 123/ for test: kms_plane_scaling
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_ctx_persistence
results: parsing output: 126/ for test: prime_mmap
results: parsing output: 127/ for test: syncobj_wait
results: parsing output: 128/ for test: gem_eio
results: parsing output: 129/ for test: kms_chamelium_frames
results: parsing output: 130/ for test: kms_frontbuffer_tracking
Done.