[127.283132] Initializing watchdogs [127.283207] /dev/watchdog0 [127.297815] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:591d Intel Kabylake (Gen9) HD Graphics P630 [127.304971] [001/162] (960s left) i915_module_load (load) [127.366738] Starting subtest: load [129.331191] Subtest load: SUCCESS (1.964s) [129.364648] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [129.365843] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [129.370878] [002/162] (958s left) core_auth (basic-auth) [129.445799] Starting subtest: basic-auth [129.448850] Subtest basic-auth: SUCCESS (0.001s) [129.565801] [003/162] (958s left) core_debugfs (read-all-entries) [129.952583] Starting subtest: read-all-entries [130.016982] Subtest read-all-entries: SUCCESS (0.003s) [130.404325] [004/162] (957s left) core_sysfs (read-all-entries) [130.729277] Starting subtest: read-all-entries [130.793856] Subtest read-all-entries: SUCCESS (0.008s) [130.968917] [005/162] (957s left) fbdev (eof) [131.027433] Subtest eof: SKIP (0.000s) [131.065874] [006/162] (957s left) fbdev (info) [131.119849] Subtest info: SKIP (0.000s) [131.160915] [007/162] (957s left) fbdev (nullptr) [131.212712] Subtest nullptr: SKIP (0.000s) [131.250718] [008/162] (957s left) fbdev (read) [131.301727] Subtest read: SKIP (0.000s) [131.339992] [009/162] (957s left) fbdev (write) [131.395175] Subtest write: SKIP (0.000s) [131.433099] [010/162] (957s left) gem_basic (bad-close) [131.484674] Starting subtest: bad-close [131.491524] Subtest bad-close: SUCCESS (0.000s) [131.530393] [011/162] (957s left) gem_basic (create-close) [131.578806] Starting subtest: create-close [131.585574] Subtest create-close: SUCCESS (0.000s) [131.631472] [012/162] (957s left) gem_basic (create-fd-close) [131.680676] Starting subtest: create-fd-close [131.687368] Subtest create-fd-close: SUCCESS (0.000s) [131.739082] [013/162] (957s left) gem_busy (busy@all-engines) [131.804329] Starting subtest: busy [131.809325] Starting dynamic subtest: all-engines [131.830375] Dynamic subtest all-engines: SUCCESS (0.027s) [131.833459] Subtest busy: SUCCESS (0.028s) [132.166204] [014/162] (956s left) gem_close_race (basic-process) [132.227587] Starting subtest: basic-process [132.289798] Subtest basic-process: SUCCESS (0.062s) [132.435480] [015/162] (956s left) gem_close_race (basic-threads) [132.494373] Starting subtest: basic-threads [133.691271] Subtest basic-threads: SUCCESS (1.196s) [133.842918] [016/162] (955s left) gem_ctx_create (basic) [133.900006] Starting subtest: basic [133.903165] Subtest basic: SUCCESS (0.000s) [134.045638] [017/162] (954s left) gem_ctx_create (basic-files) [134.101464] Starting subtest: basic-files [136.113648] Subtest basic-files: SUCCESS (2.012s) [136.301266] [018/162] (952s left) gem_ctx_exec (basic) [136.353501] Starting subtest: basic [136.356674] Subtest basic: SUCCESS (0.004s) [136.427535] [019/162] (952s left) gem_exec_basic (basic) [136.492438] Starting subtest: basic [136.495427] Starting dynamic subtest: rcs0-smem [136.498387] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [136.508958] Starting dynamic subtest: bcs0-smem [136.511938] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [136.522624] Starting dynamic subtest: vcs0-smem [136.525938] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [136.536685] Starting dynamic subtest: vecs0-smem [136.539851] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [136.543233] Subtest basic: SUCCESS (0.005s) [136.664547] [020/162] (952s left) gem_exec_create (basic) [136.722776] Starting subtest: basic [136.726190] Starting dynamic subtest: smem [138.769353] Dynamic subtest smem: SUCCESS (2.047s) [138.772612] Subtest basic: SUCCESS (2.047s) [138.915880] [021/162] (950s left) gem_exec_fence (basic-busy) [139.090481] Starting subtest: basic-busy [139.093903] Starting dynamic subtest: rcs0 [139.131725] Dynamic subtest rcs0: SUCCESS (0.041s) [139.149189] Starting dynamic subtest: bcs0 [139.159240] Dynamic subtest bcs0: SUCCESS (0.025s) [139.169967] Starting dynamic subtest: vcs0 [139.181234] Dynamic subtest vcs0: SUCCESS (0.024s) [139.191877] Starting dynamic subtest: vecs0 [139.215167] Dynamic subtest vecs0: SUCCESS (0.034s) [139.218177] Subtest basic-busy: SUCCESS (0.125s) [139.745951] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [139.750081] [022/162] (949s left) gem_exec_fence (basic-wait) [139.916843] Starting subtest: basic-wait [139.920211] Starting dynamic subtest: rcs0 [139.951462] Dynamic subtest rcs0: SUCCESS (0.034s) [139.972956] Starting dynamic subtest: bcs0 [139.986519] Dynamic subtest bcs0: SUCCESS (0.034s) [140.003759] Starting dynamic subtest: vcs0 [140.013301] Dynamic subtest vcs0: SUCCESS (0.027s) [140.030379] Starting dynamic subtest: vecs0 [140.041671] Dynamic subtest vecs0: SUCCESS (0.027s) [140.045252] Subtest basic-wait: SUCCESS (0.125s) [140.535440] [023/162] (948s left) gem_exec_fence (basic-await) [140.708515] Starting subtest: basic-await [140.711604] Starting dynamic subtest: rcs0 [140.785316] Dynamic subtest rcs0: SUCCESS (0.076s) [140.804133] Starting dynamic subtest: bcs0 [140.871879] Dynamic subtest bcs0: SUCCESS (0.086s) [140.895797] Starting dynamic subtest: vcs0 [140.963560] Dynamic subtest vcs0: SUCCESS (0.091s) [140.985562] Starting dynamic subtest: vecs0 [141.055960] Dynamic subtest vecs0: SUCCESS (0.092s) [141.059305] Subtest basic-await: SUCCESS (0.347s) [141.556592] [024/162] (947s left) gem_exec_fence (nb-await) [141.725079] Starting subtest: nb-await [141.728155] Starting dynamic subtest: rcs0 [141.788912] Dynamic subtest rcs0: SUCCESS (0.063s) [141.811134] Starting dynamic subtest: bcs0 [141.854844] Dynamic subtest bcs0: SUCCESS (0.065s) [141.868843] Starting dynamic subtest: vcs0 [141.915820] Dynamic subtest vcs0: SUCCESS (0.061s) [141.937807] Starting dynamic subtest: vecs0 [141.979804] Dynamic subtest vecs0: SUCCESS (0.063s) [141.983461] Subtest nb-await: SUCCESS (0.255s) [142.456678] [025/162] (946s left) gem_exec_gttfill (basic) [142.512975] Starting subtest: basic [145.883874] Subtest basic: SUCCESS (3.370s) [146.044905] [026/162] (943s left) gem_exec_parallel (engines) [146.170430] Starting subtest: engines [146.173496] Starting dynamic subtest: basic [148.213649] Dynamic subtest basic: SUCCESS (2.043s) [148.225426] Starting dynamic subtest: contexts [150.201837] Dynamic subtest contexts: SUCCESS (1.988s) [150.214874] Starting dynamic subtest: fds [152.085435] Dynamic subtest fds: SUCCESS (1.883s) [152.097119] Starting dynamic subtest: userptr [154.142739] Dynamic subtest userptr: SUCCESS (2.057s) [154.145827] Subtest engines: SUCCESS (7.971s) [154.312252] [027/162] (935s left) gem_exec_store (basic) [154.374650] Starting subtest: basic [154.435882] Subtest basic: SUCCESS (0.062s) [154.587350] [028/162] (934s left) gem_flink_basic (bad-flink) [154.636379] Starting subtest: bad-flink [154.639402] Subtest bad-flink: SUCCESS (0.000s) [154.683470] [029/162] (934s left) gem_flink_basic (bad-open) [154.734824] Starting subtest: bad-open [154.737968] Subtest bad-open: SUCCESS (0.000s) [154.781166] [030/162] (934s left) gem_flink_basic (basic) [154.826701] Starting subtest: basic [154.829895] Subtest basic: SUCCESS (0.000s) [154.878779] [031/162] (934s left) gem_flink_basic (double-flink) [154.928158] Starting subtest: double-flink [154.931479] Subtest double-flink: SUCCESS (0.000s) [154.987975] [032/162] (934s left) gem_flink_basic (flink-lifetime) [155.035160] Starting subtest: flink-lifetime [155.038399] Subtest flink-lifetime: SUCCESS (0.001s) [155.092614] [033/162] (934s left) gem_huc_copy (huc-copy) [155.145407] Starting subtest: huc-copy [155.168310] Subtest huc-copy: SKIP (0.000s) [155.353828] [034/162] (934s left) gem_linear_blits (basic) [155.862646] Starting subtest: basic [155.929376] Subtest basic: SUCCESS (0.004s) [156.447982] [035/162] (933s left) gem_mmap (basic) [156.802198] Starting subtest: basic [156.819521] Subtest basic: SUCCESS (0.000s) [156.866492] [036/162] (933s left) gem_mmap_gtt (basic) [156.917429] Starting subtest: basic [156.920596] Subtest basic: SUCCESS (0.001s) [156.967641] [037/162] (933s left) gem_render_linear_blits (basic) [157.023656] Starting subtest: basic [157.050559] Subtest basic: SUCCESS (0.031s) [157.106135] [038/162] (933s left) gem_render_tiled_blits (basic) [157.155440] Starting subtest: basic [157.184205] Subtest basic: SUCCESS (0.032s) [157.246377] [039/162] (933s left) gem_ringfill (basic-all) [157.474394] Starting subtest: basic-all [158.599208] Subtest basic-all: SUCCESS (1.126s) [158.676086] [040/162] (931s left) gem_softpin (allocator-basic) [158.732177] Starting subtest: allocator-basic [158.825508] Subtest allocator-basic: SUCCESS (0.096s) [158.901352] [041/162] (931s left) gem_softpin (allocator-basic-reserve) [158.954163] Starting subtest: allocator-basic-reserve [159.049406] Subtest allocator-basic-reserve: SUCCESS (0.098s) [159.144042] [042/162] (931s left) gem_softpin (safe-alignment) [159.200234] Starting subtest: safe-alignment [159.206875] Subtest safe-alignment: SUCCESS (0.010s) [159.292608] [043/162] (931s left) gem_sync (basic-all) [159.375166] Starting subtest: basic-all [161.397184] Subtest basic-all: SUCCESS (2.043s) [161.544997] [044/162] (929s left) gem_sync (basic-each) [161.619771] Starting subtest: basic-each [163.709471] Subtest basic-each: SUCCESS (2.107s) [163.862360] [045/162] (926s left) gem_tiled_blits (basic) [163.989142] Starting subtest: basic [164.004946] Subtest basic: SUCCESS (0.015s) [164.101198] [046/162] (926s left) gem_tiled_fence_blits (basic) [164.283768] Starting subtest: basic [164.290440] Subtest basic: SUCCESS (0.008s) [164.381709] [047/162] (926s left) gem_tiled_pread_basic (basic) [164.510528] Starting subtest: basic [164.625874] Subtest basic: SUCCESS (0.119s) [164.683800] [048/162] (926s left) gem_wait (busy@all-engines) [164.744734] Starting subtest: busy [164.747835] Starting dynamic subtest: all-engines [165.281172] Dynamic subtest all-engines: SUCCESS (0.536s) [165.284119] Subtest busy: SUCCESS (0.536s) [165.440959] [049/162] (925s left) gem_wait (wait@all-engines) [165.504198] Starting subtest: wait [165.507527] Starting dynamic subtest: all-engines [166.538566] Dynamic subtest all-engines: SUCCESS (1.037s) [166.542126] Subtest wait: SUCCESS (1.038s) [166.701795] [050/162] (924s left) i915_getparams_basic (basic-eu-total) [166.755515] Starting subtest: basic-eu-total [166.761629] Subtest basic-eu-total: SUCCESS (0.000s) [166.804320] [051/162] (924s left) i915_getparams_basic (basic-subslice-total) [166.856160] Starting subtest: basic-subslice-total [166.862176] Subtest basic-subslice-total: SUCCESS (0.000s) [166.905641] [052/162] (924s left) i915_hangman (error-state-basic) [166.963929] Starting subtest: error-state-basic [166.967577] Subtest error-state-basic: SUCCESS (0.006s) [167.053587] [053/162] (924s left) i915_pciid [167.150628] [054/162] (924s left) intel_hwmon (hwmon-read) [167.199228] Subtest hwmon-read: SKIP (0.000s) [167.246369] [055/162] (924s left) intel_hwmon (hwmon-write) [167.298118] Subtest hwmon-write: SKIP (0.000s) [167.345051] [056/162] (923s left) kms_addfb_basic (addfb25-4-tiled) [167.436509] Starting subtest: addfb25-4-tiled [167.439876] Subtest addfb25-4-tiled: SUCCESS (0.000s) [167.502181] [057/162] (923s left) kms_addfb_basic (addfb25-bad-modifier) [167.596979] Starting subtest: addfb25-bad-modifier [167.600318] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [167.661499] [058/162] (923s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [167.744066] Starting subtest: addfb25-framebuffer-vs-set-tiling [167.747367] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [167.810755] [059/162] (923s left) kms_addfb_basic (addfb25-modifier-no-flag) [167.887420] Starting subtest: addfb25-modifier-no-flag [167.890540] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [167.950699] [060/162] (923s left) kms_addfb_basic (addfb25-x-tiled-legacy) [168.030427] Starting subtest: addfb25-x-tiled-legacy [168.033525] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [168.096479] [061/162] (923s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [168.173417] Starting subtest: addfb25-x-tiled-mismatch-legacy [168.176548] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [168.235389] [062/162] (923s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [168.313180] Starting subtest: addfb25-yf-tiled-legacy [168.316439] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [168.379857] [063/162] (923s left) kms_addfb_basic (addfb25-y-tiled-legacy) [168.460213] Starting subtest: addfb25-y-tiled-legacy [168.463686] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [168.528979] [064/162] (923s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [168.607962] Starting subtest: addfb25-y-tiled-small-legacy [168.611200] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [168.669330] [065/162] (923s left) kms_addfb_basic (bad-pitch-0) [168.722785] Starting subtest: bad-pitch-0 [168.726097] Subtest bad-pitch-0: SUCCESS (0.000s) [168.811489] [066/162] (922s left) kms_addfb_basic (bad-pitch-1024) [168.863593] Starting subtest: bad-pitch-1024 [168.867508] Subtest bad-pitch-1024: SUCCESS (0.000s) [168.955418] [067/162] (922s left) kms_addfb_basic (bad-pitch-128) [169.007159] Starting subtest: bad-pitch-128 [169.011717] Subtest bad-pitch-128: SUCCESS (0.000s) [169.100967] [068/162] (922s left) kms_addfb_basic (bad-pitch-256) [169.152150] Starting subtest: bad-pitch-256 [169.155558] Subtest bad-pitch-256: SUCCESS (0.000s) [169.235880] [069/162] (922s left) kms_addfb_basic (bad-pitch-32) [169.290762] Starting subtest: bad-pitch-32 [169.293821] Subtest bad-pitch-32: SUCCESS (0.000s) [169.369524] [070/162] (922s left) kms_addfb_basic (bad-pitch-63) [169.425232] Starting subtest: bad-pitch-63 [169.428129] Subtest bad-pitch-63: SUCCESS (0.000s) [169.512428] [071/162] (922s left) kms_addfb_basic (bad-pitch-65536) [169.564591] Starting subtest: bad-pitch-65536 [169.568204] Subtest bad-pitch-65536: SUCCESS (0.000s) [169.659127] [072/162] (922s left) kms_addfb_basic (bad-pitch-999) [169.709730] Starting subtest: bad-pitch-999 [169.714110] Subtest bad-pitch-999: SUCCESS (0.000s) [169.807186] [073/162] (922s left) kms_addfb_basic (basic) [169.858643] Starting subtest: basic [169.862535] Subtest basic: SUCCESS (0.000s) [169.944649] [074/162] (922s left) kms_addfb_basic (basic-x-tiled-legacy) [169.996377] Starting subtest: basic-x-tiled-legacy [169.999674] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [170.209552] [075/162] (922s left) kms_addfb_basic (basic-y-tiled-legacy) [170.589177] Starting subtest: basic-y-tiled-legacy [170.653400] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [171.067373] [076/162] (921s left) kms_addfb_basic (bo-too-small) [171.391162] Starting subtest: bo-too-small [171.511953] Subtest bo-too-small: SUCCESS (0.000s) [171.559292] [077/162] (921s left) kms_addfb_basic (bo-too-small-due-to-tiling) [171.639186] Starting subtest: bo-too-small-due-to-tiling [171.642517] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [171.692463] [078/162] (921s left) kms_addfb_basic (clobberred-modifier) [171.743049] Starting subtest: clobberred-modifier [171.748111] Subtest clobberred-modifier: SUCCESS (0.000s) [171.834986] [079/162] (920s left) kms_addfb_basic (framebuffer-vs-set-tiling) [171.886814] Starting subtest: framebuffer-vs-set-tiling [171.890726] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [171.981654] [080/162] (920s left) kms_addfb_basic (invalid-get-prop) [172.033018] Starting subtest: invalid-get-prop [172.037858] Subtest invalid-get-prop: SUCCESS (0.000s) [172.125351] [081/162] (920s left) kms_addfb_basic (invalid-get-prop-any) [172.177807] Starting subtest: invalid-get-prop-any [172.181224] Subtest invalid-get-prop-any: SUCCESS (0.000s) [172.269705] [082/162] (920s left) kms_addfb_basic (invalid-set-prop) [172.318882] Starting subtest: invalid-set-prop [172.323630] Subtest invalid-set-prop: SUCCESS (0.000s) [172.410331] [083/162] (920s left) kms_addfb_basic (invalid-set-prop-any) [172.460808] Starting subtest: invalid-set-prop-any [172.464898] Subtest invalid-set-prop-any: SUCCESS (0.000s) [172.543456] [084/162] (920s left) kms_addfb_basic (no-handle) [172.594333] Starting subtest: no-handle [172.597477] Subtest no-handle: SUCCESS (0.000s) [172.684162] [085/162] (920s left) kms_addfb_basic (size-max) [172.762148] Starting subtest: size-max [172.765125] Subtest size-max: SUCCESS (0.000s) [172.829396] [086/162] (920s left) kms_addfb_basic (small-bo) [172.908099] Starting subtest: small-bo [172.911057] Subtest small-bo: SUCCESS (0.000s) [172.970841] [087/162] (920s left) kms_addfb_basic (tile-pitch-mismatch) [173.021555] Starting subtest: tile-pitch-mismatch [173.025424] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [173.118469] [088/162] (920s left) kms_addfb_basic (too-high) [173.196646] Starting subtest: too-high [173.199634] Subtest too-high: SUCCESS (0.001s) [173.260272] [089/162] (919s left) kms_addfb_basic (too-wide) [173.342592] Starting subtest: too-wide [173.345552] Subtest too-wide: SUCCESS (0.000s) [173.410827] [090/162] (919s left) kms_addfb_basic (unused-handle) [173.466455] Starting subtest: unused-handle [173.469556] Subtest unused-handle: SUCCESS (0.000s) [173.548889] [091/162] (919s left) kms_addfb_basic (unused-modifier) [173.600857] Starting subtest: unused-modifier [173.604529] Subtest unused-modifier: SUCCESS (0.000s) [173.688893] [092/162] (919s left) kms_addfb_basic (unused-offsets) [173.744168] Starting subtest: unused-offsets [173.747179] Subtest unused-offsets: SUCCESS (0.000s) [173.822999] [093/162] (919s left) kms_addfb_basic (unused-pitches) [173.875202] Starting subtest: unused-pitches [173.878822] Subtest unused-pitches: SUCCESS (0.000s) [173.961845] [094/162] (919s left) kms_busy (basic) [174.048856] Subtest basic: SKIP (0.000s) [174.096714] [095/162] (919s left) kms_prop_blob (basic) [174.150713] Starting subtest: basic [174.154033] Subtest basic: SUCCESS (0.000s) [174.197607] [096/162] (919s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [174.296196] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [174.342181] [097/162] (919s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [174.445654] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [174.491301] [098/162] (919s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [174.590256] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s) [174.636087] [099/162] (919s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [174.738610] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s) [174.785076] [100/162] (918s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [174.885794] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s) [174.932571] [101/162] (918s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [175.032128] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s) [175.077748] [102/162] (918s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [175.179161] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s) [175.224899] [103/162] (918s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [175.328599] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s) [175.374368] [104/162] (918s left) kms_dsc (dsc-basic) [175.454651] Subtest dsc-basic: SKIP (0.000s) [175.497446] [105/162] (918s left) kms_flip (basic-flip-vs-dpms) [175.581173] Starting subtest: basic-flip-vs-dpms [175.587835] Subtest basic-flip-vs-dpms: SKIP (0.001s) [175.656526] [106/162] (918s left) kms_flip (basic-flip-vs-modeset) [175.737090] Starting subtest: basic-flip-vs-modeset [175.743096] Subtest basic-flip-vs-modeset: SKIP (0.001s) [175.786414] [107/162] (918s left) kms_flip (basic-flip-vs-wf_vblank) [175.866684] Starting subtest: basic-flip-vs-wf_vblank [175.872404] Subtest basic-flip-vs-wf_vblank: SKIP (0.001s) [175.915877] [108/162] (918s left) kms_flip (basic-plain-flip) [175.995598] Starting subtest: basic-plain-flip [176.001261] Subtest basic-plain-flip: SKIP (0.001s) [176.056348] [109/162] (918s left) kms_force_connector_basic (force-connector-state) [176.202806] Starting subtest: force-connector-state [176.281099] Subtest force-connector-state: SUCCESS (0.080s) [176.440836] [110/162] (917s left) kms_force_connector_basic (force-edid) [176.591352] Starting subtest: force-edid [176.768995] Subtest force-edid: SUCCESS (0.179s) [176.853216] [111/162] (917s left) kms_force_connector_basic (force-load-detect) [176.998294] Starting subtest: force-load-detect [177.004121] Subtest force-load-detect: SKIP (0.000s) [177.066343] [112/162] (917s left) kms_force_connector_basic (prune-stale-modes) [177.214193] Starting subtest: prune-stale-modes [177.392333] Subtest prune-stale-modes: SUCCESS (0.178s) [177.475051] [113/162] (916s left) kms_frontbuffer_tracking (basic) [177.563548] Subtest basic: SKIP (0.000s) [177.617213] [114/162] (916s left) kms_hdmi_inject (inject-audio) [177.668656] Starting subtest: inject-audio [177.675179] Subtest inject-audio: SKIP (0.000s) [177.734377] [115/162] (916s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [177.813553] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s) [177.857630] [116/162] (916s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [177.940473] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s) [177.983831] [117/162] (916s left) kms_pipe_crc_basic (hang-read-crc) [178.062681] Subtest hang-read-crc: SKIP (0.000s) [178.106759] [118/162] (916s left) kms_pipe_crc_basic (nonblocking-crc) [178.188097] Subtest nonblocking-crc: SKIP (0.000s) [178.232914] [119/162] (916s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [178.311642] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s) [178.355577] [120/162] (916s left) kms_pipe_crc_basic (read-crc) [178.433138] Subtest read-crc: SKIP (0.000s) [178.478782] [121/162] (916s left) kms_pipe_crc_basic (read-crc-frame-sequence) [178.556716] Subtest read-crc-frame-sequence: SKIP (0.000s) [178.601124] [122/162] (916s left) kms_pm_backlight (basic-brightness) [178.681661] Subtest basic-brightness: SKIP (0.000s) [178.726600] [123/162] (916s left) kms_pm_rpm (basic-pci-d3-state) [190.042147] Starting subtest: basic-pci-d3-state [190.332732] Subtest basic-pci-d3-state: SUCCESS (0.190s) [190.773892] [124/162] (904s left) kms_pm_rpm (basic-rte) [191.032694] Starting subtest: basic-rte [202.440854] Subtest basic-rte: SUCCESS (11.532s) [202.744944] [125/162] (892s left) kms_psr (psr-primary-page-flip) [202.826602] Subtest psr-primary-page-flip: SKIP (0.000s) [202.870895] [126/162] (892s left) kms_psr (psr-cursor-plane-move) [202.948286] Subtest psr-cursor-plane-move: SKIP (0.000s) [202.992422] [127/162] (892s left) kms_psr (psr-sprite-plane-onoff) [203.071607] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [203.116377] [128/162] (892s left) kms_psr (psr-primary-mmap-gtt) [203.200250] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [203.250789] [129/162] (892s left) kms_setmode (basic-clone-single-crtc) [203.305103] Starting subtest: basic-clone-single-crtc [203.314175] Subtest basic-clone-single-crtc: SKIP (0.000s) [203.362147] [130/162] (892s left) i915_pm_rps (basic-api) [203.418310] Starting subtest: basic-api [203.421525] Subtest basic-api: SUCCESS (0.003s) [203.473862] [131/162] (892s left) prime_self_import (basic-llseek-bad) [203.521156] Starting subtest: basic-llseek-bad [203.527824] Subtest basic-llseek-bad: SUCCESS (0.002s) [203.589267] [132/162] (892s left) prime_self_import (basic-llseek-size) [203.634931] Starting subtest: basic-llseek-size [203.641652] Subtest basic-llseek-size: SUCCESS (0.003s) [203.706404] [133/162] (892s left) prime_self_import (basic-with_fd_dup) [203.753814] Starting subtest: basic-with_fd_dup [203.760469] Subtest basic-with_fd_dup: SUCCESS (0.002s) [203.821591] [134/162] (892s left) prime_self_import (basic-with_one_bo) [203.868668] Starting subtest: basic-with_one_bo [203.874990] Subtest basic-with_one_bo: SUCCESS (0.002s) [203.920803] [135/162] (891s left) prime_self_import (basic-with_one_bo_two_files) [203.966994] Starting subtest: basic-with_one_bo_two_files [203.973719] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s) [204.035747] [136/162] (891s left) prime_self_import (basic-with_two_bos) [204.082024] Starting subtest: basic-with_two_bos [204.088191] Subtest basic-with_two_bos: SUCCESS (0.002s) [204.152205] [137/162] (891s left) prime_vgem (basic-fence-flip) [204.204939] Starting subtest: basic-fence-flip [204.248419] Subtest basic-fence-flip: SKIP (0.041s) [204.295269] [138/162] (891s left) prime_vgem (basic-fence-mmap) [204.351064] Starting subtest: basic-fence-mmap [204.370624] Subtest basic-fence-mmap: SUCCESS (0.022s) [204.449555] [139/162] (891s left) prime_vgem (basic-fence-read) [204.509310] Starting subtest: basic-fence-read [204.547148] Subtest basic-fence-read: SUCCESS (0.046s) [204.628074] [140/162] (891s left) prime_vgem (basic-gtt) [204.683573] Starting subtest: basic-gtt [204.691779] Subtest basic-gtt: SUCCESS (0.011s) [204.761168] [141/162] (891s left) prime_vgem (basic-read) [204.816750] Starting subtest: basic-read [204.835180] Subtest basic-read: SUCCESS (0.022s) [204.913174] [142/162] (891s left) prime_vgem (basic-write) [204.972967] Starting subtest: basic-write [204.990210] Subtest basic-write: SUCCESS (0.023s) [205.066080] [143/162] (891s left) vgem_basic (setversion) [205.116893] Starting subtest: setversion [205.123452] Subtest setversion: SUCCESS (0.000s) [205.171924] [144/162] (891s left) vgem_basic (create) [205.234947] Starting subtest: create [205.238071] Subtest create: SUCCESS (0.000s) [205.281659] [145/162] (891s left) vgem_basic (debugfs) [205.332043] Starting subtest: debugfs [205.335400] Subtest debugfs: SUCCESS (0.000s) [205.386931] [146/162] (891s left) vgem_basic (dmabuf-export) [205.439653] Starting subtest: dmabuf-export [205.446616] Subtest dmabuf-export: SUCCESS (0.002s) [205.501313] [147/162] (890s left) vgem_basic (dmabuf-fence) [205.551408] Starting subtest: dmabuf-fence [205.554499] Subtest dmabuf-fence: SUCCESS (0.001s) [205.605103] [148/162] (890s left) vgem_basic (dmabuf-fence-before) [205.655160] Starting subtest: dmabuf-fence-before [205.658186] Subtest dmabuf-fence-before: SUCCESS (0.000s) [205.703125] [149/162] (890s left) vgem_basic (dmabuf-mmap) [205.754871] Starting subtest: dmabuf-mmap [205.757913] Subtest dmabuf-mmap: SUCCESS (0.009s) [205.802678] [150/162] (890s left) vgem_basic (mmap) [205.857281] Starting subtest: mmap [205.860214] Subtest mmap: SUCCESS (0.007s) [205.905430] [151/162] (890s left) vgem_basic (second-client) [205.962615] Starting subtest: second-client [205.968681] Subtest second-client: SUCCESS (0.002s) [206.019461] [152/162] (890s left) vgem_basic (sysfs) [206.069444] Starting subtest: sysfs [206.072708] Subtest sysfs: SUCCESS (0.000s) [206.117050] [153/162] (890s left) core_hotunplug (unbind-rebind) [206.223168] Starting subtest: unbind-rebind [209.675996] Subtest unbind-rebind: SUCCESS (3.453s) [209.721555] [154/162] (887s left) vgem_basic (unload) [209.771644] Starting subtest: unload [238.630249] Subtest unload: SUCCESS (28.861s) [238.696446] [155/162] (858s left) i915_module_load (reload) [238.743857] Starting subtest: reload [241.147925] Subtest reload: SUCCESS (2.406s) [241.191654] [156/162] (855s left) gem_lmem_swapping (basic) [241.253164] Subtest basic: SKIP (0.000s) [241.296718] [157/162] (855s left) gem_lmem_swapping (parallel-random-engines) [241.352775] Subtest parallel-random-engines: SKIP (0.000s) [241.395975] [158/162] (855s left) gem_lmem_swapping (random-engines) [241.449674] Subtest random-engines: SKIP (0.000s) [241.493668] [159/162] (855s left) gem_lmem_swapping (verify-random) [241.543822] Subtest verify-random: SKIP (0.000s) [241.587796] [160/162] (855s left) i915_pm_rpm (module-reload) [252.899879] Starting subtest: module-reload [280.348813] Subtest module-reload: SUCCESS (27.447s) [280.380520] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [280.381835] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true [280.385705] [161/162] (816s left) i915_selftest (live) [280.437175] Starting subtest: live [280.440332] Starting dynamic subtest: sanitycheck [282.682221] Dynamic subtest sanitycheck: SUCCESS (2.117s) [282.693717] Starting dynamic subtest: uncore [284.723905] Dynamic subtest uncore: SUCCESS (2.166s) [284.737133] Starting dynamic subtest: workarounds [287.043971] Dynamic subtest workarounds: SUCCESS (2.316s) [287.055308] Starting dynamic subtest: gt_engines [289.534611] Dynamic subtest gt_engines: SUCCESS (2.498s) [289.546262] Starting dynamic subtest: gt_timelines [298.353204] Dynamic subtest gt_timelines: SUCCESS (8.818s) [298.364641] Starting dynamic subtest: gt_contexts [300.516080] Dynamic subtest gt_contexts: SUCCESS (2.162s) [300.527439] Starting dynamic subtest: gt_lrc [305.134916] Dynamic subtest gt_lrc: SUCCESS (4.619s) [305.146623] Starting dynamic subtest: gt_mocs [307.343084] Dynamic subtest gt_mocs: SUCCESS (2.200s) [307.355874] Starting dynamic subtest: gt_pm [313.707823] Dynamic subtest gt_pm: SUCCESS (6.373s) [313.719542] Starting dynamic subtest: gt_heartbeat [315.782372] Dynamic subtest gt_heartbeat: SUCCESS (2.065s) [315.793480] Starting dynamic subtest: gt_tlb [319.054837] Dynamic subtest gt_tlb: SUCCESS (3.281s) [319.066911] Starting dynamic subtest: requests [327.330375] Dynamic subtest requests: SUCCESS (8.274s) [327.344258] Starting dynamic subtest: migrate [332.466750] Dynamic subtest migrate: SUCCESS (5.137s) [332.478248] Starting dynamic subtest: active [334.581570] Dynamic subtest active: SUCCESS (2.107s) [334.592736] Starting dynamic subtest: objects [337.203500] Dynamic subtest objects: SUCCESS (2.628s) [337.215201] Starting dynamic subtest: mman [342.424770] Dynamic subtest mman: SUCCESS (5.220s) [342.440693] Starting dynamic subtest: dmabuf [344.642212] Dynamic subtest dmabuf: SUCCESS (2.208s) [344.659189] Starting dynamic subtest: vma [346.871329] Dynamic subtest vma: SUCCESS (2.236s) [346.886450] Starting dynamic subtest: coherency [349.771315] Dynamic subtest coherency: SUCCESS (2.898s) [349.785292] Starting dynamic subtest: gtt [359.247861] Dynamic subtest gtt: SUCCESS (9.477s) [359.259616] Starting dynamic subtest: gem [361.471649] Dynamic subtest gem: SUCCESS (2.216s) [361.483221] Starting dynamic subtest: evict [364.697708] Dynamic subtest evict: SUCCESS (3.232s) [364.709561] Starting dynamic subtest: hugepages [373.241078] Dynamic subtest hugepages: SUCCESS (8.541s) [373.253541] Starting dynamic subtest: gem_contexts [387.867758] Dynamic subtest gem_contexts: SUCCESS (14.627s) [387.879526] Starting dynamic subtest: client [390.021858] Dynamic subtest client: SUCCESS (2.152s) [390.034854] Starting dynamic subtest: gem_migrate [392.102036] Dynamic subtest gem_migrate: SUCCESS (2.077s) [392.114146] Starting dynamic subtest: reset [394.401914] Dynamic subtest reset: SUCCESS (2.293s) [394.415870] Starting dynamic subtest: memory_region [396.482278] Dynamic subtest memory_region: SUCCESS (2.081s) [396.493966] Starting dynamic subtest: hangcheck [421.593450] Dynamic subtest hangcheck: SUCCESS (25.117s) [421.605192] Starting dynamic subtest: execlists [431.888722] Dynamic subtest execlists: SUCCESS (10.294s) [431.900421] Starting dynamic subtest: ring_submission [433.954011] Dynamic subtest ring_submission: SUCCESS (2.060s) [433.967068] Starting dynamic subtest: perf [436.114025] Dynamic subtest perf: SUCCESS (2.155s) [436.125670] Starting dynamic subtest: slpc [438.143712] Dynamic subtest slpc: SUCCESS (2.037s) [438.155422] Starting dynamic subtest: guc [440.185412] Dynamic subtest guc: SUCCESS (2.039s) [440.198291] Starting dynamic subtest: guc_multi_lrc [442.244326] Dynamic subtest guc_multi_lrc: SUCCESS (2.052s) [442.255425] Starting dynamic subtest: guc_hang [444.274922] Dynamic subtest guc_hang: SUCCESS (2.037s) [444.290650] Starting dynamic subtest: late_gt_pm [446.437083] Dynamic subtest late_gt_pm: SUCCESS (2.103s) [446.503886] Subtest live: SUCCESS (165.945s) [446.923111] [162/162] (650s left) dmabuf (all-tests) [447.433408] Starting subtest: all-tests [447.437144] Starting dynamic subtest: sanitycheck [447.440123] Dynamic subtest sanitycheck: SUCCESS (0.111s) [447.453539] Starting dynamic subtest: dma_fence [447.579472] Dynamic subtest dma_fence: SUCCESS (0.175s) [447.596711] Starting dynamic subtest: dma_fence_chain [458.262885] Dynamic subtest dma_fence_chain: SUCCESS (10.681s) [458.288450] Starting dynamic subtest: dma_fence_unwrap [458.334343] Dynamic subtest dma_fence_unwrap: SUCCESS (0.069s) [458.349449] Starting dynamic subtest: dma_resv [458.414467] Dynamic subtest dma_resv: SUCCESS (0.078s) [458.417559] Subtest all-tests: SUCCESS (11.124s) [458.450425] 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.