Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

automatic update checking started by default on FAW 28; ultimately failed #1366

Closed
miabbott opened this issue May 15, 2018 · 2 comments
Closed

automatic update checking started by default on FAW 28; ultimately failed #1366

miabbott opened this issue May 15, 2018 · 2 comments

Comments

@miabbott
Copy link
Member

On a fresh install of FAW 28 in a VM, I noticed that very soon after I logged into the system for the first time, the rpm-ostreed service appeared to be downloading an update in the background.

$ rpm-ostree status
State: busy; auto updates disabled
Transaction: upgrade (download only)
Deployments:
● ostree://fedora-workstation:fedora/28/x86_64/workstation
                   Version: 28.1.1 (2018-04-25 05:39:47)
                    Commit: ef3d3262fe9c62d20e18637d656943a285530363060696ece175f2313683003d
              GPGSignature: Valid signature by 128CF232A9371991C8A65695E08E7E629DB62FB1

I found this odd, since the status clearly states that auto updates are disabled, which I confirmed by examining /etc/rpm-ostreed.conf

$ cat /etc/rpm-ostreed.conf 
# Entries in this file show the compile time defaults.
# You can change settings by editing this file.
# For option meanings, see rpm-ostreed.conf(5).

[Daemon]
#AutomaticUpdatePolicy=none
#IdleExitTimeout=60

I waited for the transaction to complete, but was caught off guard when the output of rpm-ostree status -v did not include any pending updates.

$ rpm-ostree status -v
State: idle; auto updates disabled
Deployments:
● ostree://fedora-workstation:fedora/28/x86_64/workstation
                   Version: 28.1.1 (2018-04-25 05:39:47)
                    Commit: ef3d3262fe9c62d20e18637d656943a285530363060696ece175f2313683003d
                 StateRoot: fedora-workstation
              GPGSignature: 1 signature
                            Signature made Wed 25 Apr 2018 01:39:59 AM EDT using RSA key ID E08E7E629DB62FB1
                            Good signature from "Fedora 28 <[email protected]>"

An inspection of the journal showed that the upgrade transaction appeared to be started by my user (UID 1000), but hit a failure trying to open a tempfile?

$ sudo journalctl -b -u rpm-ostreed.service --no-pager
-- Logs begin at Mon 2018-05-14 22:43:21 EDT, end at Mon 2018-05-14 23:04:54 EDT. --
May 14 22:44:38 localhost.localdomain systemd[1]: Starting RPM-OSTree System Management Daemon...
May 14 22:44:38 localhost.localdomain rpm-ostree[2012]: Reading config file '/etc/rpm-ostreed.conf'
May 14 22:44:38 localhost.localdomain systemd[1]: Started RPM-OSTree System Management Daemon.
May 14 22:44:38 localhost.localdomain rpm-ostree[2012]: In idle state; will auto-exit in 61 seconds
May 14 22:44:38 localhost.localdomain rpm-ostree[2012]: Allowing active client :1.114 (uid 1000)
May 14 22:44:38 localhost.localdomain rpm-ostree[2012]: client :1.114 (uid 1000) added; new total=1
May 14 22:45:39 localhost.localdomain rpm-ostree[2012]: Initiated txn Upgrade for client :1.114 (uid 1000): /org/projectatomic/rpmostree1/fedora_workstation
May 14 22:48:18 localhost.localdomain rpm-ostree[2012]: Allowing active client :1.139 (uid 1000)
May 14 22:48:18 localhost.localdomain rpm-ostree[2012]: client :1.139 (uid 1000) added; new total=2
May 14 22:48:18 localhost.localdomain rpm-ostree[2012]: client :1.139 (uid 1000) vanished; remaining=1
May 14 22:48:49 localhost.localdomain rpm-ostree[2012]: client :1.141 (uid 0) added; new total=2
May 14 22:48:49 localhost.localdomain rpm-ostree[2012]: client :1.141 (uid 0) vanished; remaining=1
May 14 22:48:55 localhost.localdomain rpm-ostree[2012]: Allowing active client :1.143 (uid 1000)
May 14 22:48:55 localhost.localdomain rpm-ostree[2012]: client :1.143 (uid 1000) added; new total=2
May 14 22:48:55 localhost.localdomain rpm-ostree[2012]: client :1.143 (uid 1000) vanished; remaining=1
May 14 22:50:05 localhost.localdomain rpm-ostree[2012]: Allowing active client :1.145 (uid 1000)
May 14 22:50:05 localhost.localdomain rpm-ostree[2012]: client :1.145 (uid 1000) added; new total=2
May 14 22:50:05 localhost.localdomain rpm-ostree[2012]: client :1.145 (uid 1000) vanished; remaining=1
May 14 22:50:07 localhost.localdomain rpm-ostree[2012]: Allowing active client :1.147 (uid 1000)
May 14 22:50:07 localhost.localdomain rpm-ostree[2012]: client :1.147 (uid 1000) added; new total=2
May 14 22:50:07 localhost.localdomain rpm-ostree[2012]: client :1.147 (uid 1000) vanished; remaining=1
May 14 22:51:56 localhost.localdomain rpm-ostree[2012]: Allowing active client :1.150 (uid 1000)
May 14 22:51:56 localhost.localdomain rpm-ostree[2012]: client :1.150 (uid 1000) added; new total=2
May 14 22:51:56 localhost.localdomain rpm-ostree[2012]: client :1.150 (uid 1000) vanished; remaining=1
May 14 22:54:37 localhost.localdomain rpm-ostree[2012]: Allowing active client :1.153 (uid 1000)
May 14 22:54:37 localhost.localdomain rpm-ostree[2012]: client :1.153 (uid 1000) added; new total=2
May 14 22:54:38 localhost.localdomain rpm-ostree[2012]: client :1.153 (uid 1000) vanished; remaining=1
May 14 22:55:13 localhost.localdomain rpm-ostree[2012]: Allowing active client :1.155 (uid 1000)
May 14 22:55:13 localhost.localdomain rpm-ostree[2012]: client :1.155 (uid 1000) added; new total=2
May 14 22:55:13 localhost.localdomain rpm-ostree[2012]: client :1.155 (uid 1000) vanished; remaining=1
May 14 22:58:43 localhost.localdomain rpm-ostree[2012]: libostree pull from 'fedora-workstation' for fedora/28/x86_64/workstation complete
                                                        security: GPG: commit http: TLS
                                                        non-delta: meta: 2103 content: 9785
                                                        transfer: secs: 783 size: 462.0 MB
