Troubleshooting updates on Ubuntu Server 16.04: Feeds Don't Update

[surfrock66]

Running TTRSS on ubuntu server and just upgraded from 15.10-16.04. This came with php and mysql updates that gave me some headaches.

I decided to do a fresh-install, blowing away my old ttrss configuration (I have a backup and exported my opml) and re-deploying from the git master. I did keep the same DB; when I launched the new ttrss install it said it did a DB update.

Before, I was doing feed updates using a cronjob and calling "update.php --feeds" but I decided to switch to a systemd service; this is not working and I see no reason why.

According to my ttrss instance, the last update was just before I made the upgrade:

Code: Select all

No unread articles found to display.
Feeds last updated at Apr 23, 15:03

All feeds still are visible in the left-hand pane.

Php and mysql versions:

Code: Select all

surfrock66@sr66-blade:~$ php -v
PHP 5.6.11-1ubuntu3.2 (cli)
Copyright (c) 1997-2015 The PHP Group
Zend Engine v2.6.0, Copyright (c) 1998-2015 Zend Technologies
    with Zend OPcache v7.0.6-dev, Copyright (c) 1999-2015, by Zend Technologies
surfrock66@sr66-blade:~$ mysql -V
mysql  Ver 14.14 Distrib 5.7.11, for Linux (x86_64) using  EditLine wrapper


Systemd service definition:

Code: Select all

surfrock66@sr66-blade:~$ cat /lib/systemd/system/ttrss_backend.service
[Unit]
Description=ttrss_backend
After=network.target mysql.service postgresql.service

[Service]
User=www-data
ExecStart=/var/www/ttrss/update_daemon2.php

[Install]
WantedBy=multi-user.target


Systemd service status (following a reboot earlier today):

Code: Select all

surfrock66@sr66-blade:~$ sudo systemctl status ttrss_backend.service
● ttrss_backend.service - ttrss_backend
   Loaded: loaded (/lib/systemd/system/ttrss_backend.service; enabled; vendor preset: enabled)
   Active: active (running) since Sun 2016-04-24 13:59:27 PDT; 6h ago
 Main PID: 10825 (php)
    Tasks: 1 (limit: 512)
   CGroup: /system.slice/ttrss_backend.service
           └─10825 php /var/www/ttrss/update_daemon2.php

Apr 24 20:54:55 sr66-blade update_daemon2.php[10825]: [03:54:55/27274] Feedbrowser updated, 47 feeds processed.
Apr 24 20:54:56 sr66-blade update_daemon2.php[10825]: [03:54:56/27274] Purged 0 orphaned posts.
Apr 24 20:54:56 sr66-blade update_daemon2.php[10825]: [03:54:56/27274] Removed 0 (feeds) 0 (cats) orphaned counter cache entries.
Apr 24 20:54:57 sr66-blade update_daemon2.php[10825]: [03:54:57/10825] [reap_children] child 27270 reaped.
Apr 24 20:54:57 sr66-blade update_daemon2.php[10825]: [03:54:57/10825] [SIGCHLD] jobs left: 1
Apr 24 20:55:00 sr66-blade update_daemon2.php[10825]: [03:55:00/27275] Scheduled 0 feeds to update...
Apr 24 20:55:00 sr66-blade update_daemon2.php[10825]: [03:55:00/27275] Sending digests, batch of max 15 users, headline limit = 1000
Apr 24 20:55:00 sr66-blade update_daemon2.php[10825]: [03:55:00/27275] All done.
Apr 24 20:55:01 sr66-blade update_daemon2.php[10825]: [03:55:01/10825] [reap_children] child 27272 reaped.
Apr 24 20:55:01 sr66-blade update_daemon2.php[10825]: [03:55:01/10825] [SIGCHLD] jobs left: 0


If I manually kill off the demon and run it in the terminal to see the output, I see nothing wrong other than a warning:

Code: Select all

surfrock66@sr66-blade:/var/www/ttrss$ sudo systemctl stop ttrss_backend.service
surfrock66@sr66-blade:/var/www/ttrss$ php /var/www/ttrss/update_daemon2.php
[04:00:38/30306] [MASTER] installing shutdown handlers
[04:00:38/30306] [MASTER] spawned client 0 [PID:30307]...
[04:00:38/30306] [MASTER] spawned client 1 [PID:30308]...
[04:00:38/30312] Using task id 1
[04:00:38/30312] Lock: update_daemon-30308.lock
[04:00:38/30312] Waiting before update (5)
[04:00:38/30311] Using task id 0
[04:00:38/30311] Lock: update_daemon-30307.lock
[04:00:38/30311] Waiting before update (0)
[04:00:38/30311] warning: unable to create stampfile

[04:00:38/30311] Scheduled 0 feeds to update...
[04:00:38/30311] Sending digests, batch of max 15 users, headline limit = 1000
[04:00:38/30311] All done.
[04:00:38/30311] cache/simplepie: removed 0 files.
[04:00:38/30311] cache/images: removed 0 files.
[04:00:38/30311] cache/export: removed 0 files.
[04:00:38/30311] cache/upload: removed 0 files.
[04:00:38/30311] Removed 0 old lock files.
[04:00:38/30311] Removing old error log entries...
[04:00:38/30311] Feedbrowser updated, 47 feeds processed.
[04:00:39/30311] Purged 0 orphaned posts.
[04:00:39/30311] Removed 0 (feeds) 0 (cats) orphaned counter cache entries.
[04:00:40/30306] [reap_children] child 30307 reaped.
[04:00:40/30306] [SIGCHLD] jobs left: 1
[04:00:43/30312] warning: unable to create stampfile

