[89.627119] Initializing watchdogs
[89.627379]   /dev/watchdog0
[89.667164] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3184 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 605]
[89.681683] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[89.687530] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[89.692635] [001/155] (960s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[90.252614] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[90.518500] [002/155] (959s left) i915_hangman (gt-engine-hang)
[90.647930] Starting subtest: gt-engine-hang
[90.650569] Starting dynamic subtest: rcs0
[91.266818] Dynamic subtest rcs0: SUCCESS (0.615s)
[91.285418] Starting dynamic subtest: bcs0
[91.864945] Dynamic subtest bcs0: SUCCESS (0.599s)
[91.885414] Starting dynamic subtest: vcs0
[92.466095] Dynamic subtest vcs0: SUCCESS (0.598s)
[92.483975] Starting dynamic subtest: vecs0
[93.064597] Dynamic subtest vecs0: SUCCESS (0.599s)
[93.066966] Subtest gt-engine-hang: SUCCESS (2.419s)
[93.225377] [003/155] (957s left) gem_exec_balancer (full-pulse)
[93.347197] Starting subtest: full-pulse
[97.886299] Subtest full-pulse: SUCCESS (4.539s)
[98.145377] [004/155] (952s left) kms_plane (pixel-format-y-tiled-modifier)
[98.316908] Starting subtest: pixel-format-y-tiled-modifier
[98.543862] Starting dynamic subtest: pipe-A-plane-0
[99.079487] Dynamic subtest pipe-A-plane-0: SUCCESS (0.535s)
[99.098064] Starting dynamic subtest: pipe-A-plane-1
[99.544686] Dynamic subtest pipe-A-plane-1: SUCCESS (0.464s)
[99.563513] Starting dynamic subtest: pipe-A-plane-2
[100.011468] Dynamic subtest pipe-A-plane-2: SUCCESS (0.466s)
[100.029640] Starting dynamic subtest: pipe-A-plane-3
[100.478845] Dynamic subtest pipe-A-plane-3: SUCCESS (0.466s)
[100.496838] Starting dynamic subtest: pipe-A-plane-4
[100.498795] Dynamic subtest pipe-A-plane-4: SKIP (0.000s)
[100.852050] Starting dynamic subtest: pipe-B-plane-0
[101.270749] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[101.288989] Starting dynamic subtest: pipe-B-plane-1
[101.737344] Dynamic subtest pipe-B-plane-1: SUCCESS (0.465s)
[101.756201] Starting dynamic subtest: pipe-B-plane-2
[102.202730] Dynamic subtest pipe-B-plane-2: SUCCESS (0.465s)
[102.220890] Starting dynamic subtest: pipe-B-plane-3
[102.635657] Dynamic subtest pipe-B-plane-3: SUCCESS (0.432s)
[102.656528] Starting dynamic subtest: pipe-B-plane-4
[102.662628] Dynamic subtest pipe-B-plane-4: SKIP (0.000s)
[102.868042] Subtest pixel-format-y-tiled-modifier: SUCCESS (4.550s)
[103.200369] [005/155] (947s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[103.388911] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[103.391408] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[103.519535] [006/155] (947s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[103.689251] Starting subtest: basic-busy-flip-before-cursor-varying-size
[103.691115] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[103.819194] [007/155] (946s left) kms_chamelium_color (ctm-green-to-red)
[103.990301] Subtest ctm-green-to-red: SKIP (0.000s)
[104.078761] [008/155] (946s left) kms_vblank (wait-idle-hang)
[104.249200] Starting subtest: wait-idle-hang
[104.250300] Starting dynamic subtest: pipe-A-HDMI-A-1
[111.928538] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (7.674s)
[111.948683] Starting dynamic subtest: pipe-A-HDMI-A-2
[118.892431] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (6.964s)
[118.916677] Starting dynamic subtest: pipe-C-HDMI-A-1
[125.867350] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (6.967s)
[125.888523] Starting dynamic subtest: pipe-C-HDMI-A-2
[132.901069] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (7.028s)
[132.902191] Subtest wait-idle-hang: SUCCESS (28.652s)
[133.222540] [009/155] (917s left) kms_frontbuffer_tracking (hdr-rgb565-draw-mmap-gtt)
[133.407907] Starting subtest: hdr-rgb565-draw-mmap-gtt
[134.103719] Subtest hdr-rgb565-draw-mmap-gtt: SUCCESS (0.695s)
[134.353473] [010/155] (916s left) gem_exec_balancer (parallel-keep-in-fence)
[134.594078] Subtest parallel-keep-in-fence: SKIP (0.000s)
[134.718498] [011/155] (916s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[134.828763] Starting subtest: basic-gtt-cpu-noreloc
[134.837896] Subtest basic-gtt-cpu-noreloc: SUCCESS (0.008s)
[135.036369] [012/155] (916s left) dumb_buffer (create-clear)
[135.131435] Starting subtest: create-clear
[177.167111] Subtest create-clear: SUCCESS (42.035s)
[177.403161] [013/155] (873s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[177.584648] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[177.586557] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[177.720119] [014/155] (873s left) gem_exec_store (pages)
[177.838217] Starting subtest: pages
[177.839241] Starting dynamic subtest: rcs0
[177.928775] Dynamic subtest rcs0: SUCCESS (0.089s)
[177.948038] Starting dynamic subtest: bcs0
[178.026209] Dynamic subtest bcs0: SUCCESS (0.095s)
[178.046238] Starting dynamic subtest: vcs0
[178.117360] Dynamic subtest vcs0: SUCCESS (0.091s)
[178.136572] Starting dynamic subtest: vecs0
[178.199451] Dynamic subtest vecs0: SUCCESS (0.081s)
[178.200598] Subtest pages: SUCCESS (0.361s)
[178.437994] [015/155] (872s left) gem_pwrite (basic-random)
[178.534728] Starting subtest: basic-random
[184.387531] Subtest basic-random: SUCCESS (5.850s)
[184.551554] [016/155] (866s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-move)
[184.846970] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-move
[184.849357] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[185.002751] [017/155] (866s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[185.183495] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[185.185358] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[185.318577] [018/155] (866s left) kms_addfb_basic (unused-modifier)
[185.415169] Starting subtest: unused-modifier
[185.416266] Subtest unused-modifier: SUCCESS (0.000s)
[185.651397] [019/155] (865s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[185.832129] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[186.575479] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SUCCESS (0.744s)
[186.857410] [020/155] (864s left) kms_prime (basic-crc-hybrid)
[187.055379] Subtest basic-crc-hybrid: SKIP (0.000s)
[187.276219] [FACT kms_prime (basic-crc-hybrid)] new: kernel.kmod_is_loaded.vgem: true
[187.280458] [021/155] (864s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[187.460876] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[189.859606] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SUCCESS (2.398s)
[190.088717] [022/155] (861s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[190.273829] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[192.742288] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (2.469s)
[193.029989] [023/155] (858s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[193.216147] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[194.892962] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SUCCESS (1.676s)
[195.146630] [024/155] (856s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[195.329741] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[197.710594] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SUCCESS (2.379s)
[197.995782] [025/155] (854s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[198.180371] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[198.184313] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[200.493244] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (2.306s)
[200.513736] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[202.375752] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (1.879s)
[202.397176] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[204.201030] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (1.819s)
[204.202101] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (6.018s)
[204.525574] [026/155] (847s left) gem_pxp (protected-raw-src-copy-not-readible)
[207.173817] Starting subtest: protected-raw-src-copy-not-readible
[207.176898] Subtest protected-raw-src-copy-not-readible: SKIP (0.000s)
[207.304875] [027/155] (845s left) gem_exec_reloc (basic-wc-gtt-active)
[207.413458] Starting subtest: basic-wc-gtt-active
[207.555944] Subtest basic-wc-gtt-active: SUCCESS (0.142s)
[207.771857] [028/155] (844s left) i915_suspend (sysfs-reader)
[207.869862] Starting subtest: sysfs-reader
[226.459029] Subtest sysfs-reader: SUCCESS (4.040s)
[232.560560] [029/155] (826s left) syncobj_timeline (wait-all-delayed-signal)
[232.671254] Starting subtest: wait-all-delayed-signal
[232.777257] Subtest wait-all-delayed-signal: SUCCESS (0.105s)
[232.938241] [030/155] (825s left) gem_exec_fence (syncobj-timeline-export)
[233.603994] Starting subtest: syncobj-timeline-export
[233.610370] Subtest syncobj-timeline-export: SUCCESS (0.008s)
[233.895692] [031/155] (824s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[234.003846] Starting subtest: basic-gtt-wc-noreloc
[234.015654] Subtest basic-gtt-wc-noreloc: SUCCESS (0.011s)
[234.227593] [032/155] (824s left) gem_blits (basic)
[234.334996] Starting subtest: basic
[244.947285] Subtest basic: SUCCESS (10.610s)
[245.108074] [033/155] (813s left) gem_ctx_create (basic-files)
[245.234405] Starting subtest: basic-files
[247.257627] Subtest basic-files: SUCCESS (2.025s)
[247.528776] [034/155] (811s left) kms_mmap_write_crc (main)
[247.710710] Starting subtest: main
[247.713509] Starting dynamic subtest: pipe-A-HDMI-A-1
[251.150343] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.429s)
[251.154725] Subtest main: SUCCESS (3.433s)
[251.514846] [035/155] (807s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[251.687226] Starting subtest: bad-pixel-format-y-tiled-ccs
[251.688316] Starting dynamic subtest: pipe-A-HDMI-A-1
[251.696646] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[251.721879] Starting dynamic subtest: pipe-A-HDMI-A-2
[251.730803] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.001s)
[251.755699] Starting dynamic subtest: pipe-B-HDMI-A-1
[251.764138] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[251.789926] Starting dynamic subtest: pipe-B-HDMI-A-2
[251.798286] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.001s)
[251.822756] Starting dynamic subtest: pipe-C-HDMI-A-1
[251.832209] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[251.856350] Starting dynamic subtest: pipe-C-HDMI-A-2
[251.864832] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[251.865837] Subtest bad-pixel-format-y-tiled-ccs: SUCCESS (0.025s)
[252.657463] [036/155] (806s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-pwrite)
[252.841889] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-pwrite
[253.952155] Subtest hdr-2p-scndscrn-cur-indfb-draw-pwrite: SUCCESS (1.110s)
[254.159905] [037/155] (805s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[254.275071] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[254.276237] Starting dynamic subtest: smem
[254.516955] Dynamic subtest smem: SUCCESS (0.243s)
[254.518430] Subtest y-tiled-ccs-to-y-tiled-ccs: SUCCESS (0.245s)
[254.761608] [038/155] (804s left) kms_async_flips (invalid-async-flip)
[254.931852] Starting subtest: invalid-async-flip
[255.477669] Starting dynamic subtest: pipe-A-HDMI-A-1
[255.829426] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.353s)
[256.114589] Starting dynamic subtest: pipe-A-HDMI-A-2
[256.472704] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.377s)
[256.768377] Starting dynamic subtest: pipe-B-HDMI-A-1
[257.053225] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.308s)
[257.331264] Starting dynamic subtest: pipe-B-HDMI-A-2
[257.618333] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.310s)
[257.900703] Starting dynamic subtest: pipe-C-HDMI-A-1
[258.181824] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.306s)
[258.465784] Starting dynamic subtest: pipe-C-HDMI-A-2
[258.749347] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.305s)
[258.750626] Subtest invalid-async-flip: SUCCESS (3.816s)
[259.310028] [039/155] (800s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[259.497085] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[262.228548] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (2.731s)
[262.442470] [040/155] (797s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[262.627224] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[262.632822] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[273.400019] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (10.768s)
[273.428529] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[284.098910] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (10.692s)
[284.129693] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[294.781976] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.678s)
[294.785132] Subtest 2x-flip-vs-expired-vblank-interruptible: SUCCESS (32.157s)
[295.424097] [041/155] (764s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[295.612924] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[295.615000] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[295.801745] [042/155] (763s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[295.990946] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[295.992991] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[296.157905] [043/155] (763s left) gen3_render_tiledx_blits
[296.367539] [044/155] (763s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[296.554226] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[297.300888] Subtest hdr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SUCCESS (0.745s)
[297.583182] [045/155] (762s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[297.767862] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[300.300625] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SUCCESS (2.533s)
[300.549770] [046/155] (759s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-indfb-msflip-blt)
[300.738921] Starting subtest: psrhdr-2p-primscrn-indfb-msflip-blt
[300.740950] Subtest psrhdr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[300.927097] [047/155] (759s left) perf_pmu (busy-idle-check-all)
[301.034429] Starting subtest: busy-idle-check-all
[301.037255] Starting dynamic subtest: rcs0
[301.667623] Dynamic subtest rcs0: SUCCESS (0.631s)
[301.696196] Starting dynamic subtest: bcs0
[302.306102] Dynamic subtest bcs0: SUCCESS (0.635s)
[302.335215] Starting dynamic subtest: vcs0
[302.944361] Dynamic subtest vcs0: SUCCESS (0.635s)
[302.973180] Starting dynamic subtest: vecs0
[303.583302] Dynamic subtest vecs0: SUCCESS (0.636s)
[303.587714] Subtest busy-idle-check-all: SUCCESS (2.551s)
[303.727559] [048/155] (756s left) kms_async_flips (alternate-sync-async-flip-atomic)
[303.898979] Starting subtest: alternate-sync-async-flip-atomic
[304.445165] Starting dynamic subtest: pipe-A-HDMI-A-1
[306.663873] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.218s)
[307.003531] Starting dynamic subtest: pipe-A-HDMI-A-2
[309.244475] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.263s)
[309.580603] Starting dynamic subtest: pipe-B-HDMI-A-1
[311.791266] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.234s)
[312.113331] Starting dynamic subtest: pipe-B-HDMI-A-2
[314.327907] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.241s)
[314.646219] Starting dynamic subtest: pipe-C-HDMI-A-1
[316.885822] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.263s)
[317.208748] Starting dynamic subtest: pipe-C-HDMI-A-2
[319.425964] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.241s)
[319.431787] Subtest alternate-sync-async-flip-atomic: SUCCESS (15.531s)
[320.028393] [049/155] (740s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[320.140396] Starting subtest: invalid-bsd2-flag-on-vebox
[320.141733] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.001s)
[320.308198] [050/155] (740s left) kms_getfb (getfb-reject-nv12)
[320.479162] Starting subtest: getfb-reject-nv12
[320.481095] Subtest getfb-reject-nv12: SUCCESS (0.004s)
[320.643867] [051/155] (740s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[320.829606] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[320.831519] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[320.994644] [052/155] (739s left) gem_ctx_persistence (heartbeat-hostile)
[321.106932] Starting subtest: heartbeat-hostile
[322.296110] Subtest heartbeat-hostile: SUCCESS (1.189s)
[322.444570] [053/155] (738s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-pwrite)
[322.629885] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-pwrite
[323.413157] Subtest hdr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (0.783s)
[323.696846] [054/155] (737s left) gem_linear_blits (interruptible)
[324.103233] Starting subtest: interruptible
[336.615472] Subtest interruptible: SUCCESS (12.511s)
[336.768357] [055/155] (724s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[337.021077] Starting subtest: primary-y-tiled-reflect-x-0
[337.022976] Subtest primary-y-tiled-reflect-x-0: SKIP (0.002s)
[337.163853] [056/155] (723s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[337.351701] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[338.432945] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (1.081s)
[338.652540] [057/155] (722s left) gem_workarounds (suspend-resume-context)
[338.793891] Starting subtest: suspend-resume-context