[74.575063] Initializing watchdogs
[74.575262]   /dev/watchdog0
[74.595393] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:0102 Intel Sandybridge (Gen6) 2nd Generation Core Processor Family Integrated Graphics Controller (XPS 8300)
[74.603341] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[74.606878] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[74.610223] [001/133] (960s left) kms_plane_scaling (planes-scaler-unity-scaling)
[75.116230] Starting subtest: planes-scaler-unity-scaling
[75.116953] Starting dynamic subtest: pipe-A
[75.118769] Dynamic subtest pipe-A: SKIP (0.001s)
[75.131292] Starting dynamic subtest: pipe-B
[75.133029] Dynamic subtest pipe-B: SKIP (0.001s)
[75.134191] Subtest planes-scaler-unity-scaling: SKIP (0.003s)
[75.684800] [002/133] (959s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[75.747137] Starting subtest: basic-cpu-gtt-noreloc
[75.751271] Subtest basic-cpu-gtt-noreloc: SUCCESS (0.004s)
[76.764947] [003/133] (958s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[77.259405] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[77.540957] [004/133] (957s left) kms_psr (fbc-psr2-primary-blt)
[78.036582] Subtest fbc-psr2-primary-blt: SKIP (0.000s)
[78.327167] [005/133] (956s left) syncobj_timeline (reset-signaled)
[78.384104] Starting subtest: reset-signaled
[78.384677] Subtest reset-signaled: SUCCESS (0.001s)
[78.518342] [006/133] (956s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[78.571913] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.000s)
[78.623822] [007/133] (956s left) kms_atomic (atomic-invalid-params)
[79.109782] Starting subtest: atomic-invalid-params
[79.111157] Starting dynamic subtest: pipe-A-HDMI-A-1
[79.526984] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.416s)
[79.527717] Subtest atomic-invalid-params: SUCCESS (0.418s)
[80.227048] [008/133] (955s left) kms_psr (psr-sprite-mmap-cpu)
[80.719618] Subtest psr-sprite-mmap-cpu: SKIP (0.000s)
[81.016540] [009/133] (954s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[81.070641] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[81.071289] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.001s)
[81.186155] [010/133] (954s left) gem_eio (in-flight-10ms)
[81.247131] Starting subtest: in-flight-10ms
[82.742551] Subtest in-flight-10ms: SUCCESS (1.495s)
[83.807280] [FACT gem_eio (in-flight-10ms)] new: kernel.kmod_is_loaded.vgem: true
[83.809638] [011/133] (951s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[84.309750] Starting subtest: flip-vs-cursor-toggle
[98.373707] Subtest flip-vs-cursor-toggle: SUCCESS (14.055s)
[99.094639] [012/133] (936s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[99.158382] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[99.160146] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[99.372236] [013/133] (936s left) kms_cursor_crc (cursor-onscreen-256x85)
[99.874658] Starting subtest: cursor-onscreen-256x85
[99.960881] Subtest cursor-onscreen-256x85: SKIP (0.083s)
[100.565958] [014/133] (935s left) gen7_exec_parse (oacontrol-tracking)
[100.624041] Subtest oacontrol-tracking: SKIP (0.000s)
[100.674441] [015/133] (935s left) sysfs_timeslice_duration (duration)
[100.728927] Starting subtest: duration
[100.730284] Starting dynamic subtest: vcs0
[100.731511] Dynamic subtest vcs0: SKIP (0.000s)
[100.742238] Starting dynamic subtest: bcs0
[100.744198] Dynamic subtest bcs0: SKIP (0.000s)
[100.757675] Starting dynamic subtest: rcs0
[100.759840] Dynamic subtest rcs0: SKIP (0.000s)
[100.761509] Subtest duration: SKIP (0.002s)
[100.847959] [016/133] (934s left) sw_sync (sync_busy)
[100.904172] Starting subtest: sync_busy
[100.908914] Subtest sync_busy: SUCCESS (0.005s)
[101.017172] [017/133] (934s left) kms_chamelium_edid (dp-edid-resolution-list)
[101.585992] Subtest dp-edid-resolution-list: SKIP (0.000s)
[102.003907] [018/133] (933s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[102.496810] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[103.978276] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (1.481s)
[104.620194] [019/133] (931s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[105.121343] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[105.122314] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[105.719572] [020/133] (930s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[105.776289] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[105.830096] [021/133] (930s left) i915_query (query-topology-known-pci-ids)
[105.882809] Starting subtest: query-topology-known-pci-ids
[105.883917] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[106.001966] [022/133] (930s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[106.499206] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[106.500431] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[107.099918] [023/133] (929s left) gem_partial_pwrite_pread (write-display)
[107.156866] Starting subtest: write-display
[110.925926] Subtest write-display: SUCCESS (3.768s)
[111.097531] [024/133] (925s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[111.590337] Starting subtest: cursor-rapid-movement-32x32
[111.673733] Subtest cursor-rapid-movement-32x32: SKIP (0.082s)
[112.277922] [025/133] (923s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[112.334069] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[112.335390] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[112.457709] [026/133] (923s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[112.943195] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[112.943884] Starting dynamic subtest: pipe-A
[112.945813] Dynamic subtest pipe-A: SKIP (0.002s)
[112.956201] Starting dynamic subtest: pipe-B
[112.957863] Dynamic subtest pipe-B: SKIP (0.001s)
[112.958992] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SKIP (0.005s)
[113.541420] [027/133] (922s left) kms_getfb (getfb-handle-zero)
[114.033651] Starting subtest: getfb-handle-zero
[114.034136] Subtest getfb-handle-zero: SUCCESS (0.000s)
[114.637345] [028/133] (921s left) api_intel_bb (render-ccs)
[114.693132] Starting subtest: render-ccs
[114.694184] Subtest render-ccs: SKIP (0.001s)
[114.842847] [029/133] (921s left) i915_query (engine-info)
[114.896482] Starting subtest: engine-info
[114.897079] Subtest engine-info: SUCCESS (0.001s)
[115.020288] [030/133] (921s left) gem_exec_schedule (preempt-self)
[115.085486] Subtest preempt-self: SKIP (0.000s)
[115.327801] [031/133] (921s left) gem_pxp (create-protected-buffer)
[117.892628] Starting subtest: create-protected-buffer
[117.893967] Subtest create-protected-buffer: SKIP (0.000s)
[118.014296] [032/133] (918s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[118.510501] Starting subtest: 2x-plain-flip-ts-check-interruptible
[118.511945] Starting dynamic subtest: AB-VGA1-HDMI-A1
[149.122145] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.609s)
[149.127541] Subtest 2x-plain-flip-ts-check-interruptible: SUCCESS (30.612s)
[149.941654] [033/133] (886s left) gem_exec_alignment (pi-isolated)
[150.002550] Starting subtest: pi-isolated
[150.003720] Subtest pi-isolated: SKIP (0.000s)
[150.156862] [034/133] (886s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[150.647514] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[150.648587] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[151.238094] [035/133] (885s left) kms_flip (busy-flip)
[151.734931] Starting subtest: busy-flip
[151.736262] Starting dynamic subtest: A-VGA1
[152.481465] Dynamic subtest A-VGA1: SUCCESS (0.745s)
[152.495874] Starting dynamic subtest: B-VGA1
[153.183223] Dynamic subtest B-VGA1: SUCCESS (0.699s)
[153.195050] Starting dynamic subtest: A-HDMI-A1
[153.954715] Dynamic subtest A-HDMI-A1: SUCCESS (0.770s)
[153.966830] Starting dynamic subtest: B-HDMI-A1
[154.754172] Dynamic subtest B-HDMI-A1: SUCCESS (0.797s)
[154.757129] Subtest busy-flip: SUCCESS (3.022s)
[155.557380] [036/133] (881s left) perf_pmu (busy-accuracy-98)
[155.613999] Starting subtest: busy-accuracy-98
[155.616271] Starting dynamic subtest: rcs0
[155.617344] Dynamic subtest rcs0: SKIP (0.000s)
[155.632907] Starting dynamic subtest: bcs0
[155.634835] Dynamic subtest bcs0: SKIP (0.000s)
[155.649771] Starting dynamic subtest: vcs0
[155.651983] Dynamic subtest vcs0: SKIP (0.000s)
[155.653865] Subtest busy-accuracy-98: SKIP (0.002s)
[155.739981] [037/133] (881s left) kms_frontbuffer_tracking (fbc-tiling-y)
[156.233375] Starting subtest: fbc-tiling-y
[156.234404] Subtest fbc-tiling-y: SKIP (0.000s)
[156.819916] [038/133] (880s left) kms_vblank (ts-continuation-idle-hang)
[157.301508] Starting subtest: ts-continuation-idle-hang
[157.303027] Starting dynamic subtest: pipe-A-HDMI-A-1
[163.971211] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.669s)
[163.986015] Starting dynamic subtest: pipe-B-HDMI-A-1
[169.911608] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (5.939s)
[169.913786] Subtest ts-continuation-idle-hang: SUCCESS (12.613s)
[170.609117] [039/133] (866s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite)
[171.106847] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite
[171.107995] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[171.698811] [040/133] (865s left) syncobj_timeline (single-wait-available-signaled)
[171.755753] Starting subtest: single-wait-available-signaled
[171.756394] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[171.886582] [041/133] (865s left) kms_psr (fbc-psr-cursor-render)
[172.375688] Subtest fbc-psr-cursor-render: SKIP (0.000s)
[172.680206] [042/133] (864s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[173.172472] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[173.173691] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[173.782323] [043/133] (863s left) gem_render_copy_redux (flink)
[173.842455] Starting subtest: flink
[174.994053] Subtest flink: SUCCESS (1.152s)
[175.163707] [044/133] (861s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[175.645893] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[175.648020] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[176.243899] [045/133] (860s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[176.737422] Starting subtest: basic-busy-flip-before-cursor-legacy
[177.711318] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (0.974s)
[178.430640] [046/133] (858s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[178.483345] Starting subtest: framebuffer-vs-set-tiling
[178.483872] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[179.509677] [047/133] (857s left) kms_plane_multiple (tiling-y)
[179.997554] Starting subtest: tiling-y
[179.998804] Subtest tiling-y: SKIP (0.000s)
[180.577568] [048/133] (856s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[181.060271] Starting subtest: modeset-atomic-cursor-hotspot
[181.061383] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[181.659920] [049/133] (855s left) kms_hdr (static-toggle-suspend)
[182.145832] Starting subtest: static-toggle-suspend
[182.149145] Subtest static-toggle-suspend: SKIP (0.000s)
[182.741912] [050/133] (854s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[183.233992] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[183.771299] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.537s)
[184.419329] [051/133] (853s left) gem_exec_fence (basic-await)
[184.590092] Subtest basic-await: SKIP (0.000s)
[185.002487] [052/133] (852s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[185.495649] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[185.496795] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[186.097679] [053/133] (851s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[186.581417] Starting subtest: basic-flip-before-cursor-legacy
[187.564613] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.981s)
[188.272421] [054/133] (849s left) kms_vblank (query-busy)
[188.756104] Starting subtest: query-busy
[188.757025] Starting dynamic subtest: pipe-A-HDMI-A-1
[191.150809] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.394s)
[191.162290] Starting dynamic subtest: pipe-B-HDMI-A-1
[193.558754] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.405s)
[193.559364] Subtest query-busy: SUCCESS (4.804s)
[194.264487] [055/133] (843s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[194.574860] Subtest syncobj-backward-timeline-chain-engines: SKIP (0.000s)
[194.846406] [056/133] (842s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[195.327786] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[195.328804] Subtest fbcpsr-rgb565-draw-mmap-wc: SKIP (0.000s)
[195.928366] [057/133] (841s left) gem_bad_reloc (negative-reloc)
[195.987254] Starting subtest: negative-reloc
[195.988553] Subtest negative-reloc: SKIP (0.000s)
[196.145239] [058/133] (841s left) gem_mmap (bad-size)
[196.198393] Starting subtest: bad-size
[196.199891] Subtest bad-size: SUCCESS (0.001s)
[196.345654] [059/133] (841s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[196.827514] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[197.121383] [060/133] (840s left) kms_busy (extended-modeset-hang-oldfb)
[197.608794] Starting subtest: extended-modeset-hang-oldfb
[197.609593] Starting dynamic subtest: pipe-A
[204.174027] Dynamic subtest pipe-A: SUCCESS (6.564s)
[204.185506] Starting dynamic subtest: pipe-B
[210.210415] Dynamic subtest pipe-B: SUCCESS (6.033s)
[210.211020] Subtest extended-modeset-hang-oldfb: SUCCESS (12.602s)
[210.927877] [061/133] (827s left) i915_drm_fdinfo (busy)
[210.987954] Subtest busy: SKIP (0.000s)
[211.043882] [062/133] (826s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[211.099557] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[211.154986] [063/133] (826s left) kms_plane_alpha_blend (coverage-7efc)
[211.635753] Starting subtest: coverage-7efc
[211.795784] Subtest coverage-7efc: SKIP (0.160s)
[212.594869] [064/133] (825s left) gem_exec_params (secure-non-root)
[212.654863] Starting subtest: secure-non-root
[212.655815] Subtest secure-non-root: SKIP (0.000s)
[212.792827] [065/133] (825s left) kms_flip (bo-too-big)
[213.279552] Starting subtest: bo-too-big
[213.281176] Starting dynamic subtest: A-VGA1
[215.059762] Dynamic subtest A-VGA1: SUCCESS (1.778s)
[215.075249] Starting dynamic subtest: B-VGA1
[216.774487] Dynamic subtest B-VGA1: SUCCESS (1.711s)
[216.786779] Starting dynamic subtest: A-HDMI-A1
[218.527197] Dynamic subtest A-HDMI-A1: SUCCESS (1.750s)
[218.540902] Starting dynamic subtest: B-HDMI-A1
[219.991529] Dynamic subtest B-HDMI-A1: SUCCESS (1.461s)
[219.994767] Subtest bo-too-big: SUCCESS (6.714s)
[220.774331] [066/133] (817s left) kms_pm_rpm (dpms-lpsp)
[232.559650] Subtest dpms-lpsp: SKIP (0.000s)
[232.863389] [067/133] (805s left) gem_ctx_param (invalid-get-no-zeromap)
[232.920713] Starting subtest: invalid-get-no-zeromap
[232.921358] Subtest invalid-get-no-zeromap: SUCCESS (0.000s)
[233.068774] [068/133] (805s left) kms_atomic_transition (plane-all-transition-fencing)
[233.554331] Starting subtest: plane-all-transition-fencing
[233.556350] Starting dynamic subtest: pipe-A-HDMI-A-1
[234.716914] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.160s)
[234.810279] Starting dynamic subtest: pipe-B-HDMI-A-1
[236.117251] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.317s)
[236.199766] Subtest plane-all-transition-fencing: SUCCESS (2.645s)
[236.907377] [069/133] (801s left) kms_setmode (basic-clone-single-crtc)
[236.964404] Starting subtest: basic-clone-single-crtc
[236.965771] Subtest basic-clone-single-crtc: SKIP (0.000s)
[237.089736] [070/133] (801s left) gem_pwrite_snooped
[237.321840] [071/133] (801s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[237.809488] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[237.811668] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[238.425347] [072/133] (800s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[238.483205] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s)
[238.549154] [073/133] (800s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[239.038223] Starting subtest: yf-tiled-8bpp-rotate-180
[239.039397] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[239.649839] [074/133] (798s left) kms_psr (pr-basic)
[240.129577] Subtest pr-basic: SKIP (0.000s)
[240.427975] [075/133] (798s left) kms_prime (basic-crc-hybrid)
[240.934939] Subtest basic-crc-hybrid: SKIP (0.000s)
[242.032759] [076/133] (796s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[242.515381] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[242.517862] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[243.097546] [077/133] (795s left) gem_spin_batch (legacy-resubmit-new)
[243.159726] Starting subtest: legacy-resubmit-new
[243.161648] Starting dynamic subtest: default
[243.162237] Dynamic subtest default: SUCCESS (0.002s)
[243.174849] Starting dynamic subtest: render
[243.175638] Dynamic subtest render: SUCCESS (0.001s)
[243.185894] Starting dynamic subtest: bsd
[243.186719] Dynamic subtest bsd: SUCCESS (0.001s)
[243.196859] Starting dynamic subtest: bsd1
[243.197635] Dynamic subtest bsd1: SUCCESS (0.001s)
[243.207616] Starting dynamic subtest: blt
[243.208224] Dynamic subtest blt: SUCCESS (0.001s)
[243.208766] Subtest legacy-resubmit-new: SUCCESS (0.014s)
[243.413549] [078/133] (795s left) gem_pipe_control_store_loop (fresh-buffer)
[243.470847] Starting subtest: fresh-buffer
[245.618926] Subtest fresh-buffer: SUCCESS (2.149s)
[245.744749] [079/133] (793s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[245.802760] Starting subtest: invalid-multi-wait-unsubmitted
[245.803772] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[245.908411] [080/133] (793s left) kms_cursor_edge_walk (256x256-top-bottom)
[246.393542] Starting subtest: 256x256-top-bottom
[246.394887] Starting dynamic subtest: pipe-A-HDMI-A-1
[249.821783] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.426s)
[249.833900] Starting dynamic subtest: pipe-B-HDMI-A-1
[253.165504] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.341s)
[253.166570] Subtest 256x256-top-bottom: SUCCESS (6.773s)
[253.905215] [081/133] (785s left) gem_exec_balancer (invalid-bonds)
[253.961600] Subtest invalid-bonds: SKIP (0.000s)
[254.104257] [082/133] (784s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[254.599667] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[254.600681] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[255.193602] [083/133] (783s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[255.244978] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.000s)
[255.304836] [084/133] (783s left) dmabuf_sync_file (import-multiple-read-write)
[255.362251] Starting subtest: import-multiple-read-write
[255.369837] Subtest import-multiple-read-write: SUCCESS (0.009s)
[255.459839] [085/133] (783s left) kms_atomic_interruptible (universal-setplane-primary)
[255.942030] Starting subtest: universal-setplane-primary
[255.942666] Starting dynamic subtest: pipe-A-HDMI-A-1
[262.273640] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.330s)
[262.274197] Subtest universal-setplane-primary: SUCCESS (6.332s)
[262.985923] [086/133] (776s left) gem_ctx_engines (independent)
[263.048011] Starting subtest: independent
[263.049729] Subtest independent: SKIP (0.000s)
[263.249390] [087/133] (776s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[263.735621] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[263.736602] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[264.346304] [088/133] (775s left) vgem_basic (mmap)
[264.417388] Starting subtest: mmap
[264.428357] Subtest mmap: SUCCESS (0.013s)
[264.543627] [089/133] (774s left) kms_draw_crc (draw-method-mmap-wc)
[265.027663] Starting subtest: draw-method-mmap-wc
[265.028585] Starting dynamic subtest: xrgb8888-untiled
[265.314175] Dynamic subtest xrgb8888-untiled: SUCCESS (0.284s)
[265.326296] Starting dynamic subtest: rgb565-untiled
[265.594739] Dynamic subtest rgb565-untiled: SUCCESS (0.281s)
[265.607741] Starting dynamic subtest: xrgb2101010-untiled
[265.894087] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.297s)
[265.907191] Starting dynamic subtest: xbgr16161616f-untiled
[266.226929] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.330s)
[266.239831] Starting dynamic subtest: xrgb8888-xtiled
[266.393343] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.164s)
[266.405882] Starting dynamic subtest: rgb565-xtiled
[266.559654] Dynamic subtest rgb565-xtiled: SUCCESS (0.163s)
[266.572154] Starting dynamic subtest: xrgb2101010-xtiled
[266.726031] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.164s)
[266.739262] Starting dynamic subtest: xbgr16161616f-xtiled
[266.925451] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.196s)
[266.928869] Subtest draw-method-mmap-wc: SUCCESS (1.901s)
[267.557293] [090/133] (771s left) i915_hangman (engine-engine-error)
[267.620217] Subtest engine-engine-error: SKIP (0.000s)
[267.702116] [091/133] (771s left) kms_lease (master-vs-lease)
[268.181905] Starting subtest: master-vs-lease
[268.183210] Subtest master-vs-lease: SUCCESS (0.002s)
[268.779858] [092/133] (770s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[269.265147] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[269.564268] [093/133] (770s left) prime_mmap (test_forked_cpu_write)
[269.617640] Starting subtest: test_forked_cpu_write
[269.618215] Starting dynamic subtest: test_forked_cpu_write-smem
[269.633313] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.014s)
[269.635979] Subtest test_forked_cpu_write: SUCCESS (0.017s)
[269.784556] [094/133] (769s left) syncobj_timeline (etime-single-wait-submitted)
[269.841518] Starting subtest: etime-single-wait-submitted
[269.950702] Subtest etime-single-wait-submitted: SUCCESS (0.108s)
[270.084289] [095/133] (769s left) kms_content_protection (atomic-dpms)
[270.586639] Starting subtest: atomic-dpms
[270.587940] Subtest atomic-dpms: SKIP (0.000s)
[271.208551] [096/133] (768s left) gem_exec_reloc (basic-write-gtt)
[271.264602] Starting subtest: basic-write-gtt
[271.268320] Subtest basic-write-gtt: SUCCESS (0.004s)
[272.296492] [097/133] (767s left) kms_chamelium_hpd (hdmi-hpd-fast)
[272.864288] Subtest hdmi-hpd-fast: SKIP (0.000s)
[273.266338] [098/133] (766s left) gem_ctx_persistence (legacy-engines-hostile)
[273.324545] Subtest legacy-engines-hostile: SKIP (0.000s)
[273.388282] [099/133] (766s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[273.879044] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[273.880037] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[274.492532] [100/133] (765s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[274.547785] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SKIP (0.000s)
[274.615725] [101/133] (765s left) gem_softpin (evict-snoop-interruptible)
[274.675245] Starting subtest: evict-snoop-interruptible
[274.676545] Subtest evict-snoop-interruptible: SKIP (0.000s)
[274.804490] [102/133] (765s left) gem_exec_whisper (basic-forked)
[274.872802] Starting subtest: basic-forked
[276.447942] Subtest basic-forked: SUCCESS (1.574s)
[276.667384] [103/133] (763s left) kms_psr (psr2-sprite-plane-onoff)
[277.157493] Subtest psr2-sprite-plane-onoff: SKIP (0.000s)
[277.460289] [104/133] (762s left) gem_fence_thrash (bo-write-verify-none)
[277.518024] Starting subtest: bo-write-verify-none
[278.639428] Subtest bo-write-verify-none: SUCCESS (1.121s)
[278.781195] [105/133] (761s left) api_intel_allocator (fork-simple-stress)
[278.839551] Starting subtest: fork-simple-stress
[284.269319] Subtest fork-simple-stress: SUCCESS (5.430s)
[284.408672] [106/133] (755s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[284.468406] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[284.529524] [107/133] (755s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[285.014433] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[285.015831] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[285.617375] [108/133] (754s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[286.110243] Starting subtest: y-tiled-32bpp-rotate-180
[286.111453] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[286.698747] [109/133] (753s left) i915_pm_rc6_residency (media-rc6-accuracy)
[286.755625] Starting subtest: media-rc6-accuracy
[286.756564] Subtest media-rc6-accuracy: SKIP (0.000s)
[286.881684] [110/133] (753s left) kms_addfb_basic (bad-pitch-65536)
[286.933207] Starting subtest: bad-pitch-65536
[286.933746] Subtest bad-pitch-65536: SUCCESS (0.000s)
[287.979615] [111/133] (752s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[288.035418] Starting subtest: etime-multi-wait-all-available-unsubmitted
[288.142428] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.107s)
[288.278314] [112/133] (752s left) kms_big_fb (linear-32bpp-rotate-0)
[288.769506] Starting subtest: linear-32bpp-rotate-0
[290.256387] Subtest linear-32bpp-rotate-0: SUCCESS (1.486s)
[290.888133] [113/133] (749s left) gem_exec_reloc (basic-concurrent16)
[290.951085] Starting subtest: basic-concurrent16
[296.373984] Subtest basic-concurrent16: SUCCESS (5.424s)
[297.411331] [114/133] (743s left) gem_exec_schedule (in-order)
[297.474435] Subtest in-order: SKIP (0.000s)
[297.709759] [115/133] (743s left) gem_userptr_blits (vma-merge)
[297.797719] Starting subtest: vma-merge
[297.879809] Subtest vma-merge: SUCCESS (0.082s)
[298.040527] [116/133] (742s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[298.528501] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[298.530894] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[299.139893] [117/133] (741s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[299.626359] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[299.627386] Subtest psr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[300.219209] [118/133] (740s left) gem_pxp (reject-modify-context-protection-off-1)
[302.787425] Starting subtest: reject-modify-context-protection-off-1
[302.790156] Subtest reject-modify-context-protection-off-1: SKIP (0.000s)
[302.915485] [119/133] (738s left) perf_pmu (busy-idle-check-all)
[302.969013] Starting subtest: busy-idle-check-all
[302.969661] Starting dynamic subtest: rcs0
[303.593313] Dynamic subtest rcs0: SUCCESS (0.623s)
[303.608587] Starting dynamic subtest: bcs0
[304.220505] Dynamic subtest bcs0: SUCCESS (0.624s)
[304.235757] Starting dynamic subtest: vcs0
[305.343263] Dynamic subtest vcs0: SUCCESS (1.120s)
[305.346207] Subtest busy-idle-check-all: SUCCESS (2.375s)
[305.481596] [120/133] (735s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[305.969905] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[305.971028] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[306.574926] [121/133] (734s left) prime_busy (hang)
[306.637858] Starting subtest: hang
[306.638458] Starting dynamic subtest: rcs0
[312.885361] Dynamic subtest rcs0: SUCCESS (6.246s)
[312.899246] Starting dynamic subtest: bcs0
[318.899367] Dynamic subtest bcs0: SUCCESS (6.012s)
[318.912670] Starting dynamic subtest: vcs0
[324.852486] Dynamic subtest vcs0: SUCCESS (5.951s)
[324.853062] Subtest hang: SUCCESS (18.215s)
[324.991812] [122/133] (716s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[325.475977] Starting subtest: plane-ctm3x4-lut1d
[325.755099] Subtest plane-ctm3x4-lut1d: SKIP (0.280s)
[326.470437] [123/133] (714s left) gem_readwrite (read-bad-handle)
[326.528202] Starting subtest: read-bad-handle
[326.529317] Subtest read-bad-handle: SUCCESS (0.000s)
[326.652293] [124/133] (714s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[327.133735] Starting subtest: primary-y-tiled-reflect-x-180
[327.134838] Subtest primary-y-tiled-reflect-x-180: SKIP (0.002s)
[327.735740] [125/133] (713s left) gem_set_tiling_vs_pwrite
[327.946382] [126/133] (713s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[328.439495] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[328.440641] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[329.046062] [127/133] (712s left) kms_flip (plain-flip-interruptible)
[329.534966] Starting subtest: plain-flip-interruptible
[329.537139] Starting dynamic subtest: A-VGA1
[330.259643] Dynamic subtest A-VGA1: SUCCESS (0.723s)
[330.276538] Starting dynamic subtest: B-VGA1
[330.956343] Dynamic subtest B-VGA1: SUCCESS (0.694s)
[330.975384] Starting dynamic subtest: A-HDMI-A1
[331.693878] Dynamic subtest A-HDMI-A1: SUCCESS (0.734s)
[331.708743] Starting dynamic subtest: B-HDMI-A1
[332.461121] Dynamic subtest B-HDMI-A1: SUCCESS (0.764s)
[332.463438] Subtest plain-flip-interruptible: SUCCESS (2.928s)
[333.231572] [128/133] (708s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[333.726536] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[333.728153] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[334.327354] [129/133] (707s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[334.813473] Starting subtest: addfb25-x-tiled-mismatch-legacy
[334.814106] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[335.409393] [130/133] (706s left) gem_linear_blits (basic)
[336.229874] Starting subtest: basic
[336.241069] Subtest basic: SUCCESS (0.015s)
[336.421821] [131/133] (705s left) gem_mmap_offset (mmap-unmap)
[336.564912] Starting subtest: mmap-unmap
[336.565577] Starting dynamic subtest: smem0
[402.482510] Dynamic subtest smem0: SUCCESS (65.914s)
[402.484544] Subtest mmap-unmap: SUCCESS (65.916s)
[402.706809] [132/133] (638s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[403.203413] Starting subtest: x-tiled-8bpp-rotate-0
[404.357264] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.154s)
[404.997851] [133/133] (636s left) kms_chamelium_audio (hdmi-audio)
[405.560190] Subtest hdmi-audio: SKIP (0.000s)
[405.967293] Closing watchdogs
results: parsing output: 0/ for test: kms_plane_scaling
results: parsing output: 1/ for test: gem_exec_reloc
results: parsing output: 2/ for test: kms_psr
results: parsing output: 3/ for test: kms_psr
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: kms_ccs
results: parsing output: 6/ for test: kms_atomic
results: parsing output: 7/ for test: kms_psr
results: parsing output: 8/ for test: syncobj_wait
results: parsing output: 9/ for test: gem_eio
results: parsing output: 10/ for test: kms_cursor_legacy
results: parsing output: 11/ for test: gem_render_copy
results: parsing output: 12/ for test: kms_cursor_crc
results: parsing output: 13/ for test: gen7_exec_parse
results: parsing output: 14/ for test: sysfs_timeslice_duration
results: parsing output: 15/ for test: sw_sync
results: parsing output: 16/ for test: kms_chamelium_edid
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_lmem_swapping
results: parsing output: 20/ for test: i915_query
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_partial_pwrite_pread
results: parsing output: 23/ for test: kms_cursor_crc
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: kms_plane_scaling
results: parsing output: 26/ for test: kms_getfb
results: parsing output: 27/ for test: api_intel_bb
results: parsing output: 28/ for test: i915_query
results: parsing output: 29/ for test: gem_exec_schedule
results: parsing output: 30/ for test: gem_pxp
results: parsing output: 31/ for test: kms_flip
results: parsing output: 32/ for test: gem_exec_alignment
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_flip
results: parsing output: 35/ for test: perf_pmu
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_vblank
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: syncobj_timeline
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: gem_render_copy_redux
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_cursor_legacy
results: parsing output: 45/ for test: kms_addfb_basic
results: parsing output: 46/ for test: kms_plane_multiple
results: parsing output: 47/ for test: kms_cursor_legacy
results: parsing output: 48/ for test: kms_hdr
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: gem_exec_fence
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: kms_cursor_legacy
results: parsing output: 53/ for test: kms_vblank
results: parsing output: 54/ for test: gem_exec_fence
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_bad_reloc
results: parsing output: 57/ for test: gem_mmap
results: parsing output: 58/ for test: kms_psr2_sf
results: parsing output: 59/ for test: kms_busy
results: parsing output: 60/ for test: i915_drm_fdinfo
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: kms_plane_alpha_blend
results: parsing output: 63/ for test: gem_exec_params
results: parsing output: 64/ for test: kms_flip
results: parsing output: 65/ for test: kms_pm_rpm
results: parsing output: 66/ for test: gem_ctx_param
results: parsing output: 67/ for test: kms_atomic_transition
results: parsing output: 68/ for test: kms_setmode
results: parsing output: 69/ for test: gem_pwrite_snooped
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_flip_scaled_crc
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: kms_prime
results: parsing output: 75/ for test: kms_plane
results: parsing output: 76/ for test: gem_spin_batch
results: parsing output: 77/ for test: gem_pipe_control_store_loop
results: parsing output: 78/ for test: syncobj_wait
results: parsing output: 79/ for test: kms_cursor_edge_walk
results: parsing output: 80/ for test: gem_exec_balancer
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: dmabuf_sync_file
results: parsing output: 84/ for test: kms_atomic_interruptible
results: parsing output: 85/ for test: gem_ctx_engines
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: vgem_basic
results: parsing output: 88/ for test: kms_draw_crc
results: parsing output: 89/ for test: i915_hangman
results: parsing output: 90/ for test: kms_lease
results: parsing output: 91/ for test: kms_psr2_sf
results: parsing output: 92/ for test: prime_mmap
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: kms_content_protection
results: parsing output: 95/ for test: gem_exec_reloc
results: parsing output: 96/ for test: kms_chamelium_hpd
results: parsing output: 97/ for test: gem_ctx_persistence
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_flip_scaled_crc
results: parsing output: 100/ for test: gem_softpin
results: parsing output: 101/ for test: gem_exec_whisper
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: gem_fence_thrash
results: parsing output: 104/ for test: api_intel_allocator
results: parsing output: 105/ for test: kms_ccs
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: i915_pm_rc6_residency
results: parsing output: 109/ for test: kms_addfb_basic
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: gem_exec_reloc
results: parsing output: 113/ for test: gem_exec_schedule
results: parsing output: 114/ for test: gem_userptr_blits
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: gem_pxp
results: parsing output: 118/ for test: perf_pmu
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: prime_busy
results: parsing output: 121/ for test: kms_color_pipeline
results: parsing output: 122/ for test: gem_readwrite
results: parsing output: 123/ for test: kms_rotation_crc
results: parsing output: 124/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_flip
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_addfb_basic
results: parsing output: 129/ for test: gem_linear_blits
results: parsing output: 130/ for test: gem_mmap_offset
results: parsing output: 131/ for test: kms_big_fb
results: parsing output: 132/ for test: kms_chamelium_audio
Done.