[04:00:43/30312] Scheduled 0 feeds to update...
[04:00:43/30312] Sending digests, batch of max 15 users, headline limit = 1000
[04:00:43/30312] All done.
[04:00:44/30306] [reap_children] child 30308 reaped.
[04:00:44/30306] [SIGCHLD] jobs left: 0


I see "scheduled 0 feeds to update" even though it sees 47 feeds....they're all scheduled to use the default interval of 15 minutes. The output when I log in, saying no updates have happened since 4/23 3:03 PM, doesn't change. At this point I'm stumped.

[Kbird]

Comparing your systemd service definition to the one in Arch Linux, try the line

ExecStart=/var/www/ttrss/update_daemon2.php --daemon

See if that helps

[surfrock66]

Curious; I copied directly from here: https://tt-rss.org/gitlab/fox/tt-rss/wi ... atingFeeds

It does not appear to have changed the problem; the daemon output is the same as well.

[fox]

no you don't need that parameter for update_daemon2.php, the wiki one was correct

this could happen if you let the time go backwards on the server, this has been recently discussed in support i think

[surfrock66]

This thread, right?: viewtopic.php?f=1&t=3749

I saw that; I don't think it's the same issue though. I didn't mess with time at all, and the timestamps on everything within cache seem to be properly in the past:

Code: Select all

surfrock66@sr66-blade:/var/www/ttrss/cache$ ls; for i in `\ls -1`; do echo $i; ls $i; echo ""; done
total 24K
4.0K drwxrwsrwx 2 www-data www-data 4.0K Apr 23 18:01 export
4.0K -rwxr-xr-x 1 www-data www-data   31 Apr 23 18:01 .htaccess
4.0K drwxrwsrwx 2 www-data www-data 4.0K Apr 23 18:01 images
4.0K drwxrwsrwx 2 www-data www-data 4.0K Apr 23 21:53 js
4.0K drwxr-sr-x 2 www-data www-data 4.0K Apr 23 18:01 simplepie
4.0K drwxrwsrwx 2 www-data www-data 4.0K Apr 23 18:01 upload
export
total 0
0 -rwxrwxrwx 1 www-data www-data 0 Apr 23 18:01 .empty

images
total 0
0 -rwxrwxrwx 1 www-data www-data 0 Apr 23 18:01 .empty

js
total 188K
8.0K -rwxrwxrwx 1 www-data www-data 5.3K Apr 23 21:53 CheckBoxTree.js
4.0K -rwxrwxrwx 1 www-data www-data  367 Apr 23 21:53 deprecated.js
   0 -rwxrwxrwx 1 www-data www-data    0 Apr 23 18:01 .empty
 12K -rwxrwxrwx 1 www-data www-data  11K Apr 23 21:13 feedlist.js
 12K -rwxrwxrwx 1 www-data www-data  12K Apr 23 21:13 FeedTree.js
 36K -rwxrwxrwx 1 www-data www-data  36K Apr 23 21:13 functions.js
4.0K -rwxrwxrwx 1 www-data www-data  599 Apr 23 21:13 PluginHost.js
4.0K -rwxrwxrwx 1 www-data www-data 2.8K Apr 23 21:53 PrefFeedTree.js
4.0K -rwxrwxrwx 1 www-data www-data 2.3K Apr 23 21:53 PrefFilterTree.js
4.0K -rwxrwxrwx 1 www-data www-data 1.1K Apr 23 21:53 PrefLabelTree.js
 32K -rwxrwxrwx 1 www-data www-data  31K Apr 23 21:53 prefs.js
 24K -rwxrwxrwx 1 www-data www-data  21K Apr 23 21:13 tt-rss.js
 44K -rwxrwxrwx 1 www-data www-data  41K Apr 23 21:13 viewfeed.js

simplepie
total 0
0 -rwxr-xr-x 1 www-data www-data 0 Apr 23 18:01 .empty

upload
total 0
0 -rwxrwxrwx 1 www-data www-data 0 Apr 23 18:01 .empty

Curiously...all values in ttrss_feeds are in the past EXCEPT "last_update_started" which is comfortably in the future by about 7 hours, which I believe is UTC? I'm PST, so it makes sense that my time is -7...I don't think that's an issue:

Code: Select all

