[43.971300] Initializing watchdogs [43.971396] /dev/watchdog0 [43.976897] [001/171] (960s left) i915_module_load (load) [44.037812] Starting subtest: load [44.947953] Subtest load: SUCCESS (0.910s) [44.972757] [002/171] (959s left) core_auth (basic-auth) [45.069595] Starting subtest: basic-auth [45.070777] Subtest basic-auth: SUCCESS (0.001s) [45.126430] [003/171] (959s left) debugfs_test (read_all_entries) [45.185896] Starting subtest: read_all_entries [45.231834] Subtest read_all_entries: SUCCESS (0.046s) [45.308310] [004/171] (959s left) debugfs_test (basic-hwmon) [45.366137] Starting subtest: basic-hwmon [45.368162] Subtest basic-hwmon: SKIP (0.000s) [45.441163] [005/171] (959s left) fbdev (eof) [45.498426] Starting subtest: eof [45.499594] Subtest eof: SUCCESS (0.000s) [45.541876] [006/171] (958s left) fbdev (info) [45.596776] Starting subtest: info [45.597850] Subtest info: SUCCESS (0.000s) [45.644335] [007/171] (958s left) fbdev (nullptr) [45.715935] Starting subtest: nullptr [45.717763] Subtest nullptr: SUCCESS (0.000s) [45.759188] [008/171] (958s left) fbdev (read) [45.814801] Starting subtest: read [45.896360] Subtest read: SUCCESS (0.081s) [45.944626] [009/171] (958s left) fbdev (write) [46.015162] Starting subtest: write [46.056311] Subtest write: SUCCESS (0.041s) [46.092992] [010/171] (958s left) gem_basic (bad-close) [46.149104] Starting subtest: bad-close [46.151224] Subtest bad-close: SUCCESS (0.000s) [46.208361] [011/171] (958s left) gem_basic (create-close) [46.265432] Starting subtest: create-close [46.267450] Subtest create-close: SUCCESS (0.000s) [46.326465] [012/171] (958s left) gem_basic (create-fd-close) [46.383053] Starting subtest: create-fd-close [46.385243] Subtest create-fd-close: SUCCESS (0.000s) [46.458587] [013/171] (958s left) gem_busy (busy@all-engines) [46.521227] Starting subtest: busy [46.522286] Starting dynamic subtest: all-engines [46.540762] Dynamic subtest all-engines: SUCCESS (0.019s) [46.541875] Subtest busy: SUCCESS (0.020s) [46.844273] [014/171] (957s left) gem_close_race (basic-process) [46.911270] Starting subtest: basic-process [46.942215] Subtest basic-process: SUCCESS (0.031s) [47.093771] [015/171] (957s left) gem_close_race (basic-threads) [47.159124] Starting subtest: basic-threads [48.310235] Subtest basic-threads: SUCCESS (1.152s) [48.476781] [016/171] (956s left) gem_ctx_create (basic) [48.539052] Starting subtest: basic [48.540338] Subtest basic: SUCCESS (0.000s) [48.691727] [017/171] (955s left) gem_ctx_create (basic-files) [48.751783] Starting subtest: basic-files [50.762102] Subtest basic-files: SUCCESS (2.010s) [50.976935] [018/171] (953s left) gem_ctx_exec (basic) [51.036154] Starting subtest: basic [51.038117] Subtest basic: SUCCESS (0.002s) [51.126259] [019/171] (953s left) gem_exec_basic (basic) [51.187698] Starting subtest: basic [51.188802] Starting dynamic subtest: rcs0-smem [51.189813] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [51.194973] Starting dynamic subtest: bcs0-smem [51.196087] Dynamic subtest bcs0-smem: SUCCESS (0.000s) [51.201462] Starting dynamic subtest: vcs0-smem [51.202619] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [51.208214] Starting dynamic subtest: vecs0-smem [51.209330] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [51.210442] Subtest basic: SUCCESS (0.002s) [51.342077] [020/171] (953s left) gem_exec_create (basic) [51.401656] Starting subtest: basic [51.402708] Starting dynamic subtest: smem [53.440234] Dynamic subtest smem: SUCCESS (2.038s) [53.441727] Subtest basic: SUCCESS (2.038s) [53.590419] [021/171] (951s left) gem_exec_fence (basic-busy) [53.760497] Starting subtest: basic-busy [53.761516] Starting dynamic subtest: rcs0 [53.794481] Dynamic subtest rcs0: SUCCESS (0.034s) [53.800303] Starting dynamic subtest: bcs0 [53.824963] Dynamic subtest bcs0: SUCCESS (0.030s) [53.831363] Starting dynamic subtest: vcs0 [53.847348] Dynamic subtest vcs0: SUCCESS (0.023s) [53.853749] Starting dynamic subtest: vecs0 [53.877310] Dynamic subtest vecs0: SUCCESS (0.030s) [53.878498] Subtest basic-busy: SUCCESS (0.117s) [54.325443] [022/171] (950s left) gem_exec_fence (basic-wait) [54.496890] Starting subtest: basic-wait [54.497988] Starting dynamic subtest: rcs0 [54.521704] Dynamic subtest rcs0: SUCCESS (0.025s) [54.528067] Starting dynamic subtest: bcs0 [54.556242] Dynamic subtest bcs0: SUCCESS (0.034s) [54.562450] Starting dynamic subtest: vcs0 [54.580264] Dynamic subtest vcs0: SUCCESS (0.025s) [54.587060] Starting dynamic subtest: vecs0 [54.600105] Dynamic subtest vecs0: SUCCESS (0.020s) [54.601178] Subtest basic-wait: SUCCESS (0.104s) [55.007467] [023/171] (949s left) gem_exec_fence (basic-await) [55.179386] Starting subtest: basic-await [55.180396] Starting dynamic subtest: rcs0 [55.244211] Dynamic subtest rcs0: SUCCESS (0.065s) [55.249496] Starting dynamic subtest: bcs0 [55.310135] Dynamic subtest bcs0: SUCCESS (0.065s) [55.315862] Starting dynamic subtest: vcs0 [55.375381] Dynamic subtest vcs0: SUCCESS (0.066s) [55.380640] Starting dynamic subtest: vecs0 [55.440666] Dynamic subtest vecs0: SUCCESS (0.065s) [55.441719] Subtest basic-await: SUCCESS (0.261s) [55.858070] [024/171] (948s left) gem_exec_fence (nb-await) [56.035338] Starting subtest: nb-await [56.036390] Starting dynamic subtest: rcs0 [56.088850] Dynamic subtest rcs0: SUCCESS (0.054s) [56.094461] Starting dynamic subtest: bcs0 [56.144439] Dynamic subtest bcs0: SUCCESS (0.055s) [56.149358] Starting dynamic subtest: vcs0 [56.199204] Dynamic subtest vcs0: SUCCESS (0.054s) [56.204286] Starting dynamic subtest: vecs0 [56.253223] Dynamic subtest vecs0: SUCCESS (0.054s) [56.254257] Subtest nb-await: SUCCESS (0.218s) [56.673671] [025/171] (948s left) gem_exec_gttfill (basic) [56.736311] Starting subtest: basic [59.751666] Subtest basic: SUCCESS (3.015s) [59.906417] [026/171] (944s left) gem_exec_parallel (engines) [60.026773] Starting subtest: engines [60.027819] Starting dynamic subtest: basic [61.462274] Dynamic subtest basic: SUCCESS (1.435s) [61.468273] Starting dynamic subtest: contexts [62.992422] Dynamic subtest contexts: SUCCESS (1.530s) [62.998985] Starting dynamic subtest: fds [64.704531] Dynamic subtest fds: SUCCESS (1.712s) [64.710507] Starting dynamic subtest: userptr [66.085333] Dynamic subtest userptr: SUCCESS (1.381s) [66.086443] Subtest engines: SUCCESS (6.058s) [66.240892] [027/171] (938s left) gem_exec_store (basic) [66.304530] Starting subtest: basic [66.338784] Subtest basic: SUCCESS (0.034s) [66.504858] [028/171] (938s left) gem_flink_basic (bad-flink) [66.560924] Starting subtest: bad-flink [66.561950] Subtest bad-flink: SUCCESS (0.000s) [66.622624] [029/171] (938s left) gem_flink_basic (bad-open) [66.678223] Starting subtest: bad-open [66.679266] Subtest bad-open: SUCCESS (0.000s) [66.741427] [030/171] (938s left) gem_flink_basic (basic) [66.798823] Starting subtest: basic [66.799918] Subtest basic: SUCCESS (0.000s) [66.872412] [031/171] (937s left) gem_flink_basic (double-flink) [66.927353] Starting subtest: double-flink [66.928497] Subtest double-flink: SUCCESS (0.000s) [67.006884] [032/171] (937s left) gem_flink_basic (flink-lifetime) [67.062960] Starting subtest: flink-lifetime [67.064054] Subtest flink-lifetime: SUCCESS (0.001s) [67.138913] [033/171] (937s left) gem_huc_copy (huc-copy) [67.199216] Subtest huc-copy: SKIP (0.000s) [67.217297] [034/171] (937s left) gem_linear_blits (basic) [67.351378] Starting subtest: basic [67.358157] Subtest basic: SUCCESS (0.007s) [67.461413] [035/171] (937s left) gem_mmap (basic) [67.585443] Starting subtest: basic [67.590667] Subtest basic: SUCCESS (0.000s) [67.654486] [036/171] (937s left) gem_mmap_gtt (basic) [67.710912] Starting subtest: basic [67.711932] Subtest basic: SUCCESS (0.000s) [67.769494] [037/171] (937s left) gem_render_linear_blits (basic) [67.827834] Starting subtest: basic [67.847921] Subtest basic: SUCCESS (0.020s) [67.902947] [038/171] (937s left) gem_render_tiled_blits (basic) [67.962568] Starting subtest: basic [67.986971] Subtest basic: SUCCESS (0.024s) [68.034438] [039/171] (936s left) gem_ringfill (basic-all) [68.209498] Starting subtest: basic-all [69.309323] Subtest basic-all: SUCCESS (1.101s) [69.387702] [040/171] (935s left) gem_softpin (allocator-basic) [69.447808] Subtest allocator-basic: SKIP (0.000s) [69.506645] [041/171] (935s left) gem_softpin (allocator-basic-reserve) [69.566164] Subtest allocator-basic-reserve: SKIP (0.000s) [69.622705] [042/171] (935s left) gem_softpin (safe-alignment) [69.679888] Starting subtest: safe-alignment [69.686450] Subtest safe-alignment: SUCCESS (0.008s) [69.772935] [043/171] (935s left) gem_sync (basic-all) [69.833573] Starting subtest: basic-all [71.939421] Subtest basic-all: SUCCESS (2.105s) [72.103737] [044/171] (932s left) gem_sync (basic-each) [72.165063] Starting subtest: basic-each [74.231212] Subtest basic-each: SUCCESS (2.066s) [74.386550] [045/171] (930s left) gem_tiled_blits (basic) [74.514027] Starting subtest: basic [74.528358] Subtest basic: SUCCESS (0.015s) [74.627304] [046/171] (930s left) gem_tiled_fence_blits (basic) [74.823327] Starting subtest: basic [74.828884] Subtest basic: SUCCESS (0.006s) [74.929370] [047/171] (930s left) gem_tiled_pread_basic [75.206183] [048/171] (929s left) gem_wait (busy@all-engines) [75.281147] Starting subtest: busy [75.282216] Starting dynamic subtest: all-engines [75.796107] Dynamic subtest all-engines: SUCCESS (0.514s) [75.797393] Subtest busy: SUCCESS (0.514s) [75.971390] [049/171] (929s left) gem_wait (wait@all-engines) [76.035909] Starting subtest: wait [76.037131] Starting dynamic subtest: all-engines [77.051491] Dynamic subtest all-engines: SUCCESS (1.015s) [77.052856] Subtest wait: SUCCESS (1.015s) [77.221365] [050/171] (927s left) i915_getparams_basic (basic-eu-total) [77.277381] Starting subtest: basic-eu-total [77.279529] Subtest basic-eu-total: SUCCESS (0.000s) [77.336361] [051/171] (927s left) i915_getparams_basic (basic-subslice-total) [77.391332] Starting subtest: basic-subslice-total [77.393467] Subtest basic-subslice-total: SUCCESS (0.000s) [77.452568] [052/171] (927s left) i915_hangman (error-state-basic) [77.515077] Starting subtest: error-state-basic [77.521246] Subtest error-state-basic: SUCCESS (0.004s) [77.586777] [053/171] (927s left) i915_pciid [77.703947] [054/171] (927s left) kms_addfb_basic (addfb25-bad-modifier) [77.784477] Starting subtest: addfb25-bad-modifier [77.785437] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [77.886104] [055/171] (927s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [77.963668] Starting subtest: addfb25-framebuffer-vs-set-tiling [77.964772] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [78.069252] [056/171] (927s left) kms_addfb_basic (addfb25-modifier-no-flag) [78.145842] Starting subtest: addfb25-modifier-no-flag [78.146861] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [78.252522] [057/171] (926s left) kms_addfb_basic (addfb25-x-tiled-legacy) [78.330977] Starting subtest: addfb25-x-tiled-legacy [78.331951] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [78.436161] [058/171] (926s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [78.514410] Starting subtest: addfb25-x-tiled-mismatch-legacy [78.515456] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [78.622510] [059/171] (926s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [78.719572] Starting subtest: addfb25-yf-tiled-legacy [78.720664] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [78.802791] [060/171] (926s left) kms_addfb_basic (addfb25-y-tiled-legacy) [78.901515] Starting subtest: addfb25-y-tiled-legacy [78.902538] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [78.988377] [061/171] (926s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [79.106779] Starting subtest: addfb25-y-tiled-small-legacy [79.108827] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [79.202901] [062/171] (926s left) kms_addfb_basic (bad-pitch-0) [79.260521] Starting subtest: bad-pitch-0 [79.261548] Subtest bad-pitch-0: SUCCESS (0.000s) [79.402295] [063/171] (925s left) kms_addfb_basic (bad-pitch-1024) [79.457811] Starting subtest: bad-pitch-1024 [79.458867] Subtest bad-pitch-1024: SUCCESS (0.000s) [79.587550] [064/171] (925s left) kms_addfb_basic (bad-pitch-128) [79.646270] Starting subtest: bad-pitch-128 [79.647341] Subtest bad-pitch-128: SUCCESS (0.000s) [79.785338] [065/171] (925s left) kms_addfb_basic (bad-pitch-256) [79.842215] Starting subtest: bad-pitch-256 [79.843294] Subtest bad-pitch-256: SUCCESS (0.000s) [79.968846] [066/171] (925s left) kms_addfb_basic (bad-pitch-32) [80.024471] Starting subtest: bad-pitch-32 [80.025594] Subtest bad-pitch-32: SUCCESS (0.000s) [80.152395] [067/171] (925s left) kms_addfb_basic (bad-pitch-63) [80.207774] Starting subtest: bad-pitch-63 [80.208835] Subtest bad-pitch-63: SUCCESS (0.000s) [80.335602] [068/171] (924s left) kms_addfb_basic (bad-pitch-65536) [80.392164] Starting subtest: bad-pitch-65536 [80.393185] Subtest bad-pitch-65536: SUCCESS (0.000s) [80.518838] [069/171] (924s left) kms_addfb_basic (bad-pitch-999) [80.575217] Starting subtest: bad-pitch-999 [80.576266] Subtest bad-pitch-999: SUCCESS (0.000s) [80.701877] [070/171] (924s left) kms_addfb_basic (basic) [80.759396] Starting subtest: basic [80.760429] Subtest basic: SUCCESS (0.000s) [80.885162] [071/171] (924s left) kms_addfb_basic (basic-x-tiled-legacy) [81.005496] Starting subtest: basic-x-tiled-legacy [81.006548] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [81.068304] [072/171] (924s left) kms_addfb_basic (basic-y-tiled-legacy) [81.184798] Starting subtest: basic-y-tiled-legacy [81.185799] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [81.251713] [073/171] (924s left) kms_addfb_basic (bo-too-small) [81.329252] Starting subtest: bo-too-small [81.330251] Subtest bo-too-small: SUCCESS (0.000s) [81.435285] [074/171] (923s left) kms_addfb_basic (bo-too-small-due-to-tiling) [81.524272] Starting subtest: bo-too-small-due-to-tiling [81.525339] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [81.635152] [075/171] (923s left) kms_addfb_basic (clobberred-modifier) [81.692179] Starting subtest: clobberred-modifier [81.693199] Subtest clobberred-modifier: SUCCESS (0.000s) [81.818212] [076/171] (923s left) kms_addfb_basic (framebuffer-vs-set-tiling) [81.932433] Starting subtest: framebuffer-vs-set-tiling [81.933563] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [82.002105] [077/171] (923s left) kms_addfb_basic (invalid-get-prop) [82.121069] Starting subtest: invalid-get-prop [82.121985] Subtest invalid-get-prop: SUCCESS (0.000s) [82.185698] [078/171] (923s left) kms_addfb_basic (invalid-get-prop-any) [82.305475] Starting subtest: invalid-get-prop-any [82.306542] Subtest invalid-get-prop-any: SUCCESS (0.000s) [82.368411] [079/171] (923s left) kms_addfb_basic (invalid-set-prop) [82.483518] Starting subtest: invalid-set-prop [82.484525] Subtest invalid-set-prop: SUCCESS (0.000s) [82.551365] [080/171] (922s left) kms_addfb_basic (invalid-set-prop-any) [82.670645] Starting subtest: invalid-set-prop-any [82.671730] Subtest invalid-set-prop-any: SUCCESS (0.000s) [82.751601] [081/171] (922s left) kms_addfb_basic (no-handle) [82.807737] Starting subtest: no-handle [82.808860] Subtest no-handle: SUCCESS (0.000s) [82.934751] [082/171] (922s left) kms_addfb_basic (size-max) [83.013012] Starting subtest: size-max [83.014046] Subtest size-max: SUCCESS (0.000s) [83.117618] [083/171] (922s left) kms_addfb_basic (small-bo) [83.201771] Starting subtest: small-bo [83.202858] Subtest small-bo: SUCCESS (0.000s) [83.317677] [084/171] (922s left) kms_addfb_basic (tile-pitch-mismatch) [83.439362] Starting subtest: tile-pitch-mismatch [83.440406] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [83.501370] [085/171] (922s left) kms_addfb_basic (too-high) [83.578928] Starting subtest: too-high [83.579945] Subtest too-high: SUCCESS (0.000s) [83.684751] [086/171] (921s left) kms_addfb_basic (too-wide) [83.762621] Starting subtest: too-wide [83.763660] Subtest too-wide: SUCCESS (0.000s) [83.867940] [087/171] (921s left) kms_addfb_basic (unused-handle) [83.923289] Starting subtest: unused-handle [83.924364] Subtest unused-handle: SUCCESS (0.000s) [84.050922] [088/171] (921s left) kms_addfb_basic (unused-modifier) [84.106976] Starting subtest: unused-modifier [84.107939] Subtest unused-modifier: SUCCESS (0.000s) [84.234535] [089/171] (921s left) kms_addfb_basic (unused-offsets) [84.292371] Starting subtest: unused-offsets [84.293378] Subtest unused-offsets: SUCCESS (0.000s) [84.417721] [090/171] (921s left) kms_addfb_basic (unused-pitches) [84.474326] Starting subtest: unused-pitches [84.475318] Subtest unused-pitches: SUCCESS (0.000s) [84.600476] [091/171] (921s left) kms_busy (basic) [84.687394] Starting subtest: basic [84.688463] Starting dynamic subtest: flip [85.111471] Dynamic subtest flip: SUCCESS (0.423s) [85.117695] Starting dynamic subtest: modeset [85.598767] Dynamic subtest modeset: SUCCESS (0.487s) [85.599876] Subtest basic: SUCCESS (0.912s) [85.734208] [092/171] (919s left) kms_chamelium_hpd (dp-hpd-fast) [85.860531] Subtest dp-hpd-fast: SKIP (0.000s) [85.943698] [093/171] (919s left) kms_chamelium_edid (dp-edid-read) [86.071522] Subtest dp-edid-read: SKIP (0.000s) [86.153868] [094/171] (919s left) kms_chamelium_frames (dp-crc-fast) [86.315903] Subtest dp-crc-fast: SKIP (0.000s) [86.395530] [095/171] (919s left) kms_chamelium_hpd (hdmi-hpd-fast) [86.507874] Subtest hdmi-hpd-fast: SKIP (0.000s) [86.596704] [096/171] (919s left) kms_chamelium_edid (hdmi-edid-read) [86.728659] Subtest hdmi-edid-read: SKIP (0.000s) [86.822781] [097/171] (918s left) kms_chamelium_frames (hdmi-crc-fast) [86.934262] Subtest hdmi-crc-fast: SKIP (0.000s) [87.015369] [098/171] (918s left) kms_chamelium_hpd (vga-hpd-fast) [87.127768] Subtest vga-hpd-fast: SKIP (0.000s) [87.210212] [099/171] (918s left) kms_chamelium_edid (vga-edid-read) [87.323173] Subtest vga-edid-read: SKIP (0.000s) [87.406156] [100/171] (918s left) kms_prop_blob (basic) [87.464226] Starting subtest: basic [87.465299] Subtest basic: SUCCESS (0.000s) [87.522780] [101/171] (918s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [87.602228] Starting subtest: basic-busy-flip-before-cursor-atomic [88.533338] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (0.931s) [88.659454] [102/171] (917s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [88.737326] Starting subtest: basic-busy-flip-before-cursor-legacy [89.666922] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (0.930s) [89.792518] [103/171] (915s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [89.875235] Starting subtest: basic-flip-after-cursor-atomic [90.801171] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.927s) [90.928152] [104/171] (914s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [91.005700] Starting subtest: basic-flip-after-cursor-legacy [91.951770] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.947s) [92.073938] [105/171] (913s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [92.150638] Starting subtest: basic-flip-after-cursor-varying-size [93.083881] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.932s) [93.215134] [106/171] (912s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [93.291971] Starting subtest: basic-flip-before-cursor-atomic [94.223889] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.931s) [94.351196] [107/171] (911s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [94.430491] Starting subtest: basic-flip-before-cursor-legacy [95.358967] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.929s) [95.490603] [108/171] (910s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [95.565471] Starting subtest: basic-flip-before-cursor-varying-size [96.499820] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.933s) [96.629982] [109/171] (909s left) kms_flip (basic-flip-vs-dpms) [96.697540] Starting subtest: basic-flip-vs-dpms [96.699685] Starting dynamic subtest: A-VGA1 [97.632054] Dynamic subtest A-VGA1: SUCCESS (0.932s) [97.639411] Starting dynamic subtest: B-VGA1 [98.525255] Dynamic subtest B-VGA1: SUCCESS (0.893s) [98.532181] Starting dynamic subtest: C-VGA1 [99.413849] Dynamic subtest C-VGA1: SUCCESS (0.889s) [99.416028] Subtest basic-flip-vs-dpms: SUCCESS (2.718s) [99.549934] [110/171] (906s left) kms_flip (basic-flip-vs-modeset) [99.619539] Starting subtest: basic-flip-vs-modeset [99.621708] Starting dynamic subtest: A-VGA1 [100.458946] Dynamic subtest A-VGA1: SUCCESS (0.837s) [100.465224] Starting dynamic subtest: B-VGA1 [101.247116] Dynamic subtest B-VGA1: SUCCESS (0.787s) [101.253595] Starting dynamic subtest: C-VGA1 [102.034661] Dynamic subtest C-VGA1: SUCCESS (0.787s) [102.035761] Subtest basic-flip-vs-modeset: SUCCESS (2.416s) [102.169481] [111/171] (903s left) kms_flip (basic-flip-vs-wf_vblank) [102.238366] Starting subtest: basic-flip-vs-wf_vblank [102.240373] Starting dynamic subtest: A-VGA1 [103.378603] Dynamic subtest A-VGA1: SUCCESS (1.139s) [103.385707] Starting dynamic subtest: B-VGA1 [104.499599] Dynamic subtest B-VGA1: SUCCESS (1.120s) [104.505826] Starting dynamic subtest: C-VGA1 [105.620228] Dynamic subtest C-VGA1: SUCCESS (1.120s) [105.621610] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.384s) [105.774092] [112/171] (900s left) kms_flip (basic-plain-flip) [105.841371] Starting subtest: basic-plain-flip [105.842440] Starting dynamic subtest: A-VGA1 [106.699130] Dynamic subtest A-VGA1: SUCCESS (0.857s) [106.705728] Starting dynamic subtest: B-VGA1 [107.537930] Dynamic subtest B-VGA1: SUCCESS (0.838s) [107.544866] Starting dynamic subtest: C-VGA1 [108.375606] Dynamic subtest C-VGA1: SUCCESS (0.837s) [108.377431] Subtest basic-plain-flip: SUCCESS (2.537s) [108.545485] [113/171] (897s left) kms_force_connector_basic (force-connector-state) [108.614463] Starting subtest: force-connector-state [108.759532] Subtest force-connector-state: SUCCESS (0.144s) [108.936524] [114/171] (896s left) kms_force_connector_basic (force-edid) [109.005643] Starting subtest: force-edid [109.027483] Subtest force-edid: SUCCESS (0.020s) [109.120103] [115/171] (896s left) kms_force_connector_basic (force-load-detect) [109.188628] Starting subtest: force-load-detect [109.334888] Subtest force-load-detect: SUCCESS (0.147s) [109.501636] [116/171] (896s left) kms_force_connector_basic (prune-stale-modes) [109.570168] Starting subtest: prune-stale-modes [109.588216] Subtest prune-stale-modes: SUCCESS (0.017s) [109.687765] [117/171] (896s left) kms_frontbuffer_tracking (basic) [109.774171] Starting subtest: basic [111.588323] Subtest basic: SUCCESS (1.817s) [111.669785] [118/171] (894s left) kms_pipe_crc_basic (compare-crc-sanitycheck) [111.748202] Starting subtest: compare-crc-sanitycheck [111.749272] Starting dynamic subtest: pipe-A-VGA-1 [112.009796] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.261s) [112.016795] Starting dynamic subtest: pipe-B-VGA-1 [112.271155] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.260s) [112.277749] Starting dynamic subtest: pipe-C-VGA-1 [112.543622] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.272s) [112.544664] Subtest compare-crc-sanitycheck: SUCCESS (0.795s) [112.686729] [119/171] (893s left) kms_pipe_crc_basic (hang-read-crc) [112.764495] Starting subtest: hang-read-crc [112.765601] Starting dynamic subtest: pipe-A-VGA-1 [113.483140] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.716s) [113.491545] Starting dynamic subtest: pipe-B-VGA-1 [114.208635] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.726s) [114.214982] Starting dynamic subtest: pipe-C-VGA-1 [114.960093] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.750s) [114.961186] Subtest hang-read-crc: SUCCESS (2.196s) [115.073675] [120/171] (890s left) kms_pipe_crc_basic (nonblocking-crc) [115.154391] Starting subtest: nonblocking-crc [115.155428] Starting dynamic subtest: pipe-A-VGA-1 [115.582971] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.427s) [115.589325] Starting dynamic subtest: pipe-B-VGA-1 [116.007347] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.423s) [116.013802] Starting dynamic subtest: pipe-C-VGA-1 [116.444706] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.436s) [116.445878] Subtest nonblocking-crc: SUCCESS (1.290s) [116.557592] [121/171] (889s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [116.636183] Starting subtest: nonblocking-crc-frame-sequence [116.637210] Starting dynamic subtest: pipe-A-VGA-1 [117.066844] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.430s) [117.073267] Starting dynamic subtest: pipe-B-VGA-1 [117.493999] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.426s) [117.500372] Starting dynamic subtest: pipe-C-VGA-1 [117.932395] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.437s) [117.933444] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.296s) [118.046805] [122/171] (887s left) kms_pipe_crc_basic (read-crc) [118.126451] Starting subtest: read-crc [118.127678] Starting dynamic subtest: pipe-A-VGA-1 [118.488757] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.362s) [118.494984] Starting dynamic subtest: pipe-B-VGA-1 [118.846079] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.357s) [118.852416] Starting dynamic subtest: pipe-C-VGA-1 [119.216632] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.368s) [119.217725] Subtest read-crc: SUCCESS (1.089s) [119.346599] [123/171] (886s left) kms_pipe_crc_basic (read-crc-frame-sequence) [119.425413] Starting subtest: read-crc-frame-sequence [119.426459] Starting dynamic subtest: pipe-A-VGA-1 [119.788829] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.364s) [119.795163] Starting dynamic subtest: pipe-B-VGA-1 [120.147349] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.357s) [120.153993] Starting dynamic subtest: pipe-C-VGA-1 [120.518828] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.371s) [120.519969] Subtest read-crc-frame-sequence: SUCCESS (1.094s) [120.636491] [124/171] (885s left) kms_psr (primary_page_flip) [120.695446] Subtest primary_page_flip: SKIP (0.000s) [120.716211] [125/171] (885s left) kms_psr (cursor_plane_move) [120.772358] Subtest cursor_plane_move: SKIP (0.000s) [120.800099] [126/171] (885s left) kms_psr (sprite_plane_onoff) [120.856500] Subtest sprite_plane_onoff: SKIP (0.000s) [120.883304] [127/171] (885s left) kms_psr (primary_mmap_gtt) [120.941530] Subtest primary_mmap_gtt: SKIP (0.000s) [120.966280] [128/171] (885s left) kms_setmode (basic-clone-single-crtc) [121.024759] Starting subtest: basic-clone-single-crtc [121.027838] Subtest basic-clone-single-crtc: SKIP (0.000s) [121.086451] [129/171] (885s left) i915_pm_backlight (basic-brightness) [121.164904] Subtest basic-brightness: SKIP (0.000s) [121.182412] [130/171] (884s left) i915_pm_rpm (basic-pci-d3-state) [122.548969] Starting subtest: basic-pci-d3-state [122.759107] Subtest basic-pci-d3-state: SUCCESS (0.209s) [123.002998] [131/171] (883s left) i915_pm_rpm (basic-rte) [123.058421] Starting subtest: basic-rte [124.554704] Subtest basic-rte: SUCCESS (1.493s) [124.985254] [132/171] (881s left) i915_pm_rps (basic-api) [125.044796] Starting subtest: basic-api [125.047353] Subtest basic-api: SUCCESS (0.003s) [125.104522] [133/171] (881s left) prime_self_import (basic-llseek-bad) [125.159772] Starting subtest: basic-llseek-bad [125.160797] Subtest basic-llseek-bad: SUCCESS (0.001s) [125.234920] [134/171] (880s left) prime_self_import (basic-llseek-size) [125.288958] Starting subtest: basic-llseek-size [125.291314] Subtest basic-llseek-size: SUCCESS (0.002s) [125.368715] [135/171] (880s left) prime_self_import (basic-with_fd_dup) [125.424682] Starting subtest: basic-with_fd_dup [125.427284] Subtest basic-with_fd_dup: SUCCESS (0.002s) [125.500893] [136/171] (880s left) prime_self_import (basic-with_one_bo) [125.557114] Starting subtest: basic-with_one_bo [125.560021] Subtest basic-with_one_bo: SUCCESS (0.002s) [125.613287] [137/171] (880s left) prime_self_import (basic-with_one_bo_two_files) [125.666799] Starting subtest: basic-with_one_bo_two_files [125.667885] Subtest basic-with_one_bo_two_files: SUCCESS (0.001s) [125.734352] [138/171] (880s left) prime_self_import (basic-with_two_bos) [125.794194] Starting subtest: basic-with_two_bos [125.796612] Subtest basic-with_two_bos: SUCCESS (0.002s) [125.867465] [139/171] (880s left) prime_vgem (basic-fence-flip) [125.940858] Starting subtest: basic-fence-flip [126.271018] Subtest basic-fence-flip: SUCCESS (0.330s) [126.350898] [140/171] (879s left) prime_vgem (basic-fence-mmap) [126.426011] Starting subtest: basic-fence-mmap [126.445184] Subtest basic-fence-mmap: SUCCESS (0.019s) [126.516747] [141/171] (879s left) prime_vgem (basic-fence-read) [126.574034] Starting subtest: basic-fence-read [126.604020] Subtest basic-fence-read: SUCCESS (0.030s) [126.687748] [142/171] (879s left) prime_vgem (basic-gtt) [126.760826] Starting subtest: basic-gtt [126.771747] Subtest basic-gtt: SUCCESS (0.011s) [126.835953] [143/171] (879s left) prime_vgem (basic-read) [126.907532] Starting subtest: basic-read [126.923322] Subtest basic-read: SUCCESS (0.016s) [127.001705] [144/171] (879s left) prime_vgem (basic-write) [127.075829] Starting subtest: basic-write [127.093709] Subtest basic-write: SUCCESS (0.018s) [127.169195] [145/171] (879s left) prime_vgem (basic-userptr) [127.240841] Starting subtest: basic-userptr [127.249667] Subtest basic-userptr: SKIP (0.008s) [127.320160] [146/171] (879s left) vgem_basic (setversion) [127.389021] Starting subtest: setversion [127.391219] Subtest setversion: SUCCESS (0.000s) [127.434176] [147/171] (878s left) vgem_basic (create) [127.504640] Starting subtest: create [127.505842] Subtest create: SUCCESS (0.000s) [127.552983] [148/171] (878s left) vgem_basic (debugfs) [127.622095] Starting subtest: debugfs [127.623121] Subtest debugfs: SUCCESS (0.001s) [127.666951] [149/171] (878s left) vgem_basic (dmabuf-export) [127.738058] Starting subtest: dmabuf-export [127.740383] Subtest dmabuf-export: SUCCESS (0.001s) [127.816483] [150/171] (878s left) vgem_basic (dmabuf-fence) [127.888351] Starting subtest: dmabuf-fence [127.889556] Subtest dmabuf-fence: SUCCESS (0.001s) [127.935443] [151/171] (878s left) vgem_basic (dmabuf-fence-before) [128.005382] Starting subtest: dmabuf-fence-before [128.006575] Subtest dmabuf-fence-before: SUCCESS (0.001s) [128.052667] [152/171] (878s left) vgem_basic (dmabuf-mmap) [128.121260] Starting subtest: dmabuf-mmap [128.135822] Subtest dmabuf-mmap: SUCCESS (0.015s) [128.184485] [153/171] (878s left) vgem_basic (mmap) [128.254509] Starting subtest: mmap [128.264494] Subtest mmap: SUCCESS (0.010s) [128.302870] [154/171] (878s left) vgem_basic (second-client) [128.371246] Starting subtest: second-client [128.422053] Subtest second-client: SUCCESS (0.050s) [128.466829] [155/171] (878s left) vgem_basic (sysfs) [128.537947] Starting subtest: sysfs [128.539043] Subtest sysfs: SUCCESS (0.001s) [128.584632] [156/171] (877s left) core_hotunplug (unbind-rebind) [128.655573] Starting subtest: unbind-rebind [129.457021] Subtest unbind-rebind: SUCCESS (0.802s) [129.475402] [157/171] (877s left) vgem_basic (unload) [129.538758] Starting subtest: unload [158.217859] Subtest unload: SUCCESS (28.677s) [158.315550] [158/171] (848s left) i915_module_load (reload) [158.372216] Starting subtest: reload [159.920432] Subtest reload: SUCCESS (1.547s) [159.947782] [159/171] (846s left) gem_lmem_swapping (basic) [160.027340] Subtest basic: SKIP (0.000s) [160.044418] [160/171] (846s left) gem_lmem_swapping (parallel-random-engines) [160.103177] Subtest parallel-random-engines: SKIP (0.000s) [160.127287] [161/171] (846s left) gem_lmem_swapping (random-engines) [160.183663] Subtest random-engines: SKIP (0.000s) [160.211652] [162/171] (846s left) gem_lmem_swapping (verify-random) [160.266158] Subtest verify-random: SKIP (0.000s) [160.295592] [163/171] (846s left) i915_pm_rpm (module-reload) [162.204668] Starting subtest: module-reload [168.500544] Subtest module-reload: SUCCESS (6.296s) [168.513153] [164/171] (838s left) i915_selftest (live) [168.580946] Starting subtest: live [168.581998] Starting dynamic subtest: sanitycheck [169.095282] Dynamic subtest sanitycheck: SUCCESS (0.512s) [169.101324] Starting dynamic subtest: uncore [169.631123] Dynamic subtest uncore: SUCCESS (0.535s) [169.637343] Starting dynamic subtest: workarounds [170.264961] Dynamic subtest workarounds: SUCCESS (0.633s) [170.270249] Starting dynamic subtest: gt_engines [170.752099] Dynamic subtest gt_engines: SUCCESS (0.487s) [170.758390] Starting dynamic subtest: gt_timelines [176.193362] Dynamic subtest gt_timelines: SUCCESS (5.441s) [176.199633] Starting dynamic subtest: gt_contexts [176.861264] Dynamic subtest gt_contexts: SUCCESS (0.667s) [176.866299] Starting dynamic subtest: gt_lrc [177.406336] Dynamic subtest gt_lrc: SUCCESS (0.544s) [177.412706] Starting dynamic subtest: gt_mocs [178.044718] Dynamic subtest gt_mocs: SUCCESS (0.638s) [178.050057] Starting dynamic subtest: gt_pm [188.796936] Dynamic subtest gt_pm: SUCCESS (10.752s) [188.803214] Starting dynamic subtest: gt_heartbeat [189.526064] Dynamic subtest gt_heartbeat: SUCCESS (0.728s) [189.532502] Starting dynamic subtest: requests [195.672471] Dynamic subtest requests: SUCCESS (6.146s) [195.678443] Starting dynamic subtest: migrate [196.181348] Dynamic subtest migrate: SUCCESS (0.508s) [196.186637] Starting dynamic subtest: active [196.822203] Dynamic subtest active: SUCCESS (0.640s) [196.828346] Starting dynamic subtest: objects [197.662380] Dynamic subtest objects: SUCCESS (0.840s) [197.667703] Starting dynamic subtest: mman [201.593305] Dynamic subtest mman: SUCCESS (3.930s) [201.599735] Starting dynamic subtest: dmabuf [202.277164] Dynamic subtest dmabuf: SUCCESS (0.683s) [202.282202] Starting dynamic subtest: vma [202.783365] Dynamic subtest vma: SUCCESS (0.505s) [202.789707] Starting dynamic subtest: coherency [203.804165] Dynamic subtest coherency: SUCCESS (1.020s) [203.811071] Starting dynamic subtest: gtt [208.302910] Dynamic subtest gtt: SUCCESS (4.497s) [208.309225] Starting dynamic subtest: gem [209.014365] Dynamic subtest gem: SUCCESS (0.711s) [209.019673] Starting dynamic subtest: evict [209.568164] Dynamic subtest evict: SUCCESS (0.553s) [209.573444] Starting dynamic subtest: hugepages [210.676478] Dynamic subtest hugepages: SUCCESS (1.108s) [210.681878] Starting dynamic subtest: gem_contexts [215.486214] Dynamic subtest gem_contexts: SUCCESS (4.809s) [215.491687] Starting dynamic subtest: client [216.135021] Dynamic subtest client: SUCCESS (0.648s) [216.140304] Starting dynamic subtest: gem_migrate [216.682705] Dynamic subtest gem_migrate: SUCCESS (0.547s) [216.688026] Starting dynamic subtest: reset [218.339932] Dynamic subtest reset: SUCCESS (1.657s) [218.345111] Starting dynamic subtest: memory_region [218.907280] Dynamic subtest memory_region: SUCCESS (0.567s) [218.912713] Starting dynamic subtest: hangcheck [236.242292] Dynamic subtest hangcheck: SUCCESS (17.334s) [236.247634] Starting dynamic subtest: execlists [236.790128] Dynamic subtest execlists: SUCCESS (0.547s) [236.795304] Starting dynamic subtest: ring_submission [237.392580] Dynamic subtest ring_submission: SUCCESS (0.602s) [237.398051] Starting dynamic subtest: perf [238.066880] Dynamic subtest perf: SUCCESS (0.674s) [238.072900] Starting dynamic subtest: slpc [238.700287] Dynamic subtest slpc: SUCCESS (0.633s) [238.705636] Starting dynamic subtest: guc [239.218959] Dynamic subtest guc: SUCCESS (0.518s) [239.224275] Starting dynamic subtest: guc_multi_lrc [239.683355] Dynamic subtest guc_multi_lrc: SUCCESS (0.464s) [239.688693] Starting dynamic subtest: guc_hang [240.180590] Dynamic subtest guc_hang: SUCCESS (0.497s) [240.185817] Starting dynamic subtest: late_gt_pm [240.755848] Dynamic subtest late_gt_pm: SUCCESS (0.574s) [240.756973] Subtest live: SUCCESS (72.174s) [240.829381] [165/171] (765s left) dmabuf (all-tests) [240.895401] Starting subtest: all-tests [240.898716] Starting dynamic subtest: sanitycheck [240.918449] Dynamic subtest sanitycheck: SUCCESS (0.022s) [240.924817] Starting dynamic subtest: dma_fence [241.047110] Dynamic subtest dma_fence: SUCCESS (0.127s) [241.053490] Starting dynamic subtest: dma_fence_chain [252.478548] Dynamic subtest dma_fence_chain: SUCCESS (11.430s) [252.485383] Starting dynamic subtest: dma_fence_unwrap [252.507084] Dynamic subtest dma_fence_unwrap: SUCCESS (0.028s) [252.513716] Starting dynamic subtest: dma_resv [252.533057] Dynamic subtest dma_resv: SUCCESS (0.026s) [252.534149] Subtest all-tests: SUCCESS (11.638s) [252.544708] [166/171] (754s left) i915_suspend (basic-s2idle-without-i915) [252.598364] Starting subtest: basic-s2idle-without-i915 [270.071199] Subtest basic-s2idle-without-i915: SUCCESS (1.975s) [283.201213] [167/171] (751s left) i915_suspend (basic-s3-without-i915) [283.260678] Starting subtest: basic-s3-without-i915 [301.408877] Subtest basic-s3-without-i915: SUCCESS (2.006s) [304.521032] [168/171] (749s left) gem_exec_suspend (basic-s0) [304.588673] Starting subtest: basic-S0 [304.589805] Starting dynamic subtest: smem [320.977176] Dynamic subtest smem: SUCCESS (1.223s) [320.978332] Subtest basic-S0: SUCCESS (1.223s) [327.113753] [169/171] (748s left) gem_exec_suspend (basic-s3) [327.175998] Starting subtest: basic-S3 [327.177046] Starting dynamic subtest: smem [344.994740] Dynamic subtest smem: SUCCESS (1.284s) [344.995843] Subtest basic-S3: SUCCESS (1.284s) [352.132594] [170/171] (746s left) kms_chamelium_hpd (common-hpd-after-suspend) [352.266177] Subtest common-hpd-after-suspend: SKIP (0.000s) [352.349238] [171/171] (746s left) kms_pipe_crc_basic (suspend-read-crc) [352.427362] Starting subtest: suspend-read-crc [352.428463] Starting dynamic subtest: pipe-A-VGA-1 [370.172346] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.489s) [370.182562] Starting dynamic subtest: pipe-B-VGA-1 [388.181286] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.467s) [388.192638] Starting dynamic subtest: pipe-C-VGA-1 [406.189682] Dynamic subtest pipe-C-VGA-1: SUCCESS (1.508s) [406.190776] Subtest suspend-read-crc: SUCCESS (4.466s) [409.275780] Closing watchdogs Done.