[70.273708] Initializing watchdogs [70.273862] /dev/watchdog0 [70.293958] [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) [70.301781] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [70.305371] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [70.309490] [001/133] (960s left) syncobj_wait (single-wait-for-submit-signaled) [70.386172] Starting subtest: single-wait-for-submit-signaled [70.387901] Subtest single-wait-for-submit-signaled: SUCCESS (0.001s) [70.497861] [002/133] (960s left) gem_bad_reloc (negative-reloc) [70.569387] Starting subtest: negative-reloc [70.573300] Subtest negative-reloc: SKIP (0.000s) [70.700329] [003/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc) [71.191104] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc [71.195097] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [71.299619] [004/133] (959s left) kms_cursor_crc (cursor-sliding-256x85) [71.806868] Starting subtest: cursor-sliding-256x85 [71.862498] Subtest cursor-sliding-256x85: SKIP (0.053s) [71.967708] [005/133] (959s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [72.463231] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip [72.467522] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s) [72.573553] [006/133] (958s left) api_intel_allocator (standalone) [72.637253] Starting subtest: standalone [72.664966] Subtest standalone: SUCCESS (0.029s) [72.790184] [007/133] (958s left) kms_cursor_crc (cursor-random-64x21) [73.276830] Starting subtest: cursor-random-64x21 [73.330781] Subtest cursor-random-64x21: SKIP (0.051s) [73.443799] [008/133] (957s left) kms_psr (psr2-sprite-blt) [73.922991] Subtest psr2-sprite-blt: SKIP (0.000s) [73.972544] [009/133] (957s left) gem_exec_reloc (basic-wc-cpu-active) [74.046155] Starting subtest: basic-wc-cpu-active [74.156780] Subtest basic-wc-cpu-active: SUCCESS (0.111s) [74.660472] [010/133] (956s left) gem_spin_batch (spin-all) [74.735681] Starting subtest: spin-all [74.737416] Subtest spin-all: SUCCESS (0.003s) [74.930396] [011/133] (956s left) syncobj_wait (wait-delayed-signal) [74.990516] Starting subtest: wait-delayed-signal [75.094118] Subtest wait-delayed-signal: SUCCESS (0.102s) [75.181892] [012/133] (956s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf) [75.661694] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s) [75.729935] [013/133] (955s left) gem_mmap_gtt (cpuset-basic-small-copy-xy) [75.790520] Starting subtest: cpuset-basic-small-copy-XY [77.089485] Subtest cpuset-basic-small-copy-XY: SUCCESS (1.300s) [77.205953] [014/133] (954s left) gem_exec_schedule (u-semaphore-resolve) [77.367321] Subtest u-semaphore-resolve: SKIP (0.000s) [77.551982] [015/133] (953s left) syncobj_wait (single-wait-for-submit-submitted) [77.615911] Starting subtest: single-wait-for-submit-submitted [77.724923] Subtest single-wait-for-submit-submitted: SUCCESS (0.107s) [77.823545] [016/133] (953s left) kms_3d (basic) [77.885946] Starting subtest: basic [81.391719] Subtest basic: SUCCESS (3.505s) [81.761260] [017/133] (949s left) kms_ccs (crc-primary-basic-yf-tiled-ccs) [81.824508] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.000s) [81.883039] [018/133] (949s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc) [82.382593] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc [82.386218] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [82.477466] [019/133] (949s left) sw_sync (sync_merge) [82.540912] Starting subtest: sync_merge [82.543112] Subtest sync_merge: SUCCESS (0.000s) [82.610912] [020/133] (949s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs) [82.674987] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SKIP (0.000s) [82.720930] [021/133] (949s left) gem_ctx_persistence (engines-hostile) [82.788245] Subtest engines-hostile: SKIP (0.000s) [82.848264] [022/133] (948s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu) [83.334100] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu [83.338131] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [83.427840] [023/133] (948s left) kms_color_pipeline (plane-lut1d-post-ctm3x4) [83.904214] Starting subtest: plane-lut1d-post-ctm3x4 [84.523507] Subtest plane-lut1d-post-ctm3x4: SKIP (0.618s) [84.759569] [024/133] (947s left) kms_plane_cursor (viewport) [85.262196] Starting subtest: viewport [85.266313] Starting dynamic subtest: pipe-A-VGA-1-size-64 [88.035391] Dynamic subtest pipe-A-VGA-1-size-64: SUCCESS (2.772s) [88.095373] Starting dynamic subtest: pipe-A-VGA-1-size-128 [90.793902] Dynamic subtest pipe-A-VGA-1-size-128: SUCCESS (2.708s) [90.854042] Starting dynamic subtest: pipe-A-VGA-1-size-256 [93.551923] Dynamic subtest pipe-A-VGA-1-size-256: SUCCESS (2.708s) [93.670905] Starting dynamic subtest: pipe-B-HDMI-A-1-size-64 [96.466658] Dynamic subtest pipe-B-HDMI-A-1-size-64: SUCCESS (2.804s) [96.526471] Starting dynamic subtest: pipe-B-HDMI-A-1-size-128 [99.226776] Dynamic subtest pipe-B-HDMI-A-1-size-128: SUCCESS (2.711s) [99.288337] Starting dynamic subtest: pipe-B-HDMI-A-1-size-256 [101.988062] Dynamic subtest pipe-B-HDMI-A-1-size-256: SUCCESS (2.711s) [102.121320] Subtest viewport: SUCCESS (16.860s) [102.359808] [025/133] (929s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all) [102.427146] Subtest enable-vfs-bind-unbind-each-numvfs-all: SKIP (0.000s) [102.484172] [026/133] (929s left) kms_pm_rpm (fences) [114.296954] Subtest fences: SKIP (0.000s) [114.351280] [027/133] (917s left) perf_pmu (faulting-read) [114.438583] Starting subtest: faulting-read [114.440158] Starting dynamic subtest: gtt [114.441854] Dynamic subtest gtt: SUCCESS (0.002s) [114.456676] Starting dynamic subtest: wb [114.458753] Dynamic subtest wb: SUCCESS (0.001s) [114.472710] Starting dynamic subtest: wc [114.475027] Dynamic subtest wc: SUCCESS (0.001s) [114.488835] Starting dynamic subtest: uc [114.491095] Dynamic subtest uc: SUCCESS (0.001s) [114.493241] Subtest faulting-read: SUCCESS (0.006s) [114.557421] [028/133] (917s left) gem_mmap_offset (bad-object) [114.624027] Starting subtest: bad-object [114.626363] Subtest bad-object: SUCCESS (0.002s) [114.731281] [029/133] (917s left) kms_pwrite_crc [115.958851] [030/133] (916s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render) [116.452302] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render [116.456235] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [116.560801] [031/133] (915s left) vgem_basic (busy-fence) [116.680191] Starting subtest: busy-fence [116.683221] Subtest busy-fence: SUCCESS (0.001s) [116.756418] [FACT vgem_basic (busy-fence)] new: kernel.kmod_is_loaded.vgem: true [116.760112] [032/133] (915s left) gem_workarounds (suspend-resume-context) [116.837595] Starting subtest: suspend-resume-context [134.011430] Subtest suspend-resume-context: SUCCESS (0.645s) [142.186956] [033/133] (898s left) gem_pxp (display-protected-crc) [144.821606] Starting subtest: display-protected-crc [144.825619] Subtest display-protected-crc: SKIP (0.000s) [144.916472] [034/133] (895s left) syncobj_timeline (multi-wait-all-available-submitted) [144.992565] Starting subtest: multi-wait-all-available-submitted [144.994375] Subtest multi-wait-all-available-submitted: SUCCESS (0.002s) [145.104148] [035/133] (895s left) syncobj_wait (single-wait-signaled) [145.167467] Starting subtest: single-wait-signaled [145.169270] Subtest single-wait-signaled: SUCCESS (0.000s) [145.274829] [036/133] (895s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt) [145.773508] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt [147.283117] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (1.474s) [147.529572] [037/133] (893s left) perf (non-zero-reason) [147.697992] Subtest non-zero-reason: SKIP (0.000s) [147.758371] [038/133] (892s left) kms_cursor_crc (cursor-onscreen-64x64) [148.248769] Starting subtest: cursor-onscreen-64x64 [148.265893] Starting dynamic subtest: pipe-A-VGA-1 [150.587175] Dynamic subtest pipe-A-VGA-1: SUCCESS (2.282s) [150.630078] Starting dynamic subtest: pipe-B-HDMI-A-1 [152.869888] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.225s) [152.871606] Subtest cursor-onscreen-64x64: SUCCESS (4.552s) [153.148311] [039/133] (887s left) gem_mmap (basic) [153.213206] Starting subtest: basic [153.222039] Subtest basic: SUCCESS (0.000s) [153.328593] [040/133] (887s left) kms_lease (lease-get) [153.816887] Starting subtest: lease-get [153.818635] Starting dynamic subtest: pipe-A-VGA-1 [153.820416] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.001s) [153.835531] Starting dynamic subtest: pipe-A-HDMI-A-1 [153.837315] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.000s) [153.852536] Starting dynamic subtest: pipe-B-VGA-1 [153.854774] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.001s) [153.871767] Starting dynamic subtest: pipe-B-HDMI-A-1 [153.873942] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s) [153.876106] Subtest lease-get: SUCCESS (0.008s) [153.925872] [041/133] (886s left) kms_content_protection (legacy-hdcp14) [154.427908] Starting subtest: legacy-hdcp14 [154.431380] Subtest legacy-hdcp14: SKIP (0.000s) [154.540098] [042/133] (886s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt) [155.031244] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt [155.035263] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s) [155.145143] [043/133] (885s left) gem_exec_big (single) [155.207536] Starting subtest: single [158.255952] Subtest single: SUCCESS (3.026s) [158.996509] [044/133] (882s left) i915_pm_rpm (gem-execbuf-stress) [170.913295] Subtest gem-execbuf-stress: SKIP (0.000s) [170.980479] [045/133] (870s left) kms_chamelium_color (ctm-red-to-blue) [171.463565] Subtest ctm-red-to-blue: SKIP (0.000s) [171.536914] [046/133] (869s left) gem_ctx_persistence (hostile) [171.606408] Subtest hostile: SKIP (0.000s) [171.667894] [047/133] (869s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render) [172.153512] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render [174.130147] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SUCCESS (1.977s) [174.263535] [048/133] (866s left) gem_exec_nop (basic-parallel) [174.337252] Starting subtest: basic-parallel [177.126373] Subtest basic-parallel: SUCCESS (2.785s) [177.342333] [049/133] (863s left) gem_userptr_blits (sync-overlap) [177.420184] Starting subtest: sync-overlap [177.421799] Subtest sync-overlap: SUCCESS (0.000s) [177.546433] [050/133] (863s left) kms_fbcon_fbt (psr-suspend) [177.609611] Starting subtest: psr-suspend [177.613775] Subtest psr-suspend: SKIP (0.000s) [177.777228] [051/133] (863s left) gem_exec_whisper (basic-queues-all) [177.854414] Starting subtest: basic-queues-all [177.860936] Subtest basic-queues-all: SKIP (0.003s) [178.061492] [052/133] (863s left) kms_atomic_interruptible (atomic-setmode) [178.550423] Starting subtest: atomic-setmode [178.552194] Starting dynamic subtest: pipe-A-VGA-1 [184.811661] Dynamic subtest pipe-A-VGA-1: SUCCESS (6.258s) [184.813687] Subtest atomic-setmode: SUCCESS (6.259s) [185.074270] [053/133] (856s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs) [185.140830] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SKIP (0.000s) [185.199502] [054/133] (856s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt) [185.685756] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt [185.689746] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [185.790369] [055/133] (855s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs) [185.865850] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs [185.867657] Starting dynamic subtest: smem [185.871978] Dynamic subtest smem: SKIP (0.000s) [185.876244] Subtest yf-tiled-ccs-to-y-tiled-ccs: SKIP (0.001s) [186.071456] [056/133] (855s left) kms_big_fb (4-tiled-32bpp-rotate-90) [186.562911] Starting subtest: 4-tiled-32bpp-rotate-90 [186.567256] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.000s) [186.684011] [057/133] (855s left) gem_exec_reloc (basic-cpu-noreloc) [186.756311] Starting subtest: basic-cpu-noreloc [186.758145] Subtest basic-cpu-noreloc: SUCCESS (0.002s) [187.272659] [058/133] (854s left) i915_drm_fdinfo (busy-check-all) [187.336867] Subtest busy-check-all: SKIP (0.000s) [187.403837] [059/133] (854s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu) [187.890108] Starting subtest: fbc-rgb565-draw-mmap-cpu [189.647524] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (1.757s) [189.873818] [060/133] (852s left) kms_chamelium_color (ctm-limited-range) [190.350394] Subtest ctm-limited-range: SKIP (0.000s) [190.414142] [061/133] (851s left) kms_chamelium_hpd (dp-hpd-fast) [191.019673] Subtest dp-hpd-fast: SKIP (0.000s) [191.235381] [062/133] (850s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling) [191.307380] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s) [191.364510] [063/133] (850s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled) [191.430954] Starting subtest: yf-tiled-ccs-to-yf-tiled [191.433171] Starting dynamic subtest: smem [191.437213] Dynamic subtest smem: SKIP (0.000s) [191.441387] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.001s) [191.632330] [064/133] (850s left) gem_exec_balancer (bonded-sync) [191.696613] Subtest bonded-sync: SKIP (0.000s) [191.802912] [065/133] (850s left) kms_flip (2x-flip-vs-modeset-vs-hang) [192.287671] Starting subtest: 2x-flip-vs-modeset-vs-hang [192.289482] Starting dynamic subtest: AB-VGA1-HDMI-A1 [204.267263] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (11.969s) [204.270275] Subtest 2x-flip-vs-modeset-vs-hang: SUCCESS (11.972s) [204.524878] [066/133] (837s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [205.014167] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip [205.624024] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.608s) [205.899928] [067/133] (836s left) gem_eio (in-flight-internal-immediate) [205.966603] Starting subtest: in-flight-internal-immediate [206.006717] Subtest in-flight-internal-immediate: SUCCESS (0.040s) [206.529802] [068/133] (835s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt) [207.018766] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt [209.019031] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SUCCESS (2.000s) [209.261851] [069/133] (833s left) syncobj_timeline (multi-wait-for-submit-available-signaled) [209.327275] Starting subtest: multi-wait-for-submit-available-signaled [209.329025] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.001s) [209.427530] [070/133] (833s left) kms_flip (flip-vs-panning) [209.910877] Starting subtest: flip-vs-panning [209.912562] Starting dynamic subtest: A-VGA1 [217.727098] Dynamic subtest A-VGA1: SUCCESS (7.814s) [217.743116] Starting dynamic subtest: B-VGA1 [225.473794] Dynamic subtest B-VGA1: SUCCESS (7.741s) [225.491333] Starting dynamic subtest: A-HDMI-A1 [233.278919] Dynamic subtest A-HDMI-A1: SUCCESS (7.796s) [233.296306] Starting dynamic subtest: B-HDMI-A1 [241.116219] Dynamic subtest B-HDMI-A1: SUCCESS (7.836s) [241.119243] Subtest flip-vs-panning: SUCCESS (31.199s) [241.317001] [071/133] (801s left) perf (invalid-oa-exponent) [241.470984] Subtest invalid-oa-exponent: SKIP (0.000s) [241.529005] [072/133] (801s left) kms_plane (pixel-format-y-tiled-ccs-modifier) [242.008798] Starting subtest: pixel-format-y-tiled-ccs-modifier [242.012811] Subtest pixel-format-y-tiled-ccs-modifier: SKIP (0.000s) [242.104184] [073/133] (800s left) gem_exec_fence (parallel) [242.287863] Subtest parallel: SKIP (0.000s) [242.674573] [074/133] (800s left) gem_exec_schedule (fifo) [242.745994] Starting subtest: fifo [242.747714] Starting dynamic subtest: rcs0 [242.777073] Dynamic subtest rcs0: SUCCESS (0.030s) [242.793025] Starting dynamic subtest: bcs0 [242.806670] Dynamic subtest bcs0: SUCCESS (0.028s) [242.808474] Subtest fifo: SUCCESS (0.061s) [243.045445] [075/133] (799s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy) [243.121473] Starting subtest: map-fixed-invalidate-overlap-busy [243.123214] Starting dynamic subtest: gtt [244.179452] Dynamic subtest gtt: SUCCESS (1.056s) [244.196275] Starting dynamic subtest: wb [245.197979] Dynamic subtest wb: SUCCESS (1.018s) [245.213905] Starting dynamic subtest: wc [246.221984] Dynamic subtest wc: SUCCESS (1.023s) [246.238304] Starting dynamic subtest: uc [247.250900] Dynamic subtest uc: SUCCESS (1.028s) [247.252584] Subtest map-fixed-invalidate-overlap-busy: SUCCESS (4.131s) [247.400257] [076/133] (795s left) kms_flip (flip-vs-rmfb) [247.875034] Starting subtest: flip-vs-rmfb [247.876714] Starting dynamic subtest: A-VGA1 [255.680246] Dynamic subtest A-VGA1: SUCCESS (7.806s) [255.701327] Starting dynamic subtest: B-VGA1 [263.400887] Dynamic subtest B-VGA1: SUCCESS (7.719s) [263.420049] Starting dynamic subtest: A-HDMI-A1 [271.124436] Dynamic subtest A-HDMI-A1: SUCCESS (7.720s) [271.144173] Starting dynamic subtest: B-HDMI-A1 [278.877842] Dynamic subtest B-HDMI-A1: SUCCESS (7.750s) [278.879587] Subtest flip-vs-rmfb: SUCCESS (31.008s) [279.062882] [077/133] (763s left) kms_rotation_crc (primary-y-tiled-reflect-x-0) [279.541950] Starting subtest: primary-y-tiled-reflect-x-0 [279.546081] Subtest primary-y-tiled-reflect-x-0: SKIP (0.001s) [279.649033] [078/133] (763s left) syncobj_wait (single-wait-all-for-submit-unsubmitted) [279.715454] Starting subtest: single-wait-all-for-submit-unsubmitted [279.816217] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.101s) [279.913915] [079/133] (763s left) kms_psr (fbc-pr-dpms) [280.389233] Subtest fbc-pr-dpms: SKIP (0.000s) [280.463161] [080/133] (762s left) kms_big_fb (x-tiled-8bpp-rotate-0) [280.951286] Starting subtest: x-tiled-8bpp-rotate-0 [282.186680] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.234s) [282.409759] [081/133] (760s left) kms_dsc (dsc-with-bpc-formats) [282.889479] Subtest dsc-with-bpc-formats: SKIP (0.000s) [282.957136] [082/133] (760s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [283.437022] Starting subtest: basic-flip-before-cursor-varying-size [284.452198] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.011s) [284.710395] [083/133] (758s left) gem_create (create-ext-cpu-access-big) [284.891738] Starting subtest: create-ext-cpu-access-big [284.895116] Subtest create-ext-cpu-access-big: SKIP (0.001s) [284.991815] [084/133] (758s left) perf (buffer-fill) [285.126837] Subtest buffer-fill: SKIP (0.000s) [285.191457] [085/133] (758s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted) [285.252733] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted [285.360356] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.108s) [285.460149] [086/133] (757s left) gem_exec_schedule (in-order) [285.531747] Subtest in-order: SKIP (0.000s) [285.748815] [087/133] (757s left) gem_exec_whisper (basic-fds-priority) [285.823330] Starting subtest: basic-fds-priority [285.827516] Subtest basic-fds-priority: SKIP (0.001s) [286.025817] [088/133] (757s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt) [286.515337] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt [286.519544] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [286.630032] [089/133] (756s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20) [287.108612] Starting subtest: planes-downscale-factor-0-75-upscale-20x20 [287.110424] Starting dynamic subtest: pipe-A [287.117709] Dynamic subtest pipe-A: SKIP (0.002s) [287.135951] Starting dynamic subtest: pipe-B [287.144009] Dynamic subtest pipe-B: SKIP (0.001s) [287.148049] Subtest planes-downscale-factor-0-75-upscale-20x20: SKIP (0.007s) [287.213051] [090/133] (756s left) kms_vblank (wait-forked-busy) [287.694198] Starting subtest: wait-forked-busy [287.696438] Starting dynamic subtest: pipe-A-VGA-1 [290.176951] Dynamic subtest pipe-A-VGA-1: SUCCESS (2.482s) [290.195801] Starting dynamic subtest: pipe-A-HDMI-A-1 [292.603010] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.424s) [292.619210] Starting dynamic subtest: pipe-B-VGA-1 [294.969347] Dynamic subtest pipe-B-VGA-1: SUCCESS (2.364s) [294.988109] Starting dynamic subtest: pipe-B-HDMI-A-1 [297.436537] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.463s) [297.438475] Subtest wait-forked-busy: SUCCESS (9.743s) [297.703788] [091/133] (745s left) kms_flip (bo-too-big-interruptible) [298.199445] Starting subtest: bo-too-big-interruptible [298.201219] Starting dynamic subtest: A-VGA1 [299.691196] Dynamic subtest A-VGA1: SUCCESS (1.491s) [299.714651] Starting dynamic subtest: B-VGA1 [301.078920] Dynamic subtest B-VGA1: SUCCESS (1.385s) [301.097720] Starting dynamic subtest: A-HDMI-A1 [302.497758] Dynamic subtest A-HDMI-A1: SUCCESS (1.416s) [302.522292] Starting dynamic subtest: B-HDMI-A1 [303.973001] Dynamic subtest B-HDMI-A1: SUCCESS (1.472s) [303.975058] Subtest bo-too-big-interruptible: SUCCESS (5.776s) [304.227717] [092/133] (739s left) kms_sequence (queue-idle) [304.695256] Starting subtest: queue-idle [304.696928] Starting dynamic subtest: pipe-A-VGA-1 [306.993102] Dynamic subtest pipe-A-VGA-1: SUCCESS (2.297s) [307.012297] Starting dynamic subtest: pipe-A-HDMI-A-1 [309.250818] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.255s) [309.266728] Starting dynamic subtest: pipe-B-VGA-1 [311.414689] Dynamic subtest pipe-B-VGA-1: SUCCESS (2.161s) [311.430860] Starting dynamic subtest: pipe-B-HDMI-A-1 [313.659650] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.242s) [313.663356] Subtest queue-idle: SUCCESS (8.963s) [313.917487] [093/133] (729s left) kms_frontbuffer_tracking (psr-2p-rte) [314.404888] Starting subtest: psr-2p-rte [314.408933] Subtest psr-2p-rte: SKIP (0.000s) [314.519963] [094/133] (729s left) gem_exec_await (wide-contexts) [314.614324] Starting subtest: wide-contexts [336.308815] Subtest wide-contexts: SUCCESS (21.686s) [336.528789] [095/133] (707s left) kms_atomic_transition (modeset-transition-fencing) [337.064868] Starting subtest: modeset-transition-fencing [337.066549] Starting dynamic subtest: 1x-outputs [337.879205] Dynamic subtest 1x-outputs: SUCCESS (0.813s) [337.895775] Starting dynamic subtest: 2x-outputs [340.072982] Dynamic subtest 2x-outputs: SUCCESS (2.190s) [340.074658] Subtest modeset-transition-fencing: SUCCESS (3.008s) [340.351058] [096/133] (703s left) gem_wait (busy) [340.428769] Starting subtest: busy [340.430500] Starting dynamic subtest: all-engines [340.944036] Dynamic subtest all-engines: SUCCESS (0.514s) [340.963444] Starting dynamic subtest: rcs0 [341.463914] Dynamic subtest rcs0: SUCCESS (0.517s) [341.482935] Starting dynamic subtest: bcs0 [341.983167] Dynamic subtest bcs0: SUCCESS (0.516s) [342.005405] Starting dynamic subtest: vcs0 [342.498786] Dynamic subtest vcs0: SUCCESS (0.512s) [342.500843] Subtest busy: SUCCESS (2.070s) [342.731439] [097/133] (701s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip) [343.218773] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip [343.222825] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [343.343315] [098/133] (700s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf) [343.822979] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s) [343.891339] [099/133] (700s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing) [344.372538] Starting subtest: plane-use-after-nonblocking-unbind-fencing [344.375323] Starting dynamic subtest: pipe-A-VGA-1 [344.589157] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.216s) [344.644831] Starting dynamic subtest: pipe-A-HDMI-A-1 [344.901593] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.273s) [345.001977] Starting dynamic subtest: pipe-B-VGA-1 [345.174391] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.188s) [345.234010] Starting dynamic subtest: pipe-B-HDMI-A-1 [345.480292] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.266s) [345.564024] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.192s) [345.838451] [100/133] (698s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt) [346.358472] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt [347.906256] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SUCCESS (1.551s) [348.056091] [101/133] (696s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu) [348.553442] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu [350.479490] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (1.929s) [350.729711] [102/133] (693s left) kms_getfb (getfb2-handle-not-fb) [351.216228] Starting subtest: getfb2-handle-not-fb [351.218344] Subtest getfb2-handle-not-fb: SUCCESS (0.000s) [351.334702] [103/133] (693s left) gem_userptr_blits (stress-mm-invalidate-close-overlap) [351.410372] Starting subtest: stress-mm-invalidate-close-overlap [353.559548] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s) [353.691909] [104/133] (690s left) gem_mmap_wc (set-cache-level) [353.754520] Starting subtest: set-cache-level [353.756286] Subtest set-cache-level: SUCCESS (0.001s) [353.867714] [105/133] (690s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [354.349346] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip [354.353440] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s) [354.466435] [106/133] (690s left) kms_dirtyfb (drrs-dirtyfb-ioctl) [354.953427] Starting subtest: drrs-dirtyfb-ioctl [354.964793] Subtest drrs-dirtyfb-ioctl: SKIP (0.002s) [355.065473] [107/133] (689s left) i915_drm_fdinfo (virtual-busy-hang-all) [355.132799] Subtest virtual-busy-hang-all: SKIP (0.000s) [355.195513] [108/133] (689s left) prime_mmap (test_correct_cpu_write) [355.260133] Starting subtest: test_correct_cpu_write [355.261810] Starting dynamic subtest: test_correct_cpu_write-smem [355.263473] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s) [355.265548] Subtest test_correct_cpu_write: SUCCESS (0.002s) [355.367513] [109/133] (689s left) syncobj_timeline (etime-single-wait-all-submitted) [355.436016] Starting subtest: etime-single-wait-all-submitted [355.536259] Subtest etime-single-wait-all-submitted: SUCCESS (0.101s) [355.633082] [110/133] (689s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen) [356.125762] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen [356.129906] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [356.242616] [111/133] (688s left) kms_scaling_modes (scaling-mode-full-aspect) [356.719507] Starting subtest: scaling-mode-full-aspect [356.731277] Subtest scaling-mode-full-aspect: SKIP (0.000s) [356.825331] [112/133] (688s left) gem_unref_active_buffers [357.036264] [113/133] (687s left) kms_flip (2x-flip-vs-suspend-interruptible) [357.521897] Starting subtest: 2x-flip-vs-suspend-interruptible [357.527066] Starting dynamic subtest: AB-VGA1-HDMI-A1 [561.830684] Per-test timeout exceeded. Killing the current test with SIGQUIT. [574.711185] Closing watchdogs [574.715657] Initializing watchdogs [574.715735] /dev/watchdog0 [574.743375] [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) [574.758528] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [574.760280] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [574.761091] [FACT before any test] new: kernel.kmod_is_loaded.vgem: true [574.765679] [114/133] (482s left) gem_ctx_shared (exec-single-timeline) [574.843593] Subtest exec-single-timeline: SKIP (0.000s) [574.949435] [115/133] (482s left) kms_psr (fbc-pr-primary-render) [575.446064] Subtest fbc-pr-primary-render: SKIP (0.000s) [575.521710] [116/133] (481s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [576.017289] Starting subtest: nonblocking-crc-frame-sequence [576.019078] Starting dynamic subtest: pipe-A-VGA-1 [576.668711] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.629s) [576.685706] Starting dynamic subtest: pipe-B-HDMI-A-1 [577.282652] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.593s) [577.284483] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.227s) [577.555219] [117/133] (479s left) i915_suspend (sysfs-reader) [577.616165] Starting subtest: sysfs-reader [596.844987] Subtest sysfs-reader: SUCCESS (2.523s) [602.958093] [118/133] (460s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc) [603.032233] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s) [603.100539] [119/133] (460s left) kms_plane_scaling (invalid-parameters) [603.580675] Subtest invalid-parameters: SKIP (0.000s) [603.674232] [120/133] (459s left) api_intel_bb (delta-check) [603.738476] Starting subtest: delta-check [603.742235] Subtest delta-check: SKIP (0.001s) [603.874175] [121/133] (459s left) gen9_exec_parse (bb-start-cmd) [603.944621] Subtest bb-start-cmd: SKIP (0.000s) [604.014987] [122/133] (459s left) gem_softpin (noreloc-interruptible) [604.083890] Starting subtest: noreloc-interruptible [609.578232] Subtest noreloc-interruptible: SUCCESS (5.386s) [609.719309] [123/133] (454s left) dumb_buffer (create-clear) [609.780841] Starting subtest: create-clear [648.293206] Subtest create-clear: SUCCESS (38.404s) [648.429935] [124/133] (415s left) kms_psr (fbc-psr-sprite-mmap-cpu) [648.908901] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.000s) [648.982252] [125/133] (414s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled) [649.046114] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled [649.152328] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.106s) [649.257261] [126/133] (414s left) syncobj_timeline (wait-all-interrupted) [649.320312] Starting subtest: wait-all-interrupted [649.424346] Subtest wait-all-interrupted: SUCCESS (0.101s) [649.529064] [127/133] (414s left) kms_busy (extended-pageflip-hang-newfb) [650.015412] Starting subtest: extended-pageflip-hang-newfb [650.017268] Starting dynamic subtest: pipe-A [655.772285] Dynamic subtest pipe-A: SUCCESS (5.755s) [655.792797] Starting dynamic subtest: pipe-B [661.808679] Dynamic subtest pipe-B: SUCCESS (6.034s) [661.810406] Subtest extended-pageflip-hang-newfb: SUCCESS (11.795s) [662.100521] [128/133] (401s left) gem_render_copy_redux (normal) [662.168848] Starting subtest: normal [662.692034] Subtest normal: SUCCESS (0.522s) [662.816543] [129/133] (401s left) kms_pm_rpm (modeset-pc8-residency-stress) [674.589540] Subtest modeset-pc8-residency-stress: SKIP (0.000s) [674.667670] [130/133] (389s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen) [675.161737] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen [675.165817] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [675.277471] [131/133] (388s left) kms_joiner (invalid-modeset-force-big-joiner) [675.781114] Starting subtest: invalid-modeset-force-big-joiner [675.785429] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s) [675.860405] [132/133] (388s left) kms_psr (pr-sprite-mmap-cpu) [676.342371] Subtest pr-sprite-mmap-cpu: SKIP (0.000s) [676.405205] [133/133] (387s left) syncobj_wait (invalid-single-wait-all-unsubmitted) [676.471450] Starting subtest: invalid-single-wait-all-unsubmitted [676.473303] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s) [676.575657] Closing watchdogs results: parsing output: 0/ for test: syncobj_wait results: parsing output: 1/ for test: gem_bad_reloc results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: kms_cursor_crc results: parsing output: 4/ for test: kms_big_fb results: parsing output: 5/ for test: api_intel_allocator results: parsing output: 6/ for test: kms_cursor_crc results: parsing output: 7/ for test: kms_psr results: parsing output: 8/ for test: gem_exec_reloc results: parsing output: 9/ for test: gem_spin_batch results: parsing output: 10/ for test: syncobj_wait results: parsing output: 11/ for test: kms_psr2_sf results: parsing output: 12/ for test: gem_mmap_gtt results: parsing output: 13/ for test: gem_exec_schedule results: parsing output: 14/ for test: syncobj_wait results: parsing output: 15/ for test: kms_3d results: parsing output: 16/ for test: kms_ccs results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: sw_sync results: parsing output: 19/ for test: kms_ccs results: parsing output: 20/ for test: gem_ctx_persistence results: parsing output: 21/ for test: kms_frontbuffer_tracking results: parsing output: 22/ for test: kms_color_pipeline results: parsing output: 23/ for test: kms_plane_cursor results: parsing output: 24/ for test: sriov_basic results: parsing output: 25/ for test: kms_pm_rpm results: parsing output: 26/ for test: perf_pmu results: parsing output: 27/ for test: gem_mmap_offset results: parsing output: 28/ for test: kms_pwrite_crc results: parsing output: 29/ for test: kms_frontbuffer_tracking results: parsing output: 30/ for test: vgem_basic results: parsing output: 31/ for test: gem_workarounds results: parsing output: 32/ for test: gem_pxp results: parsing output: 33/ for test: syncobj_timeline results: parsing output: 34/ for test: syncobj_wait results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: perf results: parsing output: 37/ for test: kms_cursor_crc results: parsing output: 38/ for test: gem_mmap results: parsing output: 39/ for test: kms_lease results: parsing output: 40/ for test: kms_content_protection results: parsing output: 41/ for test: kms_frontbuffer_tracking results: parsing output: 42/ for test: gem_exec_big results: parsing output: 43/ for test: i915_pm_rpm results: parsing output: 44/ for test: kms_chamelium_color results: parsing output: 45/ for test: gem_ctx_persistence results: parsing output: 46/ for test: kms_frontbuffer_tracking results: parsing output: 47/ for test: gem_exec_nop results: parsing output: 48/ for test: gem_userptr_blits results: parsing output: 49/ for test: kms_fbcon_fbt results: parsing output: 50/ for test: gem_exec_whisper results: parsing output: 51/ for test: kms_atomic_interruptible results: parsing output: 52/ for test: kms_ccs results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: gem_render_copy results: parsing output: 55/ for test: kms_big_fb results: parsing output: 56/ for test: gem_exec_reloc results: parsing output: 57/ for test: i915_drm_fdinfo results: parsing output: 58/ for test: kms_frontbuffer_tracking results: parsing output: 59/ for test: kms_chamelium_color results: parsing output: 60/ for test: kms_chamelium_hpd results: parsing output: 61/ for test: kms_flip_scaled_crc results: parsing output: 62/ for test: gem_render_copy results: parsing output: 63/ for test: gem_exec_balancer results: parsing output: 64/ for test: kms_flip results: parsing output: 65/ for test: kms_big_fb results: parsing output: 66/ for test: gem_eio results: parsing output: 67/ for test: kms_frontbuffer_tracking results: parsing output: 68/ for test: syncobj_timeline results: parsing output: 69/ for test: kms_flip results: parsing output: 70/ for test: perf results: parsing output: 71/ for test: kms_plane results: parsing output: 72/ for test: gem_exec_fence results: parsing output: 73/ for test: gem_exec_schedule results: parsing output: 74/ for test: gem_userptr_blits results: parsing output: 75/ for test: kms_flip results: parsing output: 76/ for test: kms_rotation_crc results: parsing output: 77/ for test: syncobj_wait results: parsing output: 78/ for test: kms_psr results: parsing output: 79/ for test: kms_big_fb results: parsing output: 80/ for test: kms_dsc results: parsing output: 81/ for test: kms_cursor_legacy results: parsing output: 82/ for test: gem_create results: parsing output: 83/ for test: perf results: parsing output: 84/ for test: syncobj_wait results: parsing output: 85/ for test: gem_exec_schedule results: parsing output: 86/ for test: gem_exec_whisper results: parsing output: 87/ for test: kms_frontbuffer_tracking results: parsing output: 88/ for test: kms_plane_scaling results: parsing output: 89/ for test: kms_vblank results: parsing output: 90/ for test: kms_flip results: parsing output: 91/ for test: kms_sequence results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: gem_exec_await results: parsing output: 94/ for test: kms_atomic_transition results: parsing output: 95/ for test: gem_wait results: parsing output: 96/ for test: kms_big_fb results: parsing output: 97/ for test: kms_psr2_sf results: parsing output: 98/ for test: kms_atomic_transition results: parsing output: 99/ for test: kms_frontbuffer_tracking results: parsing output: 100/ for test: kms_frontbuffer_tracking results: parsing output: 101/ for test: kms_getfb results: parsing output: 102/ for test: gem_userptr_blits results: parsing output: 103/ for test: gem_mmap_wc results: parsing output: 104/ for test: kms_big_fb results: parsing output: 105/ for test: kms_dirtyfb results: parsing output: 106/ for test: i915_drm_fdinfo results: parsing output: 107/ for test: prime_mmap results: parsing output: 108/ for test: syncobj_timeline results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: kms_scaling_modes results: parsing output: 111/ for test: gem_unref_active_buffers results: parsing output: 112/ for test: kms_flip results: parsing output: 113/ for test: gem_ctx_shared results: parsing output: 114/ for test: kms_psr results: parsing output: 115/ for test: kms_pipe_crc_basic results: parsing output: 116/ for test: i915_suspend results: parsing output: 117/ for test: kms_ccs results: parsing output: 118/ for test: kms_plane_scaling results: parsing output: 119/ for test: api_intel_bb results: parsing output: 120/ for test: gen9_exec_parse results: parsing output: 121/ for test: gem_softpin results: parsing output: 122/ for test: dumb_buffer results: parsing output: 123/ for test: kms_psr results: parsing output: 124/ for test: syncobj_timeline results: parsing output: 125/ for test: syncobj_timeline results: parsing output: 126/ for test: kms_busy results: parsing output: 127/ for test: gem_render_copy_redux results: parsing output: 128/ for test: kms_pm_rpm results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: kms_joiner results: parsing output: 131/ for test: kms_psr results: parsing output: 132/ for test: syncobj_wait Done.