mysql> select title, update_interval, last_updated, last_viewed, last_update_started from ttrss_feeds;
+-----------------------------+-----------------+---------------------+---------------------+---------------------+
| title                       | update_interval | last_updated        | last_viewed         | last_update_started |
+-----------------------------+-----------------+---------------------+---------------------+---------------------+
| Tiny Tiny RSS: New Releases |               0 | 2013-10-13 19:15:04 | NULL                | 2013-10-13 19:15:01 |
| Tiny Tiny RSS: Forum        |               0 | 2013-10-13 19:15:13 | NULL                | 2013-10-13 19:15:04 |
| xkcd.com                    |               0 | 2016-04-22 14:30:01 | 2015-02-24 05:08:18 | 2016-04-25 16:12:21 |
| What If?                    |               0 | 2016-04-22 14:16:28 | NULL                | 2016-04-25 16:12:21 |
| Cute Overload               |               0 | 2016-04-22 14:17:31 | 2015-10-21 20:41:02 | 2016-04-25 16:12:21 |
| Hyperbole and a Half        |               0 | 2016-04-22 14:17:32 | NULL                | 2016-04-25 16:12:21 |
| Animal Capshunz             |               0 | 2016-04-22 14:16:24 | 2015-10-21 20:40:47 | 2016-04-25 16:12:21 |
| Animal Gifs                 |               0 | 2016-04-22 14:17:21 | 2015-12-15 14:22:45 | 2016-04-25 16:12:21 |
| Daily Squee                 |               0 | 2016-04-22 18:45:23 | 2015-02-18 18:35:11 | 2016-04-25 16:12:21 |
| I Has A Hotdog              |               0 | 2016-04-22 18:45:47 | 2015-10-21 20:41:34 | 2016-04-25 16:12:21 |
| Lolcats                     |               0 | 2016-04-22 18:45:52 | 2015-10-21 20:41:41 | 2016-04-25 16:12:21 |
| Set Phasers to LOL          |               0 | 2016-04-22 18:45:08 | 2015-03-03 16:51:35 | 2016-04-25 16:12:21 |
| ROFLrazzi                   |               0 | 2016-04-22 18:45:58 | 2015-03-03 16:49:12 | 2016-04-25 16:12:21 |
| FAIL Blog                   |               0 | 2016-04-22 14:15:55 | 2015-02-18 19:18:11 | 2016-04-25 16:12:21 |
| After 12                    |               0 | 2016-04-23 22:03:33 | 2016-04-23 22:03:26 | 2016-04-25 16:12:21 |
| FAIL Nation                 |               0 | 2016-04-22 14:16:10 | 2015-02-18 18:49:32 | 2016-04-25 16:12:21 |
| Monday Thru Friday          |               0 | 2016-04-22 14:15:59 | 2015-03-03 16:41:01 | 2016-04-25 16:12:21 |
| Poorly Dressed              |               0 | 2016-04-22 14:16:02 | 2015-03-03 16:43:01 | 2016-04-25 16:12:21 |
| School of Fail              |               0 | 2016-04-22 14:16:15 | 2015-02-19 20:16:09 | 2016-04-25 16:12:21 |
| Doctor Who                  |               0 | 2016-04-22 14:16:28 | 2015-03-21 23:19:58 | 2016-04-25 16:12:21 |
| Señor Gif                   |               0 | 2016-04-22 14:17:25 | 2015-11-19 00:46:33 | 2016-04-25 16:12:21 |
| There I Fixed It            |               0 | 2016-04-22 18:45:15 | 2015-03-03 16:52:28 | 2016-04-25 16:12:21 |
| Superheroes                 |               0 | 2016-04-22 14:16:32 | 2015-02-18 19:38:04 | 2016-04-25 16:12:21 |
| Geek Universe               |               0 | 2016-04-22 14:17:04 | 2015-10-21 20:41:21 | 2016-04-25 16:12:21 |
| So Much Pun                 |               0 | 2016-04-22 18:45:30 | 2015-03-03 16:52:10 | 2016-04-25 16:12:21 |
| Rage Comics                 |               0 | 2016-04-22 18:45:36 | 2015-03-03 16:48:46 | 2016-04-25 16:12:21 |
| Geek Life                   |               0 | 2016-04-22 14:16:06 | 2015-02-18 19:18:26 | 2016-04-25 16:12:21 |
| Video Games                 |               0 | 2016-04-22 14:16:35 | 2015-02-18 20:08:00 | 2016-04-25 16:12:21 |
| Ugliest Tattoos             |               0 | 2016-04-22 18:45:41 | 2015-03-03 16:53:03 | 2016-04-25 16:12:21 |
| Very Demotivational         |               0 | 2016-04-22 18:46:03 | 2015-03-01 23:57:37 | 2016-04-25 16:12:21 |
| This Is Photobomb           |               0 | 2016-04-22 18:46:09 | 2015-03-03 16:52:38 | 2016-04-25 16:12:21 |
| Picture Is Unrelated        |               0 | 2016-04-22 14:16:39 | 2015-03-30 01:19:39 | 2016-04-25 16:12:21 |
| Art of Trolling             |               0 | 2016-04-22 14:16:43 | 2015-06-14 16:08:44 | 2016-04-25 16:12:21 |
| Memebase                    |               0 | 2016-04-22 14:16:47 | 2015-03-01 23:49:59 | 2016-04-25 16:12:21 |
| WIN!                        |               0 | 2016-04-22 14:17:12 | 2015-02-20 21:00:17 | 2016-04-25 16:12:21 |
| Tech Blog                   |               0 | 2016-04-22 14:17:14 | 2015-10-21 20:42:28 | 2016-04-25 16:12:21 |
| The Perry Bible Fellowship  |               0 | 2016-04-22 14:17:14 | 2014-09-16 18:47:30 | 2016-04-25 16:12:21 |
| Cringe                      |               0 | 2016-04-22 14:16:51 | 2015-06-09 17:07:48 | 2016-04-25 16:12:21 |
| Parenting                   |               0 | 2016-04-22 14:16:55 | 2015-06-03 18:17:37 | 2016-04-25 16:12:21 |
| Web Comics                  |               0 | 2016-04-22 14:17:29 | 2015-10-21 20:41:52 | 2016-04-25 16:12:21 |
| Cartoons & Anime            |               0 | 2016-04-22 18:46:15 | 2015-10-21 20:42:36 | 2016-04-25 16:12:21 |
| Tribler                     |               0 | 2016-04-22 14:17:06 | 2015-01-18 07:37:46 | 2016-04-25 16:12:21 |
| Pydio                       |               0 | 2016-04-22 14:16:56 | 2015-03-06 16:55:55 | 2016-04-25 16:12:21 |
| AwesomeWM                   |               0 | 2016-04-22 14:17:17 | 2015-05-31 04:26:22 | 2016-04-25 16:12:21 |
| Subsonic                    |               0 | 2016-04-22 14:17:08 | NULL                | 2016-04-25 16:12:21 |
| Encopy (Torque)             |               0 | 2016-04-22 14:16:18 | 2015-06-14 04:13:31 | 2016-04-25 16:12:21 |
| Gogs                        |               0 | 2016-04-22 14:17:16 | NULL                | 2016-04-25 16:12:21 |
+-----------------------------+-----------------+---------------------+---------------------+---------------------+
47 rows in set (0.00 sec)


