[75.771673] Initializing watchdogs
[75.771783]   /dev/watchdog0
[75.790631] [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)
[75.798879] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[75.802643] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[75.805775] [001/131] (960s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[76.194699] Starting subtest: cursorA-vs-flipB-varying-size
[76.195852] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[76.646918] [002/131] (959s left) kms_vblank (query-forked-busy)
[77.014465] Starting subtest: query-forked-busy
[77.016532] Starting dynamic subtest: pipe-A-HDMI-A-1
[79.575402] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.556s)
[79.583660] Starting dynamic subtest: pipe-B-HDMI-A-1
[82.004314] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.425s)
[82.005222] Subtest query-forked-busy: SUCCESS (4.984s)
[82.544254] [003/131] (953s left) syncobj_timeline (transfer-timeline-point)
[82.610594] Starting subtest: transfer-timeline-point
[82.611371] Subtest transfer-timeline-point: SUCCESS (0.001s)
[82.696658] [004/131] (953s left) kms_cursor_crc (cursor-offscreen-512x170)
[83.085556] Starting subtest: cursor-offscreen-512x170
[83.087424] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[83.526370] [005/131] (952s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[83.899651] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[83.901206] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[84.326692] [006/131] (952s left) perf_pmu (busy-no-semaphores)
[84.401455] Starting subtest: busy-no-semaphores
[84.402453] Starting dynamic subtest: rcs0
[84.924676] Dynamic subtest rcs0: SUCCESS (0.522s)
[84.940209] Starting dynamic subtest: bcs0
[85.442367] Dynamic subtest bcs0: SUCCESS (0.517s)
[85.459935] Starting dynamic subtest: vcs0
[86.466772] Dynamic subtest vcs0: SUCCESS (1.023s)
[86.467568] Subtest busy-no-semaphores: SUCCESS (2.063s)
[86.572998] [007/131] (949s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[86.938506] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[86.939955] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[87.390147] [008/131] (949s left) i915_module_load (resize-bar)
[87.445143] Starting subtest: resize-bar
[87.449985] Subtest resize-bar: SKIP (0.006s)
[87.501720] [009/131] (949s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[87.556669] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[87.623792] [010/131] (949s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[87.995092] Starting subtest: psr-rgb101010-draw-pwrite
[87.996586] Subtest psr-rgb101010-draw-pwrite: SKIP (0.000s)
[88.435444] [011/131] (948s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[88.810646] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[88.812073] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[89.255877] [012/131] (947s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[89.693853] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[90.043874] [013/131] (946s left) fbdev (pan)
[90.098562] Starting subtest: pan
[90.138639] Subtest pan: SUCCESS (0.041s)
[90.230076] [014/131] (946s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[90.596094] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[90.826197] [015/131] (946s left) gem_eio (in-flight-internal-1us)
[90.888776] Starting subtest: in-flight-internal-1us
[90.925702] Subtest in-flight-internal-1us: SUCCESS (0.037s)
[91.697496] [016/131] (945s left) gem_exec_params (secure-non-root)
[91.757038] Starting subtest: secure-non-root
[91.758573] Subtest secure-non-root: SKIP (0.000s)
[91.868396] [017/131] (945s left) kms_joiner (basic-force-ultra-joiner)
[92.233386] Starting subtest: basic-force-ultra-joiner
[92.235038] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[92.678677] [018/131] (944s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[92.734514] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[92.736231] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.001s)
[92.826651] [019/131] (944s left) kms_psr (fbc-pr-primary-page-flip)
[93.195593] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[93.419085] [020/131] (943s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[93.476679] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[93.540890] [021/131] (943s left) gem_mmap_gtt (fault-concurrent)
[93.596474] Starting subtest: fault-concurrent
[96.367025] Subtest fault-concurrent: SUCCESS (2.769s)
[96.482433] [022/131] (940s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[96.556222] Starting subtest: map-fixed-invalidate-overlap-busy
[96.556962] Starting dynamic subtest: gtt
[97.639430] Dynamic subtest gtt: SUCCESS (1.082s)
[97.652316] Starting dynamic subtest: wb
[98.691149] Dynamic subtest wb: SUCCESS (1.051s)
[98.704735] Starting dynamic subtest: wc
[99.748084] Dynamic subtest wc: SUCCESS (1.056s)
[99.758765] Starting dynamic subtest: uc
[100.806180] Dynamic subtest uc: SUCCESS (1.058s)
[100.807091] Subtest map-fixed-invalidate-overlap-busy: SUCCESS (4.248s)
[100.940567] [023/131] (936s left) kms_psr (fbc-psr-primary-render)
[101.310225] Subtest fbc-psr-primary-render: SKIP (0.000s)
[101.543627] [024/131] (935s left) gem_eio (wait-wedge-1us)
[101.608975] Starting subtest: wait-wedge-1us
[101.633938] Subtest wait-wedge-1us: SUCCESS (0.027s)
[102.389049] [025/131] (935s left) gem_ppgtt (blt-vs-render-ctxn)
[102.449104] Starting subtest: blt-vs-render-ctxN
[135.279082] Subtest blt-vs-render-ctxN: SUCCESS (32.827s)
[135.395557] [026/131] (902s left) gem_flink_race (flink_name)
[135.525693] Starting subtest: flink_name
[140.899345] Subtest flink_name: SUCCESS (5.373s)
[141.004878] [027/131] (896s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[141.073446] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[141.176060] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.102s)
[141.279436] [028/131] (896s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[141.339030] Starting subtest: cpuset-medium-copy-XY
[142.955926] Subtest cpuset-medium-copy-XY: SUCCESS (1.620s)
[143.066802] [029/131] (894s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[143.540799] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[143.542322] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[143.982719] [030/131] (893s left) gem_ctx_create (basic-files)
[144.045917] Starting subtest: basic-files
[146.059762] Subtest basic-files: SUCCESS (2.014s)
[146.283225] [031/131] (891s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[146.348648] Starting subtest: y-tiled-ccs-to-yf-tiled
[146.349876] Starting dynamic subtest: smem
[146.351518] Dynamic subtest smem: SKIP (0.000s)
[146.353047] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[146.548831] [032/131] (891s left) gem_exec_reloc (basic-range)
[146.603973] Starting subtest: basic-range
[146.618896] Subtest basic-range: SUCCESS (0.014s)
[147.358287] [033/131] (890s left) syncobj_basic (bad-create-flags)
[147.416590] Starting subtest: bad-create-flags
[147.417309] Subtest bad-create-flags: SUCCESS (0.000s)
[147.508245] [034/131] (890s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[147.876051] Starting subtest: addfb25-y-tiled-legacy
[147.876825] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s)
[148.307108] [035/131] (889s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[148.381043] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[148.381851] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[148.474052] [036/131] (889s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[148.926280] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[149.266111] [037/131] (888s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[149.646292] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[149.648644] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[150.085283] [038/131] (887s left) gem_mmap_gtt (big-copy-xy)
[150.143092] Starting subtest: big-copy-XY
[151.790506] Subtest big-copy-XY: SUCCESS (1.649s)
[151.890640] [039/131] (886s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[152.034839] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s)
[152.115516] [040/131] (886s left) gem_exec_params (no-bsd)
[152.178427] Starting subtest: no-bsd
[152.179256] Subtest no-bsd: SUCCESS (0.000s)
[152.276886] [041/131] (885s left) gem_exec_reloc (basic-gtt-noreloc)
[152.335322] Starting subtest: basic-gtt-noreloc
[152.337794] Subtest basic-gtt-noreloc: SUCCESS (0.003s)
[153.098262] [042/131] (885s left) gem_mmap_gtt (basic-read)
[153.152208] Starting subtest: basic-read
[153.189802] Subtest basic-read: SUCCESS (0.037s)
[153.307245] [043/131] (885s left) gem_mmap_gtt (medium-copy)
[153.358476] Starting subtest: medium-copy
[154.070857] Subtest medium-copy: SUCCESS (0.712s)
[154.174811] [044/131] (884s left) kms_plane_multiple (tiling-yf)
[154.643039] Starting subtest: tiling-yf
[154.644723] Subtest tiling-yf: SKIP (0.000s)
[155.098883] [045/131] (883s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[155.466947] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[155.468313] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[155.905087] [046/131] (882s left) i915_power (sanity)
[155.958758] Starting subtest: sanity
[159.965520] Subtest sanity: SUCCESS (4.006s)
[160.077178] [047/131] (878s left) sw_sync (sync_expired_merge)
[160.141084] Starting subtest: sync_expired_merge
[161.216027] Subtest sync_expired_merge: SUCCESS (1.074s)
[161.289911] [048/131] (877s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[161.662108] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[161.813407] Subtest async-flip-with-page-flip-events-linear-atomic: SKIP (0.152s)
[162.363933] [049/131] (876s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[162.737307] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[162.738621] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[163.179437] [050/131] (875s left) kms_scaling_modes (scaling-mode-center)
[163.549023] Starting subtest: scaling-mode-center
[163.551774] Subtest scaling-mode-center: SKIP (0.000s)
[164.000903] [051/131] (874s left) gem_exec_fence (keep-in-fence)
[164.175635] Subtest keep-in-fence: SKIP (0.000s)
[164.616319] [FACT gem_exec_fence (keep-in-fence)] new: kernel.kmod_is_loaded.vgem: true
[164.619583] [052/131] (874s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[164.994898] Starting subtest: flip-vs-dpms-on-nop-interruptible
[164.996894] Starting dynamic subtest: A-VGA1
[166.064740] Dynamic subtest A-VGA1: SUCCESS (1.068s)
[166.077937] Starting dynamic subtest: B-VGA1
[167.033143] Dynamic subtest B-VGA1: SUCCESS (0.966s)
[167.045954] Starting dynamic subtest: A-HDMI-A1
[168.055658] Dynamic subtest A-HDMI-A1: SUCCESS (1.021s)
[168.068924] Starting dynamic subtest: B-HDMI-A1
[169.104994] Dynamic subtest B-HDMI-A1: SUCCESS (1.047s)
[169.106190] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (4.111s)
[169.769457] [053/131] (869s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[170.153756] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[170.156512] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.001s)
[170.595923] [054/131] (868s left) kms_chamelium_color (ctm-max)
[170.959753] Subtest ctm-max: SKIP (0.000s)
[171.187119] [055/131] (867s left) syncobj_eventfd (binary-wait)
[171.246942] Starting subtest: binary-wait
[171.259156] Subtest binary-wait: SUCCESS (0.012s)
[171.362562] [056/131] (867s left) api_intel_bb (render)
[171.418473] Starting subtest: render
[171.419440] Starting dynamic subtest: render-none-512
[171.502963] Dynamic subtest render-none-512: SUCCESS (0.084s)
[171.515933] Starting dynamic subtest: render-none-reloc-512
[171.587765] Dynamic subtest render-none-reloc-512: SUCCESS (0.085s)
[171.599808] Starting dynamic subtest: render-none-1024
[171.914557] Dynamic subtest render-none-1024: SUCCESS (0.325s)
[171.927373] Starting dynamic subtest: render-none-reloc-1024
[172.239530] Dynamic subtest render-none-reloc-1024: SUCCESS (0.324s)
[172.250963] Starting dynamic subtest: render-x-512
[172.316534] Dynamic subtest render-x-512: SUCCESS (0.077s)
[172.329689] Starting dynamic subtest: render-x-reloc-512
[172.392125] Dynamic subtest render-x-reloc-512: SUCCESS (0.074s)
[172.403692] Starting dynamic subtest: render-x-1024
[172.683042] Dynamic subtest render-x-1024: SUCCESS (0.289s)
[172.694826] Starting dynamic subtest: render-x-reloc-1024
[172.973966] Dynamic subtest render-x-reloc-1024: SUCCESS (0.290s)
[172.986069] Starting dynamic subtest: render-y-512
[173.050163] Dynamic subtest render-y-512: SUCCESS (0.076s)
[173.061888] Starting dynamic subtest: render-y-reloc-512
[173.126470] Dynamic subtest render-y-reloc-512: SUCCESS (0.075s)
[173.138882] Starting dynamic subtest: render-y-1024
[173.417745] Dynamic subtest render-y-1024: SUCCESS (0.290s)
[173.429352] Starting dynamic subtest: render-y-reloc-1024
[173.708969] Dynamic subtest render-y-reloc-1024: SUCCESS (0.290s)
[173.710036] Subtest render: SUCCESS (2.291s)
[173.839523] [057/131] (865s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[173.898243] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[173.964258] [058/131] (865s left) gem_ctx_freq (sysfs)
[174.025205] Starting subtest: sysfs
[174.026146] Starting dynamic subtest: gt0
[179.044744] Dynamic subtest gt0: SUCCESS (5.020s)
[179.046187] Subtest sysfs: SUCCESS (5.021s)
[179.145560] [059/131] (860s left) gem_lmem_swapping (parallel-random-engines)
[179.200834] Subtest parallel-random-engines: SKIP (0.000s)
[179.258352] [060/131] (859s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[179.631137] Starting subtest: fbcpsr-suspend
[179.632457] Subtest fbcpsr-suspend: SKIP (0.000s)
[180.075250] [061/131] (859s left) syncobj_timeline (single-wait-all-available-submitted)
[180.131841] Starting subtest: single-wait-all-available-submitted
[180.132660] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[180.225154] [062/131] (859s left) kms_pm_dc (dc6-dpms)
[191.324342] Subtest dc6-dpms: SKIP (0.000s)
[191.390479] [063/131] (847s left) gem_eio (in-flight-contexts-1us)
[191.462096] Starting subtest: in-flight-contexts-1us
[194.828870] Subtest in-flight-contexts-1us: SUCCESS (3.369s)
[195.603933] [064/131] (843s left) kms_prop_blob (blob-prop-core)
[195.660787] Starting subtest: blob-prop-core
[195.661508] Subtest blob-prop-core: SUCCESS (0.000s)
[195.759716] [065/131] (843s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[196.127411] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[196.128891] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[196.577233] [066/131] (842s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[196.948725] Starting subtest: primary-y-tiled-reflect-x-180
[196.950213] Subtest primary-y-tiled-reflect-x-180: SKIP (0.001s)
[197.391639] [067/131] (842s left) gen7_exec_parse (bitmasks)
[197.452165] Subtest bitmasks: SKIP (0.000s)
[197.528886] [068/131] (842s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[197.891410] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[211.559316] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (13.668s)
[212.116336] [069/131] (827s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[212.490642] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[212.491918] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[212.932300] [070/131] (826s left) i915_drm_fdinfo (virtual-busy-hang)
[212.997309] Subtest virtual-busy-hang: SKIP (0.000s)
[213.058805] [071/131] (826s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[213.122057] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[213.123753] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[213.328433] [072/131] (826s left) kms_lease (implicit-plane-lease)
[213.693481] Starting subtest: implicit-plane-lease
[213.697273] Subtest implicit-plane-lease: SUCCESS (0.003s)
[214.148600] [073/131] (825s left) kms_draw_crc (draw-method-mmap-wc)
[214.518537] Starting subtest: draw-method-mmap-wc
[214.520430] Starting dynamic subtest: xrgb8888-untiled
[214.792170] Dynamic subtest xrgb8888-untiled: SUCCESS (0.272s)
[214.808791] Starting dynamic subtest: rgb565-untiled
[215.074939] Dynamic subtest rgb565-untiled: SUCCESS (0.281s)
[215.091741] Starting dynamic subtest: xrgb2101010-untiled
[215.374483] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.297s)
[215.388445] Starting dynamic subtest: xbgr16161616f-untiled
[215.707109] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.330s)
[215.723852] Starting dynamic subtest: xrgb8888-xtiled
[215.891517] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.181s)
[215.905634] Starting dynamic subtest: rgb565-xtiled
[216.056459] Dynamic subtest rgb565-xtiled: SUCCESS (0.164s)
[216.070528] Starting dynamic subtest: xrgb2101010-xtiled
[216.223116] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.164s)
[216.235733] Starting dynamic subtest: xbgr16161616f-xtiled
[216.422393] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.198s)
[216.423696] Subtest draw-method-mmap-wc: SUCCESS (1.904s)
[216.890880] [074/131] (823s left) kms_rotation_crc (sprite-rotation-180)
[217.250903] Starting subtest: sprite-rotation-180
[220.571815] Subtest sprite-rotation-180: SUCCESS (3.322s)
[221.191206] [075/131] (818s left) gem_eio (kms)
[221.566752] Starting subtest: kms
[234.007293] Subtest kms: SUCCESS (12.440s)
[234.608144] [076/131] (805s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[235.026117] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[235.265190] [077/131] (804s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[235.632893] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[235.634169] Subtest fbcpsr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[236.077903] [078/131] (804s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[236.135643] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s)
[236.199565] [079/131] (804s left) perf_pmu (render-node-busy)
[236.263472] Starting subtest: render-node-busy
[236.264218] Starting dynamic subtest: rcs0
[236.805500] Dynamic subtest rcs0: SUCCESS (0.542s)
[236.830491] Starting dynamic subtest: bcs0
[237.352555] Dynamic subtest bcs0: SUCCESS (0.544s)
[237.369236] Starting dynamic subtest: vcs0
[238.394486] Dynamic subtest vcs0: SUCCESS (1.039s)
[238.395843] Subtest render-node-busy: SUCCESS (2.133s)
[238.501354] [080/131] (801s left) gem_mmap (basic-small-bo)
[238.554685] Starting subtest: basic-small-bo
[238.973099] Subtest basic-small-bo: SUCCESS (0.418s)
[239.097476] [081/131] (801s left) gem_exec_reloc (basic-cpu-noreloc)
[239.242807] Starting subtest: basic-cpu-noreloc
[239.244932] Subtest basic-cpu-noreloc: SUCCESS (0.002s)
[240.017788] [082/131] (800s left) kms_3d
[243.887496] [083/131] (796s left) gem_userptr_blits (vma-merge)
[243.974226] Starting subtest: vma-merge
[244.060867] Subtest vma-merge: SUCCESS (0.086s)
[244.190501] [084/131] (796s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[244.254217] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[244.359887] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.105s)
[244.453837] [085/131] (796s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[244.507685] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SKIP (0.000s)
[244.581182] [086/131] (796s left) kms_flip (nonblocking-read)
[244.940633] Starting subtest: nonblocking-read
[244.941278] Subtest nonblocking-read: SUCCESS (0.000s)
[245.397163] [087/131] (795s left) gem_create (create-ext-placement-all)
[245.570343] Starting subtest: create-ext-placement-all
[245.571230] Subtest create-ext-placement-all: SUCCESS (0.000s)
[245.682912] [088/131] (795s left) syncobj_wait (invalid-reset-one-illegal-handle)
[245.737448] Starting subtest: invalid-reset-one-illegal-handle
[245.738132] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[245.834383] [089/131] (794s left) kms_psr (fbc-psr2-suspend)
[246.202732] Subtest fbc-psr2-suspend: SKIP (0.000s)
[246.440780] [090/131] (794s left) kms_cursor_edge_walk (64x64-left-edge)
[246.800322] Starting subtest: 64x64-left-edge
[246.802232] Starting dynamic subtest: pipe-A-HDMI-A-1
[250.280453] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.478s)
[250.293559] Starting dynamic subtest: pipe-B-HDMI-A-1
[253.607166] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.325s)
[253.607785] Subtest 64x64-left-edge: SUCCESS (6.808s)
[254.168335] [091/131] (786s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[254.545762] Starting subtest: y-tiled-32bpp-rotate-90
[254.547206] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[254.981852] [092/131] (785s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[255.351781] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[255.353248] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[255.808729] [093/131] (785s left) kms_cursor_crc (cursor-random-256x85)
[256.183555] Starting subtest: cursor-random-256x85
[256.244833] Subtest cursor-random-256x85: SKIP (0.060s)
[256.697682] [094/131] (784s left) kms_psr (psr2-primary-mmap-cpu)
[257.064055] Subtest psr2-primary-mmap-cpu: SKIP (0.000s)
[257.305172] [095/131] (783s left) syncobj_timeline (invalid-transfer-bad-pad)
[257.365018] Starting subtest: invalid-transfer-bad-pad
[257.365664] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[257.459780] [096/131] (783s left) gem_mmap_offset (perf)
[257.515410] Starting subtest: perf
[257.516835] Starting dynamic subtest: smem0
[257.648696] Dynamic subtest smem0: SUCCESS (0.133s)
[257.649357] Subtest perf: SUCCESS (0.135s)
[257.776138] [097/131] (783s left) gem_exercise_blt (fast-copy)
[257.833837] Subtest fast-copy: SKIP (0.000s)
[257.902896] [098/131] (783s left) gem_basic (bad-close)
[257.957832] Starting subtest: bad-close
[257.959257] Subtest bad-close: SUCCESS (0.000s)
[258.058477] [099/131] (783s left) kms_flip (absolute-wf_vblank-interruptible)
[258.429195] Starting subtest: absolute-wf_vblank-interruptible
[258.431366] Starting dynamic subtest: A-VGA1
[266.175976] Dynamic subtest A-VGA1: SUCCESS (7.745s)
[266.190771] Starting dynamic subtest: B-VGA1
[273.881480] Dynamic subtest B-VGA1: SUCCESS (7.703s)
[273.898571] Starting dynamic subtest: A-HDMI-A1
[281.755393] Dynamic subtest A-HDMI-A1: SUCCESS (7.871s)
[281.770561] Starting dynamic subtest: B-HDMI-A1
[289.657631] Dynamic subtest B-HDMI-A1: SUCCESS (7.898s)
[289.660826] Subtest absolute-wf_vblank-interruptible: SUCCESS (31.231s)
[290.303548] [100/131] (751s left) gem_exec_flush (basic-batch-kernel-default-uc)
[290.389182] Starting subtest: basic-batch-kernel-default-uc
[296.026738] Subtest basic-batch-kernel-default-uc: SUCCESS (5.638s)
[296.233439] [101/131] (745s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[296.605150] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[298.544993] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (1.940s)
[299.046278] [102/131] (742s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[299.412325] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[299.413841] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[299.861793] [103/131] (741s left) gem_exec_reloc (basic-wc-active)
[299.926194] Starting subtest: basic-wc-active
[300.036763] Subtest basic-wc-active: SUCCESS (0.110s)
[300.775729] [104/131] (740s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[301.144917] Starting subtest: extended-modeset-hang-oldfb-with-reset
[301.146824] Starting dynamic subtest: pipe-A
[311.684324] Dynamic subtest pipe-A: SUCCESS (10.536s)
[311.697516] Starting dynamic subtest: pipe-B
[322.433962] Dynamic subtest pipe-B: SUCCESS (10.747s)
[322.435098] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (21.288s)
[322.994381] [105/131] (718s left) kms_cursor_crc (cursor-suspend)
[323.376961] Starting subtest: cursor-suspend
[323.378049] Starting dynamic subtest: pipe-A-HDMI-A-1
[357.469103] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.931s)
[357.485169] Starting dynamic subtest: pipe-B-HDMI-A-1
[392.491497] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.021s)
[392.492266] Subtest cursor-suspend: SUCCESS (3.956s)
[400.070871] [106/131] (648s left) syncobj_wait (single-wait-all-for-submit-signaled)
[400.159212] Starting subtest: single-wait-all-for-submit-signaled
[400.159909] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[400.261859] [107/131] (648s left) syncobj_wait (multi-wait-submitted)
[400.320611] Starting subtest: multi-wait-submitted
[400.424043] Subtest multi-wait-submitted: SUCCESS (0.104s)
[400.527768] [108/131] (648s left) gem_render_copy (y-tiled)
[400.596510] Starting subtest: y-tiled
[400.597235] Starting dynamic subtest: smem
[400.662909] Dynamic subtest smem: SUCCESS (0.066s)
[400.663839] Subtest y-tiled: SUCCESS (0.067s)
[400.875095] [109/131] (648s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[400.933658] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.000s)
[401.003006] [110/131] (647s left) api_intel_allocator (reloc-allocator)
[401.058734] Starting subtest: reloc-allocator
[401.059397] Starting dynamic subtest: basic
[401.064139] Dynamic subtest basic: SUCCESS (0.005s)
[401.083990] Starting dynamic subtest: parallel-one
[401.084762] Dynamic subtest parallel-one: SUCCESS (0.007s)
[401.101310] Starting dynamic subtest: print
[401.102253] Dynamic subtest print: SUCCESS (0.000s)
[401.116377] Starting dynamic subtest: reuse
[401.117432] Dynamic subtest reuse: SUCCESS (0.000s)
[401.140548] Starting dynamic subtest: fork-reopen-allocator
[401.141759] Dynamic subtest fork-reopen-allocator: SUCCESS (0.017s)
[401.142646] Subtest reloc-allocator: SUCCESS (0.037s)
[401.225578] [111/131] (647s left) kms_properties (crtc-properties-atomic)
[401.588352] Starting subtest: crtc-properties-atomic
[401.589093] Starting dynamic subtest: pipe-A-HDMI-A-1
[401.820054] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.231s)
[401.836640] Starting dynamic subtest: pipe-B-HDMI-A-1
[402.128768] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.306s)
[402.129694] Subtest crtc-properties-atomic: SUCCESS (0.543s)
[402.685539] [112/131] (646s left) gen9_exec_parse (bb-secure)
[402.745213] Subtest bb-secure: SKIP (0.000s)
[402.810584] [113/131] (646s left) gem_exec_schedule (fifo)
[402.883251] Starting subtest: fifo
[402.884098] Starting dynamic subtest: rcs0
[402.914421] Dynamic subtest rcs0: SUCCESS (0.030s)
[402.932956] Starting dynamic subtest: bcs0
[402.944570] Dynamic subtest bcs0: SUCCESS (0.028s)
[402.945464] Subtest fifo: SUCCESS (0.062s)
[403.185477] [114/131] (645s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[403.557475] Starting subtest: x-tiled-32bpp-rotate-180
[405.006168] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.449s)
[405.491031] [115/131] (643s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[405.856563] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[405.857936] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[406.313441] [116/131] (642s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[406.629000] Starting subtest: syncobj-timeline-invalid-flags
[406.629784] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.001s)
[406.879291] [117/131] (642s left) kms_writeback (writeback-fb-id)
[407.247771] Subtest writeback-fb-id: SKIP (0.000s)
[407.484047] [118/131] (641s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[407.850794] Starting subtest: compare-crc-sanitycheck-nv12
[407.851447] Starting dynamic subtest: pipe-A-HDMI-A-1
[407.852624] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[407.867511] Starting dynamic subtest: pipe-B-HDMI-A-1
[407.868704] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[407.869992] Subtest compare-crc-sanitycheck-nv12: SKIP (0.005s)
[408.305676] [119/131] (641s left) gem_ctx_persistence (legacy-engines-mixed)
[408.366328] Subtest legacy-engines-mixed: SKIP (0.000s)
[408.453777] [120/131] (641s left) gem_exec_schedule (submit-early-slice)
[408.519040] Subtest submit-early-slice: SKIP (0.000s)
[408.721740] [121/131] (640s left) kms_plane_scaling (planes-scaler-unity-scaling)
[409.079989] Starting subtest: planes-scaler-unity-scaling
[409.080765] Starting dynamic subtest: pipe-A
[409.082642] Dynamic subtest pipe-A: SKIP (0.001s)
[409.097664] Starting dynamic subtest: pipe-B
[409.099707] Dynamic subtest pipe-B: SKIP (0.001s)
[409.100907] Subtest planes-scaler-unity-scaling: SKIP (0.006s)
[409.539394] [122/131] (640s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[409.912231] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[409.913594] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[410.353621] [123/131] (639s left) gem_ctx_persistence (heartbeat-hostile)
[410.418113] Subtest heartbeat-hostile: SKIP (0.000s)
[410.495460] [124/131] (639s left) kms_plane (plane-position-hole)
[410.859396] Starting subtest: plane-position-hole
[411.126152] Starting dynamic subtest: pipe-A-plane-1
[411.568555] Dynamic subtest pipe-A-plane-1: SUCCESS (0.442s)
[411.583190] Starting dynamic subtest: pipe-A-plane-2
[411.584494] Dynamic subtest pipe-A-plane-2: SUCCESS (0.009s)
[411.887982] Starting dynamic subtest: pipe-B-plane-1
[412.331186] Dynamic subtest pipe-B-plane-1: SUCCESS (0.453s)
[412.345910] Starting dynamic subtest: pipe-B-plane-2
[412.347683] Dynamic subtest pipe-B-plane-2: SUCCESS (0.009s)
[412.348561] Subtest plane-position-hole: SUCCESS (1.481s)
[412.911243] [125/131] (636s left) vgem_basic (dmabuf-export)
[412.981714] Starting subtest: dmabuf-export
[412.983331] Subtest dmabuf-export: SUCCESS (0.003s)
[413.100982] [126/131] (636s left) gem_exec_balancer (sequential)
[413.162966] Subtest sequential: SKIP (0.000s)
[413.264656] [127/131] (636s left) gem_pwrite (basic-exhaustion)
[413.318762] Starting subtest: basic-exhaustion
[418.854697] Subtest basic-exhaustion: SUCCESS (5.533s)
[418.973455] [128/131] (631s left) kms_psr (psr-primary-mmap-cpu)
[419.335881] Subtest psr-primary-mmap-cpu: SKIP (0.000s)
[419.580725] [129/131] (630s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[419.952448] Starting subtest: 4-tiled-8bpp-rotate-270
[419.953954] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.000s)
[420.419937] [130/131] (629s left) gem_exec_schedule (u-semaphore-user)
[420.496367] Subtest u-semaphore-user: SKIP (0.000s)
[420.705974] [131/131] (629s left) vgem_basic (bad-handle)
[420.776766] Starting subtest: bad-handle
[420.777377] Subtest bad-handle: SUCCESS (0.000s)
[420.860250] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_legacy
results: parsing output: 1/ for test: kms_vblank
results: parsing output: 2/ for test: syncobj_timeline
results: parsing output: 3/ for test: kms_cursor_crc
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: perf_pmu
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: i915_module_load
results: parsing output: 8/ for test: kms_ccs
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_chamelium_frames
results: parsing output: 12/ for test: fbdev
results: parsing output: 13/ for test: kms_psr2_sf
results: parsing output: 14/ for test: gem_eio
results: parsing output: 15/ for test: gem_exec_params
results: parsing output: 16/ for test: kms_joiner
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: gem_mmap_gtt
results: parsing output: 21/ for test: gem_userptr_blits
results: parsing output: 22/ for test: kms_psr
results: parsing output: 23/ for test: gem_eio
results: parsing output: 24/ for test: gem_ppgtt
results: parsing output: 25/ for test: gem_flink_race
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: gem_mmap_gtt
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: gem_ctx_create
results: parsing output: 30/ for test: gem_render_copy
results: parsing output: 31/ for test: gem_exec_reloc
results: parsing output: 32/ for test: syncobj_basic
results: parsing output: 33/ for test: kms_addfb_basic
results: parsing output: 34/ for test: syncobj_wait
results: parsing output: 35/ for test: kms_chamelium_hpd
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_mmap_gtt
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: gem_exec_params
results: parsing output: 40/ for test: gem_exec_reloc
results: parsing output: 41/ for test: gem_mmap_gtt
results: parsing output: 42/ for test: gem_mmap_gtt
results: parsing output: 43/ for test: kms_plane_multiple
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: i915_power
results: parsing output: 46/ for test: sw_sync
results: parsing output: 47/ for test: kms_async_flips
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_scaling_modes
results: parsing output: 50/ for test: gem_exec_fence
results: parsing output: 51/ for test: kms_flip
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: kms_chamelium_color
results: parsing output: 54/ for test: syncobj_eventfd
results: parsing output: 55/ for test: api_intel_bb
results: parsing output: 56/ for test: kms_ccs
results: parsing output: 57/ for test: gem_ctx_freq
results: parsing output: 58/ for test: gem_lmem_swapping
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: kms_pm_dc
results: parsing output: 62/ for test: gem_eio
results: parsing output: 63/ for test: kms_prop_blob
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_rotation_crc
results: parsing output: 66/ for test: gen7_exec_parse
results: parsing output: 67/ for test: kms_cursor_legacy
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: i915_drm_fdinfo
results: parsing output: 70/ for test: gem_render_copy
results: parsing output: 71/ for test: kms_lease
results: parsing output: 72/ for test: kms_draw_crc
results: parsing output: 73/ for test: kms_rotation_crc
results: parsing output: 74/ for test: gem_eio
results: parsing output: 75/ for test: kms_psr2_sf
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_flip_scaled_crc
results: parsing output: 78/ for test: perf_pmu
results: parsing output: 79/ for test: gem_mmap
results: parsing output: 80/ for test: gem_exec_reloc
results: parsing output: 81/ for test: kms_3d
results: parsing output: 82/ for test: gem_userptr_blits
results: parsing output: 83/ for test: syncobj_wait
results: parsing output: 84/ for test: kms_flip_scaled_crc
results: parsing output: 85/ for test: kms_flip
results: parsing output: 86/ for test: gem_create
results: parsing output: 87/ for test: syncobj_wait
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: kms_cursor_edge_walk
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_cursor_crc
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: gem_mmap_offset
results: parsing output: 96/ for test: gem_exercise_blt
results: parsing output: 97/ for test: gem_basic
results: parsing output: 98/ for test: kms_flip
results: parsing output: 99/ for test: gem_exec_flush
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: gem_exec_reloc
results: parsing output: 103/ for test: kms_busy
results: parsing output: 104/ for test: kms_cursor_crc
results: parsing output: 105/ for test: syncobj_wait
results: parsing output: 106/ for test: syncobj_wait
results: parsing output: 107/ for test: gem_render_copy
results: parsing output: 108/ for test: kms_ccs
results: parsing output: 109/ for test: api_intel_allocator
results: parsing output: 110/ for test: kms_properties
results: parsing output: 111/ for test: gen9_exec_parse
results: parsing output: 112/ for test: gem_exec_schedule
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: gem_exec_fence
results: parsing output: 116/ for test: kms_writeback
results: parsing output: 117/ for test: kms_pipe_crc_basic
results: parsing output: 118/ for test: gem_ctx_persistence
results: parsing output: 119/ for test: gem_exec_schedule
results: parsing output: 120/ for test: kms_plane_scaling
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gem_ctx_persistence
results: parsing output: 123/ for test: kms_plane
results: parsing output: 124/ for test: vgem_basic
results: parsing output: 125/ for test: gem_exec_balancer
results: parsing output: 126/ for test: gem_pwrite
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: gem_exec_schedule
results: parsing output: 130/ for test: vgem_basic
Done.