[59.702257] Initializing watchdogs
[59.702303]   /dev/watchdog0
[59.715872] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[59.720546] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.722760] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.725989] [001/133] (960s left) kms_chamelium_color (ctm-blue-to-red)
[59.842813] Subtest ctm-blue-to-red: SKIP (0.000s)
[59.882105] [002/133] (960s left) core_auth (getclient-master-drop)
[59.916879] Starting subtest: getclient-master-drop
[59.941010] Subtest getclient-master-drop: SUCCESS (0.024s)
[60.035849] [003/133] (960s left) gem_userptr_blits (huge-split)
[60.107812] Starting subtest: huge-split
[60.111880] Subtest huge-split: SUCCESS (0.006s)
[60.239658] [004/133] (960s left) kms_pm_lpsp (kms-lpsp)
[61.330963] Starting subtest: kms-lpsp
[61.333302] Starting dynamic subtest: pipe-A-eDP-1
[61.516181] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.189s)
[61.810028] Subtest kms-lpsp: SUCCESS (0.480s)
[62.609476] [005/133] (957s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[62.670362] Starting subtest: y-tiled-to-vebox-x-tiled
[62.674868] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[62.850669] [006/133] (957s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[62.953723] Starting subtest: 4-tiled-8bpp-rotate-90
[62.976475] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.022s)
[63.100613] [007/133] (957s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[63.189815] Starting subtest: disable-crc-after-crtc
[63.191748] Starting dynamic subtest: pipe-A-eDP-1
[64.858136] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.668s)
[64.866602] Starting dynamic subtest: pipe-B-eDP-1
[67.109576] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.250s)
[67.117746] Starting dynamic subtest: pipe-C-eDP-1
[69.356973] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.247s)
[69.365816] Starting dynamic subtest: pipe-D-eDP-1
[71.618552] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.261s)
[71.620897] Subtest disable-crc-after-crtc: SUCCESS (8.430s)
[72.445897] [008/133] (948s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[72.504893] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[72.507186] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[72.599846] [009/133] (947s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[72.695843] Starting subtest: plane-upscale-20x20-with-pixel-format
[72.698321] Starting dynamic subtest: pipe-A
[73.754195] Dynamic subtest pipe-A: SUCCESS (1.061s)
[73.762455] Starting dynamic subtest: pipe-B
[75.853751] Dynamic subtest pipe-B: SUCCESS (2.099s)
[75.860383] Starting dynamic subtest: pipe-C
[77.056074] Dynamic subtest pipe-C: SUCCESS (1.201s)
[77.064684] Starting dynamic subtest: pipe-D
[78.282971] Dynamic subtest pipe-D: SUCCESS (1.226s)
[78.285326] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.590s)
[79.477189] [010/133] (941s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[79.573811] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[79.578151] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[79.660921] [011/133] (940s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted)
[79.723726] Starting subtest: etime-single-wait-all-available-unsubmitted
[79.827469] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.102s)
[79.898459] [012/133] (940s left) gem_exec_balancer (nop)
[79.953641] Starting subtest: nop
[126.644496] Subtest nop: SUCCESS (46.688s)
[126.950070] [013/133] (893s left) dumb_buffer (create-clear)
[127.001522] Starting subtest: create-clear
[161.580191] Subtest create-clear: SUCCESS (34.574s)
[161.686783] [014/133] (859s left) kms_color (gamma)
[161.818897] Starting subtest: gamma
[161.820824] Starting dynamic subtest: pipe-A-eDP-1
[162.519526] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.696s)
[162.529051] Starting dynamic subtest: pipe-B-eDP-1
[164.003367] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.487s)
[164.011173] Starting dynamic subtest: pipe-C-eDP-1
[165.361440] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.359s)
[165.369680] Starting dynamic subtest: pipe-D-eDP-1
[166.692774] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.331s)
[166.695220] Subtest gamma: SUCCESS (4.876s)
[167.491355] [015/133] (853s left) gem_tiled_pread_pwrite
[167.602936] [016/133] (853s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[167.691928] Starting subtest: fbc-psr2-sprite-mmap-cpu
[167.694299] Starting dynamic subtest: eDP-1
[167.698593] Dynamic subtest eDP-1: SKIP (0.000s)
[167.702798] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[167.775485] [017/133] (853s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[167.836665] Starting subtest: multi-wait-all-for-submit-signaled
[167.838926] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[167.936941] [018/133] (852s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[168.045684] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[168.049849] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[168.145612] [019/133] (852s left) gem_workarounds (reset-context)
[168.216364] Starting subtest: reset-context
[168.393639] Subtest reset-context: SUCCESS (0.175s)
[168.541553] [020/133] (852s left) syncobj_wait (invalid-single-wait-unsubmitted)
[168.599059] Starting subtest: invalid-single-wait-unsubmitted
[168.600895] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[168.690139] [021/133] (852s left) kms_rmfb (close-fd)
[168.790880] Starting subtest: close-fd
[168.792970] Starting dynamic subtest: pipe-A-eDP-1
[168.900454] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.108s)
[168.909464] Starting dynamic subtest: pipe-B-eDP-1
[170.055959] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.154s)
[170.065714] Starting dynamic subtest: pipe-C-eDP-1
[171.187217] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.127s)
[171.195731] Starting dynamic subtest: pipe-D-eDP-1
[172.312903] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.125s)
[172.314884] Subtest close-fd: SUCCESS (3.519s)
[173.459415] [022/133] (847s left) kms_chamelium_hpd (hdmi-hpd)
[173.840319] Subtest hdmi-hpd: SKIP (0.000s)
[174.659555] [023/133] (846s left) gem_userptr_blits (stress-mm)
[174.734085] Starting subtest: stress-mm
[180.102074] Subtest stress-mm: SUCCESS (5.369s)
[180.232199] [024/133] (840s left) gem_exec_fence (submit)
[180.420601] Starting subtest: submit
[180.425063] Subtest submit: SKIP (0.000s)
[181.989159] [FACT gem_exec_fence (submit)] new: kernel.kmod_is_loaded.vgem: true
[181.995282] [025/133] (839s left) kms_psr (pr-primary-page-flip)
[182.085909] Starting subtest: pr-primary-page-flip
[182.089932] Subtest pr-primary-page-flip: SKIP (0.000s)
[182.156461] [026/133] (839s left) gem_exec_await (wide-contexts)
[182.332872] Starting subtest: wide-contexts
[205.820043] Subtest wide-contexts: SUCCESS (23.486s)
[206.011438] [027/133] (815s left) kms_cursor_crc (cursor-random-512x170)
[206.379891] Starting subtest: cursor-random-512x170
[206.384559] Subtest cursor-random-512x170: SKIP (0.001s)
[206.541724] [028/133] (814s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[206.640643] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[213.574967] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.937s)
[213.683442] [029/133] (807s left) gem_create (create-invalid-size)
[213.747767] Starting subtest: create-invalid-size
[213.749927] Subtest create-invalid-size: SUCCESS (0.000s)
[213.944343] [030/133] (807s left) gem_busy (extended)
[214.134760] Starting subtest: extended
[214.137336] Starting dynamic subtest: rcs0
[214.211449] Dynamic subtest rcs0: SUCCESS (0.077s)
[214.221244] Starting dynamic subtest: bcs0
[214.258332] Dynamic subtest bcs0: SUCCESS (0.045s)
[214.272603] Starting dynamic subtest: vcs0
[215.894291] Dynamic subtest vcs0: SUCCESS (1.633s)
[215.905425] Starting dynamic subtest: vcs1
[217.880089] Dynamic subtest vcs1: SUCCESS (1.983s)
[217.891879] Starting dynamic subtest: vecs0
[219.926961] Dynamic subtest vecs0: SUCCESS (2.046s)
[219.938567] Starting dynamic subtest: ccs0
[219.971901] Dynamic subtest ccs0: SUCCESS (0.045s)
[219.974505] Subtest extended: SUCCESS (5.838s)
[220.229492] [031/133] (801s left) gem_mmap_offset (perf)
[220.299316] Starting subtest: perf
[220.301667] Starting dynamic subtest: smem0
[220.661848] Dynamic subtest smem0: SUCCESS (0.361s)
[220.664397] Subtest perf: SUCCESS (0.362s)
[220.791818] [032/133] (800s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[221.185408] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[222.027154] [033/133] (799s left) gem_exec_schedule (reorder-wide)
[222.212425] Subtest reorder-wide: SKIP (0.000s)
[222.392727] [034/133] (799s left) kms_rotation_crc (sprite-rotation-90)
[222.484178] Starting subtest: sprite-rotation-90
[222.488275] Subtest sprite-rotation-90: SKIP (0.001s)
[222.567633] [035/133] (799s left) kms_dp_link_training (non-uhbr-mst)
[222.648471] Starting subtest: non-uhbr-mst
[222.657359] Subtest non-uhbr-mst: SKIP (0.000s)
[222.721450] [036/133] (798s left) kms_flip (nonexisting-fb)
[222.815345] Starting subtest: nonexisting-fb
[222.817757] Starting dynamic subtest: A-eDP1
[224.024563] Dynamic subtest A-eDP1: SUCCESS (1.208s)
[224.038599] Starting dynamic subtest: B-eDP1
[225.151740] Dynamic subtest B-eDP1: SUCCESS (1.126s)
[225.161462] Starting dynamic subtest: C-eDP1
[226.288592] Dynamic subtest C-eDP1: SUCCESS (1.135s)
[226.299195] Starting dynamic subtest: D-eDP1
[227.421697] Dynamic subtest D-eDP1: SUCCESS (1.133s)
[227.426514] Subtest nonexisting-fb: SUCCESS (4.612s)
[228.596021] [037/133] (793s left) syncobj_wait (wait-for-submit-snapshot)
[228.660674] Starting subtest: wait-for-submit-snapshot
[228.741344] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[228.829854] [038/133] (792s left) kms_cursor_edge_walk (256x256-top-bottom)
[228.929369] Starting subtest: 256x256-top-bottom
[228.931645] Starting dynamic subtest: pipe-A-eDP-1
[232.358634] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.429s)
[232.367626] Starting dynamic subtest: pipe-D-eDP-1
[235.484316] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.123s)
[235.486418] Subtest 256x256-top-bottom: SUCCESS (6.555s)
[236.290593] [039/133] (785s left) gem_exec_schedule (smoketest-all)
[236.364552] Starting subtest: smoketest-all
[268.746306] Subtest smoketest-all: SUCCESS (32.340s)
[269.958270] [040/133] (751s left) gem_sync (basic-store-each)
[270.024845] Starting subtest: basic-store-each
[272.656450] Subtest basic-store-each: SUCCESS (2.641s)
[272.842553] [041/133] (748s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[272.949498] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[273.939390] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (0.990s)
[274.074303] [042/133] (747s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[274.185264] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[278.671447] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.490s)
[279.788229] [043/133] (742s left) gem_mmap_gtt (basic)
[279.849311] Subtest basic: SKIP (0.000s)
[279.912340] [044/133] (742s left) gem_exec_params (batch-first)
[279.967707] Starting subtest: batch-first
[279.974366] Subtest batch-first: SUCCESS (0.006s)
[280.093466] [045/133] (741s left) kms_plane_cursor (viewport)
[280.189345] Starting subtest: viewport
[280.193764] Starting dynamic subtest: pipe-A-eDP-1-size-64
[282.598672] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.410s)
[282.658576] Starting dynamic subtest: pipe-A-eDP-1-size-128
[285.055215] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.404s)
[285.115623] Starting dynamic subtest: pipe-A-eDP-1-size-256
[287.538279] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.428s)
[287.886393] Starting dynamic subtest: pipe-B-eDP-1-size-64
[291.027182] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.147s)
[291.085549] Starting dynamic subtest: pipe-B-eDP-1-size-128
[293.515504] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.438s)
[293.574765] Starting dynamic subtest: pipe-B-eDP-1-size-256
[295.994558] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.427s)
[296.346625] Starting dynamic subtest: pipe-C-eDP-1-size-64
[299.089996] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.752s)
[299.128036] Starting dynamic subtest: pipe-C-eDP-1-size-128
[301.144780] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.025s)
[301.182364] Starting dynamic subtest: pipe-C-eDP-1-size-256
[303.244879] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.069s)
[303.579327] Starting dynamic subtest: pipe-D-eDP-1-size-64
[306.320197] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.752s)
[306.360055] Starting dynamic subtest: pipe-D-eDP-1-size-128
[308.410281] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.058s)
[308.447637] Starting dynamic subtest: pipe-D-eDP-1-size-256
[310.464806] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.025s)
[310.787585] Subtest viewport: SUCCESS (30.598s)
[311.597635] [046/133] (710s left) syncobj_eventfd (invalid-bad-flags)
[311.664034] Starting subtest: invalid-bad-flags
[311.666313] Subtest invalid-bad-flags: SUCCESS (0.000s)
[311.751240] [047/133] (710s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[311.849250] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[319.130476] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.284s)
[319.258701] [048/133] (702s left) perf (invalid-oa-metric-set-id)
[319.397804] Starting subtest: invalid-oa-metric-set-id
[319.408996] Subtest invalid-oa-metric-set-id: SUCCESS (0.010s)
[319.452508] [049/133] (702s left) gem_pxp (create-valid-protected-context)
[319.572883] Starting subtest: create-valid-protected-context
[319.575284] Subtest create-valid-protected-context: SUCCESS (0.002s)
[319.677412] [050/133] (702s left) gem_ctx_persistence (legacy-engines-queued)
[319.722958] Starting subtest: legacy-engines-queued
[319.725321] Starting dynamic subtest: render
[319.790820] Dynamic subtest render: SUCCESS (0.067s)
[319.799784] Starting dynamic subtest: bsd1
[321.847476] Dynamic subtest bsd1: SUCCESS (2.053s)
[321.859811] Starting dynamic subtest: bsd2
[323.829498] Dynamic subtest bsd2: SUCCESS (1.977s)
[323.841355] Starting dynamic subtest: blt
[323.902748] Dynamic subtest blt: SUCCESS (0.071s)
[323.916614] Starting dynamic subtest: vebox
[325.813506] Dynamic subtest vebox: SUCCESS (1.905s)
[325.816671] Subtest legacy-engines-queued: SUCCESS (6.091s)
[325.902724] [051/133] (696s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[326.007037] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[326.009253] Starting dynamic subtest: pipe-A-eDP-1
[326.033736] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[326.043908] Starting dynamic subtest: pipe-B-eDP-1
[326.066549] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[326.074620] Starting dynamic subtest: pipe-C-eDP-1
[326.097272] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[326.105029] Starting dynamic subtest: pipe-D-eDP-1
[326.127769] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[326.131999] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[328.205620] [052/133] (694s left) kms_psr (fbc-pr-cursor-plane-onoff)
[328.295065] Starting subtest: fbc-pr-cursor-plane-onoff
[328.299349] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[328.378982] [053/133] (693s left) kms_lease (lease-get)
[328.458202] Starting subtest: lease-get
[328.460533] Starting dynamic subtest: pipe-A-eDP-1
[328.462732] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[328.471335] Starting dynamic subtest: pipe-B-eDP-1
[328.473460] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[328.481673] Starting dynamic subtest: pipe-C-eDP-1
[328.483795] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[328.492315] Starting dynamic subtest: pipe-D-eDP-1
[328.494412] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[328.496589] Subtest lease-get: SUCCESS (0.010s)
[328.594544] [054/133] (693s left) kms_force_connector_basic (force-load-detect)
[328.675021] Starting subtest: force-load-detect
[328.679562] Subtest force-load-detect: SKIP (0.000s)
[328.785157] [055/133] (693s left) kms_atomic (atomic-plane-damage)
[328.875078] Starting subtest: atomic-plane-damage
[328.919346] Starting dynamic subtest: pipe-A-eDP-1
[329.463125] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.542s)
[329.465534] Subtest atomic-plane-damage: SUCCESS (0.589s)
[330.331062] [056/133] (692s left) i915_query (query-regions-unallocated)
[330.388713] Starting subtest: query-regions-unallocated
[330.390798] Subtest query-regions-unallocated: SUCCESS (0.000s)
[330.494247] [057/133] (691s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[330.583929] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[330.586210] Starting dynamic subtest: pipe-A-eDP-1
[330.608030] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[330.618158] Starting dynamic subtest: pipe-B-eDP-1
[330.638973] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[330.647277] Starting dynamic subtest: pipe-C-eDP-1
[330.668246] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[330.676452] Starting dynamic subtest: pipe-D-eDP-1
[330.698312] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[330.702352] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[332.886530] [058/133] (689s left) api_intel_allocator (fork-simple-stress-signal)
[332.954377] Starting subtest: fork-simple-stress-signal
[338.358297] Subtest fork-simple-stress-signal: SUCCESS (5.405s)
[338.515579] [059/133] (684s left) gem_softpin (noreloc-interruptible)
[338.586691] Starting subtest: noreloc-interruptible
[344.028342] Subtest noreloc-interruptible: SUCCESS (5.439s)
[344.173432] [060/133] (678s left) syncobj_timeline (single-wait-available-submitted)
[344.234580] Starting subtest: single-wait-available-submitted
[344.236913] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[344.342274] [061/133] (678s left) gem_exec_capture (capture-recoverable)
[344.407719] Starting subtest: capture-recoverable
[344.412404] Subtest capture-recoverable: SUCCESS (0.004s)
[344.523853] [062/133] (678s left) gem_close (basic)
[344.566617] Starting subtest: basic
[344.569060] Subtest basic: SUCCESS (0.000s)
[344.657048] [063/133] (678s left) gem_exec_schedule (preempt-contexts)
[344.732979] Starting subtest: preempt-contexts
[344.735086] Starting dynamic subtest: rcs0
[344.817147] Dynamic subtest rcs0: SUCCESS (0.091s)
[344.827393] Starting dynamic subtest: bcs0
[344.896756] Dynamic subtest bcs0: SUCCESS (0.079s)
[344.906777] Starting dynamic subtest: vcs0
[344.960568] Dynamic subtest vcs0: SUCCESS (0.062s)
[344.970750] Starting dynamic subtest: vcs1
[345.030244] Dynamic subtest vcs1: SUCCESS (0.069s)
[345.039990] Starting dynamic subtest: vecs0
[345.086556] Dynamic subtest vecs0: SUCCESS (0.056s)
[345.095525] Starting dynamic subtest: ccs0
[345.179689] Dynamic subtest ccs0: SUCCESS (0.092s)
[345.181802] Subtest preempt-contexts: SUCCESS (0.455s)
[346.989311] [064/133] (675s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[347.107235] Starting subtest: cursorB-vs-flipA-atomic
[347.111624] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s)
[347.248908] [065/133] (675s left) kms_content_protection (dp-mst-type-1)
[347.391168] Starting subtest: dp-mst-type-1
[347.395727] Subtest dp-mst-type-1: SKIP (0.000s)
[347.521446] [066/133] (675s left) gem_fenced_exec_thrash (2-spare-fences)
[347.579988] Subtest 2-spare-fences: SKIP (0.000s)
[347.660186] [067/133] (675s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[349.186549] Starting subtest: modeset-lpsp-stress-no-wait
[359.271060] Subtest modeset-lpsp-stress-no-wait: SUCCESS (10.084s)
[359.362555] [068/133] (663s left) kms_psr (fbc-psr-sprite-plane-onoff)
[359.460165] Starting subtest: fbc-psr-sprite-plane-onoff
[359.462463] Starting dynamic subtest: eDP-1
[359.466529] Dynamic subtest eDP-1: SKIP (0.000s)
[359.470660] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[359.531596] [069/133] (663s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[359.638382] Starting subtest: extended-modeset-hang-oldfb-with-reset
[359.640380] Starting dynamic subtest: pipe-A
[371.126232] Dynamic subtest pipe-A: SUCCESS (11.486s)
[371.135908] Starting dynamic subtest: pipe-D
[383.394187] Dynamic subtest pipe-D: SUCCESS (12.266s)
[383.396471] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (23.757s)
[384.183344] [070/133] (638s left) kms_invalid_mode (bad-hsync-start)
[384.288605] Starting subtest: bad-hsync-start
[384.291069] Starting dynamic subtest: pipe-A-eDP-1
[384.579406] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.291s)
[384.589630] Starting dynamic subtest: pipe-B-eDP-1
[384.591623] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[384.599618] Starting dynamic subtest: pipe-C-eDP-1
[384.601926] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[384.610202] Starting dynamic subtest: pipe-D-eDP-1
[384.612097] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[384.613887] Subtest bad-hsync-start: SUCCESS (0.297s)
[385.412465] [071/133] (637s left) gem_exec_params (rel-constants-invalid-ring)
[385.469704] Starting subtest: rel-constants-invalid-ring
[385.471585] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[385.563107] [072/133] (637s left) kms_psr (psr-cursor-plane-move)
[385.656190] Starting subtest: psr-cursor-plane-move
[385.658404] Starting dynamic subtest: eDP-1
[387.405669] Dynamic subtest eDP-1: SUCCESS (1.748s)
[387.407558] Subtest psr-cursor-plane-move: SUCCESS (1.749s)
[388.256450] [073/133] (634s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[388.362580] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[388.366649] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[388.450125] [074/133] (634s left) i915_pm_rpm (system-suspend-execbuf)
[389.968417] Starting subtest: system-suspend-execbuf
[449.758326] Subtest system-suspend-execbuf: SUCCESS (45.106s)
[450.168764] [075/133] (573s left) kms_addfb_basic (addfb25-4-tiled)
[450.404593] Starting subtest: addfb25-4-tiled
[450.406464] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[450.508736] [076/133] (572s left) perf_pmu (faulting-read)
[450.552791] Starting subtest: faulting-read
[450.555125] Starting dynamic subtest: wb
[450.557381] Dynamic subtest wb: SUCCESS (0.001s)
[450.567418] Starting dynamic subtest: wc
[450.569816] Dynamic subtest wc: SUCCESS (0.000s)
[450.579092] Starting dynamic subtest: uc
[450.581413] Dynamic subtest uc: SUCCESS (0.000s)
[450.583560] Subtest faulting-read: SUCCESS (0.003s)
[450.666612] [077/133] (572s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[450.759814] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[450.764068] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[450.865991] [078/133] (572s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[450.960608] Starting subtest: fbc-farfromfence-mmap-gtt
[450.964864] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[451.053328] [079/133] (572s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[451.108669] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[451.110716] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[451.198664] [080/133] (572s left) gem_exec_whisper (basic-fds-forked-all)
[451.257489] Starting subtest: basic-fds-forked-all
[515.072689] Warning: kernel log ringbuffer underflow, some records lost.
[515.076592] Killing the test because the kernel is tainted.
[634.893719] Timeout. Killing the current test with SIGKILL.
[634.899079] Child refuses to die, tainted 0x42c4. Aborting.
[634.904389] Closing watchdogs
[634.924828] [FACT gem_exec_whisper (basic-fds-forked-all)] new: kernel.is_tainted.taint_die: true
[634.924844] [FACT gem_exec_whisper (basic-fds-forked-all)] new: kernel.is_tainted.taint_warn: true
[634.925494] Closing watchdogs
results: parsing output: 0/ for test: kms_chamelium_color
results: parsing output: 1/ for test: core_auth
results: parsing output: 2/ for test: gem_userptr_blits
results: parsing output: 3/ for test: kms_pm_lpsp
results: parsing output: 4/ for test: gem_render_copy
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: kms_pipe_crc_basic
results: parsing output: 7/ for test: syncobj_wait
results: parsing output: 8/ for test: kms_plane_scaling
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: syncobj_timeline
results: parsing output: 11/ for test: gem_exec_balancer
results: parsing output: 12/ for test: dumb_buffer
results: parsing output: 13/ for test: kms_color
results: parsing output: 14/ for test: gem_tiled_pread_pwrite
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: syncobj_timeline
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: gem_workarounds
results: parsing output: 19/ for test: syncobj_wait
results: parsing output: 20/ for test: kms_rmfb
results: parsing output: 21/ for test: kms_chamelium_hpd
results: parsing output: 22/ for test: gem_userptr_blits
results: parsing output: 23/ for test: gem_exec_fence
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: gem_exec_await
results: parsing output: 26/ for test: kms_cursor_crc
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gem_create
results: parsing output: 29/ for test: gem_busy
results: parsing output: 30/ for test: gem_mmap_offset
results: parsing output: 31/ for test: kms_chamelium_edid
results: parsing output: 32/ for test: gem_exec_schedule
results: parsing output: 33/ for test: kms_rotation_crc
results: parsing output: 34/ for test: kms_dp_link_training
results: parsing output: 35/ for test: kms_flip
results: parsing output: 36/ for test: syncobj_wait
results: parsing output: 37/ for test: kms_cursor_edge_walk
results: parsing output: 38/ for test: gem_exec_schedule
results: parsing output: 39/ for test: gem_sync
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: gem_mmap_gtt
results: parsing output: 43/ for test: gem_exec_params
results: parsing output: 44/ for test: kms_plane_cursor
results: parsing output: 45/ for test: syncobj_eventfd
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: perf
results: parsing output: 48/ for test: gem_pxp
results: parsing output: 49/ for test: gem_ctx_persistence
results: parsing output: 50/ for test: kms_ccs
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: kms_lease
results: parsing output: 53/ for test: kms_force_connector_basic
results: parsing output: 54/ for test: kms_atomic
results: parsing output: 55/ for test: i915_query
results: parsing output: 56/ for test: kms_ccs
results: parsing output: 57/ for test: api_intel_allocator
results: parsing output: 58/ for test: gem_softpin
results: parsing output: 59/ for test: syncobj_timeline
results: parsing output: 60/ for test: gem_exec_capture
results: parsing output: 61/ for test: gem_close
results: parsing output: 62/ for test: gem_exec_schedule
results: parsing output: 63/ for test: kms_cursor_legacy
results: parsing output: 64/ for test: kms_content_protection
results: parsing output: 65/ for test: gem_fenced_exec_thrash
results: parsing output: 66/ for test: kms_pm_rpm
results: parsing output: 67/ for test: kms_psr
results: parsing output: 68/ for test: kms_busy
results: parsing output: 69/ for test: kms_invalid_mode
results: parsing output: 70/ for test: gem_exec_params
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: i915_pm_rpm
results: parsing output: 74/ for test: kms_addfb_basic
results: parsing output: 75/ for test: perf_pmu
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: syncobj_timeline
results: parsing output: 79/ for test: gem_exec_whisper
results: parsing output: 80/ for test: kms_ccs
results: no output, setting notrun
results: parsing output: 81/ for test: prime_mmap
results: no output, setting notrun
results: parsing output: 82/ for test: kms_psr2_sf
results: no output, setting notrun
results: parsing output: 83/ for test: kms_hdr
results: no output, setting notrun
results: parsing output: 84/ for test: gem_exec_reloc
results: no output, setting notrun
results: parsing output: 85/ for test: kms_cursor_crc
results: no output, setting notrun
results: parsing output: 86/ for test: gem_exec_reloc
results: no output, setting notrun
results: parsing output: 87/ for test: gem_exec_params
results: no output, setting notrun
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 91/ for test: gem_ctx_shared
results: no output, setting notrun
results: parsing output: 92/ for test: gem_ctx_persistence
results: no output, setting notrun
results: parsing output: 93/ for test: kms_vrr
results: no output, setting notrun
results: parsing output: 94/ for test: kms_psr_stress_test
results: no output, setting notrun
results: parsing output: 95/ for test: kms_universal_plane
results: no output, setting notrun
results: parsing output: 96/ for test: syncobj_wait
results: no output, setting notrun
results: parsing output: 97/ for test: gen9_exec_parse
results: no output, setting notrun
results: parsing output: 98/ for test: prime_busy
results: no output, setting notrun
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 100/ for test: kms_feature_discovery
results: no output, setting notrun
results: parsing output: 101/ for test: gem_spin_batch
results: no output, setting notrun
results: parsing output: 102/ for test: gem_lmem_swapping
results: no output, setting notrun
results: parsing output: 103/ for test: kms_addfb_basic
results: no output, setting notrun
results: parsing output: 104/ for test: gem_exec_flush
results: no output, setting notrun
results: parsing output: 105/ for test: gem_eio
results: no output, setting notrun
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 107/ for test: kms_prop_blob
results: no output, setting notrun
results: parsing output: 108/ for test: kms_big_fb
results: no output, setting notrun
results: parsing output: 109/ for test: i915_pm_freq_api
results: no output, setting notrun
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 111/ for test: vgem_basic
results: no output, setting notrun
results: parsing output: 112/ for test: gem_pxp
results: no output, setting notrun
results: parsing output: 113/ for test: kms_plane
results: no output, setting notrun
results: parsing output: 114/ for test: kms_flip
results: no output, setting notrun
results: parsing output: 115/ for test: gem_exec_reloc
results: no output, setting notrun
results: parsing output: 116/ for test: kms_cursor_legacy
results: no output, setting notrun
results: parsing output: 117/ for test: gem_lmem_swapping
results: no output, setting notrun
results: parsing output: 118/ for test: kms_ccs
results: no output, setting notrun
results: parsing output: 119/ for test: kms_plane
results: no output, setting notrun
results: parsing output: 120/ for test: kms_pipe_b_c_ivb
results: no output, setting notrun
results: parsing output: 121/ for test: i915_drm_fdinfo
results: no output, setting notrun
results: parsing output: 122/ for test: kms_flip
results: no output, setting notrun
results: parsing output: 123/ for test: gem_readwrite
results: no output, setting notrun
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 125/ for test: gem_partial_pwrite_pread
results: no output, setting notrun
results: parsing output: 126/ for test: kms_vblank
results: no output, setting notrun
results: parsing output: 127/ for test: kms_big_fb
results: no output, setting notrun
results: parsing output: 128/ for test: kms_big_fb
results: no output, setting notrun
results: parsing output: 129/ for test: sysfs_timeslice_duration
results: no output, setting notrun
results: parsing output: 130/ for test: gem_partial_pwrite_pread
results: no output, setting notrun
results: parsing output: 131/ for test: gem_ctx_exec
results: no output, setting notrun
results: parsing output: 132/ for test: kms_flip_scaled_crc
results: no output, setting notrun
Done.