[fox]

what's that about? "[04:00:38/30311] warning: unable to create stampfile"

stamp file is created in LOCK_DIRECTORY in config.php, check that is exists and has correct permissions, remove any possible old files in there

i'm not sure but its possible that update subprocesses won't launch correctly if they can't create lockfiles although if they fail because of it they probably should report errors

also does everything work without systemd i.e. if you run daemon2 from command line? if so maybe it's some ubuntu issue

the unit file i'm using on debian is pretty much identical to the one on the wiki and everything seems to work fine

>Curiously...all values in ttrss_feeds are in the past EXCEPT "last_update_started" which is comfortably in the future by about 7 hours, which I believe is UTC? I'm PST, so it makes sense that my time is -7...I don't think that's an issue:

tt-rss uses UTC internally for everything

[fox]

although now that i think about it, daemon master process should exit on startup if LOCK_DIRECTORY is unavailable, so i'm somewhat not sure wtf is going on there

e: also, try running update.php --force-update

e2: yet another thing is that i somehow broke feed selection on mysql when updating and you just ran into it when you switched to git, you can try going back through several latest master changesets and see if your feeds start updating magically (one candidate being 9e84bab)

although fwiw it seems to work fine on mysql

[fox]

also, i think there was another report that importing tt-rss settings with OPML set things incorrectly and possibly prevented updates (idk, set global update interval to -1 or something?), maybe that's what happened here, that was also semi-recently reported in support, i think

[surfrock66]

Ok:

1) Removed stampfile in /ttrss/lock. Killed systemd service, ran update_daemon2 manually...still got the warning. Lock directory is 777, should be writeable...also lockfile is created in the same spot and gets updated. Not sure; still, seems like just a warning.
2) Running daemon2 manually doesn't update either. Could be an Ubuntu thing, not sure.
3) Ok. Did the force-update on update.php...ttrss page now shows this:

Code: Select all

No unread articles found to display.
Feeds last updated at Wed, Dec 31 1969 - 16:00

So, 0 time -7. All timestamps in my db have been purged:

Code: Select all

