[89.372687] Initializing watchdogs [89.373121] /dev/watchdog0 [89.472134] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:22b1 Intel Cherryview (Gen8) Atom/Celeron/Pentium Processor x5-E8000/J3xxx/N3xxx Integrated Graphics Controller [89.500306] [001/162] (960s left) i915_module_load (load) [89.834809] Starting subtest: load [96.171385] Subtest load: SUCCESS (6.336s) [96.551875] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [96.568087] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [96.587759] [002/162] (953s left) core_auth (basic-auth) [96.967419] Starting subtest: basic-auth [96.986163] Subtest basic-auth: SUCCESS (0.009s) [97.188775] [003/162] (953s left) core_debugfs (read-all-entries) [97.430686] Starting subtest: read-all-entries [97.451825] Subtest read-all-entries: SUCCESS (0.022s) [97.645539] [004/162] (953s left) core_sysfs (read-all-entries) [97.883271] Starting subtest: read-all-entries [97.923529] Subtest read-all-entries: SUCCESS (0.026s) [98.119883] [005/162] (952s left) fbdev (eof) [98.409119] Subtest eof: SKIP (0.000s) [98.588300] [006/162] (952s left) fbdev (info) [98.864213] Subtest info: SKIP (0.000s) [99.032434] [007/162] (952s left) fbdev (nullptr) [99.315390] Subtest nullptr: SKIP (0.000s) [99.482395] [008/162] (952s left) fbdev (read) [99.767035] Subtest read: SKIP (0.000s) [99.946964] [009/162] (951s left) fbdev (write) [100.225168] Subtest write: SKIP (0.000s) [100.397372] [010/162] (951s left) gem_basic (bad-close) [100.636192] Starting subtest: bad-close [100.640709] Subtest bad-close: SUCCESS (0.000s) [100.829834] [011/162] (951s left) gem_basic (create-close) [101.062876] Starting subtest: create-close [101.071124] Subtest create-close: SUCCESS (0.001s) [101.251305] [012/162] (951s left) gem_basic (create-fd-close) [101.480735] Starting subtest: create-fd-close [101.487140] Subtest create-fd-close: SUCCESS (0.001s) [101.666374] [013/162] (950s left) gem_busy (busy@all-engines) [101.989836] Starting subtest: busy [101.994196] Starting dynamic subtest: all-engines [102.210475] Dynamic subtest all-engines: SUCCESS (0.227s) [102.212449] Subtest busy: SUCCESS (0.229s) [102.768355] [014/162] (949s left) gem_close_race (basic-process) [103.099081] Starting subtest: basic-process [103.281594] Subtest basic-process: SUCCESS (0.185s) [103.613426] [015/162] (949s left) gem_close_race (basic-threads) [103.916894] Starting subtest: basic-threads [105.210425] Subtest basic-threads: SUCCESS (1.291s) [105.562210] [016/162] (947s left) gem_ctx_create (basic) [105.855633] Starting subtest: basic [105.860112] Subtest basic: SUCCESS (0.000s) [106.173723] [017/162] (947s left) gem_ctx_create (basic-files) [106.481535] Starting subtest: basic-files [108.550779] Subtest basic-files: SUCCESS (2.069s) [108.947815] [018/162] (944s left) gem_ctx_exec (basic) [109.222121] Starting subtest: basic [109.237834] Subtest basic: SUCCESS (0.017s) [109.433610] [019/162] (944s left) gem_exec_basic (basic) [109.687538] Starting subtest: basic [109.691749] Starting dynamic subtest: rcs0-smem [109.696178] Dynamic subtest rcs0-smem: SUCCESS (0.008s) [109.739759] Starting dynamic subtest: bcs0-smem [109.741483] Dynamic subtest bcs0-smem: SUCCESS (0.004s) [109.772584] Starting dynamic subtest: vcs0-smem [109.774556] Dynamic subtest vcs0-smem: SUCCESS (0.007s) [109.805111] Starting dynamic subtest: vecs0-smem [109.806836] Dynamic subtest vecs0-smem: SUCCESS (0.004s) [109.808616] Subtest basic: SUCCESS (0.029s) [110.058705] [020/162] (943s left) gem_exec_create (basic) [110.368811] Starting subtest: basic [110.371872] Starting dynamic subtest: smem [112.471121] Dynamic subtest smem: SUCCESS (2.103s) [112.474202] Subtest basic: SUCCESS (2.105s) [112.783641] [021/162] (941s left) gem_exec_fence (basic-busy) [113.230113] Starting subtest: basic-busy [113.232380] Starting dynamic subtest: rcs0 [113.259153] Dynamic subtest rcs0: SUCCESS (0.030s) [113.324386] Starting dynamic subtest: bcs0 [113.337281] Dynamic subtest bcs0: SUCCESS (0.050s) [113.405676] Starting dynamic subtest: vcs0 [113.410758] Dynamic subtest vcs0: SUCCESS (0.036s) [113.444180] Starting dynamic subtest: vecs0 [113.455443] Dynamic subtest vecs0: SUCCESS (0.028s) [113.458225] Subtest basic-busy: SUCCESS (0.157s) [114.400867] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [114.413073] [022/162] (939s left) gem_exec_fence (basic-wait) [114.870515] Starting subtest: basic-wait [114.872583] Starting dynamic subtest: rcs0 [114.898888] Dynamic subtest rcs0: SUCCESS (0.030s) [114.945971] Starting dynamic subtest: bcs0 [114.947939] Dynamic subtest bcs0: SUCCESS (0.032s) [114.985172] Starting dynamic subtest: vcs0 [114.987284] Dynamic subtest vcs0: SUCCESS (0.029s) [115.023424] Starting dynamic subtest: vecs0 [115.025222] Dynamic subtest vecs0: SUCCESS (0.032s) [115.026897] Subtest basic-wait: SUCCESS (0.140s) [115.820674] [023/162] (938s left) gem_exec_fence (basic-await) [116.303345] Starting subtest: basic-await [116.306908] Starting dynamic subtest: rcs0 [116.516502] Dynamic subtest rcs0: SUCCESS (0.209s) [116.561095] Starting dynamic subtest: bcs0 [116.708746] Dynamic subtest bcs0: SUCCESS (0.197s) [116.752806] Starting dynamic subtest: vcs0 [116.916178] Dynamic subtest vcs0: SUCCESS (0.191s) [116.980325] Starting dynamic subtest: vecs0 [117.119314] Dynamic subtest vecs0: SUCCESS (0.203s) [117.121503] Subtest basic-await: SUCCESS (0.816s) [117.922989] [024/162] (936s left) gem_exec_fence (nb-await) [118.384596] Starting subtest: nb-await [118.393220] Starting dynamic subtest: rcs0 [118.493956] Dynamic subtest rcs0: SUCCESS (0.108s) [118.536594] Starting dynamic subtest: bcs0 [118.597595] Dynamic subtest bcs0: SUCCESS (0.099s) [118.643758] Starting dynamic subtest: vcs0 [118.681985] Dynamic subtest vcs0: SUCCESS (0.083s) [118.728793] Starting dynamic subtest: vecs0 [118.770508] Dynamic subtest vecs0: SUCCESS (0.083s) [118.772818] Subtest nb-await: SUCCESS (0.383s) [119.572894] [025/162] (935s left) gem_exec_gttfill (basic) [119.863508] Starting subtest: basic [155.129511] Subtest basic: SUCCESS (35.268s) [155.518124] [026/162] (899s left) gem_exec_parallel (engines) [156.066183] Starting subtest: engines [156.071445] Starting dynamic subtest: basic [163.441982] Dynamic subtest basic: SUCCESS (7.382s) [163.482896] Starting dynamic subtest: contexts [174.435862] Dynamic subtest contexts: SUCCESS (10.988s) [174.478329] Starting dynamic subtest: fds [187.447678] Dynamic subtest fds: SUCCESS (13.004s) [187.504452] Starting dynamic subtest: userptr [316.547544] Per-test timeout exceeded. Killing the current test with SIGQUIT. [316.553634] Warning: kernel log ringbuffer underflow, some records lost. [428.421893] Timeout. Killing the current test with SIGKILL. [428.981089] Closing watchdogs [429.007949] Initializing watchdogs [429.008408] /dev/watchdog0 [429.106870] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:22b1 Intel Cherryview (Gen8) Atom/Celeron/Pentium Processor x5-E8000/J3xxx/N3xxx Integrated Graphics Controller [429.168512] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [429.177947] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [429.181581] [FACT before any test] new: kernel.kmod_is_loaded.vgem: true [429.190459] [027/162] (626s left) gem_exec_store (basic) [429.484419] Starting subtest: basic [429.569067] Subtest basic: SUCCESS (0.084s) [429.923386] [028/162] (625s left) gem_flink_basic (bad-flink) [430.181176] Starting subtest: bad-flink [430.188799] Subtest bad-flink: SUCCESS (0.000s) [430.401259] [029/162] (625s left) gem_flink_basic (bad-open) [430.643710] Starting subtest: bad-open [430.645488] Subtest bad-open: SUCCESS (0.002s) [430.874804] [030/162] (625s left) gem_flink_basic (basic) [431.118580] Starting subtest: basic [431.122199] Subtest basic: SUCCESS (0.000s) [431.344377] [031/162] (624s left) gem_flink_basic (double-flink) [431.592988] Starting subtest: double-flink [431.595210] Subtest double-flink: SUCCESS (0.001s) [431.815275] [032/162] (624s left) gem_flink_basic (flink-lifetime) [432.049842] Starting subtest: flink-lifetime [432.053735] Subtest flink-lifetime: SUCCESS (0.009s) [432.285633] [033/162] (624s left) gem_huc_copy (huc-copy) [432.542200] Subtest huc-copy: SKIP (0.000s) [432.763628] [034/162] (624s left) gem_linear_blits (basic) [433.730208] Starting subtest: basic [433.774247] Subtest basic: SUCCESS (0.049s) [434.040433] [035/162] (623s left) gem_mmap (basic) [434.449719] Starting subtest: basic [434.466263] Subtest basic: SUCCESS (0.001s) [434.680502] [036/162] (622s left) gem_mmap_gtt (basic) [434.919843] Starting subtest: basic [434.933373] Subtest basic: SUCCESS (0.004s) [435.153293] [037/162] (622s left) gem_render_linear_blits (basic) [435.507904] Starting subtest: basic [435.695365] Subtest basic: SUCCESS (0.196s) [435.929496] [038/162] (621s left) gem_render_tiled_blits (basic) [436.199614] Starting subtest: basic [436.404503] Subtest basic: SUCCESS (0.200s) [436.627478] [039/162] (621s left) gem_ringfill (basic-all) [437.224131] Starting subtest: basic-all [438.603573] Subtest basic-all: SUCCESS (1.390s) [438.856917] [040/162] (619s left) gem_softpin (allocator-basic) [439.136931] Starting subtest: allocator-basic [439.556640] Subtest allocator-basic: SUCCESS (0.417s) [439.864253] [041/162] (618s left) gem_softpin (allocator-basic-reserve) [440.116155] Starting subtest: allocator-basic-reserve [440.538712] Subtest allocator-basic-reserve: SUCCESS (0.422s) [440.833297] [042/162] (617s left) gem_softpin (safe-alignment) [441.097131] Starting subtest: safe-alignment [441.154764] Subtest safe-alignment: SUCCESS (0.057s) [441.393303] [043/162] (617s left) gem_sync (basic-all) [441.673171] Starting subtest: basic-all [445.429562] Subtest basic-all: SUCCESS (3.757s) [445.784193] [044/162] (613s left) gem_sync (basic-each) [446.068599] Starting subtest: basic-each [448.827964] Subtest basic-each: SUCCESS (2.756s) [449.196488] [045/162] (610s left) gem_tiled_blits (basic) [449.693689] Starting subtest: basic [449.810537] Subtest basic: SUCCESS (0.115s) [450.086981] [046/162] (609s left) gem_tiled_fence_blits (basic) [450.959992] Starting subtest: basic [451.017809] Subtest basic: SUCCESS (0.082s) [451.299500] [047/162] (608s left) gem_tiled_pread_basic (basic) [451.716939] Starting subtest: basic [452.836141] Subtest basic: SUCCESS (1.121s) [453.053694] [048/162] (606s left) gem_wait (busy@all-engines) [453.380624] Starting subtest: busy [453.383891] Starting dynamic subtest: all-engines [453.928921] Dynamic subtest all-engines: SUCCESS (0.544s) [453.935185] Subtest busy: SUCCESS (0.550s) [454.390363] [049/162] (605s left) gem_wait (wait@all-engines) [454.696559] Starting subtest: wait [454.699124] Starting dynamic subtest: all-engines [455.759281] Dynamic subtest all-engines: SUCCESS (1.056s) [455.764167] Subtest wait: SUCCESS (1.064s) [456.204279] [050/162] (604s left) i915_getparams_basic (basic-eu-total) [456.441986] Starting subtest: basic-eu-total [456.448322] Subtest basic-eu-total: SUCCESS (0.000s) [456.660952] [051/162] (603s left) i915_getparams_basic (basic-subslice-total) [456.895834] Starting subtest: basic-subslice-total [456.902725] Subtest basic-subslice-total: SUCCESS (0.000s) [457.125914] [052/162] (603s left) i915_hangman (error-state-basic) [457.409974] Starting subtest: error-state-basic [457.457950] Subtest error-state-basic: SUCCESS (0.039s) [457.712611] [053/162] (603s left) i915_pciid [458.169348] [054/162] (603s left) intel_hwmon (hwmon-read) [458.413326] Subtest hwmon-read: SKIP (0.000s) [458.640395] [055/162] (602s left) intel_hwmon (hwmon-write) [458.906114] Subtest hwmon-write: SKIP (0.000s) [459.122949] [056/162] (602s left) kms_addfb_basic (addfb25-4-tiled) [459.807925] Starting subtest: addfb25-4-tiled [459.811775] Subtest addfb25-4-tiled: SUCCESS (0.002s) [460.048350] [057/162] (601s left) kms_addfb_basic (addfb25-bad-modifier) [460.631074] Starting subtest: addfb25-bad-modifier [460.635229] Subtest addfb25-bad-modifier: SUCCESS (0.001s) [460.870806] [058/162] (601s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [461.518706] Starting subtest: addfb25-framebuffer-vs-set-tiling [461.524989] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [461.750225] [059/162] (600s left) kms_addfb_basic (addfb25-modifier-no-flag) [462.323668] Starting subtest: addfb25-modifier-no-flag [462.326683] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [462.560764] [060/162] (600s left) kms_addfb_basic (addfb25-x-tiled-legacy) [463.163922] Starting subtest: addfb25-x-tiled-legacy [463.166699] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [463.403868] [061/162] (599s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [464.040752] Starting subtest: addfb25-x-tiled-mismatch-legacy [464.045359] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.002s) [464.304151] [062/162] (598s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [464.930500] Starting subtest: addfb25-yf-tiled-legacy [464.934448] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.001s) [465.171757] [063/162] (598s left) kms_addfb_basic (addfb25-y-tiled-legacy) [465.938264] Starting subtest: addfb25-y-tiled-legacy [465.941500] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s) [466.175284] [064/162] (597s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [466.819516] Starting subtest: addfb25-y-tiled-small-legacy [466.824641] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [467.057118] [065/162] (596s left) kms_addfb_basic (bad-pitch-0) [467.286534] Starting subtest: bad-pitch-0 [467.292575] Subtest bad-pitch-0: SUCCESS (0.000s) [467.794342] [066/162] (596s left) kms_addfb_basic (bad-pitch-1024) [468.025234] Starting subtest: bad-pitch-1024 [468.029903] Subtest bad-pitch-1024: SUCCESS (0.000s) [468.608650] [067/162] (595s left) kms_addfb_basic (bad-pitch-128) [468.851751] Starting subtest: bad-pitch-128 [468.856231] Subtest bad-pitch-128: SUCCESS (0.000s) [469.376882] [068/162] (595s left) kms_addfb_basic (bad-pitch-256) [469.612764] Starting subtest: bad-pitch-256 [469.616256] Subtest bad-pitch-256: SUCCESS (0.000s) [470.197959] [069/162] (594s left) kms_addfb_basic (bad-pitch-32) [470.436212] Starting subtest: bad-pitch-32 [470.440213] Subtest bad-pitch-32: SUCCESS (0.000s) [471.071216] [070/162] (593s left) kms_addfb_basic (bad-pitch-63) [471.306832] Starting subtest: bad-pitch-63 [471.311233] Subtest bad-pitch-63: SUCCESS (0.000s) [471.913536] [071/162] (593s left) kms_addfb_basic (bad-pitch-65536) [472.160588] Starting subtest: bad-pitch-65536 [472.164205] Subtest bad-pitch-65536: SUCCESS (0.002s) [472.789467] [072/162] (592s left) kms_addfb_basic (bad-pitch-999) [473.030460] Starting subtest: bad-pitch-999 [473.033344] Subtest bad-pitch-999: SUCCESS (0.001s) [473.581578] [073/162] (591s left) kms_addfb_basic (basic) [473.820949] Starting subtest: basic [473.823888] Subtest basic: SUCCESS (0.000s) [474.379272] [074/162] (591s left) kms_addfb_basic (basic-x-tiled-legacy) [474.697249] Starting subtest: basic-x-tiled-legacy [474.701271] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [475.303351] [075/162] (590s left) kms_addfb_basic (basic-y-tiled-legacy) [475.542471] Starting subtest: basic-y-tiled-legacy [475.545863] Subtest basic-y-tiled-legacy: SUCCESS (0.002s) [476.123839] [076/162] (590s left) kms_addfb_basic (bo-too-small) [476.758233] Starting subtest: bo-too-small [476.761540] Subtest bo-too-small: SUCCESS (0.001s) [477.012656] [077/162] (589s left) kms_addfb_basic (bo-too-small-due-to-tiling) [477.565866] Starting subtest: bo-too-small-due-to-tiling [477.568324] Subtest bo-too-small-due-to-tiling: SUCCESS (0.007s) [477.811304] [078/162] (588s left) kms_addfb_basic (clobberred-modifier) [478.078286] Starting subtest: clobberred-modifier [478.081851] Subtest clobberred-modifier: SUCCESS (0.003s) [478.665483] [079/162] (588s left) kms_addfb_basic (framebuffer-vs-set-tiling) [478.910947] Starting subtest: framebuffer-vs-set-tiling [478.915371] Subtest framebuffer-vs-set-tiling: SUCCESS (0.002s) [479.524595] [080/162] (587s left) kms_addfb_basic (invalid-get-prop) [479.765391] Starting subtest: invalid-get-prop [479.767528] Subtest invalid-get-prop: SUCCESS (0.000s) [480.405789] [081/162] (587s left) kms_addfb_basic (invalid-get-prop-any) [480.698792] Starting subtest: invalid-get-prop-any [480.700835] Subtest invalid-get-prop-any: SUCCESS (0.000s) [481.354385] [082/162] (586s left) kms_addfb_basic (invalid-set-prop) [481.605628] Starting subtest: invalid-set-prop [481.608679] Subtest invalid-set-prop: SUCCESS (0.000s) [482.230447] [083/162] (585s left) kms_addfb_basic (invalid-set-prop-any) [482.486197] Starting subtest: invalid-set-prop-any [482.489312] Subtest invalid-set-prop-any: SUCCESS (0.000s) [483.084211] [084/162] (585s left) kms_addfb_basic (no-handle) [483.330128] Starting subtest: no-handle [483.333128] Subtest no-handle: SUCCESS (0.000s) [483.939460] [085/162] (584s left) kms_addfb_basic (size-max) [484.588846] Starting subtest: size-max [484.591252] Subtest size-max: SUCCESS (0.002s) [484.843778] [086/162] (583s left) kms_addfb_basic (small-bo) [485.430492] Starting subtest: small-bo [485.432703] Subtest small-bo: SUCCESS (0.000s) [485.667547] [087/162] (583s left) kms_addfb_basic (tile-pitch-mismatch) [485.914835] Starting subtest: tile-pitch-mismatch [485.916888] Subtest tile-pitch-mismatch: SUCCESS (0.001s) [486.534467] [088/162] (582s left) kms_addfb_basic (too-high) [487.120329] Starting subtest: too-high [487.122900] Subtest too-high: SUCCESS (0.005s) [487.360220] [089/162] (581s left) kms_addfb_basic (too-wide) [487.977152] Starting subtest: too-wide [487.981929] Subtest too-wide: SUCCESS (0.000s) [488.215500] [090/162] (581s left) kms_addfb_basic (unused-handle) [488.458976] Starting subtest: unused-handle [488.460600] Subtest unused-handle: SUCCESS (0.000s) [489.033587] [091/162] (580s left) kms_addfb_basic (unused-modifier) [489.276628] Starting subtest: unused-modifier [489.279593] Subtest unused-modifier: SUCCESS (0.001s) [489.914289] [092/162] (579s left) kms_addfb_basic (unused-offsets) [490.149533] Starting subtest: unused-offsets [490.152987] Subtest unused-offsets: SUCCESS (0.000s) [490.745987] [093/162] (579s left) kms_addfb_basic (unused-pitches) [490.994405] Starting subtest: unused-pitches [490.997117] Subtest unused-pitches: SUCCESS (0.000s) [491.615280] [094/162] (578s left) kms_busy (basic) [492.152179] Subtest basic: SKIP (0.000s) [492.366756] [095/162] (578s left) kms_prop_blob (basic) [492.601661] Starting subtest: basic [492.605318] Subtest basic: SUCCESS (0.000s) [492.818748] [096/162] (577s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [493.411827] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [493.626354] [097/162] (577s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [494.266742] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [494.470989] [098/162] (576s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [495.091556] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s) [495.296092] [099/162] (576s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [495.923160] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s) [496.132564] [100/162] (575s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [496.778570] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s) [496.994740] [101/162] (574s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [497.630969] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s) [497.857374] [102/162] (574s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [498.495152] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s) [498.721767] [103/162] (573s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [499.357588] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s) [499.564337] [104/162] (572s left) kms_dsc (dsc-basic) [500.114413] Subtest dsc-basic: SKIP (0.000s) [500.340823] [105/162] (572s left) kms_flip (basic-flip-vs-dpms) [500.964231] Starting subtest: basic-flip-vs-dpms [500.976319] Subtest basic-flip-vs-dpms: SKIP (0.006s) [501.252480] [106/162] (571s left) kms_flip (basic-flip-vs-modeset) [501.840448] Starting subtest: basic-flip-vs-modeset [501.853219] Subtest basic-flip-vs-modeset: SKIP (0.008s) [502.133533] [107/162] (571s left) kms_flip (basic-flip-vs-wf_vblank) [502.769653] Starting subtest: basic-flip-vs-wf_vblank [502.782574] Subtest basic-flip-vs-wf_vblank: SKIP (0.012s) [503.069469] [108/162] (570s left) kms_flip (basic-plain-flip) [503.667454] Starting subtest: basic-plain-flip [503.678190] Subtest basic-plain-flip: SKIP (0.011s) [503.964531] [109/162] (569s left) kms_force_connector_basic (force-connector-state) [504.418409] Starting subtest: force-connector-state [505.308133] Subtest force-connector-state: SUCCESS (0.878s) [506.663277] [110/162] (567s left) kms_force_connector_basic (force-edid) [507.064428] Starting subtest: force-edid [507.298984] Subtest force-edid: SUCCESS (0.236s) [507.990935] [111/162] (566s left) kms_force_connector_basic (force-load-detect) [508.397880] Starting subtest: force-load-detect [508.401477] Subtest force-load-detect: SKIP (0.000s) [508.933591] [112/162] (565s left) kms_force_connector_basic (prune-stale-modes) [509.305478] Starting subtest: prune-stale-modes [509.523632] Subtest prune-stale-modes: SUCCESS (0.228s) [510.273425] [113/162] (564s left) kms_frontbuffer_tracking (basic) [510.978871] Subtest basic: SKIP (0.000s) [511.240854] [114/162] (563s left) kms_hdmi_inject (inject-audio) [511.512131] Starting subtest: inject-audio [512.075481] Subtest inject-audio: SUCCESS (0.566s) [512.538324] [115/162] (562s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [513.170382] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s) [513.408812] [116/162] (561s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [513.996223] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s) [514.243406] [117/162] (561s left) kms_pipe_crc_basic (hang-read-crc) [514.880261] Subtest hang-read-crc: SKIP (0.000s) [515.133267] [118/162] (560s left) kms_pipe_crc_basic (nonblocking-crc) [515.686770] Subtest nonblocking-crc: SKIP (0.000s) [515.967175] [119/162] (559s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [516.629838] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s) [516.885335] [120/162] (559s left) kms_pipe_crc_basic (read-crc) [517.479844] Subtest read-crc: SKIP (0.000s) [517.729445] [121/162] (558s left) kms_pipe_crc_basic (read-crc-frame-sequence) [518.347866] Subtest read-crc-frame-sequence: SKIP (0.000s) [518.596575] [122/162] (558s left) kms_pm_backlight (basic-brightness) [519.148224] Subtest basic-brightness: SKIP (0.000s) [519.389659] [123/162] (557s left) kms_pm_rpm (basic-pci-d3-state) [521.426562] Starting subtest: basic-pci-d3-state [521.658184] Subtest basic-pci-d3-state: SUCCESS (0.231s) [521.894197] [124/162] (555s left) kms_pm_rpm (basic-rte) [522.125387] Starting subtest: basic-rte [523.967901] Subtest basic-rte: SUCCESS (1.835s) [524.494500] [125/162] (552s left) kms_psr (psr-primary-page-flip) [525.090495] Subtest psr-primary-page-flip: SKIP (0.000s) [525.374943] [126/162] (552s left) kms_psr (psr-cursor-plane-move) [525.982602] Subtest psr-cursor-plane-move: SKIP (0.000s) [526.223299] [127/162] (551s left) kms_psr (psr-sprite-plane-onoff) [526.863139] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [527.110752] [128/162] (550s left) kms_psr (psr-primary-mmap-gtt) [527.634793] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [527.872856] [129/162] (550s left) kms_setmode (basic-clone-single-crtc) [528.125497] Starting subtest: basic-clone-single-crtc [528.130546] Subtest basic-clone-single-crtc: SKIP (0.001s) [528.380338] [130/162] (550s left) i915_pm_rps (basic-api) [528.708265] Starting subtest: basic-api [528.736183] Subtest basic-api: SUCCESS (0.030s) [528.999226] [131/162] (549s left) prime_self_import (basic-llseek-bad) [529.242985] Starting subtest: basic-llseek-bad [529.259729] Subtest basic-llseek-bad: SUCCESS (0.017s) [529.501663] [132/162] (549s left) prime_self_import (basic-llseek-size) [529.731883] Starting subtest: basic-llseek-size [529.759397] Subtest basic-llseek-size: SUCCESS (0.033s) [530.026257] [133/162] (549s left) prime_self_import (basic-with_fd_dup) [530.262179] Starting subtest: basic-with_fd_dup [530.273688] Subtest basic-with_fd_dup: SUCCESS (0.017s) [530.531254] [134/162] (548s left) prime_self_import (basic-with_one_bo) [530.765304] Starting subtest: basic-with_one_bo [530.795773] Subtest basic-with_one_bo: SUCCESS (0.023s) [531.046409] [135/162] (548s left) prime_self_import (basic-with_one_bo_two_files) [531.266521] Starting subtest: basic-with_one_bo_two_files [531.300645] Subtest basic-with_one_bo_two_files: SUCCESS (0.031s) [531.571618] [136/162] (548s left) prime_self_import (basic-with_two_bos) [531.809143] Starting subtest: basic-with_two_bos [531.832747] Subtest basic-with_two_bos: SUCCESS (0.023s) [532.070400] [137/162] (547s left) prime_vgem (basic-fence-flip) [532.344476] Starting subtest: basic-fence-flip [532.698358] Subtest basic-fence-flip: SKIP (0.346s) [533.033121] [138/162] (547s left) prime_vgem (basic-fence-mmap) [533.309854] Starting subtest: basic-fence-mmap [533.495095] Subtest basic-fence-mmap: SUCCESS (0.177s) [533.763389] [139/162] (546s left) prime_vgem (basic-fence-read) [534.031188] Starting subtest: basic-fence-read [534.331308] Subtest basic-fence-read: SUCCESS (0.299s) [534.612966] [140/162] (546s left) prime_vgem (basic-gtt) [534.877329] Starting subtest: basic-gtt [534.964456] Subtest basic-gtt: SUCCESS (0.085s) [535.233122] [141/162] (545s left) prime_vgem (basic-read) [535.513275] Starting subtest: basic-read [535.654988] Subtest basic-read: SUCCESS (0.145s) [535.928476] [142/162] (545s left) prime_vgem (basic-write) [536.211788] Starting subtest: basic-write [536.405374] Subtest basic-write: SUCCESS (0.196s) [536.654838] [143/162] (544s left) vgem_basic (setversion) [536.897912] Starting subtest: setversion [536.908260] Subtest setversion: SUCCESS (0.000s) [537.142560] [144/162] (544s left) vgem_basic (create) [537.391272] Starting subtest: create [537.397883] Subtest create: SUCCESS (0.001s) [537.634635] [145/162] (544s left) vgem_basic (debugfs) [537.883813] Starting subtest: debugfs [537.888162] Subtest debugfs: SUCCESS (0.002s) [538.135709] [146/162] (544s left) vgem_basic (dmabuf-export) [538.401335] Starting subtest: dmabuf-export [538.423352] Subtest dmabuf-export: SUCCESS (0.020s) [538.678767] [147/162] (543s left) vgem_basic (dmabuf-fence) [538.929279] Starting subtest: dmabuf-fence [538.943922] Subtest dmabuf-fence: SUCCESS (0.008s) [539.188386] [148/162] (543s left) vgem_basic (dmabuf-fence-before) [539.431241] Starting subtest: dmabuf-fence-before [539.435154] Subtest dmabuf-fence-before: SUCCESS (0.002s) [539.675434] [149/162] (543s left) vgem_basic (dmabuf-mmap) [539.911775] Starting subtest: dmabuf-mmap [539.971503] Subtest dmabuf-mmap: SUCCESS (0.064s) [540.200826] [150/162] (542s left) vgem_basic (mmap) [540.480331] Starting subtest: mmap [540.540458] Subtest mmap: SUCCESS (0.067s) [540.822998] [151/162] (542s left) vgem_basic (second-client) [541.070911] Starting subtest: second-client [541.088223] Subtest second-client: SUCCESS (0.017s) [541.331506] [152/162] (542s left) vgem_basic (sysfs) [541.572411] Starting subtest: sysfs [541.575597] Subtest sysfs: SUCCESS (0.007s) [541.831854] [153/162] (541s left) core_hotunplug (unbind-rebind) [542.266212] Starting subtest: unbind-rebind [549.220129] Subtest unbind-rebind: SUCCESS (6.923s) [549.425113] [154/162] (534s left) vgem_basic (unload) [549.667287] Starting subtest: unload [578.930181] Subtest unload: SUCCESS (29.264s) [579.335545] [155/162] (504s left) i915_module_load (reload) [579.557811] Starting subtest: reload [589.306802] Subtest reload: SUCCESS (9.740s) [589.787964] [156/162] (494s left) gem_lmem_swapping (basic) [590.135166] Subtest basic: SKIP (0.000s) [590.359737] [157/162] (494s left) gem_lmem_swapping (parallel-random-engines) [590.620395] Subtest parallel-random-engines: SKIP (0.000s) [590.838153] [158/162] (494s left) gem_lmem_swapping (random-engines) [591.112730] Subtest random-engines: SKIP (0.000s) [591.342676] [159/162] (494s left) gem_lmem_swapping (verify-random) [591.608400] Subtest verify-random: SKIP (0.000s) [591.823193] [160/162] (493s left) i915_pm_rpm (module-reload) [593.871276] Starting subtest: module-reload [616.843649] Subtest module-reload: SUCCESS (22.972s) [617.002163] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [617.007893] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true [617.016214] [161/162] (468s left) i915_selftest (live) [617.264889] Starting subtest: live [617.268200] Starting dynamic subtest: sanitycheck [624.551511] Dynamic subtest sanitycheck: SUCCESS (7.286s) [624.604870] Starting dynamic subtest: uncore [631.568434] Dynamic subtest uncore: SUCCESS (7.006s) [631.704273] Starting dynamic subtest: workarounds [639.332323] Dynamic subtest workarounds: SUCCESS (7.748s) [639.379816] Starting dynamic subtest: gt_engines [647.386898] Dynamic subtest gt_engines: SUCCESS (8.049s) [647.438956] Starting dynamic subtest: gt_timelines [688.172676] Dynamic subtest gt_timelines: SUCCESS (40.774s) [688.222244] Starting dynamic subtest: gt_contexts [695.597237] Dynamic subtest gt_contexts: SUCCESS (7.418s) [695.658709] Starting dynamic subtest: gt_lrc [706.616433] Dynamic subtest gt_lrc: SUCCESS (11.010s) [706.774938] Starting dynamic subtest: gt_mocs [713.841774] Dynamic subtest gt_mocs: SUCCESS (7.216s) [713.888727] Starting dynamic subtest: gt_pm [722.578866] Dynamic subtest gt_pm: SUCCESS (8.732s) [722.622432] Starting dynamic subtest: gt_heartbeat [730.128372] Dynamic subtest gt_heartbeat: SUCCESS (7.542s) [730.173312] Starting dynamic subtest: gt_tlb [738.063720] Dynamic subtest gt_tlb: SUCCESS (7.931s) [738.110067] Starting dynamic subtest: requests [752.403448] Dynamic subtest requests: SUCCESS (14.330s) [752.462326] Starting dynamic subtest: migrate [764.218600] Dynamic subtest migrate: SUCCESS (11.796s) [764.258568] Starting dynamic subtest: active [771.609120] Dynamic subtest active: SUCCESS (7.387s) [771.652850] Starting dynamic subtest: objects [780.472233] Dynamic subtest objects: SUCCESS (8.855s) [780.573396] Starting dynamic subtest: mman [794.827678] Dynamic subtest mman: SUCCESS (14.344s) [794.874614] Starting dynamic subtest: dmabuf [802.299961] Dynamic subtest dmabuf: SUCCESS (7.466s) [802.346166] Starting dynamic subtest: vma [809.536893] Dynamic subtest vma: SUCCESS (7.228s) [809.583354] Starting dynamic subtest: coherency [824.419519] Dynamic subtest coherency: SUCCESS (14.874s) [824.469463] Starting dynamic subtest: gtt [840.028205] Dynamic subtest gtt: SUCCESS (15.599s) [840.073973] Starting dynamic subtest: gem [848.628641] Dynamic subtest gem: SUCCESS (8.595s) [848.673076] Starting dynamic subtest: evict [864.721991] Dynamic subtest evict: SUCCESS (16.085s) [864.766313] Starting dynamic subtest: hugepages [872.609249] Dynamic subtest hugepages: SUCCESS (7.879s) [872.655377] Starting dynamic subtest: gem_contexts [910.142262] Dynamic subtest gem_contexts: SUCCESS (37.519s) [910.182780] Starting dynamic subtest: client [917.549215] Dynamic subtest client: SUCCESS (7.403s) [917.595084] Starting dynamic subtest: gem_migrate [924.756917] Dynamic subtest gem_migrate: SUCCESS (7.203s) [924.805217] Starting dynamic subtest: reset [940.270846] Dynamic subtest reset: SUCCESS (15.506s) [940.316846] Starting dynamic subtest: memory_region [948.527126] Dynamic subtest memory_region: SUCCESS (8.249s) [948.682081] Starting dynamic subtest: hangcheck [981.235634] Dynamic subtest hangcheck: SUCCESS (32.691s) [981.283450] Starting dynamic subtest: execlists [995.278205] Dynamic subtest execlists: SUCCESS (14.031s) [995.320834] Starting dynamic subtest: ring_submission [1002.436178] Dynamic subtest ring_submission: SUCCESS (7.150s) [1002.485235] Starting dynamic subtest: perf [1010.223166] Dynamic subtest perf: SUCCESS (7.777s) [1010.263480] Starting dynamic subtest: slpc [1017.362636] Dynamic subtest slpc: SUCCESS (7.134s) [1017.411305] Starting dynamic subtest: guc [1024.452200] Dynamic subtest guc: SUCCESS (7.084s) [1024.499472] Starting dynamic subtest: guc_multi_lrc [1031.578497] Dynamic subtest guc_multi_lrc: SUCCESS (7.118s) [1031.620461] Starting dynamic subtest: guc_hang [1038.714062] Dynamic subtest guc_hang: SUCCESS (7.131s) [1038.775904] Starting dynamic subtest: late_gt_pm [1046.067176] Dynamic subtest late_gt_pm: SUCCESS (7.336s) [1046.069170] Subtest live: SUCCESS (428.797s) [1046.238402] [162/162] ( 39s left) dmabuf (all-tests) [1046.485628] Starting subtest: all-tests [1046.489201] Starting dynamic subtest: sanitycheck [1046.548589] Dynamic subtest sanitycheck: SUCCESS (0.067s) [1046.698129] Starting dynamic subtest: dma_fence [1046.777947] Dynamic subtest dma_fence: SUCCESS (0.220s) [1046.879106] Starting dynamic subtest: dma_fence_chain [1046.882350] Dynamic subtest dma_fence_chain: SKIP (0.003s) [1046.936625] Starting dynamic subtest: dma_fence_unwrap [1046.942295] Dynamic subtest dma_fence_unwrap: SUCCESS (0.086s) [1047.004957] Starting dynamic subtest: dma_resv [1047.006818] Dynamic subtest dma_resv: SUCCESS (0.106s) [1047.008744] Subtest all-tests: SUCCESS (0.528s) [1047.171537] Closing watchdogs results: parsing output: 0/ for test: i915_module_load results: parsing output: 1/ for test: core_auth results: parsing output: 2/ for test: core_debugfs results: parsing output: 3/ for test: core_sysfs results: parsing output: 4/ for test: fbdev results: parsing output: 5/ for test: fbdev results: parsing output: 6/ for test: fbdev results: parsing output: 7/ for test: fbdev results: parsing output: 8/ for test: fbdev results: parsing output: 9/ for test: gem_basic results: parsing output: 10/ for test: gem_basic results: parsing output: 11/ for test: gem_basic results: parsing output: 12/ for test: gem_busy results: parsing output: 13/ for test: gem_close_race results: parsing output: 14/ for test: gem_close_race results: parsing output: 15/ for test: gem_ctx_create results: parsing output: 16/ for test: gem_ctx_create results: parsing output: 17/ for test: gem_ctx_exec results: parsing output: 18/ for test: gem_exec_basic results: parsing output: 19/ for test: gem_exec_create results: parsing output: 20/ for test: gem_exec_fence results: parsing output: 21/ for test: gem_exec_fence results: parsing output: 22/ for test: gem_exec_fence results: parsing output: 23/ for test: gem_exec_fence results: parsing output: 24/ for test: gem_exec_gttfill results: parsing output: 25/ for test: gem_exec_parallel results: parsing output: 26/ for test: gem_exec_store results: parsing output: 27/ for test: gem_flink_basic results: parsing output: 28/ for test: gem_flink_basic results: parsing output: 29/ for test: gem_flink_basic results: parsing output: 30/ for test: gem_flink_basic results: parsing output: 31/ for test: gem_flink_basic results: parsing output: 32/ for test: gem_huc_copy results: parsing output: 33/ for test: gem_linear_blits results: parsing output: 34/ for test: gem_mmap results: parsing output: 35/ for test: gem_mmap_gtt results: parsing output: 36/ for test: gem_render_linear_blits results: parsing output: 37/ for test: gem_render_tiled_blits results: parsing output: 38/ for test: gem_ringfill results: parsing output: 39/ for test: gem_softpin results: parsing output: 40/ for test: gem_softpin results: parsing output: 41/ for test: gem_softpin results: parsing output: 42/ for test: gem_sync results: parsing output: 43/ for test: gem_sync results: parsing output: 44/ for test: gem_tiled_blits results: parsing output: 45/ for test: gem_tiled_fence_blits results: parsing output: 46/ for test: gem_tiled_pread_basic results: parsing output: 47/ for test: gem_wait results: parsing output: 48/ for test: gem_wait results: parsing output: 49/ for test: i915_getparams_basic results: parsing output: 50/ for test: i915_getparams_basic results: parsing output: 51/ for test: i915_hangman results: parsing output: 52/ for test: i915_pciid results: parsing output: 53/ for test: intel_hwmon results: parsing output: 54/ for test: intel_hwmon results: parsing output: 55/ for test: kms_addfb_basic results: parsing output: 56/ for test: kms_addfb_basic results: parsing output: 57/ for test: kms_addfb_basic results: parsing output: 58/ for test: kms_addfb_basic results: parsing output: 59/ for test: kms_addfb_basic results: parsing output: 60/ for test: kms_addfb_basic results: parsing output: 61/ for test: kms_addfb_basic results: parsing output: 62/ for test: kms_addfb_basic results: parsing output: 63/ for test: kms_addfb_basic results: parsing output: 64/ for test: kms_addfb_basic results: parsing output: 65/ for test: kms_addfb_basic results: parsing output: 66/ for test: kms_addfb_basic results: parsing output: 67/ for test: kms_addfb_basic results: parsing output: 68/ for test: kms_addfb_basic results: parsing output: 69/ for test: kms_addfb_basic results: parsing output: 70/ for test: kms_addfb_basic results: parsing output: 71/ for test: kms_addfb_basic results: parsing output: 72/ for test: kms_addfb_basic results: parsing output: 73/ for test: kms_addfb_basic results: parsing output: 74/ for test: kms_addfb_basic results: parsing output: 75/ for test: kms_addfb_basic results: parsing output: 76/ for test: kms_addfb_basic results: parsing output: 77/ for test: kms_addfb_basic results: parsing output: 78/ for test: kms_addfb_basic results: parsing output: 79/ for test: kms_addfb_basic results: parsing output: 80/ for test: kms_addfb_basic results: parsing output: 81/ for test: kms_addfb_basic results: parsing output: 82/ for test: kms_addfb_basic results: parsing output: 83/ for test: kms_addfb_basic results: parsing output: 84/ for test: kms_addfb_basic results: parsing output: 85/ for test: kms_addfb_basic results: parsing output: 86/ for test: kms_addfb_basic results: parsing output: 87/ for test: kms_addfb_basic results: parsing output: 88/ for test: kms_addfb_basic results: parsing output: 89/ for test: kms_addfb_basic results: parsing output: 90/ for test: kms_addfb_basic results: parsing output: 91/ for test: kms_addfb_basic results: parsing output: 92/ for test: kms_addfb_basic results: parsing output: 93/ for test: kms_busy results: parsing output: 94/ for test: kms_prop_blob results: parsing output: 95/ for test: kms_cursor_legacy results: parsing output: 96/ for test: kms_cursor_legacy results: parsing output: 97/ for test: kms_cursor_legacy results: parsing output: 98/ for test: kms_cursor_legacy results: parsing output: 99/ for test: kms_cursor_legacy results: parsing output: 100/ for test: kms_cursor_legacy results: parsing output: 101/ for test: kms_cursor_legacy results: parsing output: 102/ for test: kms_cursor_legacy results: parsing output: 103/ for test: kms_dsc results: parsing output: 104/ for test: kms_flip results: parsing output: 105/ for test: kms_flip results: parsing output: 106/ for test: kms_flip results: parsing output: 107/ for test: kms_flip results: parsing output: 108/ for test: kms_force_connector_basic results: parsing output: 109/ for test: kms_force_connector_basic results: parsing output: 110/ for test: kms_force_connector_basic results: parsing output: 111/ for test: kms_force_connector_basic results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: kms_hdmi_inject results: parsing output: 114/ for test: kms_pipe_crc_basic results: parsing output: 115/ for test: kms_pipe_crc_basic results: parsing output: 116/ for test: kms_pipe_crc_basic results: parsing output: 117/ for test: kms_pipe_crc_basic results: parsing output: 118/ for test: kms_pipe_crc_basic results: parsing output: 119/ for test: kms_pipe_crc_basic results: parsing output: 120/ for test: kms_pipe_crc_basic results: parsing output: 121/ for test: kms_pm_backlight results: parsing output: 122/ for test: kms_pm_rpm results: parsing output: 123/ for test: kms_pm_rpm results: parsing output: 124/ for test: kms_psr results: parsing output: 125/ for test: kms_psr results: parsing output: 126/ for test: kms_psr results: parsing output: 127/ for test: kms_psr results: parsing output: 128/ for test: kms_setmode results: parsing output: 129/ for test: i915_pm_rps results: parsing output: 130/ for test: prime_self_import results: parsing output: 131/ for test: prime_self_import results: parsing output: 132/ for test: prime_self_import results: parsing output: 133/ for test: prime_self_import results: parsing output: 134/ for test: prime_self_import results: parsing output: 135/ for test: prime_self_import results: parsing output: 136/ for test: prime_vgem results: parsing output: 137/ for test: prime_vgem results: parsing output: 138/ for test: prime_vgem results: parsing output: 139/ for test: prime_vgem results: parsing output: 140/ for test: prime_vgem results: parsing output: 141/ for test: prime_vgem results: parsing output: 142/ for test: vgem_basic results: parsing output: 143/ for test: vgem_basic results: parsing output: 144/ for test: vgem_basic results: parsing output: 145/ for test: vgem_basic results: parsing output: 146/ for test: vgem_basic results: parsing output: 147/ for test: vgem_basic results: parsing output: 148/ for test: vgem_basic results: parsing output: 149/ for test: vgem_basic results: parsing output: 150/ for test: vgem_basic results: parsing output: 151/ for test: vgem_basic results: parsing output: 152/ for test: core_hotunplug results: parsing output: 153/ for test: vgem_basic results: parsing output: 154/ for test: i915_module_load results: parsing output: 155/ for test: gem_lmem_swapping results: parsing output: 156/ for test: gem_lmem_swapping results: parsing output: 157/ for test: gem_lmem_swapping results: parsing output: 158/ for test: gem_lmem_swapping results: parsing output: 159/ for test: i915_pm_rpm results: parsing output: 160/ for test: i915_selftest results: parsing output: 161/ for test: dmabuf Done.