[63.506595] Initializing watchdogs
[63.506662]   /dev/watchdog0
[63.527274] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[63.538223] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[63.541975] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.544293] [001/132] (960s left) kms_feature_discovery (psr1)
[65.050531] Starting subtest: psr1
[65.052223] Subtest psr1: SKIP (0.000s)
[65.154494] [002/132] (958s left) gem_exec_whisper (basic-queues-priority)
[65.271982] Starting subtest: basic-queues-priority
[87.691114] Subtest basic-queues-priority: SUCCESS (22.429s)
[87.933850] [003/132] (936s left) gem_shrink (reclaim)
[88.012150] Starting subtest: reclaim
[90.276090] Subtest reclaim: SUCCESS (2.260s)
[90.447900] [004/132] (933s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[92.002256] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[92.003200] Starting dynamic subtest: pipe-A-HDMI-A-3
[92.006714] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[92.014660] Starting dynamic subtest: pipe-B-HDMI-A-3
[92.018142] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[92.025827] Starting dynamic subtest: pipe-C-HDMI-A-3
[92.029205] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[92.036831] Starting dynamic subtest: pipe-D-HDMI-A-3
[92.040334] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[92.042119] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.005s)
[92.293145] [005/132] (932s left) kms_pm_dc (dc6-psr)
[94.808220] Starting subtest: dc6-psr
[94.810041] Subtest dc6-psr: SKIP (0.000s)
[94.891412] [006/132] (929s left) gem_exec_capture (userptr)
[94.994147] Starting subtest: userptr
[95.936124] Subtest userptr: SUCCESS (0.942s)
[96.059825] [007/132] (928s left) perf_pmu (busy-accuracy-98)
[96.122445] Starting subtest: busy-accuracy-98
[96.123403] Starting dynamic subtest: rcs0
[99.180174] Dynamic subtest rcs0: SUCCESS (3.057s)
[99.188795] Starting dynamic subtest: bcs0
[102.253233] Dynamic subtest bcs0: SUCCESS (3.071s)
[102.262984] Starting dynamic subtest: vcs0
[105.313159] Dynamic subtest vcs0: SUCCESS (3.060s)
[105.322066] Starting dynamic subtest: vcs1
[108.370246] Dynamic subtest vcs1: SUCCESS (3.057s)
[108.379118] Starting dynamic subtest: vecs0
[111.425160] Dynamic subtest vecs0: SUCCESS (3.055s)
[111.434151] Starting dynamic subtest: vecs1
[114.479349] Dynamic subtest vecs1: SUCCESS (3.054s)
[114.488161] Starting dynamic subtest: ccs0
[117.533358] Dynamic subtest ccs0: SUCCESS (3.054s)
[117.534271] Subtest busy-accuracy-98: SUCCESS (21.410s)
[117.694982] [008/132] (906s left) sysfs_heartbeat_interval (nopreempt)
[117.773548] Starting subtest: nopreempt
[117.774484] Starting dynamic subtest: vecs0
[122.042268] Dynamic subtest vecs0: SUCCESS (4.268s)
[122.051378] Starting dynamic subtest: ccs0
[126.285298] Dynamic subtest ccs0: SUCCESS (4.243s)
[126.294418] Starting dynamic subtest: vcs0
[130.488389] Dynamic subtest vcs0: SUCCESS (4.203s)
[130.497563] Starting dynamic subtest: bcs0
[134.638198] Dynamic subtest bcs0: SUCCESS (4.149s)
[134.647337] Starting dynamic subtest: vecs1
[138.837368] Dynamic subtest vecs1: SUCCESS (4.199s)
[138.846512] Starting dynamic subtest: rcs0
[143.132083] Dynamic subtest rcs0: SUCCESS (4.294s)
[143.141225] Starting dynamic subtest: vcs1
[147.318254] Dynamic subtest vcs1: SUCCESS (4.186s)
[147.319351] Subtest nopreempt: SUCCESS (29.544s)
[147.440083] [009/132] (877s left) kms_flip (2x-blocking-wf_vblank)
[148.945971] Starting subtest: 2x-blocking-wf_vblank
[148.958989] Subtest 2x-blocking-wf_vblank: SKIP (0.013s)
[149.160737] [010/132] (875s left) kms_plane (pixel-format-yf-tiled-modifier)
[150.683128] Starting subtest: pixel-format-yf-tiled-modifier
[150.684882] Subtest pixel-format-yf-tiled-modifier: SKIP (0.000s)
[150.788403] [011/132] (873s left) gem_spin_batch (engines)
[150.892909] Starting subtest: engines
[150.893907] Starting dynamic subtest: rcs0
[154.153222] Dynamic subtest rcs0: SUCCESS (3.258s)
[154.165591] Starting dynamic subtest: bcs0
[157.387621] Dynamic subtest bcs0: SUCCESS (3.232s)
[157.398488] Starting dynamic subtest: vcs0
[160.623612] Dynamic subtest vcs0: SUCCESS (3.235s)
[160.633630] Starting dynamic subtest: vcs1
[163.858688] Dynamic subtest vcs1: SUCCESS (3.234s)
[163.869696] Starting dynamic subtest: vecs0
[167.093723] Dynamic subtest vecs0: SUCCESS (3.234s)
[167.103844] Starting dynamic subtest: vecs1
[170.327754] Dynamic subtest vecs1: SUCCESS (3.233s)
[170.338631] Starting dynamic subtest: ccs0
[173.562386] Dynamic subtest ccs0: SUCCESS (3.233s)
[173.564125] Subtest engines: SUCCESS (22.667s)
[173.812186] [012/132] (850s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[175.321875] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.000s)
[175.372704] [013/132] (849s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[176.883728] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[176.885263] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[177.104694] [014/132] (847s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[178.619281] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[178.671543] [015/132] (846s left) kms_invalid_mode (bad-vtotal)
[180.177970] Starting subtest: bad-vtotal
[180.178951] Starting dynamic subtest: pipe-A-HDMI-A-3
[180.222989] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.045s)
[180.232586] Starting dynamic subtest: pipe-B-HDMI-A-3
[180.233769] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.001s)
[180.242789] Starting dynamic subtest: pipe-C-HDMI-A-3
[180.243935] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.001s)
[180.252558] Starting dynamic subtest: pipe-D-HDMI-A-3
[180.253460] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.001s)
[180.254415] Subtest bad-vtotal: SUCCESS (0.051s)
[180.399955] [016/132] (844s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[181.910131] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[181.970552] [017/132] (843s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[182.044475] Starting subtest: x-tiled-to-vebox-y-tiled
[182.046478] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[182.270492] [018/132] (842s left) gem_exec_schedule (preempt-queue)
[182.354482] Subtest preempt-queue: SKIP (0.000s)
[182.683904] [019/132] (842s left) gem_exec_fence (expired-history)
[183.256070] Starting subtest: expired-history
[189.601329] Subtest expired-history: SUCCESS (6.345s)
[191.275681] [FACT gem_exec_fence (expired-history)] new: kernel.kmod_is_loaded.vgem: true
[191.277585] [020/132] (833s left) kms_color (legacy-gamma-reset)
[192.795178] Starting subtest: legacy-gamma-reset
[192.796134] Starting dynamic subtest: pipe-A-HDMI-A-3
[193.064769] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.269s)
[193.079030] Starting dynamic subtest: pipe-B-HDMI-A-3
[193.094957] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.029s)
[193.104565] Starting dynamic subtest: pipe-C-HDMI-A-3
[193.115784] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.021s)
[193.125159] Starting dynamic subtest: pipe-D-HDMI-A-3
[193.137547] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.022s)
[193.138465] Subtest legacy-gamma-reset: SUCCESS (0.343s)
[193.280069] [021/132] (832s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[194.811007] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[196.173095] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.361s)
[196.321080] [022/132] (829s left) kms_draw_crc (fill-fb)
[197.835417] Starting subtest: fill-fb
[198.371559] Subtest fill-fb: SUCCESS (0.536s)
[198.545641] [023/132] (826s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[200.063972] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[200.065739] Subtest psr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[200.192814] [024/132] (825s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[200.296207] Starting subtest: wait-all-for-submit-delayed-submit
[200.401256] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.104s)
[200.572588] [025/132] (825s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[202.086157] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[202.087041] Starting dynamic subtest: pipe-A-HDMI-A-3
[202.095807] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[202.105500] Starting dynamic subtest: pipe-B-HDMI-A-3
[202.113826] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[202.123263] Starting dynamic subtest: pipe-C-HDMI-A-3
[202.131312] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[202.140581] Starting dynamic subtest: pipe-D-HDMI-A-3
[202.151526] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[202.160607] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.004s)
[202.366398] [026/132] (823s left) core_setmaster (master-drop-set-root)
[202.455506] Starting subtest: master-drop-set-root
[202.488482] Subtest master-drop-set-root: SUCCESS (0.033s)
[202.568835] [027/132] (823s left) kms_addfb_basic (unused-offsets)
[202.651069] Starting subtest: unused-offsets
[202.651959] Subtest unused-offsets: SUCCESS (0.000s)
[204.235927] [028/132] (821s left) kms_psr (psr2-cursor-blt)
[205.778400] Subtest psr2-cursor-blt: SKIP (0.000s)
[205.851825] [029/132] (819s left) prime_busy (after)
[205.941959] Starting subtest: after
[205.945925] Starting dynamic subtest: rcs0
[205.999047] Dynamic subtest rcs0: SUCCESS (0.053s)
[206.008871] Starting dynamic subtest: bcs0
[206.049499] Dynamic subtest bcs0: SUCCESS (0.050s)
[206.065671] Starting dynamic subtest: vcs0
[206.092928] Dynamic subtest vcs0: SUCCESS (0.043s)
[206.120471] Starting dynamic subtest: vcs1
[206.134174] Dynamic subtest vcs1: SUCCESS (0.040s)
[206.151475] Starting dynamic subtest: vecs0
[206.174018] Dynamic subtest vecs0: SUCCESS (0.039s)
[206.187557] Starting dynamic subtest: vecs1
[206.214465] Dynamic subtest vecs1: SUCCESS (0.040s)
[206.231167] Starting dynamic subtest: ccs0
[206.256432] Dynamic subtest ccs0: SUCCESS (0.041s)
[206.369952] Subtest after: SUCCESS (0.427s)
[206.535293] [030/132] (819s left) i915_query (query-garbage)
[206.612057] Starting subtest: query-garbage
[206.612936] Subtest query-garbage: SUCCESS (0.000s)
[206.746416] [031/132] (819s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[208.315518] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[208.421848] [032/132] (817s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[209.948537] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[209.950213] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[210.100266] [033/132] (816s left) kms_cursor_edge_walk (128x128-left-edge)
[211.642386] Starting subtest: 128x128-left-edge
[211.643223] Starting dynamic subtest: pipe-A-HDMI-A-3
[214.984382] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (3.342s)
[214.994355] Starting dynamic subtest: pipe-D-HDMI-A-3
[218.203439] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (3.218s)
[218.204314] Subtest 128x128-left-edge: SUCCESS (6.562s)
[218.388145] [034/132] (807s left) syncobj_basic (bad-pad-handle-to-fd)
[218.470084] Starting subtest: bad-pad-handle-to-fd
[218.471123] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[218.599352] [035/132] (807s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[220.124840] Starting subtest: yf-tiled-64bpp-rotate-180
[220.126557] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[220.267978] [036/132] (806s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[221.816438] Starting subtest: addfb25-y-tiled-small-legacy
[221.818273] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[221.961520] [037/132] (804s left) gem_ctx_param (invalid-set-no-zeromap)
[222.069388] Starting subtest: invalid-set-no-zeromap
[222.070209] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[222.249925] [038/132] (804s left) kms_cursor_crc (cursor-onscreen-max-size)
[224.091161] Starting subtest: cursor-onscreen-max-size
[224.094573] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[224.300982] [039/132] (802s left) kms_psr (psr2-cursor-plane-move)
[225.817420] Subtest psr2-cursor-plane-move: SKIP (0.000s)
[225.882022] [040/132] (800s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[227.416033] Starting subtest: y-tiled-32bpp-rotate-270
[227.417919] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[227.638772] [041/132] (799s left) prime_mmap (test_forked_cpu_write)
[227.720795] Starting subtest: test_forked_cpu_write
[227.721726] Starting dynamic subtest: test_forked_cpu_write-smem
[227.729514] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.009s)
[227.739194] Starting dynamic subtest: test_forked_cpu_write-lmem0
[227.740155] Dynamic subtest test_forked_cpu_write-lmem0: SUCCESS (0.009s)
[227.741054] Subtest test_forked_cpu_write: SUCCESS (0.019s)
[227.898849] [042/132] (798s left) prime_mmap (test_refcounting)
[227.975955] Starting subtest: test_refcounting
[227.976944] Starting dynamic subtest: test_refcounting-smem
[228.026153] Dynamic subtest test_refcounting-smem: SUCCESS (0.050s)
[228.035746] Starting dynamic subtest: test_refcounting-lmem0
[228.228936] Dynamic subtest test_refcounting-lmem0: SUCCESS (0.202s)
[228.229935] Subtest test_refcounting: SUCCESS (0.253s)
[228.337834] [043/132] (798s left) gem_exec_gttfill (multigpu-basic)
[228.539523] Starting subtest: multigpu-basic
[242.635945] Subtest multigpu-basic: SUCCESS (14.096s)
[242.722318] [044/132] (784s left) kms_psr (fbc-psr-cursor-plane-move)
[244.277613] Subtest fbc-psr-cursor-plane-move: SKIP (0.000s)
[244.333620] [045/132] (782s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[245.861619] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[245.863323] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[245.993793] [046/132] (781s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[247.542616] Starting subtest: 4-tiled-8bpp-rotate-0
[249.157935] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.614s)
[249.342752] [047/132] (777s left) kms_plane_multiple (tiling-none)
[250.859251] Starting subtest: tiling-none
[250.860164] Starting dynamic subtest: pipe-A-HDMI-A-3
[251.723897] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.863s)
[251.734438] Starting dynamic subtest: pipe-B-HDMI-A-3
[252.490095] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.765s)
[252.500702] Starting dynamic subtest: pipe-C-HDMI-A-3
[253.263253] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.773s)
[253.275563] Starting dynamic subtest: pipe-D-HDMI-A-3
[254.035404] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.770s)
[254.036273] Subtest tiling-none: SUCCESS (3.176s)
[254.273861] [048/132] (772s left) gem_mmap_gtt (basic-small-bo-tiledx)
[254.361073] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[254.434133] [049/132] (772s left) gem_ctx_shared (detached-shared-gtt)
[254.529250] Starting subtest: detached-shared-gtt
[256.678538] Subtest detached-shared-gtt: SUCCESS (2.150s)
[258.409082] [050/132] (768s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[259.928824] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[259.930574] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[260.055573] [051/132] (767s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[260.164574] Starting subtest: invalid-multi-wait-unsubmitted
[260.165493] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[260.280785] [052/132] (767s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[261.799769] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[261.801527] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[262.036914] [053/132] (765s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[263.554333] Starting subtest: bad-aux-stride-y-tiled-ccs
[263.556600] Starting dynamic subtest: pipe-A-HDMI-A-3
[263.565211] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[263.575677] Starting dynamic subtest: pipe-B-HDMI-A-3
[263.584877] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[263.595385] Starting dynamic subtest: pipe-C-HDMI-A-3
[263.604033] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[263.614165] Starting dynamic subtest: pipe-D-HDMI-A-3
[263.624039] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[263.625672] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.006s)
[263.829236] [054/132] (763s left) gem_mmap_gtt (medium-copy-odd)
[263.909153] Subtest medium-copy-odd: SKIP (0.000s)
[263.984301] [055/132] (763s left) sw_sync (sync_random_merge)
[264.034229] Starting subtest: sync_random_merge
[264.104590] Subtest sync_random_merge: SUCCESS (0.071s)
[264.188572] [056/132] (763s left) perf_pmu (interrupts)
[264.260490] Starting subtest: interrupts
[265.412621] Subtest interrupts: SUCCESS (1.152s)
[265.540628] [057/132] (762s left) vgem_basic (unload)
[265.590300] Starting subtest: unload
[294.514439] Subtest unload: SUCCESS (28.923s)
[294.690715] [058/132] (733s left) kms_chamelium_edid (dp-mode-timings)
[296.249457] Subtest dp-mode-timings: SKIP (0.000s)
[296.361454] [059/132] (731s left) syncobj_wait (wait-all-snapshot)
[296.452323] Starting subtest: wait-all-snapshot
[296.534849] Subtest wait-all-snapshot: SUCCESS (0.082s)
[296.693072] [060/132] (731s left) i915_query (engine-info-invalid)
[296.771565] Starting subtest: engine-info-invalid
[296.772795] Subtest engine-info-invalid: SUCCESS (0.000s)
[296.924353] [061/132] (731s left) kms_atomic_interruptible (legacy-cursor)
[298.449926] Starting subtest: legacy-cursor
[298.452050] Starting dynamic subtest: pipe-A-HDMI-A-3
[304.656462] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (6.205s)
[304.657423] Subtest legacy-cursor: SUCCESS (6.206s)
[304.800907] [062/132] (723s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[306.318862] Starting subtest: flip-vs-cursor-toggle
[318.924574] Subtest flip-vs-cursor-toggle: SUCCESS (12.606s)
[319.091741] [063/132] (709s left) perf_pmu (busy-idle-no-semaphores)
[319.163416] Starting subtest: busy-idle-no-semaphores
[319.164389] Starting dynamic subtest: rcs0
[319.850272] Dynamic subtest rcs0: SUCCESS (0.686s)
[319.865801] Starting dynamic subtest: bcs0
[320.508512] Dynamic subtest bcs0: SUCCESS (0.655s)
[320.523841] Starting dynamic subtest: vcs0
[321.165223] Dynamic subtest vcs0: SUCCESS (0.654s)
[321.180989] Starting dynamic subtest: vcs1
[321.821660] Dynamic subtest vcs1: SUCCESS (0.653s)
[321.837053] Starting dynamic subtest: vecs0
[322.478412] Dynamic subtest vecs0: SUCCESS (0.654s)
[322.496380] Starting dynamic subtest: vecs1
[323.133931] Dynamic subtest vecs1: SUCCESS (0.652s)
[323.152224] Starting dynamic subtest: ccs0
[323.789079] Dynamic subtest ccs0: SUCCESS (0.652s)
[323.790947] Subtest busy-idle-no-semaphores: SUCCESS (4.626s)
[324.026466] [064/132] (704s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[325.551781] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[325.553451] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[325.759703] [065/132] (702s left) template (b)
[325.847400] Starting subtest: B
[325.848455] Subtest B: SUCCESS (0.000s)
[325.982560] [066/132] (702s left) kms_frontbuffer_tracking (fbc-1p-rte)
[327.503579] Starting subtest: fbc-1p-rte
[331.213812] Subtest fbc-1p-rte: SUCCESS (3.711s)
[331.513090] [067/132] (697s left) gem_unref_active_buffers
[331.859489] [068/132] (696s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[333.376015] Starting subtest: short-flip-before-cursor-atomic-transitions
[334.403554] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (1.028s)
[334.597910] [069/132] (694s left) i915_pm_freq_api (freq-suspend)
[334.694375] Starting subtest: freq-suspend
[334.695321] Starting dynamic subtest: gt0
[352.620193] Dynamic subtest gt0: SUCCESS (4.022s)
[352.621484] Subtest freq-suspend: SUCCESS (4.023s)
[362.874184] [070/132] (675s left) gen9_exec_parse (unaligned-access)
[362.986710] Subtest unaligned-access: SKIP (0.000s)
[363.068147] [071/132] (675s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip)
[364.568745] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip
[364.570654] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[364.725643] [072/132] (674s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[366.238592] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[368.949485] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (2.751s)
[369.165071] [073/132] (669s left) gen9_exec_parse (batch-invalid-length)
[369.247209] Subtest batch-invalid-length: SKIP (0.000s)
[369.325003] [074/132] (669s left) gem_pread (bench)
[369.404174] Subtest bench: SKIP (0.000s)
[369.507124] [075/132] (669s left) kms_plane (planar-pixel-format-settings)
[371.008141] Starting subtest: planar-pixel-format-settings
[371.137625] Subtest planar-pixel-format-settings: SUCCESS (0.131s)
[371.343649] [076/132] (667s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[372.853351] Starting subtest: 2x-flip-vs-cursor-legacy
[372.856534] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.002s)
[372.947102] [077/132] (666s left) kms_content_protection (lic-type-0-hdcp14)
[374.528016] Starting subtest: lic-type-0-hdcp14
[374.536255] Subtest lic-type-0-hdcp14: SKIP (0.006s)
[374.751305] [078/132] (664s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[376.258352] Starting subtest: cursorA-vs-flipA-toggle
[387.131113] Subtest cursorA-vs-flipA-toggle: SUCCESS (10.904s)
[387.386788] [079/132] (652s left) gem_eio (in-flight-contexts-immediate)
[387.688670] Starting subtest: in-flight-contexts-immediate
[401.847482] Subtest in-flight-contexts-immediate: SUCCESS (14.161s)
[403.381871] [080/132] (636s left) gem_exec_balancer (invalid-balancer)
[403.480625] Starting subtest: invalid-balancer
[405.091902] Subtest invalid-balancer: SUCCESS (1.612s)
[405.516173] [081/132] (634s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[405.593471] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[405.659539] [082/132] (633s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[407.181357] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[407.183190] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[407.329960] [083/132] (632s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[408.875509] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[408.877397] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[409.109127] [084/132] (630s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[410.624453] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[410.625419] Starting dynamic subtest: pipe-A-HDMI-A-3
[410.634330] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[410.646109] Starting dynamic subtest: pipe-B-HDMI-A-3
[410.654973] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[410.666574] Starting dynamic subtest: pipe-C-HDMI-A-3
[410.675192] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[410.686804] Starting dynamic subtest: pipe-D-HDMI-A-3
[410.697511] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[410.699279] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.007s)
[410.909147] [085/132] (628s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[412.440561] Starting subtest: extended-modeset-hang-oldfb-with-reset
[412.442698] Starting dynamic subtest: pipe-A
[423.288454] Dynamic subtest pipe-A: SUCCESS (10.848s)
[423.303670] Starting dynamic subtest: pipe-D
[433.976215] Dynamic subtest pipe-D: SUCCESS (10.686s)
[433.977182] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (21.540s)
[434.242242] [086/132] (605s left) gem_userptr_blits (input-checking)
[434.334352] Starting subtest: input-checking
[434.335260] Subtest input-checking: SUCCESS (0.000s)
[434.517254] [087/132] (605s left) kms_frontbuffer_tracking (fbc-tiling-y)
[436.036533] Starting subtest: fbc-tiling-y
[436.038359] Subtest fbc-tiling-y: SKIP (0.000s)
[436.187943] [088/132] (603s left) gem_exec_reloc (basic-cpu-gtt)
[436.303337] Subtest basic-cpu-gtt: SKIP (0.000s)
[436.386668] [089/132] (603s left) kms_flip (2x-flip-vs-fences-interruptible)
[437.905566] Starting subtest: 2x-flip-vs-fences-interruptible
[437.907426] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[438.016645] [090/132] (602s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[439.553802] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[439.615718] [091/132] (600s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[441.135666] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[441.137599] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[441.283960] [092/132] (599s left) gem_close_race (multigpu-basic-threads)
[441.428015] Starting subtest: multigpu-basic-threads
[441.430458] Subtest multigpu-basic-threads: SKIP (0.000s)
[441.718144] [093/132] (598s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[443.405104] Starting subtest: cursor-rapid-movement-64x21
[443.409740] Starting dynamic subtest: pipe-A-HDMI-A-3
[443.824687] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.415s)
[443.864069] Starting dynamic subtest: pipe-D-HDMI-A-3
[444.141407] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.287s)
[444.142360] Subtest cursor-rapid-movement-64x21: SUCCESS (0.736s)
[444.521126] [094/132] (596s left) gem_pwrite_snooped
[444.686162] [095/132] (595s left) kms_sequence (get-busy)
[446.202455] Starting subtest: get-busy
[446.203466] Starting dynamic subtest: pipe-A-HDMI-A-3
[448.729062] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.527s)
[448.742514] Starting dynamic subtest: pipe-B-HDMI-A-3
[451.124106] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (2.395s)
[451.137324] Starting dynamic subtest: pipe-C-HDMI-A-3
[453.529182] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (2.404s)
[453.542423] Starting dynamic subtest: pipe-D-HDMI-A-3
[455.951418] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.421s)
[455.952576] Subtest get-busy: SUCCESS (9.754s)
[456.131183] [096/132] (584s left) kms_lease (atomic-implicit-crtc)
[457.655068] Starting subtest: atomic-implicit-crtc
[457.657712] Starting dynamic subtest: pipe-A-HDMI-A-3
[457.662716] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.003s)
[457.674762] Starting dynamic subtest: pipe-B-HDMI-A-3
[457.679453] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.011s)
[457.691454] Starting dynamic subtest: pipe-C-HDMI-A-3
[457.696278] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.011s)
[457.708437] Starting dynamic subtest: pipe-D-HDMI-A-3
[457.713774] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.011s)
[457.714800] Subtest atomic-implicit-crtc: SUCCESS (0.044s)
[457.794814] [097/132] (582s left) kms_flip (flip-vs-dpms-on-nop)
[459.320373] Starting subtest: flip-vs-dpms-on-nop
[459.325256] Starting dynamic subtest: A-HDMI-A3
[460.363253] Dynamic subtest A-HDMI-A3: SUCCESS (1.037s)
[460.377450] Starting dynamic subtest: B-HDMI-A3
[461.335968] Dynamic subtest B-HDMI-A3: SUCCESS (0.971s)
[461.350065] Starting dynamic subtest: C-HDMI-A3
[462.307289] Dynamic subtest C-HDMI-A3: SUCCESS (0.969s)
[462.321459] Starting dynamic subtest: D-HDMI-A3
[463.280341] Dynamic subtest D-HDMI-A3: SUCCESS (0.970s)
[463.286256] Subtest flip-vs-dpms-on-nop: SUCCESS (3.961s)
[463.517839] [098/132] (577s left) kms_psr (psr-sprite-blt)
[465.032890] Subtest psr-sprite-blt: SKIP (0.000s)
[465.085563] [099/132] (575s left) api_intel_allocator (default-alignment)
[465.166990] Starting subtest: default-alignment
[465.173982] Subtest default-alignment: SUCCESS (0.008s)
[465.353386] [100/132] (575s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[466.873449] Starting subtest: compare-crc-sanitycheck-nv12
[466.874435] Starting dynamic subtest: pipe-A-HDMI-A-3
[467.582828] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.707s)
[467.599979] Starting dynamic subtest: pipe-B-HDMI-A-3
[468.189619] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.604s)
[468.203529] Starting dynamic subtest: pipe-C-HDMI-A-3
[468.757382] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.566s)
[468.770939] Starting dynamic subtest: pipe-D-HDMI-A-3
[469.324022] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.565s)
[469.325004] Subtest compare-crc-sanitycheck-nv12: SUCCESS (2.452s)
[469.503975] [101/132] (571s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[471.021398] Starting subtest: cursor-vs-flip-legacy
[501.951169] Subtest cursor-vs-flip-legacy: SUCCESS (30.927s)
[502.192321] [102/132] (538s left) kms_big_fb (linear-16bpp-rotate-90)
[503.725320] Starting subtest: linear-16bpp-rotate-90
[503.780665] Subtest linear-16bpp-rotate-90: SKIP (0.055s)
[503.975238] [103/132] (537s left) kms_atomic (plane-cursor-legacy)
[505.491554] Starting subtest: plane-cursor-legacy
[505.492481] Starting dynamic subtest: pipe-A-HDMI-A-3
[506.022186] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.529s)
[506.023148] Subtest plane-cursor-legacy: SUCCESS (0.531s)
[506.219356] [104/132] (535s left) gem_bad_reloc (negative-reloc)
[506.311994] Subtest negative-reloc: SKIP (0.000s)
[506.391653] [105/132] (534s left) syncobj_eventfd (binary-wait-signaled)
[506.477614] Starting subtest: binary-wait-signaled
[506.478549] Subtest binary-wait-signaled: SUCCESS (0.000s)
[506.643128] [106/132] (534s left) api_intel_bb (full-batch)
[506.723979] Starting subtest: full-batch
[506.753195] Subtest full-batch: SUCCESS (0.030s)
[506.887661] [107/132] (534s left) gem_mmap_offset (bad-flags)
[506.973656] Starting subtest: bad-flags
[506.974647] Subtest bad-flags: SUCCESS (0.000s)
[507.141658] [108/132] (534s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[508.663562] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[508.665416] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[508.813128] [109/132] (532s left) kms_chamelium_audio (hdmi-audio-edid)
[510.404612] Subtest hdmi-audio-edid: SKIP (0.000s)
[510.527722] [110/132] (531s left) gem_exec_whisper (basic-contexts-priority)
[510.631983] Starting subtest: basic-contexts-priority
[533.073190] Subtest basic-contexts-priority: SUCCESS (22.443s)
[533.331153] [111/132] (508s left) gem_exec_flush (basic-wb-rw-default)
[533.418432] Subtest basic-wb-rw-default: SKIP (0.000s)
[533.504128] [112/132] (508s left) kms_flip (basic-plain-flip)
[535.020662] Starting subtest: basic-plain-flip
[535.026675] Starting dynamic subtest: A-HDMI-A3
[535.792648] Dynamic subtest A-HDMI-A3: SUCCESS (0.766s)
[535.808733] Starting dynamic subtest: B-HDMI-A3
[536.480267] Dynamic subtest B-HDMI-A3: SUCCESS (0.686s)
[536.497035] Starting dynamic subtest: C-HDMI-A3
[537.169287] Dynamic subtest C-HDMI-A3: SUCCESS (0.688s)
[537.183399] Starting dynamic subtest: D-HDMI-A3
[537.857293] Dynamic subtest D-HDMI-A3: SUCCESS (0.687s)
[537.858284] Subtest basic-plain-flip: SUCCESS (2.838s)
[538.106670] [113/132] (503s left) syncobj_timeline (reset-signaled)
[538.185602] Starting subtest: reset-signaled
[538.186542] Subtest reset-signaled: SUCCESS (0.000s)
[538.385342] [114/132] (503s left) i915_pm_rps (reset)
[538.472423] Starting subtest: reset
[543.273333] Subtest reset: SUCCESS (4.802s)
[543.487137] [115/132] (498s left) gem_wait (await)
[543.579513] Starting subtest: await
[543.580481] Starting dynamic subtest: all-engines
[544.702742] Dynamic subtest all-engines: SUCCESS (1.123s)
[544.721987] Starting dynamic subtest: rcs0
[545.768456] Dynamic subtest rcs0: SUCCESS (1.063s)
[545.784972] Starting dynamic subtest: bcs0
[546.829561] Dynamic subtest bcs0: SUCCESS (1.060s)
[546.846727] Starting dynamic subtest: vcs0
[547.890614] Dynamic subtest vcs0: SUCCESS (1.059s)
[547.907416] Starting dynamic subtest: vcs1
[548.950937] Dynamic subtest vcs1: SUCCESS (1.055s)
[548.967669] Starting dynamic subtest: vecs0
[550.012059] Dynamic subtest vecs0: SUCCESS (1.056s)
[550.033391] Starting dynamic subtest: vecs1
[551.075988] Dynamic subtest vecs1: SUCCESS (1.059s)
[551.097062] Starting dynamic subtest: ccs0
[552.138992] Dynamic subtest ccs0: SUCCESS (1.058s)
[552.145554] Subtest await: SUCCESS (8.563s)
[552.434417] [116/132] (489s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[552.514845] Starting subtest: etime-single-wait-all-for-submit-submitted
[552.623160] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.108s)
[552.748024] [117/132] (489s left) gem_exec_schedule (submit-golden-slice)
[552.843353] Starting subtest: submit-golden-slice
[552.844394] Starting dynamic subtest: rcs0
[552.923194] Dynamic subtest rcs0: SUCCESS (0.079s)
[552.936584] Starting dynamic subtest: bcs0
[552.975787] Dynamic subtest bcs0: SUCCESS (0.051s)
[552.989350] Starting dynamic subtest: vcs0
[553.026692] Dynamic subtest vcs0: SUCCESS (0.050s)
[553.040357] Starting dynamic subtest: vcs1
[553.083250] Dynamic subtest vcs1: SUCCESS (0.055s)
[553.096655] Starting dynamic subtest: vecs0
[553.134804] Dynamic subtest vecs0: SUCCESS (0.050s)
[553.148122] Starting dynamic subtest: vecs1
[553.188508] Dynamic subtest vecs1: SUCCESS (0.053s)
[553.201960] Starting dynamic subtest: ccs0
[553.239798] Dynamic subtest ccs0: SUCCESS (0.050s)
[553.240719] Subtest submit-golden-slice: SUCCESS (0.397s)
[553.701575] [118/132] (488s left) gem_userptr_blits (readonly-unsync)
[553.788236] Subtest readonly-unsync: SKIP (0.000s)
[553.985681] [119/132] (488s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[554.064703] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[554.065681] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[554.188285] [120/132] (488s left) gem_fence_thrash (bo-copy)
[554.238357] Starting subtest: bo-copy
[554.269476] Subtest bo-copy: SKIP (0.031s)
[554.342298] [121/132] (488s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[555.862441] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[555.864288] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[556.012205] [122/132] (486s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[557.555326] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[557.557203] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[557.684904] [123/132] (485s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[559.221442] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[559.222409] Starting dynamic subtest: pipe-A
[559.328323] Dynamic subtest pipe-A: SUCCESS (0.107s)
[559.350255] Starting dynamic subtest: pipe-B
[559.528779] Dynamic subtest pipe-B: SUCCESS (0.199s)
[559.556177] Starting dynamic subtest: pipe-C
[559.687873] Dynamic subtest pipe-C: SUCCESS (0.157s)
[559.702183] Starting dynamic subtest: pipe-D
[559.812761] Dynamic subtest pipe-D: SUCCESS (0.124s)
[559.814071] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SUCCESS (0.593s)
[560.082247] [124/132] (482s left) prime_mmap (test_correct_cpu_write)
[560.162201] Starting subtest: test_correct_cpu_write
[560.163166] Starting dynamic subtest: test_correct_cpu_write-smem
[560.164192] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[560.176202] Starting dynamic subtest: test_correct_cpu_write-lmem0
[560.177183] Dynamic subtest test_correct_cpu_write-lmem0: SUCCESS (0.000s)
[560.178148] Subtest test_correct_cpu_write: SUCCESS (0.003s)
[560.331726] [125/132] (482s left) gem_mmap_gtt (cpuset-big-copy-odd)
[560.410566] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[560.485331] [126/132] (482s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[562.001431] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[562.002367] Starting dynamic subtest: pipe-A-valid-mode
[562.964913] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.962s)
[562.966568] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (0.964s)
[563.155955] [127/132] (479s left) gem_ctx_persistence (hostile)
[563.240898] Starting subtest: hostile
[572.754590] Subtest hostile: SUCCESS (9.511s)
[572.888650] [128/132] (470s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[572.977663] Starting subtest: y-tiled-to-vebox-y-tiled
[572.979801] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[573.262598] [129/132] (469s left) kms_vblank (wait-idle)
[574.782192] Starting subtest: wait-idle
[574.783165] Starting dynamic subtest: pipe-A-HDMI-A-3
[577.043361] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.262s)
[577.058642] Starting dynamic subtest: pipe-D-HDMI-A-3
[579.233255] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.187s)
[579.234204] Subtest wait-idle: SUCCESS (4.454s)
[579.401808] [130/132] (463s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[580.043925] Starting subtest: syncobj-timeline-multiple-ext-nodes
[580.046999] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.008s)
[580.375614] [131/132] (462s left) kms_cursor_legacy (forked-bo)
[581.891594] Starting subtest: forked-bo
[581.892525] Starting dynamic subtest: pipe-A
[587.303938] Dynamic subtest pipe-A: SUCCESS (5.411s)
[587.329491] Starting dynamic subtest: pipe-B
[592.732961] Dynamic subtest pipe-B: SUCCESS (5.422s)
[592.755794] Starting dynamic subtest: pipe-C
[598.157890] Dynamic subtest pipe-C: SUCCESS (5.422s)
[598.180580] Starting dynamic subtest: pipe-D
[603.586436] Dynamic subtest pipe-D: SUCCESS (5.424s)
[603.613263] Starting dynamic subtest: all-pipes
[609.033660] Dynamic subtest all-pipes: SUCCESS (5.444s)
[609.034552] Subtest forked-bo: SUCCESS (27.138s)
[609.148361] [132/132] (434s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[609.232690] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[609.233679] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[609.375643] Closing watchdogs
results: parsing output: 0/ for test: kms_feature_discovery
results: parsing output: 1/ for test: gem_exec_whisper
results: parsing output: 2/ for test: gem_shrink
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: kms_pm_dc
results: parsing output: 5/ for test: gem_exec_capture
results: parsing output: 6/ for test: perf_pmu
results: parsing output: 7/ for test: sysfs_heartbeat_interval
results: parsing output: 8/ for test: kms_flip
results: parsing output: 9/ for test: kms_plane
results: parsing output: 10/ for test: gem_spin_batch
results: parsing output: 11/ for test: kms_psr
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: kms_invalid_mode
results: parsing output: 15/ for test: kms_psr2_sf
results: parsing output: 16/ for test: gem_render_copy
results: parsing output: 17/ for test: gem_exec_schedule
results: parsing output: 18/ for test: gem_exec_fence
results: parsing output: 19/ for test: kms_color
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: kms_draw_crc
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: core_setmaster
results: parsing output: 26/ for test: kms_addfb_basic
results: parsing output: 27/ for test: kms_psr
results: parsing output: 28/ for test: prime_busy
results: parsing output: 29/ for test: i915_query
results: parsing output: 30/ for test: kms_chamelium_hpd
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_cursor_edge_walk
results: parsing output: 33/ for test: syncobj_basic
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: kms_addfb_basic
results: parsing output: 36/ for test: gem_ctx_param
results: parsing output: 37/ for test: kms_cursor_crc
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: prime_mmap
results: parsing output: 41/ for test: prime_mmap
results: parsing output: 42/ for test: gem_exec_gttfill
results: parsing output: 43/ for test: kms_psr
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: kms_plane_multiple
results: parsing output: 47/ for test: gem_mmap_gtt
results: parsing output: 48/ for test: gem_ctx_shared
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: syncobj_wait
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_ccs
results: parsing output: 53/ for test: gem_mmap_gtt
results: parsing output: 54/ for test: sw_sync
results: parsing output: 55/ for test: perf_pmu
results: parsing output: 56/ for test: vgem_basic
results: parsing output: 57/ for test: kms_chamelium_edid
results: parsing output: 58/ for test: syncobj_wait
results: parsing output: 59/ for test: i915_query
results: parsing output: 60/ for test: kms_atomic_interruptible
results: parsing output: 61/ for test: kms_cursor_legacy
results: parsing output: 62/ for test: perf_pmu
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: template
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_unref_active_buffers
results: parsing output: 67/ for test: kms_cursor_legacy
results: parsing output: 68/ for test: i915_pm_freq_api
results: parsing output: 69/ for test: gen9_exec_parse
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gen9_exec_parse
results: parsing output: 73/ for test: gem_pread
results: parsing output: 74/ for test: kms_plane
results: parsing output: 75/ for test: kms_cursor_legacy
results: parsing output: 76/ for test: kms_content_protection
results: parsing output: 77/ for test: kms_cursor_legacy
results: parsing output: 78/ for test: gem_eio
results: parsing output: 79/ for test: gem_exec_balancer
results: parsing output: 80/ for test: kms_pipe_b_c_ivb
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_ccs
results: parsing output: 84/ for test: kms_busy
results: parsing output: 85/ for test: gem_userptr_blits
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_exec_reloc
results: parsing output: 88/ for test: kms_flip
results: parsing output: 89/ for test: kms_psr2_sf
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_close_race
results: parsing output: 92/ for test: kms_cursor_crc
results: parsing output: 93/ for test: gem_pwrite_snooped
results: parsing output: 94/ for test: kms_sequence
results: parsing output: 95/ for test: kms_lease
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: api_intel_allocator
results: parsing output: 99/ for test: kms_pipe_crc_basic
results: parsing output: 100/ for test: kms_cursor_legacy
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: kms_atomic
results: parsing output: 103/ for test: gem_bad_reloc
results: parsing output: 104/ for test: syncobj_eventfd
results: parsing output: 105/ for test: api_intel_bb
results: parsing output: 106/ for test: gem_mmap_offset
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_chamelium_audio
results: parsing output: 109/ for test: gem_exec_whisper
results: parsing output: 110/ for test: gem_exec_flush
results: parsing output: 111/ for test: kms_flip
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: i915_pm_rps
results: parsing output: 114/ for test: gem_wait
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: gem_exec_schedule
results: parsing output: 117/ for test: gem_userptr_blits
results: parsing output: 118/ for test: syncobj_wait
results: parsing output: 119/ for test: gem_fence_thrash
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_plane_scaling
results: parsing output: 123/ for test: prime_mmap
results: parsing output: 124/ for test: gem_mmap_gtt
results: parsing output: 125/ for test: kms_flip_scaled_crc
results: parsing output: 126/ for test: gem_ctx_persistence
results: parsing output: 127/ for test: gem_render_copy
results: parsing output: 128/ for test: kms_vblank
results: parsing output: 129/ for test: gem_exec_fence
results: parsing output: 130/ for test: kms_cursor_legacy
results: parsing output: 131/ for test: syncobj_timeline
Done.