mysql> select title, update_interval, last_updated, last_viewed, last_update_started from ttrss_feeds;
+-----------------------------+-----------------+---------------------+---------------------+---------------------+
| title                       | update_interval | last_updated        | last_viewed         | last_update_started |
+-----------------------------+-----------------+---------------------+---------------------+---------------------+
| Tiny Tiny RSS: New Releases |               0 | 1970-01-01 00:00:00 | NULL                | 1970-01-01 00:00:00 |
| Tiny Tiny RSS: Forum        |               0 | 1970-01-01 00:00:00 | NULL                | 1970-01-01 00:00:00 |
| xkcd.com                    |               0 | 1970-01-01 00:00:00 | 2015-02-24 05:08:18 | 1970-01-01 00:00:00 |
| What If?                    |               0 | 1970-01-01 00:00:00 | NULL                | 1970-01-01 00:00:00 |
| Cute Overload               |               0 | 1970-01-01 00:00:00 | 2015-10-21 20:41:02 | 1970-01-01 00:00:00 |
| Hyperbole and a Half        |               0 | 1970-01-01 00:00:00 | NULL                | 1970-01-01 00:00:00 |
| Animal Capshunz             |               0 | 1970-01-01 00:00:00 | 2015-10-21 20:40:47 | 1970-01-01 00:00:00 |
| Animal Gifs                 |               0 | 1970-01-01 00:00:00 | 2015-12-15 14:22:45 | 1970-01-01 00:00:00 |
| Daily Squee                 |               0 | 1970-01-01 00:00:00 | 2015-02-18 18:35:11 | 1970-01-01 00:00:00 |
| I Has A Hotdog              |               0 | 1970-01-01 00:00:00 | 2015-10-21 20:41:34 | 1970-01-01 00:00:00 |
| Lolcats                     |               0 | 1970-01-01 00:00:00 | 2015-10-21 20:41:41 | 1970-01-01 00:00:00 |
| Set Phasers to LOL          |               0 | 1970-01-01 00:00:00 | 2015-03-03 16:51:35 | 1970-01-01 00:00:00 |
| ROFLrazzi                   |               0 | 1970-01-01 00:00:00 | 2015-03-03 16:49:12 | 1970-01-01 00:00:00 |
| FAIL Blog                   |               0 | 1970-01-01 00:00:00 | 2015-02-18 19:18:11 | 1970-01-01 00:00:00 |
| After 12                    |               0 | 1970-01-01 00:00:00 | 2016-04-23 22:03:26 | 1970-01-01 00:00:00 |
| FAIL Nation                 |               0 | 1970-01-01 00:00:00 | 2015-02-18 18:49:32 | 1970-01-01 00:00:00 |
| Monday Thru Friday          |               0 | 1970-01-01 00:00:00 | 2015-03-03 16:41:01 | 1970-01-01 00:00:00 |
| Poorly Dressed              |               0 | 1970-01-01 00:00:00 | 2015-03-03 16:43:01 | 1970-01-01 00:00:00 |
| School of Fail              |               0 | 1970-01-01 00:00:00 | 2015-02-19 20:16:09 | 1970-01-01 00:00:00 |
| Doctor Who                  |               0 | 1970-01-01 00:00:00 | 2015-03-21 23:19:58 | 1970-01-01 00:00:00 |
| Señor Gif                   |               0 | 1970-01-01 00:00:00 | 2015-11-19 00:46:33 | 1970-01-01 00:00:00 |
| There I Fixed It            |               0 | 1970-01-01 00:00:00 | 2015-03-03 16:52:28 | 1970-01-01 00:00:00 |
| Superheroes                 |               0 | 1970-01-01 00:00:00 | 2015-02-18 19:38:04 | 1970-01-01 00:00:00 |
| Geek Universe               |               0 | 1970-01-01 00:00:00 | 2015-10-21 20:41:21 | 1970-01-01 00:00:00 |
| So Much Pun                 |               0 | 1970-01-01 00:00:00 | 2015-03-03 16:52:10 | 1970-01-01 00:00:00 |
| Rage Comics                 |               0 | 1970-01-01 00:00:00 | 2015-03-03 16:48:46 | 1970-01-01 00:00:00 |
| Geek Life                   |               0 | 1970-01-01 00:00:00 | 2015-02-18 19:18:26 | 1970-01-01 00:00:00 |
| Video Games                 |               0 | 1970-01-01 00:00:00 | 2015-02-18 20:08:00 | 1970-01-01 00:00:00 |
| Ugliest Tattoos             |               0 | 1970-01-01 00:00:00 | 2015-03-03 16:53:03 | 1970-01-01 00:00:00 |
| Very Demotivational         |               0 | 1970-01-01 00:00:00 | 2015-03-01 23:57:37 | 1970-01-01 00:00:00 |
| This Is Photobomb           |               0 | 1970-01-01 00:00:00 | 2015-03-03 16:52:38 | 1970-01-01 00:00:00 |
| Picture Is Unrelated        |               0 | 1970-01-01 00:00:00 | 2015-03-30 01:19:39 | 1970-01-01 00:00:00 |
| Art of Trolling             |               0 | 1970-01-01 00:00:00 | 2015-06-14 16:08:44 | 1970-01-01 00:00:00 |
| Memebase                    |               0 | 1970-01-01 00:00:00 | 2015-03-01 23:49:59 | 1970-01-01 00:00:00 |
| WIN!                        |               0 | 1970-01-01 00:00:00 | 2015-02-20 21:00:17 | 1970-01-01 00:00:00 |
| Tech Blog                   |               0 | 1970-01-01 00:00:00 | 2015-10-21 20:42:28 | 1970-01-01 00:00:00 |
| The Perry Bible Fellowship  |               0 | 1970-01-01 00:00:00 | 2014-09-16 18:47:30 | 1970-01-01 00:00:00 |
| Cringe                      |               0 | 1970-01-01 00:00:00 | 2015-06-09 17:07:48 | 1970-01-01 00:00:00 |
| Parenting                   |               0 | 1970-01-01 00:00:00 | 2015-06-03 18:17:37 | 1970-01-01 00:00:00 |
| Web Comics                  |               0 | 1970-01-01 00:00:00 | 2015-10-21 20:41:52 | 1970-01-01 00:00:00 |
| Cartoons & Anime            |               0 | 1970-01-01 00:00:00 | 2015-10-21 20:42:36 | 1970-01-01 00:00:00 |
| Tribler                     |               0 | 1970-01-01 00:00:00 | 2015-01-18 07:37:46 | 1970-01-01 00:00:00 |
| Pydio                       |               0 | 1970-01-01 00:00:00 | 2015-03-06 16:55:55 | 1970-01-01 00:00:00 |
| AwesomeWM                   |               0 | 1970-01-01 00:00:00 | 2015-05-31 04:26:22 | 1970-01-01 00:00:00 |
| Subsonic                    |               0 | 1970-01-01 00:00:00 | NULL                | 1970-01-01 00:00:00 |
| Encopy (Torque)             |               0 | 1970-01-01 00:00:00 | 2015-06-14 04:13:31 | 1970-01-01 00:00:00 |
| Gogs                        |               0 | 1970-01-01 00:00:00 | NULL                | 1970-01-01 00:00:00 |
+-----------------------------+-----------------+---------------------+---------------------+---------------------+
47 rows in set (0.00 sec)


4) Hmm...update interval is 0 for all of them...is this field in minutes/hours? I can update the table to set the times back and to fix that...I set the update interval to 15 mins in the gui, but seems like it's 0'd out.

[surfrock66]

I ran this and got this output in sql:

Code: Select all

mysql> update ttrss_feeds set last_updated='2016-04-23 00:00:00', last_update_started='2016-04-23 00:00:00', update_interval='15'  where title like '%';
Query OK, 0 rows affected (0.13 sec)
Rows matched: 47  Changed: 0  Warnings: 0