May 14 22:58:43 localhost.localdomain rpm-ostree[2012]: Txn Upgrade on /org/projectatomic/rpmostree1/fedora_workstation successful
May 14 22:58:43 localhost.localdomain rpm-ostree[2012]: Initiated txn AutomaticUpdateTrigger for client :1.114 (uid 1000): /org/projectatomic/rpmostree1/fedora_workstation
May 14 22:58:45 localhost.localdomain rpm-ostree[2012]: libostree pull from 'fedora-workstation' for fedora/28/x86_64/workstation complete
                                                        security: GPG: commit http: TLS
                                                        non-delta: meta: 1 content: 0
                                                        transfer: secs: 1 size: 569 bytes
May 14 22:58:45 localhost.localdomain rpm-ostree[2012]: Txn AutomaticUpdateTrigger on /org/projectatomic/rpmostree1/fedora_workstation failed: open(O_TMPFILE): No such file or directory
May 14 23:03:12 localhost.localdomain rpm-ostree[2012]: Allowing active client :1.157 (uid 1000)
May 14 23:03:12 localhost.localdomain rpm-ostree[2012]: client :1.157 (uid 1000) added; new total=2
May 14 23:03:12 localhost.localdomain rpm-ostree[2012]: client :1.157 (uid 1000) vanished; remaining=1
May 14 23:03:17 localhost.localdomain rpm-ostree[2012]: Allowing active client :1.159 (uid 1000)
May 14 23:03:17 localhost.localdomain rpm-ostree[2012]: client :1.159 (uid 1000) added; new total=2
May 14 23:03:17 localhost.localdomain rpm-ostree[2012]: client :1.159 (uid 1000) vanished; remaining=1

The logs in the journal around the rpm-ostreed failure looks like it is coming from gnome-software perhaps?

May 14 22:58:42 localhost.localdomain audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=systemd-tmpfiles-clean comm="systemd" exe="/usr/lib/systemd/sys
temd" hostname=? addr=? terminal=? res=success'                                                                                                                                                                    
May 14 22:58:42 localhost.localdomain audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=systemd-tmpfiles-clean comm="systemd" exe="/usr/lib/systemd/syst
emd" hostname=? addr=? terminal=? res=success'                                                                                                                                                                     
May 14 22:58:42 localhost.localdomain systemd[1]: Started Cleanup of Temporary Directories.                                                                                                                        
May 14 22:58:43 localhost.localdomain rpm-ostree[2012]: libostree pull from 'fedora-workstation' for fedora/28/x86_64/workstation complete                                                                         
                                                        security: GPG: commit http: TLS                                                                                                                            
                                                        non-delta: meta: 2103 content: 9785                                                                                                                        
                                                        transfer: secs: 783 size: 462.0 MB                                                                                                                         
May 14 22:58:43 localhost.localdomain rpm-ostree[2012]: Txn Upgrade on /org/projectatomic/rpmostree1/fedora_workstation successful                                                                                 
May 14 22:58:43 localhost.localdomain rpm-ostree[2012]: Initiated txn AutomaticUpdateTrigger for client :1.114 (uid 1000): /org/projectatomic/rpmostree1/fedora_workstation                                        
May 14 22:58:45 localhost.localdomain rpm-ostree[2012]: libostree pull from 'fedora-workstation' for fedora/28/x86_64/workstation complete                                                                         
                                                        security: GPG: commit http: TLS                                                                                                                            
                                                        non-delta: meta: 1 content: 0                                                                                                                              
                                                        transfer: secs: 1 size: 569 bytes                                                                                                                          
May 14 22:58:45 localhost.localdomain rpm-ostree[2012]: Txn AutomaticUpdateTrigger on /org/projectatomic/rpmostree1/fedora_workstation failed: open(O_TMPFILE): No such file or directory                          
May 14 22:58:45 localhost.localdomain gnome-software[1847]: can't reliably fixup error code 36 in domain g-io-error-quark                                                                                          
May 14 22:58:45 localhost.localdomain gnome-software[1847]: failed to call gs_plugin_refresh on rpm-ostree: GDBus.Error:org.projectatomic.rpmostreed.Error.Failed: open(O_TMPFILE): No such file or directory

cc: @matthiasclasen
@cgwalters
Copy link
Member

Yep, it's gnome-software. See some musings on this in #247 (comment)

The O_TMPFILE issue is #1360 (comment) which should be fixed in master.

@miabbott
Copy link
Member Author

Thanks for the info @cgwalters; closing

@shannara shannara mentioned this issue Jul 25, 2018
Closed
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees
No one assigned
Labels
None yet
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
2 participants
@cgwalters @miabbott