mysql> select title, update_interval, last_updated, last_viewed, last_update_started from ttrss_feeds;
+-----------------------------+-----------------+---------------------+---------------------+---------------------+
| title                       | update_interval | last_updated        | last_viewed         | last_update_started |
+-----------------------------+-----------------+---------------------+---------------------+---------------------+
| Tiny Tiny RSS: New Releases |              15 | 2016-04-23 00:00:00 | NULL                | 2016-04-23 00:00:00 |
| Tiny Tiny RSS: Forum        |              15 | 2016-04-23 00:00:00 | NULL                | 2016-04-23 00:00:00 |
| xkcd.com                    |              15 | 2016-04-23 00:00:00 | 2015-02-24 05:08:18 | 2016-04-23 00:00:00 |
| What If?                    |              15 | 2016-04-23 00:00:00 | NULL                | 2016-04-23 00:00:00 |
| Cute Overload               |              15 | 2016-04-23 00:00:00 | 2015-10-21 20:41:02 | 2016-04-23 00:00:00 |
| Hyperbole and a Half        |              15 | 2016-04-23 00:00:00 | NULL                | 2016-04-23 00:00:00 |
| Animal Capshunz             |              15 | 2016-04-23 00:00:00 | 2015-10-21 20:40:47 | 2016-04-23 00:00:00 |
| Animal Gifs                 |              15 | 2016-04-23 00:00:00 | 2015-12-15 14:22:45 | 2016-04-23 00:00:00 |
| Daily Squee                 |              15 | 2016-04-23 00:00:00 | 2015-02-18 18:35:11 | 2016-04-23 00:00:00 |
| I Has A Hotdog              |              15 | 2016-04-23 00:00:00 | 2015-10-21 20:41:34 | 2016-04-23 00:00:00 |
| Lolcats                     |              15 | 2016-04-23 00:00:00 | 2015-10-21 20:41:41 | 2016-04-23 00:00:00 |
| Set Phasers to LOL          |              15 | 2016-04-23 00:00:00 | 2015-03-03 16:51:35 | 2016-04-23 00:00:00 |
| ROFLrazzi                   |              15 | 2016-04-23 00:00:00 | 2015-03-03 16:49:12 | 2016-04-23 00:00:00 |
| FAIL Blog                   |              15 | 2016-04-23 00:00:00 | 2015-02-18 19:18:11 | 2016-04-23 00:00:00 |
| After 12                    |              15 | 2016-04-23 00:00:00 | 2016-04-23 22:03:26 | 2016-04-23 00:00:00 |
| FAIL Nation                 |              15 | 2016-04-23 00:00:00 | 2015-02-18 18:49:32 | 2016-04-23 00:00:00 |
| Monday Thru Friday          |              15 | 2016-04-23 00:00:00 | 2015-03-03 16:41:01 | 2016-04-23 00:00:00 |
| Poorly Dressed              |              15 | 2016-04-23 00:00:00 | 2015-03-03 16:43:01 | 2016-04-23 00:00:00 |
| School of Fail              |              15 | 2016-04-23 00:00:00 | 2015-02-19 20:16:09 | 2016-04-23 00:00:00 |
| Doctor Who                  |              15 | 2016-04-23 00:00:00 | 2015-03-21 23:19:58 | 2016-04-23 00:00:00 |
| Señor Gif                   |              15 | 2016-04-23 00:00:00 | 2015-11-19 00:46:33 | 2016-04-23 00:00:00 |
| There I Fixed It            |              15 | 2016-04-23 00:00:00 | 2015-03-03 16:52:28 | 2016-04-23 00:00:00 |
| Superheroes                 |              15 | 2016-04-23 00:00:00 | 2015-02-18 19:38:04 | 2016-04-23 00:00:00 |
| Geek Universe               |              15 | 2016-04-23 00:00:00 | 2015-10-21 20:41:21 | 2016-04-23 00:00:00 |
| So Much Pun                 |              15 | 2016-04-23 00:00:00 | 2015-03-03 16:52:10 | 2016-04-23 00:00:00 |
| Rage Comics                 |              15 | 2016-04-23 00:00:00 | 2015-03-03 16:48:46 | 2016-04-23 00:00:00 |
| Geek Life                   |              15 | 2016-04-23 00:00:00 | 2015-02-18 19:18:26 | 2016-04-23 00:00:00 |
| Video Games                 |              15 | 2016-04-23 00:00:00 | 2015-02-18 20:08:00 | 2016-04-23 00:00:00 |
| Ugliest Tattoos             |              15 | 2016-04-23 00:00:00 | 2015-03-03 16:53:03 | 2016-04-23 00:00:00 |
| Very Demotivational         |              15 | 2016-04-23 00:00:00 | 2015-03-01 23:57:37 | 2016-04-23 00:00:00 |
| This Is Photobomb           |              15 | 2016-04-23 00:00:00 | 2015-03-03 16:52:38 | 2016-04-23 00:00:00 |
| Picture Is Unrelated        |              15 | 2016-04-23 00:00:00 | 2015-03-30 01:19:39 | 2016-04-23 00:00:00 |
| Art of Trolling             |              15 | 2016-04-23 00:00:00 | 2015-06-14 16:08:44 | 2016-04-23 00:00:00 |
| Memebase                    |              15 | 2016-04-23 00:00:00 | 2015-03-01 23:49:59 | 2016-04-23 00:00:00 |
| WIN!                        |              15 | 2016-04-23 00:00:00 | 2015-02-20 21:00:17 | 2016-04-23 00:00:00 |
| Tech Blog                   |              15 | 2016-04-23 00:00:00 | 2015-10-21 20:42:28 | 2016-04-23 00:00:00 |
| The Perry Bible Fellowship  |              15 | 2016-04-23 00:00:00 | 2014-09-16 18:47:30 | 2016-04-23 00:00:00 |
| Cringe                      |              15 | 2016-04-23 00:00:00 | 2015-06-09 17:07:48 | 2016-04-23 00:00:00 |
| Parenting                   |              15 | 2016-04-23 00:00:00 | 2015-06-03 18:17:37 | 2016-04-23 00:00:00 |
| Web Comics                  |              15 | 2016-04-23 00:00:00 | 2015-10-21 20:41:52 | 2016-04-23 00:00:00 |
| Cartoons & Anime            |              15 | 2016-04-23 00:00:00 | 2015-10-21 20:42:36 | 2016-04-23 00:00:00 |
| Tribler                     |              15 | 2016-04-23 00:00:00 | 2015-01-18 07:37:46 | 2016-04-23 00:00:00 |
| Pydio                       |              15 | 2016-04-23 00:00:00 | 2015-03-06 16:55:55 | 2016-04-23 00:00:00 |
| AwesomeWM                   |              15 | 2016-04-23 00:00:00 | 2015-05-31 04:26:22 | 2016-04-23 00:00:00 |
| Subsonic                    |              15 | 2016-04-23 00:00:00 | NULL                | 2016-04-23 00:00:00 |
| Encopy (Torque)             |              15 | 2016-04-23 00:00:00 | 2015-06-14 04:13:31 | 2016-04-23 00:00:00 |
| Gogs                        |              15 | 2016-04-23 00:00:00 | NULL                | 2016-04-23 00:00:00 |
+-----------------------------+-----------------+---------------------+---------------------+---------------------+
47 rows in set (0.00 sec)


So now my ttrss page shows:

Code: Select all

No unread articles found to display.
Feeds last updated at Apr 22, 17:00

Cycled the service, still 0 to update:

Code: Select all

surfrock66@sr66-blade:/var/www/ttrss$ sudo systemctl start ttrss_backend.service
surfrock66@sr66-blade:/var/www/ttrss$ sudo systemctl status ttrss_backend.service
● ttrss_backend.service - ttrss_backend
   Loaded: loaded (/lib/systemd/system/ttrss_backend.service; enabled; vendor preset: enabled)
   Active: active (running) since Mon 2016-04-25 10:24:40 PDT; 5s ago
 Main PID: 30688 (php)
    Tasks: 4 (limit: 512)
   CGroup: /system.slice/ttrss_backend.service
           ├─30688 php /var/www/ttrss/update_daemon2.php
           ├─30691 php /var/www/ttrss/update_daemon2.php
           ├─30693 sh -c /usr/bin/php update.php --daemon-loop   --task 1 --pidlock 30691
           └─30695 /usr/bin/php update.php --daemon-loop --task 1 --pidlock 30691

Apr 25 10:24:40 sr66-blade update_daemon2.php[30688]: [17:24:40/30694] cache/export: removed 0 files.
Apr 25 10:24:40 sr66-blade update_daemon2.php[30688]: [17:24:40/30694] cache/upload: removed 0 files.
Apr 25 10:24:40 sr66-blade update_daemon2.php[30688]: [17:24:40/30694] Removed 0 old lock files.
Apr 25 10:24:40 sr66-blade update_daemon2.php[30688]: [17:24:40/30694] Removing old error log entries...
Apr 25 10:24:41 sr66-blade update_daemon2.php[30688]: [17:24:41/30694] Feedbrowser updated, 47 feeds processed.
Apr 25 10:24:42 sr66-blade update_daemon2.php[30688]: [17:24:42/30694] Purged 0 orphaned posts.
Apr 25 10:24:42 sr66-blade update_daemon2.php[30688]: [17:24:42/30694] Removed 0 (feeds) 0 (cats) orphaned counter cache entries.
Apr 25 10:24:43 sr66-blade update_daemon2.php[30688]: [17:24:43/30688] [reap_children] child 30690 reaped.
Apr 25 10:24:43 sr66-blade update_daemon2.php[30688]: [17:24:43/30688] [SIGCHLD] jobs left: 1
Apr 25 10:24:45 sr66-blade update_daemon2.php[30688]: [17:24:45/30695] Scheduled 0 feeds to update...


[fox]

0 basically means "use default" which falls back to your user preference in ttrss_user_prefs (default_update_something, can't miss it)

nvm

e: as usual you can email me the dump of your database so i could import it here and take a look

[surfrock66]

Link to dump on gdrive sent via PM; users table not included.

My final fallback plan will be to wipe out the DB and start over, then insert the old users table entries, then re-import the feed xml. This is all cat pictures and updates to open source projects...it's not like my business will fall apart or anything.

[pcause]

I have been running on Ubuntu 16.04 since the first alphas (Mate). I have not had any issues with the updating. I can't remember what issues I originally had, but I wound up adding the update.php --daemon to rc.local and have systemd run rc.local. This works fine.

[fox]

Link to dump on gdrive sent via PM; users table not included.

the important part is being able to easily import it, i'm not really getting paid here to dig through your sql dumps with a text editor you know, i don't care about your troubles nearly enough to do that

either make a working dump while zeroing out password hashes or w/e i don't really give a shit or you're on your own

[fox]

re: new dump, i'm afraid the news aren't good

i've imported the database and launched the daemon (without even logging in or w/e):

Code: Select all

naboo:tt-rss-test:% ./update_daemon2.php
[15:55:27/3373] [MASTER] installing shutdown handlers
[15:55:27/3373] [MASTER] spawned client 0 [PID:3375]...
[15:55:27/3373] [MASTER] spawned client 1 [PID:3376]...
PHP Warning:  chmod(): Operation not permitted in /home/fox/public_html/tt-rss-test/plugins/cache_starred_images/init.php on line 38
PHP Warning:  Starred cache directory is not writable. in /home/fox/public_html/tt-rss-test/plugins/cache_starred_images/init.php on line 47
[15:55:27/3379] Using task id 1
[15:55:27/3379] Lock: update_daemon-3376.lock
[15:55:27/3379] Waiting before update (5)
PHP Warning:  chmod(): Operation not permitted in /home/fox/public_html/tt-rss-test/plugins/cache_starred_images/init.php on line 38
PHP Warning:  Starred cache directory is not writable. in /home/fox/public_html/tt-rss-test/plugins/cache_starred_images/init.php on line 47
[15:55:27/3380] Using task id 0
[15:55:27/3380] Lock: update_daemon-3375.lock
[15:55:27/3380] Waiting before update (0)
[15:55:27/3380] Scheduled 45 feeds to update...
[15:55:27/3380] Base feed: http://xkcd.com/rss.xml
[15:55:27/3380]  => 2016-04-23 00:00:00, 5 2
[15:55:27/3380]     0.0722 (sec)
[15:55:27/3380] Base feed: http://what-if.xkcd.com/feed.atom
[15:55:27/3380]  => 2016-04-23 00:00:00, 6 2
[15:55:27/3380]     0.0702 (sec)
[15:55:27/3380] Base feed: http://cuteoverload.com/feed/
[15:55:27/3380]  => 2016-04-23 00:00:00, 7 2
[15:55:27/3380]     0.0818 (sec)
...
[15:55:31/3380] Base feed: http://memebase.cheezburger.com/webcomics/rss
[15:55:31/3380]  => 2016-04-23 00:00:00, 85 2
[15:55:31/3380]     0.0833 (sec)
[15:55:31/3380] Base feed: http://geek.cheezburger.com/cartoons/rss
[15:55:31/3380]  => 2016-04-23 00:00:00, 86 2
[15:55:31/3380]     0.0700 (sec)
[15:55:31/3380] Base feed: https://github.com/Tribler/tribler/releases.atom
[15:55:31/3380]  => 2016-04-23 00:00:00, 87 2
[15:55:31/3380]     0.0703 (sec)
[15:55:31/3380] Base feed: https://github.com/pydio/pydio-core/releases.atom
[15:55:31/3380]  => 2016-04-23 00:00:00, 88 2
[15:55:32/3380]     0.0697 (sec)
[15:55:32/3380] Base feed: https://github.com/awesomeWM/awesome/releases.atom
[15:55:32/3380]  => 2016-04-23 00:00:00, 90 2
[15:55:32/3379] Scheduled 0 feeds to update...
[15:55:32/3379] Sending digests, batch of max 15 users, headline limit = 1000
[15:55:32/3379] All done.
[15:55:32/3380]     0.1182 (sec)
[15:55:32/3380] Base feed: http://sourceforge.net/p/subsonic/news/feed
[15:55:32/3380]  => 2016-04-23 00:00:00, 91 2
[15:55:32/3380]     0.0822 (sec)
[15:55:32/3380] Base feed: https://github.com/econpy/torque/releases.atom
[15:55:32/3380]  => 2016-04-23 00:00:00, 92 2
[15:55:32/3380]     0.0708 (sec)
[15:55:32/3380] Base feed: https://github.com/gogits/gogs/releases.atom
[15:55:32/3380]  => 2016-04-23 00:00:00, 94 2
[15:55:32/3380]     0.0699 (sec)
[15:55:32/3380] Processed 45 feeds in 5.1868 (sec), 0.1153 (sec/feed avg)
[15:55:32/3380] Sending digests, batch of max 15 users, headline limit = 1000
[15:55:32/3380] All done.
[15:55:32/3380] cache/simplepie: removed 0 files.
[15:55:32/3380] cache/images: removed 0 files.
[15:55:32/3380] cache/export: removed 0 files.
[15:55:32/3380] cache/upload: removed 0 files.
[15:55:32/3380] Removed 0 old lock files.
[15:55:32/3380] Removing old error log entries...
[15:55:32/3380] Feedbrowser updated, 47 feeds processed.
[15:55:32/3380] Purged 0 orphaned posts.
[15:55:32/3380] Removed 0 (feeds) 0 (cats) orphaned counter cache entries.
[15:55:33/3373] [reap_children] child 3375 seems active but lockfile is unlocked.
[15:55:33/3373] [reap_children] child 3376 reaped.
[15:55:33/3373] [SIGCHLD] jobs left: 0
[15:55:33/3373] [SIGCHLD] jobs left: 0
^C[15:55:40/3373] [MASTER] SIG_INT received.

[15:55:40/3373] removing lockfile (master)...


ignoring irrelevant permission errors, it seemed to pick up and go immediately. so the problem doesn't seem to be with the database and feed selection code per se. not sure what to tell you at this point tbh.

i'm running php7 and whatever mysql debian stable is shipping at the moment but unless i'm missing something neither should affect anything.

e: however, i'm still seeing this:

Code: Select all

mysql> select id, title, update_interval, last_updated, last_viewed, last_update_started from ttrss_feeds ;
+----+-----------------------------+-----------------+---------------------+---------------------+---------------------+
| id | title                       | update_interval | last_updated        | last_viewed         | last_update_started |
+----+-----------------------------+-----------------+---------------------+---------------------+---------------------+
|  1 | Tiny Tiny RSS: New Releases |              15 | 2016-04-23 00:00:00 | NULL                | 2016-04-23 00:00:00 |
|  2 | Tiny Tiny RSS: Forum        |              15 | 2016-04-23 00:00:00 | NULL                | 2016-04-23 00:00:00 |
|  5 | xkcd.com                    |              15 | 2016-04-23 00:00:00 | 2015-02-24 05:08:18 | 2016-04-26 15:55:27 |
|  6 | What If?                    |              15 | 2016-04-23 00:00:00 | NULL                | 2016-04-26 15:55:27 |
|  7 | Cute Overload               |              15 | 2016-04-23 00:00:00 | 2015-10-21 20:41:02 | 2016-04-26 15:55:27 |
|  8 | Hyperbole and a Half        |              15 | 2016-04-23 00:00:00 | NULL                | 2016-04-26 15:55:27 |


so last_updated didn't actually update to current time. strange.

e2: so it's a schema problem:

Code: Select all

mysql> select id,update_interval,auth_login,feed_url,auth_pass,cache_images,mark_unread_on_update, owner_uid,pubsub_state, auth_pass_encrypted,feed_language from ttrss_feeds where id = 70;
ERROR 1054 (42S22): Unknown column 'feed_language' in 'field list'
mysql> Bye


looks like the update was not entirely successful or there is a script error somewhere

e3: well if feed_language is missing you need to run the following from schema/updates/mysql/128.sql:

Code: Select all

alter table ttrss_feeds add column feed_language varchar(100);
update ttrss_feeds set feed_language = '';
alter table ttrss_feeds change feed_language feed_language varchar(100) not null;
alter table ttrss_feeds alter column feed_language set default '';


i have no idea why the upgrade script didn't process correctly (it should at least stop if there are errors) i'm afraid, also i can't guarantee your database being internally consistent now.